builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-037 starttime: 1450196433.96 results: success (0) buildid: 20151215070825 builduid: 1539578ed650459e8fe5bf194deeb4de revision: 0fb60a06349bce8b13f7f7d3c31305af13320b77 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:33.959334) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:33.959918) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:33.960214) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006402 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:33.995054) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:33.995335) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:34.008587) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:34.008906) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004597 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:34.058066) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:34.058372) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:34.058730) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:34.059004) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-15 08:20:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 139M=0s 2015-12-15 08:20:34 (139 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175325 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:34.247279) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:34.247654) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018959 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:34.298877) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:34.299200) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0fb60a06349bce8b13f7f7d3c31305af13320b77 --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 0fb60a06349bce8b13f7f7d3c31305af13320b77 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-15 08:20:34,416 truncating revision to first 12 chars 2015-12-15 08:20:34,416 Setting DEBUG logging. 2015-12-15 08:20:34,416 attempt 1/10 2015-12-15 08:20:34,416 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0fb60a06349b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-15 08:20:34,641 unpacking tar archive at: fx-team-0fb60a06349b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.491901 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:34.803595) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:34.803866) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:34.818474) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:34.818745) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:34.819122) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-15 08:20:34.819452) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:20:35 INFO - MultiFileLogger online at 20151215 08:20:35 in /builds/slave/test 08:20:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:20:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:20:35 INFO - {'append_to_log': False, 08:20:35 INFO - 'base_work_dir': '/builds/slave/test', 08:20:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:20:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:20:35 INFO - 'branch': 'Fx-Team-Non-PGO', 08:20:35 INFO - 'buildbot_json_path': 'buildprops.json', 08:20:35 INFO - 'config_files': ('talos/linux_config.py',), 08:20:35 INFO - 'default_actions': ('clobber', 08:20:35 INFO - 'read-buildbot-config', 08:20:35 INFO - 'download-and-extract', 08:20:35 INFO - 'populate-webroot', 08:20:35 INFO - 'create-virtualenv', 08:20:35 INFO - 'install', 08:20:35 INFO - 'run-tests'), 08:20:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:20:35 INFO - 'download_minidump_stackwalk': True, 08:20:35 INFO - 'download_symbols': 'ondemand', 08:20:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:20:35 INFO - 'tooltool.py': '/tools/tooltool.py', 08:20:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:20:35 INFO - '/tools/misc-python/virtualenv.py')}, 08:20:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:20:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:20:35 INFO - 'installer_path': 'installer.exe', 08:20:35 INFO - 'log_level': 'info', 08:20:35 INFO - 'log_name': 'talos', 08:20:35 INFO - 'log_to_console': True, 08:20:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:20:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:20:35 INFO - 'opt_config_files': (), 08:20:35 INFO - 'pip_index': False, 08:20:35 INFO - 'sps_profile': False, 08:20:35 INFO - 'sps_profile_interval': 0, 08:20:35 INFO - 'suite': 'dromaeojs-e10s', 08:20:35 INFO - 'system_bits': '64', 08:20:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:20:35 INFO - 'title': 'talos-linux64-ix-037', 08:20:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:20:35 INFO - 'use_talos_json': True, 08:20:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:20:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:20:35 INFO - 'work_dir': 'build'} 08:20:35 INFO - ##### 08:20:35 INFO - ##### Running clobber step. 08:20:35 INFO - ##### 08:20:35 INFO - Running pre-action listener: _resource_record_pre_action 08:20:35 INFO - Running main action method: clobber 08:20:35 INFO - rmtree: /builds/slave/test/build 08:20:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:20:35 INFO - Running post-action listener: _resource_record_post_action 08:20:35 INFO - ##### 08:20:35 INFO - ##### Running read-buildbot-config step. 08:20:35 INFO - ##### 08:20:35 INFO - Running pre-action listener: _resource_record_pre_action 08:20:35 INFO - Running main action method: read_buildbot_config 08:20:35 INFO - Using buildbot properties: 08:20:35 INFO - { 08:20:35 INFO - "properties": { 08:20:35 INFO - "buildnumber": 574, 08:20:35 INFO - "product": "firefox", 08:20:35 INFO - "script_repo_revision": "production", 08:20:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:20:35 INFO - "repository": "", 08:20:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 08:20:35 INFO - "buildid": "20151215070825", 08:20:35 INFO - "slavename": "talos-linux64-ix-037", 08:20:35 INFO - "pgo_build": "False", 08:20:35 INFO - "basedir": "/builds/slave/test", 08:20:35 INFO - "project": "", 08:20:35 INFO - "platform": "ubuntu64_hw", 08:20:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:20:35 INFO - "slavebuilddir": "test", 08:20:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:20:35 INFO - "branch": "fx-team", 08:20:35 INFO - "repo_path": "integration/fx-team", 08:20:35 INFO - "stage_platform": "linux64", 08:20:35 INFO - "builduid": "1539578ed650459e8fe5bf194deeb4de", 08:20:35 INFO - "revision": "0fb60a06349bce8b13f7f7d3c31305af13320b77" 08:20:35 INFO - }, 08:20:35 INFO - "sourcestamp": { 08:20:35 INFO - "repository": "", 08:20:35 INFO - "hasPatch": false, 08:20:35 INFO - "project": "", 08:20:35 INFO - "branch": "fx-team-linux64-talos", 08:20:35 INFO - "changes": [ 08:20:35 INFO - { 08:20:35 INFO - "category": null, 08:20:35 INFO - "files": [ 08:20:35 INFO - { 08:20:35 INFO - "url": null, 08:20:35 INFO - "name": "https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 08:20:35 INFO - } 08:20:35 INFO - ], 08:20:35 INFO - "repository": "", 08:20:35 INFO - "rev": "0fb60a06349bce8b13f7f7d3c31305af13320b77", 08:20:35 INFO - "who": "gijskruitbosch@gmail.com", 08:20:35 INFO - "when": 1450196404, 08:20:35 INFO - "number": 7362340, 08:20:35 INFO - "comments": "Bug 1230831 - fix treatment of tabs with no group information, r=mconley", 08:20:35 INFO - "project": "", 08:20:35 INFO - "at": "Tue 15 Dec 2015 08:20:04", 08:20:35 INFO - "branch": "fx-team-linux64-talos", 08:20:35 INFO - "revlink": "", 08:20:35 INFO - "properties": [ 08:20:35 INFO - [ 08:20:35 INFO - "buildid", 08:20:35 INFO - "20151215070825", 08:20:35 INFO - "Change" 08:20:35 INFO - ], 08:20:35 INFO - [ 08:20:35 INFO - "builduid", 08:20:35 INFO - "1539578ed650459e8fe5bf194deeb4de", 08:20:35 INFO - "Change" 08:20:35 INFO - ], 08:20:35 INFO - [ 08:20:35 INFO - "pgo_build", 08:20:35 INFO - "False", 08:20:35 INFO - "Change" 08:20:35 INFO - ] 08:20:35 INFO - ], 08:20:35 INFO - "revision": "0fb60a06349bce8b13f7f7d3c31305af13320b77" 08:20:35 INFO - } 08:20:35 INFO - ], 08:20:35 INFO - "revision": "0fb60a06349bce8b13f7f7d3c31305af13320b77" 08:20:35 INFO - } 08:20:35 INFO - } 08:20:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:20:35 INFO - Running post-action listener: _resource_record_post_action 08:20:35 INFO - ##### 08:20:35 INFO - ##### Running download-and-extract step. 08:20:35 INFO - ##### 08:20:35 INFO - Running pre-action listener: _resource_record_pre_action 08:20:35 INFO - Running main action method: download_and_extract 08:20:35 INFO - mkdir: /builds/slave/test/build/tests 08:20:35 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')]} 08:20:35 INFO - https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:20:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/test_packages.json 08:20:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/test_packages.json 08:20:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:20:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:20:38 INFO - Downloaded 1302 bytes. 08:20:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:20:38 INFO - Using the following test package requirements: 08:20:38 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:20:38 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:20:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:20:38 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:20:38 INFO - u'jsshell-linux-x86_64.zip'], 08:20:38 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:20:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:20:38 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:20:38 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:20:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:20:38 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:20:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:20:38 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:20:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:20:38 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:20:38 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:20:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:20:38 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:38 INFO - https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:20:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:20:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:20:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:20:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:20:40 INFO - Downloaded 21863279 bytes. 08:20:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 08:20:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:20:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:20:41 INFO - Return code: 0 08:20:41 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:20:41 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')]} 08:20:41 INFO - https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:20:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:20:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:20:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:20:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:20:42 INFO - Downloaded 21863279 bytes. 08:20:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 08:20:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:20:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:20:44 INFO - Return code: 0 08:20:44 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')]} 08:20:44 INFO - https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:20:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:20:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:20:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:20:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:20:46 INFO - Downloaded 11132052 bytes. 08:20:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 08:20:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:20:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 08:20:46 INFO - Return code: 0 08:20:46 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')]} 08:20:46 INFO - https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:20:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:20:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:20:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:20:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:20:47 INFO - Downloaded 57739652 bytes. 08:20:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:20:47 INFO - mkdir: /builds/slave/test/properties 08:20:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:20:47 INFO - Writing to file /builds/slave/test/properties/build_url 08:20:47 INFO - Contents: 08:20:47 INFO - build_url:https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:20:47 INFO - Running post-action listener: _resource_record_post_action 08:20:47 INFO - Running post-action listener: set_extra_try_arguments 08:20:47 INFO - ##### 08:20:47 INFO - ##### Running populate-webroot step. 08:20:47 INFO - ##### 08:20:47 INFO - Running pre-action listener: _resource_record_pre_action 08:20:47 INFO - Running main action method: populate_webroot 08:20:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:20:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:20:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:20:47 INFO - '--tppagecycles', 08:20:47 INFO - '7'], 08:20:47 INFO - 'tests': ['tsvgm']}}, 08:20:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:20:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:20:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:20:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:20:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:20:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:20:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:20:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:47 INFO - 'talos_options': ['--e10s'], 08:20:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:20:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:47 INFO - 'tests': ['damp', 'tps']}, 08:20:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:47 INFO - 'talos_options': ['--e10s'], 08:20:47 INFO - 'tests': ['damp', 'tps']}, 08:20:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:20:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:20:47 INFO - 'other': {'tests': ['a11yr', 08:20:47 INFO - 'ts_paint', 08:20:47 INFO - 'tpaint', 08:20:47 INFO - 'sessionrestore', 08:20:47 INFO - 'sessionrestore_no_auto_restore']}, 08:20:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:20:47 INFO - 'tests': ['a11yr', 08:20:47 INFO - 'ts_paint', 08:20:47 INFO - 'tpaint', 08:20:47 INFO - 'sessionrestore', 08:20:47 INFO - 'sessionrestore_no_auto_restore']}, 08:20:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:20:47 INFO - 'tests': ['a11yr', 08:20:47 INFO - 'ts_paint', 08:20:47 INFO - 'tpaint', 08:20:47 INFO - 'sessionrestore', 08:20:47 INFO - 'sessionrestore_no_auto_restore']}, 08:20:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:20:47 INFO - 'tests': ['a11yr', 08:20:47 INFO - 'ts_paint', 08:20:47 INFO - 'tpaint', 08:20:47 INFO - 'sessionrestore', 08:20:47 INFO - 'sessionrestore_no_auto_restore']}, 08:20:47 INFO - 'other_l64': {'tests': ['a11yr', 08:20:47 INFO - 'ts_paint', 08:20:47 INFO - 'tpaint', 08:20:47 INFO - 'sessionrestore', 08:20:47 INFO - 'sessionrestore_no_auto_restore']}, 08:20:47 INFO - 'other_nol64': {'tests': ['a11yr', 08:20:47 INFO - 'ts_paint', 08:20:47 INFO - 'tpaint', 08:20:47 INFO - 'sessionrestore', 08:20:47 INFO - 'sessionrestore_no_auto_restore']}, 08:20:47 INFO - 'svgr': {'tests': ['tsvgx', 08:20:47 INFO - 'tsvgr_opacity', 08:20:47 INFO - 'tart', 08:20:47 INFO - 'tscrollx', 08:20:47 INFO - 'cart']}, 08:20:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:20:47 INFO - 'tests': ['tsvgx', 08:20:47 INFO - 'tsvgr_opacity', 08:20:47 INFO - 'tart', 08:20:47 INFO - 'tscrollx', 08:20:47 INFO - 'cart']}, 08:20:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:47 INFO - 'tests': ['tp5o']}, 08:20:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:47 INFO - 'talos_options': ['--e10s'], 08:20:47 INFO - 'tests': ['tp5o']}, 08:20:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:47 INFO - 'talos_options': ['--xperf_path', 08:20:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:20:47 INFO - 'tests': ['tp5n']}, 08:20:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:47 INFO - 'talos_options': ['--e10s', 08:20:47 INFO - '--xperf_path', 08:20:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:20:47 INFO - 'tests': ['tp5n']}}, 08:20:47 INFO - 'talos.zip': {'path': '', 08:20:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:20:47 INFO - Running post-action listener: _resource_record_post_action 08:20:47 INFO - ##### 08:20:47 INFO - ##### Running create-virtualenv step. 08:20:47 INFO - ##### 08:20:47 INFO - Running pre-action listener: _resource_record_pre_action 08:20:47 INFO - Running main action method: create_virtualenv 08:20:47 INFO - Creating virtualenv /builds/slave/test/build/venv 08:20:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:20:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:20:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:20:48 INFO - Using real prefix '/usr' 08:20:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:20:48 INFO - Installing distribute.............................................................................................................................................................................................done. 08:20:50 INFO - Installing pip.................done. 08:20:50 INFO - Return code: 0 08:20:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f23827e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1509240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15980b0>, '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 0x1598fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1599440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044', '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 08:20:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:20:50 INFO - Using env: {'DISPLAY': ':0', 08:20:50 INFO - 'HOME': '/home/cltbld', 08:20:50 INFO - 'LANG': 'en_US.UTF-8', 08:20:50 INFO - 'LANGUAGE': 'en_US:en', 08:20:50 INFO - 'LOGNAME': 'cltbld', 08:20:50 INFO - 'MAIL': '/var/mail/cltbld', 08:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:50 INFO - 'MOZ_NO_REMOTE': '1', 08:20:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:50 INFO - 'NO_EM_RESTART': '1', 08:20:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:50 INFO - 'PWD': '/builds/slave/test', 08:20:50 INFO - 'SHELL': '/bin/bash', 08:20:50 INFO - 'SHLVL': '1', 08:20:50 INFO - 'TERM': 'linux', 08:20:50 INFO - 'TMOUT': '86400', 08:20:50 INFO - 'USER': 'cltbld', 08:20:50 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044', 08:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:50 INFO - '_': '/tools/buildbot/bin/python'} 08:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:20:50 INFO - Cleaning up... 08:20:50 INFO - Return code: 0 08:20:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f23827e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1509240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15980b0>, '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 0x1598fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1599440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044', '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 08:20:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:20:50 INFO - Using env: {'DISPLAY': ':0', 08:20:50 INFO - 'HOME': '/home/cltbld', 08:20:50 INFO - 'LANG': 'en_US.UTF-8', 08:20:50 INFO - 'LANGUAGE': 'en_US:en', 08:20:50 INFO - 'LOGNAME': 'cltbld', 08:20:50 INFO - 'MAIL': '/var/mail/cltbld', 08:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:50 INFO - 'MOZ_NO_REMOTE': '1', 08:20:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:50 INFO - 'NO_EM_RESTART': '1', 08:20:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:50 INFO - 'PWD': '/builds/slave/test', 08:20:50 INFO - 'SHELL': '/bin/bash', 08:20:50 INFO - 'SHLVL': '1', 08:20:50 INFO - 'TERM': 'linux', 08:20:50 INFO - 'TMOUT': '86400', 08:20:50 INFO - 'USER': 'cltbld', 08:20:50 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044', 08:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:50 INFO - '_': '/tools/buildbot/bin/python'} 08:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:50 INFO - Downloading/unpacking psutil>=0.7.1 08:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:52 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:20:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:20:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:20:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:20:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:20:52 INFO - Installing collected packages: psutil 08:20:52 INFO - Running setup.py install for psutil 08:20:52 INFO - building 'psutil._psutil_linux' extension 08:20:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:20:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:20:52 INFO - building 'psutil._psutil_posix' extension 08:20:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:20:53 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 08:20:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:20:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:20:53 INFO - Successfully installed psutil 08:20:53 INFO - Cleaning up... 08:20:53 INFO - Return code: 0 08:20:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:20: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')]} 08:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20: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')]} 08:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20: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', '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 0x7f23827e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1509240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15980b0>, '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 0x1598fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1599440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044', '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 08:20: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:20: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 mozsystemmonitor==0.0.0 08:20:53 INFO - Using env: {'DISPLAY': ':0', 08:20:53 INFO - 'HOME': '/home/cltbld', 08:20:53 INFO - 'LANG': 'en_US.UTF-8', 08:20:53 INFO - 'LANGUAGE': 'en_US:en', 08:20:53 INFO - 'LOGNAME': 'cltbld', 08:20:53 INFO - 'MAIL': '/var/mail/cltbld', 08:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:53 INFO - 'MOZ_NO_REMOTE': '1', 08:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:53 INFO - 'NO_EM_RESTART': '1', 08:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:53 INFO - 'PWD': '/builds/slave/test', 08:20:53 INFO - 'SHELL': '/bin/bash', 08:20:53 INFO - 'SHLVL': '1', 08:20:53 INFO - 'TERM': 'linux', 08:20:53 INFO - 'TMOUT': '86400', 08:20:53 INFO - 'USER': 'cltbld', 08:20:53 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044', 08:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:53 INFO - '_': '/tools/buildbot/bin/python'} 08:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:20:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:20:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:20:55 INFO - Installing collected packages: mozsystemmonitor 08:20:55 INFO - Running setup.py install for mozsystemmonitor 08:20:55 INFO - Successfully installed mozsystemmonitor 08:20:55 INFO - Cleaning up... 08:20:55 INFO - Return code: 0 08:20:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:20: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')]} 08:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20: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')]} 08:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f23827e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1509240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15980b0>, '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 0x1598fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1599440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044', '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 08:20:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:20:55 INFO - Using env: {'DISPLAY': ':0', 08:20:55 INFO - 'HOME': '/home/cltbld', 08:20:55 INFO - 'LANG': 'en_US.UTF-8', 08:20:55 INFO - 'LANGUAGE': 'en_US:en', 08:20:55 INFO - 'LOGNAME': 'cltbld', 08:20:55 INFO - 'MAIL': '/var/mail/cltbld', 08:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:55 INFO - 'MOZ_NO_REMOTE': '1', 08:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:55 INFO - 'NO_EM_RESTART': '1', 08:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:55 INFO - 'PWD': '/builds/slave/test', 08:20:55 INFO - 'SHELL': '/bin/bash', 08:20:55 INFO - 'SHLVL': '1', 08:20:55 INFO - 'TERM': 'linux', 08:20:55 INFO - 'TMOUT': '86400', 08:20:55 INFO - 'USER': 'cltbld', 08:20:55 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044', 08:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:55 INFO - '_': '/tools/buildbot/bin/python'} 08:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:55 INFO - Downloading/unpacking blobuploader==1.2.4 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20:57 INFO - Downloading blobuploader-1.2.4.tar.gz 08:20:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:20:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:20:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20:57 INFO - Downloading docopt-0.6.1.tar.gz 08:20:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:20:57 INFO - Installing collected packages: blobuploader, requests, docopt 08:20:57 INFO - Running setup.py install for blobuploader 08:20:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:20:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:20:58 INFO - Running setup.py install for requests 08:20:58 INFO - Running setup.py install for docopt 08:20:58 INFO - Successfully installed blobuploader requests docopt 08:20:58 INFO - Cleaning up... 08:20:58 INFO - Return code: 0 08:20:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f23827e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1509240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15980b0>, '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 0x1598fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1599440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044', '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 08:20:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:20:58 INFO - Using env: {'DISPLAY': ':0', 08:20:58 INFO - 'HOME': '/home/cltbld', 08:20:58 INFO - 'LANG': 'en_US.UTF-8', 08:20:58 INFO - 'LANGUAGE': 'en_US:en', 08:20:58 INFO - 'LOGNAME': 'cltbld', 08:20:58 INFO - 'MAIL': '/var/mail/cltbld', 08:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:58 INFO - 'MOZ_NO_REMOTE': '1', 08:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:58 INFO - 'NO_EM_RESTART': '1', 08:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:58 INFO - 'PWD': '/builds/slave/test', 08:20:58 INFO - 'SHELL': '/bin/bash', 08:20:58 INFO - 'SHLVL': '1', 08:20:58 INFO - 'TERM': 'linux', 08:20:58 INFO - 'TMOUT': '86400', 08:20:58 INFO - 'USER': 'cltbld', 08:20:58 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044', 08:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:58 INFO - '_': '/tools/buildbot/bin/python'} 08:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:20:58 INFO - Running setup.py (path:/tmp/pip-HNuZxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:20:58 INFO - Running setup.py (path:/tmp/pip-dbDA_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:20:58 INFO - Running setup.py (path:/tmp/pip-x7t9gM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:20:58 INFO - Running setup.py (path:/tmp/pip-ekR3pU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:20:58 INFO - Running setup.py (path:/tmp/pip-Gzl_8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:20:59 INFO - Running setup.py (path:/tmp/pip-xv0pOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:20:59 INFO - Running setup.py (path:/tmp/pip-g7Sh6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:20:59 INFO - Running setup.py (path:/tmp/pip-9lq89k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:20:59 INFO - Running setup.py (path:/tmp/pip-7rEJQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:20:59 INFO - Running setup.py (path:/tmp/pip-iKoyuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:20:59 INFO - Running setup.py (path:/tmp/pip-g03_Ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:20:59 INFO - Running setup.py (path:/tmp/pip-qATHkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:20:59 INFO - Running setup.py (path:/tmp/pip-TA4dkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:20:59 INFO - Running setup.py (path:/tmp/pip-fLrnYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:59 INFO - Running setup.py (path:/tmp/pip-AadOqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:20:59 INFO - Running setup.py (path:/tmp/pip-Frxa_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:20:59 INFO - Running setup.py (path:/tmp/pip-vljRO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:20:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:20:59 INFO - Running setup.py install for manifestparser 08:21:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:21:00 INFO - Running setup.py install for mozcrash 08:21:00 INFO - Running setup.py install for mozdebug 08:21:00 INFO - Running setup.py install for mozdevice 08:21:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:21:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:21:00 INFO - Running setup.py install for mozfile 08:21:00 INFO - Running setup.py install for mozhttpd 08:21:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:21:00 INFO - Running setup.py install for mozinfo 08:21:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:21:00 INFO - Running setup.py install for mozInstall 08:21:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:21:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:21:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:21:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:21:00 INFO - Running setup.py install for mozleak 08:21:00 INFO - Running setup.py install for mozlog 08:21:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:21:00 INFO - Running setup.py install for moznetwork 08:21:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:21:01 INFO - Running setup.py install for mozprocess 08:21:01 INFO - Running setup.py install for mozprofile 08:21:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:21:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:21:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:21:01 INFO - Running setup.py install for mozrunner 08:21:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:21:01 INFO - Running setup.py install for mozscreenshot 08:21:01 INFO - Running setup.py install for moztest 08:21:01 INFO - Running setup.py install for mozversion 08:21:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:21:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:21:01 INFO - Cleaning up... 08:21:01 INFO - Return code: 0 08:21:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f23827e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1509240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15980b0>, '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 0x1598fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1599440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044', '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 08:21:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:21:01 INFO - Using env: {'DISPLAY': ':0', 08:21:01 INFO - 'HOME': '/home/cltbld', 08:21:01 INFO - 'LANG': 'en_US.UTF-8', 08:21:01 INFO - 'LANGUAGE': 'en_US:en', 08:21:01 INFO - 'LOGNAME': 'cltbld', 08:21:01 INFO - 'MAIL': '/var/mail/cltbld', 08:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:01 INFO - 'MOZ_NO_REMOTE': '1', 08:21:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:01 INFO - 'NO_EM_RESTART': '1', 08:21:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:01 INFO - 'PWD': '/builds/slave/test', 08:21:01 INFO - 'SHELL': '/bin/bash', 08:21:01 INFO - 'SHLVL': '1', 08:21:01 INFO - 'TERM': 'linux', 08:21:01 INFO - 'TMOUT': '86400', 08:21:01 INFO - 'USER': 'cltbld', 08:21:01 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044', 08:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:01 INFO - '_': '/tools/buildbot/bin/python'} 08:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:21:01 INFO - Running setup.py (path:/tmp/pip-lUTofL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:21:01 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)) 08:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:21:01 INFO - Running setup.py (path:/tmp/pip-uUt0JO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:21:02 INFO - Running setup.py (path:/tmp/pip-xLAM9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:21:02 INFO - Running setup.py (path:/tmp/pip-vC1xcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:21:02 INFO - Running setup.py (path:/tmp/pip-Xa9tKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:21:02 INFO - Running setup.py (path:/tmp/pip-TAl7Fc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:21:02 INFO - Running setup.py (path:/tmp/pip-kie7rp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:21:02 INFO - Running setup.py (path:/tmp/pip-e17Xsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:21:02 INFO - Running setup.py (path:/tmp/pip-GKkxAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:21:02 INFO - Running setup.py (path:/tmp/pip-p7GyVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:21:02 INFO - Running setup.py (path:/tmp/pip-jKyiPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:21:02 INFO - Running setup.py (path:/tmp/pip-igMus3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:21:02 INFO - Running setup.py (path:/tmp/pip-gMgXdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:21:02 INFO - Running setup.py (path:/tmp/pip-tPuFZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:02 INFO - Running setup.py (path:/tmp/pip-4RfN6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:02 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)) 08:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:21:02 INFO - Running setup.py (path:/tmp/pip-woFRPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:21:03 INFO - Running setup.py (path:/tmp/pip-kYE37s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:21:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:04 INFO - Downloading blessings-1.5.1.tar.gz 08:21:04 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 08:21:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:21:04 INFO - Installing collected packages: blessings 08:21:04 INFO - Running setup.py install for blessings 08:21:04 INFO - Successfully installed blessings 08:21:04 INFO - Cleaning up... 08:21:05 INFO - Return code: 0 08:21:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:21:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:21:05 INFO - Reading from file tmpfile_stdout 08:21:05 INFO - Current package versions: 08:21:05 INFO - argparse == 1.2.1 08:21:05 INFO - blessings == 1.5.1 08:21:05 INFO - blobuploader == 1.2.4 08:21:05 INFO - docopt == 0.6.1 08:21:05 INFO - manifestparser == 1.1 08:21:05 INFO - mozInstall == 1.12 08:21:05 INFO - mozcrash == 0.16 08:21:05 INFO - mozdebug == 0.1 08:21:05 INFO - mozdevice == 0.47 08:21:05 INFO - mozfile == 1.2 08:21:05 INFO - mozhttpd == 0.7 08:21:05 INFO - mozinfo == 0.9 08:21:05 INFO - mozleak == 0.1 08:21:05 INFO - mozlog == 3.1 08:21:05 INFO - moznetwork == 0.27 08:21:05 INFO - mozprocess == 0.22 08:21:05 INFO - mozprofile == 0.27 08:21:05 INFO - mozrunner == 6.11 08:21:05 INFO - mozscreenshot == 0.1 08:21:05 INFO - mozsystemmonitor == 0.0 08:21:05 INFO - moztest == 0.7 08:21:05 INFO - mozversion == 1.4 08:21:05 INFO - psutil == 3.1.1 08:21:05 INFO - requests == 1.2.3 08:21:05 INFO - wsgiref == 0.1.2 08:21:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f23827e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1509240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15980b0>, '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 0x1598fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1599440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044', '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 08:21:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:21:05 INFO - Using env: {'DISPLAY': ':0', 08:21:05 INFO - 'HOME': '/home/cltbld', 08:21:05 INFO - 'LANG': 'en_US.UTF-8', 08:21:05 INFO - 'LANGUAGE': 'en_US:en', 08:21:05 INFO - 'LOGNAME': 'cltbld', 08:21:05 INFO - 'MAIL': '/var/mail/cltbld', 08:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:05 INFO - 'MOZ_NO_REMOTE': '1', 08:21:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:05 INFO - 'NO_EM_RESTART': '1', 08:21:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:05 INFO - 'PWD': '/builds/slave/test', 08:21:05 INFO - 'SHELL': '/bin/bash', 08:21:05 INFO - 'SHLVL': '1', 08:21:05 INFO - 'TERM': 'linux', 08:21:05 INFO - 'TMOUT': '86400', 08:21:05 INFO - 'USER': 'cltbld', 08:21:05 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044', 08:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:05 INFO - '_': '/tools/buildbot/bin/python'} 08:21:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:21:05 INFO - Cleaning up... 08:21:05 INFO - Return code: 0 08:21:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f23827e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1509240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15980b0>, '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 0x1598fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1599440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044', '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 08:21:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:21:05 INFO - Using env: {'DISPLAY': ':0', 08:21:05 INFO - 'HOME': '/home/cltbld', 08:21:05 INFO - 'LANG': 'en_US.UTF-8', 08:21:05 INFO - 'LANGUAGE': 'en_US:en', 08:21:05 INFO - 'LOGNAME': 'cltbld', 08:21:05 INFO - 'MAIL': '/var/mail/cltbld', 08:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:05 INFO - 'MOZ_NO_REMOTE': '1', 08:21:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:05 INFO - 'NO_EM_RESTART': '1', 08:21:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:05 INFO - 'PWD': '/builds/slave/test', 08:21:05 INFO - 'SHELL': '/bin/bash', 08:21:05 INFO - 'SHLVL': '1', 08:21:05 INFO - 'TERM': 'linux', 08:21:05 INFO - 'TMOUT': '86400', 08:21:05 INFO - 'USER': 'cltbld', 08:21:05 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044', 08:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:05 INFO - '_': '/tools/buildbot/bin/python'} 08:21:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:05 INFO - Downloading/unpacking jsonschema 08:21: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 08:21: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 08:21: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 08:21: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 08:21: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 08:21: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 08:21:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:21:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 08:21:07 INFO - Downloading/unpacking functools32 (from jsonschema) 08:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:07 INFO - Downloading functools32-3.2.3-2.tar.gz 08:21:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:21:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:21:07 INFO - warning: no files found matching '*.txt' 08:21:07 INFO - no previously-included directories found matching 'build' 08:21:07 INFO - no previously-included directories found matching 'dist' 08:21:07 INFO - no previously-included directories found matching '.git*' 08:21:07 INFO - Installing collected packages: jsonschema, functools32 08:21:07 INFO - Running setup.py install for functools32 08:21:07 INFO - warning: no files found matching '*.txt' 08:21:07 INFO - no previously-included directories found matching 'build' 08:21:07 INFO - no previously-included directories found matching 'dist' 08:21:07 INFO - no previously-included directories found matching '.git*' 08:21:07 INFO - Successfully installed jsonschema functools32 08:21:07 INFO - Cleaning up... 08:21:07 INFO - Return code: 0 08:21:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:21: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')]} 08:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21: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')]} 08:21:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f23827e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1509240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15980b0>, '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 0x1598fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1599440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044', '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 08:21:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:21:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:21:07 INFO - Using env: {'DISPLAY': ':0', 08:21:07 INFO - 'HOME': '/home/cltbld', 08:21:07 INFO - 'LANG': 'en_US.UTF-8', 08:21:07 INFO - 'LANGUAGE': 'en_US:en', 08:21:07 INFO - 'LOGNAME': 'cltbld', 08:21:07 INFO - 'MAIL': '/var/mail/cltbld', 08:21:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:07 INFO - 'MOZ_NO_REMOTE': '1', 08:21:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:07 INFO - 'NO_EM_RESTART': '1', 08:21:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:07 INFO - 'PWD': '/builds/slave/test', 08:21:07 INFO - 'SHELL': '/bin/bash', 08:21:07 INFO - 'SHLVL': '1', 08:21:07 INFO - 'TERM': 'linux', 08:21:07 INFO - 'TMOUT': '86400', 08:21:07 INFO - 'USER': 'cltbld', 08:21:07 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044', 08:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:07 INFO - '_': '/tools/buildbot/bin/python'} 08:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:08 INFO - Downloading/unpacking flake8 08:21: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 08:21: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 08:21: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 08:21: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 08:21: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 08:21: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 08:21:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:21:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 08:21:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:21: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 08:21: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 08:21: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 08:21: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 08:21: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 08:21: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 08:21:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:21:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 08:21:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:21: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 08:21: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 08:21: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 08:21: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 08:21: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 08:21: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 08:21:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 08:21:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:21: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 08:21: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 08:21: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 08:21: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 08:21: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 08:21: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 08:21:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:21:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:21:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:21:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:21:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:21:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:21:10 INFO - no previously-included directories found matching 'docs/_build' 08:21:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:21:10 INFO - Running setup.py install for pep8 08:21:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:21:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:21:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:21:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:21:10 INFO - no previously-included directories found matching 'docs/_build' 08:21:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:21:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:21:10 INFO - Cleaning up... 08:21:10 INFO - Return code: 0 08:21:10 INFO - Running post-action listener: _resource_record_post_action 08:21:10 INFO - Running post-action listener: _start_resource_monitoring 08:21:10 INFO - Starting resource monitoring. 08:21:10 INFO - ##### 08:21:10 INFO - ##### Running install step. 08:21:10 INFO - ##### 08:21:10 INFO - Running pre-action listener: _resource_record_pre_action 08:21:10 INFO - Running main action method: install 08:21:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:21:10 INFO - Reading from file tmpfile_stdout 08:21:10 INFO - Detecting whether we're running mozinstall >=1.0... 08:21:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:21:10 INFO - Reading from file tmpfile_stdout 08:21:10 INFO - Output received: 08:21:10 INFO - Usage: mozinstall [options] installer 08:21:10 INFO - Options: 08:21:10 INFO - -h, --help show this help message and exit 08:21:10 INFO - -d DEST, --destination=DEST 08:21:10 INFO - Directory to install application into. [default: 08:21:10 INFO - "/builds/slave/test"] 08:21:10 INFO - --app=APP Application being installed. [default: firefox] 08:21:10 INFO - mkdir: /builds/slave/test/build/application 08:21:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:21:25 INFO - Reading from file tmpfile_stdout 08:21:25 INFO - Output received: 08:21:25 INFO - /builds/slave/test/build/application/firefox/firefox 08:21:25 INFO - Running post-action listener: _resource_record_post_action 08:21:25 INFO - ##### 08:21:25 INFO - ##### Running run-tests step. 08:21:25 INFO - ##### 08:21:25 INFO - Running pre-action listener: _resource_record_pre_action 08:21:25 INFO - Running main action method: run_tests 08:21:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:21:25 INFO - Python 2.7.3 08:21:25 INFO - Return code: 0 08:21:25 INFO - grabbing minidump binary from tooltool 08:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15980b0>, '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 0x1598fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1599440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:21:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:21:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:21:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:21:25 INFO - Return code: 0 08:21:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:21:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:21:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:21:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:21:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:21:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:21:26 INFO - Return code: 0 08:21:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost'] in /builds/slave/test/build 08:21:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost 08:21:26 INFO - Using env: {'DISPLAY': ':0', 08:21:26 INFO - 'HOME': '/home/cltbld', 08:21:26 INFO - 'LANG': 'en_US.UTF-8', 08:21:26 INFO - 'LANGUAGE': 'en_US:en', 08:21:26 INFO - 'LOGNAME': 'cltbld', 08:21:26 INFO - 'MAIL': '/var/mail/cltbld', 08:21:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:21:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:21:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:26 INFO - 'MOZ_NO_REMOTE': '1', 08:21:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:21:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:26 INFO - 'NO_EM_RESTART': '1', 08:21:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:26 INFO - 'PWD': '/builds/slave/test', 08:21:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:21:26 INFO - 'SHELL': '/bin/bash', 08:21:26 INFO - 'SHLVL': '1', 08:21:26 INFO - 'TERM': 'linux', 08:21:26 INFO - 'TMOUT': '86400', 08:21:26 INFO - 'USER': 'cltbld', 08:21:26 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044', 08:21:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:26 INFO - '_': '/tools/buildbot/bin/python'} 08:21:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost'] with output_timeout 3600 08:21:26 INFO - mozversion INFO | application_buildid: 20151215070825 08:21:26 INFO - mozversion INFO | application_changeset: 0fb60a06349bce8b13f7f7d3c31305af13320b77 08:21:26 INFO - mozversion INFO | application_display_name: Nightly 08:21:26 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:21:26 INFO - mozversion INFO | application_name: Firefox 08:21:26 INFO - mozversion INFO | application_remotingname: firefox 08:21:26 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 08:21:26 INFO - mozversion INFO | application_vendor: Mozilla 08:21:26 INFO - mozversion INFO | application_version: 46.0a1 08:21:26 INFO - mozversion INFO | platform_buildid: 20151215070825 08:21:26 INFO - mozversion INFO | platform_changeset: 0fb60a06349bce8b13f7f7d3c31305af13320b77 08:21:26 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 08:21:26 INFO - mozversion INFO | platform_version: 46.0a1 08:21:26 INFO - 2015-12-15 08:21:26,620 DEBUG : using testdate: 1450196486 08:21:26 INFO - 2015-12-15 08:21:26,620 DEBUG : actual date: 1450196486 08:21:26 INFO - 2015-12-15 08:21:26,628 INFO : starting webserver on 'localhost:55551' 08:21:26 INFO - 2015-12-15 08:21:26,629 INFO : Starting test suite talos-linux64-ix-037.e 08:21:26 INFO - 2015-12-15 08:21:26,629 INFO : Starting test dromaeo_css 08:21:26 INFO - 2015-12-15 08:21:26,629 DEBUG : operating with platform_type : linux_ 08:21:26 INFO - 2015-12-15 08:21:26,630 INFO : Initialising browser for dromaeo_css test... 08:21:26 INFO - 2015-12-15 08:21:26,643 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzt3Cyf/profile http://localhost:55551/getInfo.html 08:21:31 INFO - 2015-12-15 08:21:31,593 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:21:31 INFO - 2015-12-15 08:21:31,593 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:21:31 INFO - 2015-12-15 08:21:31,593 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:21:31 INFO - 2015-12-15 08:21:31,593 DEBUG : BROWSER_OUTPUT: __metrics 08:21:31 INFO - 2015-12-15 08:21:31,722 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] 08:21:32 INFO - 2015-12-15 08:21:32,889 INFO : Browser initialized. 08:21:32 INFO - 2015-12-15 08:21:32,890 INFO : Running cycle 1/1 for dromaeo_css test... 08:21:32 INFO - 2015-12-15 08:21:32,890 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzt3Cyf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:21:44 INFO - 2015-12-15 08:21:44,880 DEBUG : BROWSER_OUTPUT: RSS: Main: 143085568 08:21:44 INFO - 2015-12-15 08:21:44,880 DEBUG : BROWSER_OUTPUT: 08:22:34 INFO - 2015-12-15 08:22:34,507 DEBUG : BROWSER_OUTPUT: 1450196554507 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] 08:24:46 INFO - 2015-12-15 08:24:46,542 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55551/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55551/tests/dromaeo/cssquery-ext.html) 08:24:47 INFO - 2015-12-15 08:24:47,769 DEBUG : BROWSER_OUTPUT: RSS: Main: 146825216 08:24:47 INFO - 2015-12-15 08:24:47,769 DEBUG : BROWSER_OUTPUT: 08:27:49 INFO - 2015-12-15 08:27:49,868 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55551/tests/dromaeo/cssquery-ext.html (next: http://localhost:55551/tests/dromaeo/cssquery-jquery.html) 08:27:50 INFO - 2015-12-15 08:27:50,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 146767872 08:27:50 INFO - 2015-12-15 08:27:50,460 DEBUG : BROWSER_OUTPUT: 08:30:52 INFO - 2015-12-15 08:30:52,279 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55551/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55551/tests/dromaeo/cssquery-mootools.html) 08:30:52 INFO - 2015-12-15 08:30:52,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 145043456 08:30:52 INFO - 2015-12-15 08:30:52,881 DEBUG : BROWSER_OUTPUT: 08:33:54 INFO - 2015-12-15 08:33:54,640 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55551/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55551/tests/dromaeo/cssquery-prototype.html) 08:33:55 INFO - 2015-12-15 08:33:55,241 DEBUG : BROWSER_OUTPUT: RSS: Main: 144130048 08:33:55 INFO - 2015-12-15 08:33:55,241 DEBUG : BROWSER_OUTPUT: 08:36:57 INFO - 2015-12-15 08:36:57,821 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55551/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55551/tests/dromaeo/cssquery-yui.html) 08:36:58 INFO - 2015-12-15 08:36:58,448 DEBUG : BROWSER_OUTPUT: RSS: Main: 145580032 08:36:58 INFO - 2015-12-15 08:36:58,448 DEBUG : BROWSER_OUTPUT: 08:40:00 INFO - 2015-12-15 08:40:00,874 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55551/tests/dromaeo/cssquery-yui.html (next: http://localhost:55551/tests/dromaeo/cssquery-dojo.html) 08:40:01 INFO - 2015-12-15 08:40:01,125 DEBUG : BROWSER_OUTPUT: RSS: Main: 146939904 08:40:01 INFO - 2015-12-15 08:40:01,125 DEBUG : BROWSER_OUTPUT: 08:40:01 INFO - 2015-12-15 08:40:01,126 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:40:01 INFO - 2015-12-15 08:40:01,126 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:40:01 INFO - 2015-12-15 08:40:01,127 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:40:01 INFO - 2015-12-15 08:40:01,127 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:40:01 INFO - 2015-12-15 08:40:01,130 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2695.6360891279674;2734.4394399148177;2775;2788.8187267827575;2789.8744556494958;4616.2613981762925;4819.734914579701;4827.927581086282;4845.660803743739;4888.437829649587;4670.789814458349;4733.242681171013;4733.881652958669;4769.594584460325;4820.204666230068;4437.667174961883;4473.619742321906;4485.058137791051;4523.525029871866;4554.407926969489;4464.352668863013;4490.977545112286;4549.135664223803;4561.56665116815;4590.196715574778;4197.496300443951;4314.201872653538;4331.090471001094;4408.184485870124;4427.335899615051;4436.334549817521;4481.193385190664;4482.036362182146;4489.461264648263;4524.11779702958;4223.944013996501;4477.888052798674;4479.126570318789;4487.596116349544;4494.415725955638;4595.471520775121;4669.906601867943;4773.140834649762;4780.617550595979;4787.377640906695;5104.744762761847;5177.767000484987;5178.792848286064;5194.0910340690225;5238.895222095537;4846.539578740014;5013.1227035268685;5212.921806172911;5216.713080780555;5218.660787048868;4697.13103075932;4707.6233901287815;4714.033623107255;4724.811007559728;4842;5314.92027619586;5314.946850531523;5315.069862773999;5340.626156169031;5369.24830523727;5084.211947148198;5092.116944131353;5093.261477085802;5110.821121260738;5151.7166555839785;4895.8041678332465;5020.1214787412055;5068.189089745623;5150.793968241228;5189.273501709764;5106.259592359087;5107.642465027412;5110.131277682803;5118.436971933084;5160.7935682573025;5083.467317731585;5084.6440749147205;5089.4147173074825;5102.540771330524;5116.795328186831;4094.61101195386;4148.543660197376;4192.266353388145;4228.175505776406;4267.125239325931;3735.159589092487;3761.4921985531605;3781.1681430085337;3797.6582107610448;3807.276617442677;4451.532589078165;4490.146872094291;4497.797599108048;4510.594046535827;4540;4855.150348688965;4949.183384741477;4958.082754690394;4974.726390048582;5113.309703190096;4408.7575183365225;4474.39595654589;4506.639468842484;4529.909401811945;4531.116432295737;4595.333676616872;4640.32715256286;4648.7443190624845;4656.301554766745;4680.4149481314835;4653.441587009581;4755.144074066701;4771.95228047715;4900.558949694545;4947.060058588857;5231.686098834082;5246.291750613771;5249.947500525099;5251.186066159751;5287.9471205287455;4927.285543596086;4947.505249475023;4949.727764972961;4955.752212389294;4988;4886.755662216946;5009.423916249532;5083.212102124176;5150.97424512875;5230.895382092413;5166.844994650167;5173.017126745906;5178.482151784791;5195.038917800219;5211.244369566316;5046.823361182341;5051.318072060225;5053.924191137209;5054.772535235997;5069.847904562869;4724.811007559659;4836.032793441396;4966.205407134841;5070.188769796815;5105.897882042413;4824.396950381202;4830.589399900907;4875.414950205856;4880.755962201804;4895.094407534618;4818.6626936114135;5003.824866129668;5037.420696619935;5042.520960508746;5087.313212716236;4821.855344339676;4823.2282834746275;4824.49342818999;4834.178189707828;4842.394700662418 08:40:01 INFO - 2015-12-15 08:40:01,130 DEBUG : BROWSER_OUTPUT: |1;ext.html;564.7486868343584;571.4285714285714;575.2866445607447;575.9884802303955;581.1776336483874;33042.66957330426;34032.65967340326;34086.659133408655;34089.488657670154;34139.31721365578;39057.60942390575;39193.41209881854;39574;39609.40585891207;39725;7921.445498815086;8037.196280371974;8047.275745182932;8055.556944368057;8075.676972921076;7772;7845.843083138334;7872.055353357605;7884.4875083119705;7885.408594355417;7920.485168464032;7965.800854978643;8021.157778433268;8022.037355517346;8040.075391330013;7879.290863822255;7942.801429964239;7943.483673561229;7944.563049032301;7964.8805267921025;7830.060392752849;7937.880931786028;7970.601469926481;7976.7208147714555;7988.360931125496;36835.26329473422;37013.814930925444;37065.814670926746;37279;37355;2335.8648450357855;2960.881564737408;3090.273785660368;3116.1897906544464;3143.827089510076;26442.206733798015;30652.8467357664;31671.683283167105;32022;33271.33457330864;3166.2875852933134;3168.984155079233;3203.8718451262152;3210.6228013674827;3260.96739032609;180049;181642;181798;182812;183303;38140;38631.227375452334;49863.76158026536;49983;50262.49737502651;36265.63734362675;36452;36488.635113648525;36579.634203658155;36657;12069.456874440672;12091.274523528617;12237.265764054186;12260.693482662826;12304.200226985216;9236.122568355995;9259.351845370895;9265.490398028038;9270.258379329638;9272.768180795534;12841.229526228457;13393.330333483287;13424.261665608485;13478.86521134776;13520.256385898674;5441.972790136024;5573.136163894603;5579.358373787067;5593.8321850344555;5626.690532020778;887.2103827593447;916.2532535983286;956.8373376526007;984.5372674842812;1004.1916257412706;25973.650929586653;26084.34789130287;26389.73610263911;26391.208263751734;26629.733702662725;916.4180745226696;951.70497145885;957.1816097236901;1057.5241141486363;1071.0628200324716;12928;12977;13125.949924006056;13147.60557183286;13148.868511314955;309381;311055;315626;316343;316726;44327.55672443234;45171.54828451739;45252.15356694718;45417.31874021892;45620.315695264595;1223.822545730864;1229.8032314829763;1232.1375037473624;1238.6965193527462;1238.758442103799;23970.640440393756;24072;24197.308969270187;24354.269371918163;24378.634320485562;34855.65144348524;35472;35577.46633800443;35906;36211.456828148126;247432;247653;249670;249724;251342;29053.564196536645;29431.705682942895;42539.57460425356;43146.784266078466;43799.124017518836;37555.81222093872;37556;37648.36461447782;38190;38467.2306553873;32663.67336326606;32843.83578082094;33336;33747.15632109217;33776.49335260022;32812.67187328096;32921.83539082289;33053.19888212886;33055.83472082624;33110.50334245036;32975.34049318952;33446;38476.2304753909;38867.80566097151;39550.40674389829;28222.85888570544;30014.84992575023;30371.211407548682;30762.230944226572;33873;23685.881570592035;23800.642990355504;24045.299841570333;24110.276691699277;24178.51642967166 08:40:01 INFO - 2015-12-15 08:40:01,130 DEBUG : BROWSER_OUTPUT: |2;jquery.html;333.87312821127966;334.50493269960475;338.5717067909094;342.49995007289357;343.05317324185245;12030.819537706919;12385.318807465586;14850.77723834142;15035.530117306578;16311.347546098157;13573.592792216225;13587.932060339685;13867.791983120236;13906.652333691663;13967.860321396784;4726.0075384169195;4761.523847615228;4833.589144922686;4948.183549714293;4955.479674634165;4971.900561988758;5021.347224860781;5168.48315168482;5169.095408303532;5176.611754118438;4845;5028.698278103326;5121.078205922932;5134.358205224347;5148.5623721983675;5068.239764035406;5074.112030394666;5082.288479612857;5100.33695619569;5104.234364845266;4849.248366503162;5185.585153187736;5193.480651934814;5202.375714914235;5203.98522288154;18191;18209.180586873623;18378.632427351513;18767.436976890716;18803.24787008518;1831.157667472964;1851.1022154255174;1858.656148612511;1945.085809669453;1945.6497830390524;8988.280937524982;9177.265818734486;9197.448153110834;11702;12253.774622537674;1743.302678928426;1795.721663142215;1802.1619946724704;1825.3976187858107;1872.1668857358482;54788;56560.71719641375;57310.140347895234;57507;58479;9987.350822196535;9992.950035249924;10002.599896004223;10055.69832905014;10094.343867648578;12360.44378002992;12405;12416.81374779379;12469.064820138527;12512.562060328028;6903.827404314932;6932.688029038705;6953.930460695328;6958;7001.474889383317;6537.640429776313;6544.70548825304;6557.311482294386;6559.311272316433;6589.439897608757;3938.4639990403766;4063.918721625551;4272.6795490338345;4334.69959012295;4343.630791382705;2903.143572646032;2976.732094111497;3044.6955304469375;3142.230153612334;3154.242981684379;798.2376830127331;800.4396922154515;860.3762272352494;877.6489404238229;915.2815040193416;9977.600895964226;12894.67763305925;14768.778468322984;15031.173285469404;15212.087274763328;392.1353415718334;400.2914840731888;402.45869305783674;420.4303169205682;421;5485.972570137204;5779.913301300484;5792;5813.56398270123;5827.912581311284;499018;506645;507848;507852;514440;72419.6379018112;78471;78661.60669196617;78745;79156.20843791604;431.4520558890255;433.3651200990564;436.7248633361026;437.5864807756703;440.48463297941487;9786.41281523111;14041.297935102999;14486.782698259745;14519.92740036293;14749.631259218177;35196.455475378476;36163.45754813627;36337.45493817542;36340.81829590941;36473.63526364809;41870.37194442025;41905.580944190166;43209.56790432055;43807.78096109499;44497.332540012576;8943.910560894308;9197.678081267124;9232.492212928353;9257.305702072506;9266.397684150508;15361.385544578092;15977.603359496168;16312.265948032129;16500.092494912897;16916.915415423337;13300.467981281028;13515.797263041259;13924.373403196678;14151;14152.292385380895;13138.474461021835;13435.731285374433;13455.46178152863;13511.256880871253;13899.583012509642;13234.139780914209;13659.79510307366;13700.794488082885;13921.721565568834;13990.510332138327;9075.682351117679;9223.677171298972;9436;9438.386504877435;9444.150026497648;13140.145890517086;13381.799273010718;13579.185248885098;13708.45166193381;13799.655008624864 08:40:01 INFO - 2015-12-15 08:40:01,131 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1377.4145987955117;1406.5006922542498;1443.9855601443996;1642.5072478256525;1722.0958996526822;5862.32583252926;5974.074018527135;7117.430605551556;7368.926310736891;7447.404207663388;6969.128858892638;7134.678939447725;7170.462215333845;7190.496665233436;7215.314545118205;2052.6715725483928;2084.593504266669;2094.120469402847;2094.89525523724;2097.8531502794813;2006.5986802639457;2054.6712525995845;2059.6704527275638;2062.7937206279403;2084.333013435701;2044.47865794223;2071.533904871407;2078.355709729981;2080.3030984620095;2094.8428867834896;2059.938201853947;2077.3352527191305;2083.197968782015;2086.4992401823606;2088.2169186555043;2056.95886082279;2074.6887966804948;2075.8339332853334;2081.3859911326194;2089.634313995045;6876.415504682108;6973.232944376115;6997;7030.753923612649;7043.084399028145;4090.2433049885567;4218.8523401680795;4219.367094935754;4222.704410691253;4222.915541689149;2703.1214855172148;2737.603047558113;2789.288731373487;2790.1071657069747;2804.8176868503483;870.9085546017703;872.97817554561;891.5185799668236;903.2548147778043;930.06993006993;9754.268429867789;9758.414495130315;9760.804783904283;9771.755706107333;9776.853347199798;3790.8673196437994;3827.4258861171047;3843.0200298923596;3898.103436209631;3916.4712763776524;8494.575271236414;8499.915000850036;8504.65981360751;8509.74470765878;8517.95741021291;4184.91630167401;4191.91616167675;4214.1150358425075;4216.072464057902;4222.303319952235;3236.64396916339;3296.175956010997;3692.2615476904725;3801;3836.5779764225913;3488.267463832573;3524.3656141894194;3530.911727206789;3538.7345949053924;3582.5669732107367;1072.702030543036;1077.6012875236213;1080.470569420978;1099.7580532282884;1122.1976286954866;1136.8863113688565;1146.6731981385433;1160.709822544364;1172.888575585318;1210.818377243403;6600.636964966973;6637.867242655217;6640.9667951660895;6673.366030227217;6674.566153200027;976.4531862157214;1010.1767059846202;1022.0954455307107;1071.0681706914877;1090.3239991205503;5494.587905907073;5500.147477141049;5541.2796336476;5547.77808887648;5547.889042219133;8470.957645211734;8491.405601607952;8662.6101825418;8727.738167854974;8781.692640757543;8585.18440748128;8605.139486051345;8606.784830379165;8614.82770344602;8624.353173511887;6794.218664853605;6887.345702158287;6894.551854129566;6971.721131154697;6974.686139123752;6635.9004614929845;6660.56706314088;6662.666866656551;6669.166354205724;6680.766173183915;7694.269044440769;7818.0618325799;7863.882041769492;7883;8006.159353268056;7969.521828690297;7972.322352600094;8033.517988920684;8077.03075630928;8174.468659537349;5099.413567439792;5180.792768289226;5531.612787104864;6008.939910600838;6045.335013148638;6546.443552297917;6853.588784672936;6887.035814985806;6889.689963951534;6890.896636550356;6432.935670643234;6485.902711459237;6583.144191255106;6647.434968027772;6697.397234248941;6383.6808159592765;6413.070104834679;6422.839429014312;6424.293327734039;6435.581687190318;6616.206055273398;6694.163229596301;6740.224874139537;6742.887423575055;6760.797176084725;6076.058210977306;6076.270847498328;6089.117078023751;6132.2947860996555;6146.231721034871;5854.795082172103;5904.232449781501;5910.497607703393;5919.023361145535;5929.318128415115 08:40:01 INFO - 2015-12-15 08:40:01,133 DEBUG : BROWSER_OUTPUT: |4;prototype.html;291.3575565877241;292.6342072409488;296.93912747886685;298.18743922810347;299.83509070011496;5562.582806289524;5567.359753628329;5588.441155884415;5650.943490565103;5671.234383358245;5515.034868897937;5535.58483113766;5535.667859928397;5554.1113421852515;5559.833205003846;4282.8715138545895;4288.3781851631575;4296.205202037633;4296.226679197744;4298.183345164424;4132.917341653165;4216.241076606209;4266.2534056540135;4266.7866606669695;4277.379779931924;4194;4209.03192265779;4213.199492096507;4216.894577635553;4217.641500472463;4207.368894665809;4219.135077309144;4222.8310867565415;4225.746455212697;4226.767527785971;3635.0730563706084;3637.8181090945345;3638.472421498894;3641.10792855752;3645.7447978641508;5205.063088644042;5265.736713164327;5380.166074258496;5416.485433883775;5418.674879507243;4853.805847766085;4856.95143048572;4858.611311095104;4868.975655121737;4872.9756351218375;5892.705364731746;5907.881842363172;5910.468057874812;5921.407859214087;5933.910991335133;3973.264945984973;3976.1451287972936;3977.602239776028;3978.622030907059;3983.4821473208585;5971.790987315467;6210.9999999999545;6214.906776398312;6215.595986260879;6215.751369945152;4007.6593489553716;4026.3356546169553;4033.2941735196223;4035.636792688672;4047.757134571876;4097.323941549671;4097.426360309559;4098.590140985937;4100.7334523255895;4102.774347410861;4790.257510085942;4795.160846851787;4799.784009719501;4802.975985120122;4808.110499557523;5759.568032397503;5882.647041177543;5892.086726557391;5900.4984576310635;5912.290525137011;1428.9071210371292;1454.9127052376891;1460.5764328344874;1465.1136062682137;1465.6482444213311;954.6038394066524;955.5031383680447;956.2780101023822;971.3589031239349;971.5190980464574;5042.647014708935;5049.065922804293;5050.797968081236;5053.8736531587;5062.012907483006;6038.516918646497;6039.094135879654;6041.365656605993;6050.364711705296;6051.062085376773;5017.3226614406585;5019.949800502021;5035.899282014339;5040.2691609716385;5047.293378926953;3225.483922572377;3295.307985323061;3297.093299342652;3312.950305745416;3319.71782398494;5686.175504551817;5726.770929162787;5750.25246717924;5756.510696590753;5756.827295181068;6168.704572039922;6333.96833015832;6361.9045714314325;6371.681415929185;6378.872422551616;5782.59521833476;5789.2763404574425;5807.361190269152;5815.534757219497;5820.563457740771;6141.170941922962;6171.228596425447;6175.042868355233;6177.135201071944;6184.907226391698;5840.503557197516;6030.698465076816;6038.939610604013;6059.3637668045985;6061.878762424815;5775.566832487664;5813.418658134153;5817.825465236049;5828.2423284974375;5844.211031510692;4020.979895100506;4090.181963607231;4090.3250963590676;4095.6723462122363;4098.569650186688;6000.5799594028;6164.8767024658355;6177;6178.752849885954;6190.350013248724;5902.321233058082;5921.822345329647;5929.466348028698;5936.3470018297085;5944.3164036136395;5904.675242861512;5933.406659334032;5933.703314834327;5940.61386009908;5954.76180952757;5679.460451257124;5754.280714910637;5761.683107429131;5797.362290148165;5808.419158084327;5960.433758792908;5973.402659733992;5981.9401805983125;5984.611000284967;5990.430909063632;5797.449242321973;5813.244278243801;5828.825135245949;5831.912521312099;5833.7666493341485 08:40:01 INFO - 2015-12-15 08:40:01,133 DEBUG : BROWSER_OUTPUT: |5;yui.html;783.878498832681;784.0434669702964;788.3850596534703;788.4323287233194;798.0503201190579;10834.40410777407;10965.232433729621;10976.725581860457;10986.615468458585;11045.226834121615;11118.499667514961;11244.606438774625;11283.266587671795;11287.830682539769;11305.982461578456;763.3397111498556;772.1236396689742;778.6106946526737;778.9260020298091;780.6331024418514;770.3721467004374;784.7135795434654;784.8508783331149;788.2747871957813;789.124072279769;813.1705660226565;818.443458448255;820.7414664380701;821.195228675898;823.3166471828398;815.8572249856281;819.5369616166847;820.2576668115365;820.2781552233996;823.1398188892622;603.4086595136747;604.0938592111833;605.9727312270915;606.6875559087074;607.1166452811149;9704.466254356008;9747.902520974842;9758.975307592671;9789.510524473748;9835.803283934352;8790.780230494225;9401.388909720914;9556.665516706882;9879.506024698736;9918.752031199205;8615;8722.171393717586;8741.475511469333;8741.562921853945;8754.343424243143;3192.9201769955703;3240.902772916816;3272.96727032729;3290.8683652653867;3294.0776582556923;37709.43435848464;41735.58264417377;43232;43362.34956475655;43365.783171083945;8051.959740201379;8361.916380836235;8521.914780852112;9248.398854074598;9341.205997490153;15849.128297943493;16060.437884674215;16066.27701753424;16088.678226435406;16107.516774496784;6196.132541444202;6226.968865155645;6249.187605611241;6512.34876512345;6522.282548919615;3380.4760262159402;3420.1449637590604;3428.3314753622803;3461.8442170102408;3534.081138903852;2640.168346970698;2651.4962157190457;2653.6815582130266;2657.6146458763756;2659.135780871186;461.1284671969979;465.0977104417419;466.3354719524664;478.7343024621299;483.52131389924426;460.1464283753656;490.2890808327939;494.79960615950597;547.7589860461384;567.5091046244968;7285.70857165718;7430.7399241026305;7572.280633339824;7690.884636730453;7757.4181936355;557.567884889206;558.0958846668342;574.6810520161267;575.9164921086502;582.9970850145806;3215.1479857837694;3561.679448849616;3644.9453258201147;3683.7421380503106;3737.3459644562095;48371.5162848374;48495.27257091076;48651.27023094657;48651.513484865405;48711.269330960065;40604.39093413601;40741.1851762969;42569.57430425656;43363.34954975678;43724;41673.79163104165;42347.57652423498;42497.57502424998;42598;43824.56175438269;7873.645685944261;8212.753617391489;8312.25189732927;8315.667373305;8354;31870.639759896974;31962.041138765875;32103.678963211005;33107.50338744873;33235;37567.43648845324;37840.43239351467;38409.807950961185;39100;39149.6085039146;9952.55213515379;10009.149222315893;10185.33795303303;10675.092617127631;10708.30396024256;10609.363438193734;10738.73153171177;10956.397398142859;11112.888871111185;11148.721281968015;9985.750356241153;10080.143187829117;10081.445520496443;10456.32033917793;10670.146388289073;10049.497525123861;10052.145567626541;10141.847872281774;10256.282060255711;10784.460776961278;9860.753481163028;9934.940909633613;10186.337888037255;10223.131033862204;10248.795024099327;8530.445521041112;8558.443701159405;8775.210231079234;8989.820203596022;9352.298577606844;8269.131741167092;8471.279941205066;8561.101084386299;8727.519986400808;8760.649574017223 08:40:01 INFO - 2015-12-15 08:40:01,133 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:40:01 INFO - 2015-12-15 08:40:01,133 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:40:01 INFO - 2015-12-15 08:40:01,133 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,318 08:40:01 INFO - 2015-12-15 08:40:01,133 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:40:01 INFO - 2015-12-15 08:40:01,133 DEBUG : BROWSER_OUTPUT: __startTimestamp1450197601126__endTimestamp 08:40:01 INFO - 2015-12-15 08:40:01,133 DEBUG : BROWSER_OUTPUT: 08:40:01 INFO - 2015-12-15 08:40:01,133 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:40:01 INFO - 2015-12-15 08:40:01,134 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:40:01 INFO - 2015-12-15 08:40:01,134 DEBUG : BROWSER_OUTPUT: 08:40:01 INFO - 2015-12-15 08:40:01,134 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4744.11 Median:4834.18 stddev:492.88 (10.2%) stddev-sans-first:467.46 08:40:01 INFO - 2015-12-15 08:40:01,135 DEBUG : BROWSER_OUTPUT: Values: 2695.6 2734.4 2775.0 2788.8 2789.9 4616.3 4819.7 4827.9 4845.7 4888.4 4670.8 4733.2 4733.9 4769.6 4820.2 4437.7 4473.6 4485.1 4523.5 4554.4 4464.4 4491.0 4549.1 4561.6 4590.2 4197.5 4314.2 4331.1 4408.2 4427.3 4436.3 4481.2 4482.0 4489.5 4524.1 4223.9 4477.9 4479.1 4487.6 4494.4 4595.5 4669.9 4773.1 4780.6 4787.4 5104.7 5177.8 5178.8 5194.1 5238.9 4846.5 5013.1 5212.9 5216.7 5218.7 4697.1 4707.6 4714.0 4724.8 4842.0 5314.9 5314.9 5315.1 5340.6 5369.2 5084.2 5092.1 5093.3 5110.8 5151.7 4895.8 5020.1 5068.2 5150.8 5189.3 5106.3 5107.6 5110.1 5118.4 5160.8 5083.5 5084.6 5089.4 5102.5 5116.8 4094.6 4148.5 4192.3 4228.2 4267.1 3735.2 3761.5 3781.2 3797.7 3807.3 4451.5 4490.1 4497.8 4510.6 4540.0 4855.2 4949.2 4958.1 4974.7 5113.3 4408.8 4474.4 4506.6 4529.9 4531.1 4595.3 4640.3 4648.7 4656.3 4680.4 4653.4 4755.1 4772.0 4900.6 4947.1 5231.7 5246.3 5249.9 5251.2 5287.9 4927.3 4947.5 4949.7 4955.8 4988.0 4886.8 5009.4 5083.2 5151.0 5230.9 5166.8 5173.0 5178.5 5195.0 5211.2 5046.8 5051.3 5053.9 5054.8 5069.8 4724.8 4836.0 4966.2 5070.2 5105.9 4824.4 4830.6 4875.4 4880.8 4895.1 4818.7 5003.8 5037.4 5042.5 5087.3 4821.9 4823.2 4824.5 4834.2 4842.4 08:40:01 INFO - 2015-12-15 08:40:01,135 DEBUG : BROWSER_OUTPUT: 08:40:01 INFO - 2015-12-15 08:40:01,135 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39869.92 Median:34114.40 stddev:66518.84 (195.0%) stddev-sans-first:66639.98 08:40:01 INFO - 2015-12-15 08:40:01,135 DEBUG : BROWSER_OUTPUT: Values: 564.7 571.4 575.3 576.0 581.2 33042.7 34032.7 34086.7 34089.5 34139.3 39057.6 39193.4 39574.0 39609.4 39725.0 7921.4 8037.2 8047.3 8055.6 8075.7 7772.0 7845.8 7872.1 7884.5 7885.4 7920.5 7965.8 8021.2 8022.0 8040.1 7879.3 7942.8 7943.5 7944.6 7964.9 7830.1 7937.9 7970.6 7976.7 7988.4 36835.3 37013.8 37065.8 37279.0 37355.0 2335.9 2960.9 3090.3 3116.2 3143.8 26442.2 30652.8 31671.7 32022.0 33271.3 3166.3 3169.0 3203.9 3210.6 3261.0 180049.0 181642.0 181798.0 182812.0 183303.0 38140.0 38631.2 49863.8 49983.0 50262.5 36265.6 36452.0 36488.6 36579.6 36657.0 12069.5 12091.3 12237.3 12260.7 12304.2 9236.1 9259.4 9265.5 9270.3 9272.8 12841.2 13393.3 13424.3 13478.9 13520.3 5442.0 5573.1 5579.4 5593.8 5626.7 887.2 916.3 956.8 984.5 1004.2 25973.7 26084.3 26389.7 26391.2 26629.7 916.4 951.7 957.2 1057.5 1071.1 12928.0 12977.0 13125.9 13147.6 13148.9 309381.0 311055.0 315626.0 316343.0 316726.0 44327.6 45171.5 45252.2 45417.3 45620.3 1223.8 1229.8 1232.1 1238.7 1238.8 23970.6 24072.0 24197.3 24354.3 24378.6 34855.7 35472.0 35577.5 35906.0 36211.5 247432.0 247653.0 249670.0 249724.0 251342.0 29053.6 29431.7 42539.6 43146.8 43799.1 37555.8 37556.0 37648.4 38190.0 38467.2 32663.7 32843.8 33336.0 33747.2 33776.5 32812.7 32921.8 33053.2 33055.8 33110.5 32975.3 33446.0 38476.2 38867.8 39550.4 28222.9 30014.8 30371.2 30762.2 33873.0 23685.9 23800.6 24045.3 24110.3 24178.5 08:40:01 INFO - 2015-12-15 08:40:01,135 DEBUG : BROWSER_OUTPUT: 08:40:01 INFO - 2015-12-15 08:40:01,135 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27044.20 Median:420.72 stddev:82937.16 (19713.4%) stddev-sans-first:83145.57 08:40:01 INFO - 2015-12-15 08:40:01,136 DEBUG : BROWSER_OUTPUT: Values: 333.9 334.5 338.6 342.5 343.1 12030.8 12385.3 14850.8 15035.5 16311.3 13573.6 13587.9 13867.8 13906.7 13967.9 4726.0 4761.5 4833.6 4948.2 4955.5 4971.9 5021.3 5168.5 5169.1 5176.6 4845.0 5028.7 5121.1 5134.4 5148.6 5068.2 5074.1 5082.3 5100.3 5104.2 4849.2 5185.6 5193.5 5202.4 5204.0 18191.0 18209.2 18378.6 18767.4 18803.2 1831.2 1851.1 1858.7 1945.1 1945.6 8988.3 9177.3 9197.4 11702.0 12253.8 1743.3 1795.7 1802.2 1825.4 1872.2 54788.0 56560.7 57310.1 57507.0 58479.0 9987.4 9993.0 10002.6 10055.7 10094.3 12360.4 12405.0 12416.8 12469.1 12512.6 6903.8 6932.7 6953.9 6958.0 7001.5 6537.6 6544.7 6557.3 6559.3 6589.4 3938.5 4063.9 4272.7 4334.7 4343.6 2903.1 2976.7 3044.7 3142.2 3154.2 798.2 800.4 860.4 877.6 915.3 9977.6 12894.7 14768.8 15031.2 15212.1 392.1 400.3 402.5 420.4 421.0 5486.0 5779.9 5792.0 5813.6 5827.9 499018.0 506645.0 507848.0 507852.0 514440.0 72419.6 78471.0 78661.6 78745.0 79156.2 431.5 433.4 436.7 437.6 440.5 9786.4 14041.3 14486.8 14519.9 14749.6 35196.5 36163.5 36337.5 36340.8 36473.6 41870.4 41905.6 43209.6 43807.8 44497.3 8943.9 9197.7 9232.5 9257.3 9266.4 15361.4 15977.6 16312.3 16500.1 16916.9 13300.5 13515.8 13924.4 14151.0 14152.3 13138.5 13435.7 13455.5 13511.3 13899.6 13234.1 13659.8 13700.8 13921.7 13990.5 9075.7 9223.7 9436.0 9438.4 9444.2 13140.1 13381.8 13579.2 13708.5 13799.7 08:40:01 INFO - 2015-12-15 08:40:01,136 DEBUG : BROWSER_OUTPUT: 08:40:01 INFO - 2015-12-15 08:40:01,136 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5008.36 Median:6060.70 stddev:2603.58 (43.0%) stddev-sans-first:2596.58 08:40:01 INFO - 2015-12-15 08:40:01,137 DEBUG : BROWSER_OUTPUT: Values: 1377.4 1406.5 1444.0 1642.5 1722.1 5862.3 5974.1 7117.4 7368.9 7447.4 6969.1 7134.7 7170.5 7190.5 7215.3 2052.7 2084.6 2094.1 2094.9 2097.9 2006.6 2054.7 2059.7 2062.8 2084.3 2044.5 2071.5 2078.4 2080.3 2094.8 2059.9 2077.3 2083.2 2086.5 2088.2 2057.0 2074.7 2075.8 2081.4 2089.6 6876.4 6973.2 6997.0 7030.8 7043.1 4090.2 4218.9 4219.4 4222.7 4222.9 2703.1 2737.6 2789.3 2790.1 2804.8 870.9 873.0 891.5 903.3 930.1 9754.3 9758.4 9760.8 9771.8 9776.9 3790.9 3827.4 3843.0 3898.1 3916.5 8494.6 8499.9 8504.7 8509.7 8518.0 4184.9 4191.9 4214.1 4216.1 4222.3 3236.6 3296.2 3692.3 3801.0 3836.6 3488.3 3524.4 3530.9 3538.7 3582.6 1072.7 1077.6 1080.5 1099.8 1122.2 1136.9 1146.7 1160.7 1172.9 1210.8 6600.6 6637.9 6641.0 6673.4 6674.6 976.5 1010.2 1022.1 1071.1 1090.3 5494.6 5500.1 5541.3 5547.8 5547.9 8471.0 8491.4 8662.6 8727.7 8781.7 8585.2 8605.1 8606.8 8614.8 8624.4 6794.2 6887.3 6894.6 6971.7 6974.7 6635.9 6660.6 6662.7 6669.2 6680.8 7694.3 7818.1 7863.9 7883.0 8006.2 7969.5 7972.3 8033.5 8077.0 8174.5 5099.4 5180.8 5531.6 6008.9 6045.3 6546.4 6853.6 6887.0 6889.7 6890.9 6432.9 6485.9 6583.1 6647.4 6697.4 6383.7 6413.1 6422.8 6424.3 6435.6 6616.2 6694.2 6740.2 6742.9 6760.8 6076.1 6076.3 6089.1 6132.3 6146.2 5854.8 5904.2 5910.5 5919.0 5929.3 08:40:01 INFO - 2015-12-15 08:40:01,137 DEBUG : BROWSER_OUTPUT: 08:40:01 INFO - 2015-12-15 08:40:01,137 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4845.07 Median:5564.97 stddev:1466.91 (26.4%) stddev-sans-first:1430.65 08:40:01 INFO - 2015-12-15 08:40:01,137 DEBUG : BROWSER_OUTPUT: Values: 291.4 292.6 296.9 298.2 299.8 5562.6 5567.4 5588.4 5650.9 5671.2 5515.0 5535.6 5535.7 5554.1 5559.8 4282.9 4288.4 4296.2 4296.2 4298.2 4132.9 4216.2 4266.3 4266.8 4277.4 4194.0 4209.0 4213.2 4216.9 4217.6 4207.4 4219.1 4222.8 4225.7 4226.8 3635.1 3637.8 3638.5 3641.1 3645.7 5205.1 5265.7 5380.2 5416.5 5418.7 4853.8 4857.0 4858.6 4869.0 4873.0 5892.7 5907.9 5910.5 5921.4 5933.9 3973.3 3976.1 3977.6 3978.6 3983.5 5971.8 6211.0 6214.9 6215.6 6215.8 4007.7 4026.3 4033.3 4035.6 4047.8 4097.3 4097.4 4098.6 4100.7 4102.8 4790.3 4795.2 4799.8 4803.0 4808.1 5759.6 5882.6 5892.1 5900.5 5912.3 1428.9 1454.9 1460.6 1465.1 1465.6 954.6 955.5 956.3 971.4 971.5 5042.6 5049.1 5050.8 5053.9 5062.0 6038.5 6039.1 6041.4 6050.4 6051.1 5017.3 5019.9 5035.9 5040.3 5047.3 3225.5 3295.3 3297.1 3313.0 3319.7 5686.2 5726.8 5750.3 5756.5 5756.8 6168.7 6334.0 6361.9 6371.7 6378.9 5782.6 5789.3 5807.4 5815.5 5820.6 6141.2 6171.2 6175.0 6177.1 6184.9 5840.5 6030.7 6038.9 6059.4 6061.9 5775.6 5813.4 5817.8 5828.2 5844.2 4021.0 4090.2 4090.3 4095.7 4098.6 6000.6 6164.9 6177.0 6178.8 6190.4 5902.3 5921.8 5929.5 5936.3 5944.3 5904.7 5933.4 5933.7 5940.6 5954.8 5679.5 5754.3 5761.7 5797.4 5808.4 5960.4 5973.4 5981.9 5984.6 5990.4 5797.4 5813.2 5828.8 5831.9 5833.8 08:40:01 INFO - 2015-12-15 08:40:01,137 DEBUG : BROWSER_OUTPUT: 08:40:01 INFO - 2015-12-15 08:40:01,137 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11984.67 Median:48681.39 stddev:13798.95 (28.3%) stddev-sans-first:13812.02 08:40:01 INFO - 2015-12-15 08:40:01,138 DEBUG : BROWSER_OUTPUT: Values: 783.9 784.0 788.4 788.4 798.1 10834.4 10965.2 10976.7 10986.6 11045.2 11118.5 11244.6 11283.3 11287.8 11306.0 763.3 772.1 778.6 778.9 780.6 770.4 784.7 784.9 788.3 789.1 813.2 818.4 820.7 821.2 823.3 815.9 819.5 820.3 820.3 823.1 603.4 604.1 606.0 606.7 607.1 9704.5 9747.9 9759.0 9789.5 9835.8 8790.8 9401.4 9556.7 9879.5 9918.8 8615.0 8722.2 8741.5 8741.6 8754.3 3192.9 3240.9 3273.0 3290.9 3294.1 37709.4 41735.6 43232.0 43362.3 43365.8 8052.0 8361.9 8521.9 9248.4 9341.2 15849.1 16060.4 16066.3 16088.7 16107.5 6196.1 6227.0 6249.2 6512.3 6522.3 3380.5 3420.1 3428.3 3461.8 3534.1 2640.2 2651.5 2653.7 2657.6 2659.1 461.1 465.1 466.3 478.7 483.5 460.1 490.3 494.8 547.8 567.5 7285.7 7430.7 7572.3 7690.9 7757.4 557.6 558.1 574.7 575.9 583.0 3215.1 3561.7 3644.9 3683.7 3737.3 48371.5 48495.3 48651.3 48651.5 48711.3 40604.4 40741.2 42569.6 43363.3 43724.0 41673.8 42347.6 42497.6 42598.0 43824.6 7873.6 8212.8 8312.3 8315.7 8354.0 31870.6 31962.0 32103.7 33107.5 33235.0 37567.4 37840.4 38409.8 39100.0 39149.6 9952.6 10009.1 10185.3 10675.1 10708.3 10609.4 10738.7 10956.4 11112.9 11148.7 9985.8 10080.1 10081.4 10456.3 10670.1 10049.5 10052.1 10141.8 10256.3 10784.5 9860.8 9934.9 10186.3 10223.1 10248.8 8530.4 8558.4 8775.2 8989.8 9352.3 8269.1 8471.3 8561.1 8727.5 8760.6 08:40:01 INFO - 2015-12-15 08:40:01,138 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:40:01 INFO - 2015-12-15 08:40:01,138 DEBUG : BROWSER_OUTPUT: 08:40:01 INFO - 2015-12-15 08:40:01,825 INFO : Browser exited with error code: 0 08:40:01 INFO - 2015-12-15 08:40:01,844 INFO : Completed test dromaeo_css (00:18:35) 08:40:01 INFO - 2015-12-15 08:40:01,844 INFO : Starting test kraken 08:40:01 INFO - 2015-12-15 08:40:01,844 DEBUG : operating with platform_type : linux_ 08:40:01 INFO - 2015-12-15 08:40:01,844 INFO : Initialising browser for kraken test... 08:40:01 INFO - 2015-12-15 08:40:01,850 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwbjbCn/profile http://localhost:55551/getInfo.html 08:40:06 INFO - 2015-12-15 08:40:06,719 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:40:06 INFO - 2015-12-15 08:40:06,719 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:40:06 INFO - 2015-12-15 08:40:06,719 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:40:06 INFO - 2015-12-15 08:40:06,719 DEBUG : BROWSER_OUTPUT: __metrics 08:40:06 INFO - 2015-12-15 08:40:06,840 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] 08:40:07 INFO - 2015-12-15 08:40:07,797 INFO : Browser initialized. 08:40:07 INFO - 2015-12-15 08:40:07,797 INFO : Running cycle 1/1 for kraken test... 08:40:07 INFO - 2015-12-15 08:40:07,798 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwbjbCn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:40:19 INFO - 2015-12-15 08:40:19,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 143323136 08:40:19 INFO - 2015-12-15 08:40:19,798 DEBUG : BROWSER_OUTPUT: 08:40:22 INFO - 2015-12-15 08:40:22,373 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55551/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55551/tests/kraken/driver.html?testName=audio-beat-detection) 08:40:22 INFO - 2015-12-15 08:40:22,994 DEBUG : BROWSER_OUTPUT: RSS: Main: 144097280 08:40:22 INFO - 2015-12-15 08:40:22,994 DEBUG : BROWSER_OUTPUT: 08:40:25 INFO - 2015-12-15 08:40:25,777 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55551/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55551/tests/kraken/driver.html?testName=audio-dft) 08:40:26 INFO - 2015-12-15 08:40:26,378 DEBUG : BROWSER_OUTPUT: RSS: Main: 144080896 08:40:26 INFO - 2015-12-15 08:40:26,379 DEBUG : BROWSER_OUTPUT: 08:40:29 INFO - 2015-12-15 08:40:29,262 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55551/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55551/tests/kraken/driver.html?testName=audio-fft) 08:40:29 INFO - 2015-12-15 08:40:29,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 137875456 08:40:29 INFO - 2015-12-15 08:40:29,851 DEBUG : BROWSER_OUTPUT: 08:40:31 INFO - 2015-12-15 08:40:31,944 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55551/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55551/tests/kraken/driver.html?testName=audio-oscillator) 08:40:32 INFO - 2015-12-15 08:40:32,525 DEBUG : BROWSER_OUTPUT: RSS: Main: 139083776 08:40:32 INFO - 2015-12-15 08:40:32,525 DEBUG : BROWSER_OUTPUT: 08:40:34 INFO - 2015-12-15 08:40:34,771 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55551/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55551/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:40:35 INFO - 2015-12-15 08:40:35,360 DEBUG : BROWSER_OUTPUT: RSS: Main: 140234752 08:40:35 INFO - 2015-12-15 08:40:35,360 DEBUG : BROWSER_OUTPUT: 08:40:38 INFO - 2015-12-15 08:40:38,505 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55551/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55551/tests/kraken/driver.html?testName=imaging-darkroom) 08:40:39 INFO - 2015-12-15 08:40:39,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 141717504 08:40:39 INFO - 2015-12-15 08:40:39,099 DEBUG : BROWSER_OUTPUT: 08:40:42 INFO - 2015-12-15 08:40:42,574 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55551/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55551/tests/kraken/driver.html?testName=imaging-desaturate) 08:40:43 INFO - 2015-12-15 08:40:43,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 139161600 08:40:43 INFO - 2015-12-15 08:40:43,167 DEBUG : BROWSER_OUTPUT: 08:40:46 INFO - 2015-12-15 08:40:46,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55551/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55551/tests/kraken/driver.html?testName=json-parse-financial) 08:40:46 INFO - 2015-12-15 08:40:46,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 139706368 08:40:46 INFO - 2015-12-15 08:40:46,695 DEBUG : BROWSER_OUTPUT: 08:40:48 INFO - 2015-12-15 08:40:48,436 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55551/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55551/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:40:49 INFO - 2015-12-15 08:40:49,023 DEBUG : BROWSER_OUTPUT: RSS: Main: 141213696 08:40:49 INFO - 2015-12-15 08:40:49,023 DEBUG : BROWSER_OUTPUT: 08:40:50 INFO - 2015-12-15 08:40:50,907 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55551/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55551/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:40:51 INFO - 2015-12-15 08:40:51,528 DEBUG : BROWSER_OUTPUT: RSS: Main: 140169216 08:40:51 INFO - 2015-12-15 08:40:51,528 DEBUG : BROWSER_OUTPUT: 08:40:53 INFO - 2015-12-15 08:40:53,668 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55551/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55551/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:40:54 INFO - 2015-12-15 08:40:54,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 140607488 08:40:54 INFO - 2015-12-15 08:40:54,257 DEBUG : BROWSER_OUTPUT: 08:40:56 INFO - 2015-12-15 08:40:56,853 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55551/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55551/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:40:57 INFO - 2015-12-15 08:40:57,454 DEBUG : BROWSER_OUTPUT: RSS: Main: 140681216 08:40:57 INFO - 2015-12-15 08:40:57,454 DEBUG : BROWSER_OUTPUT: 08:41:00 INFO - 2015-12-15 08:41:00,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55551/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55551/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:41:00 INFO - 2015-12-15 08:41:00,676 DEBUG : BROWSER_OUTPUT: RSS: Main: 141254656 08:41:00 INFO - 2015-12-15 08:41:00,676 DEBUG : BROWSER_OUTPUT: 08:41:02 INFO - 2015-12-15 08:41:02,471 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55551/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55551/tests/kraken/driver.html?testName=ai-astar) 08:41:02 INFO - 2015-12-15 08:41:02,722 DEBUG : BROWSER_OUTPUT: RSS: Main: 140722176 08:41:02 INFO - 2015-12-15 08:41:02,722 DEBUG : BROWSER_OUTPUT: 08:41:02 INFO - 2015-12-15 08:41:02,722 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:41:02 INFO - 2015-12-15 08:41:02,722 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:41:02 INFO - 2015-12-15 08:41:02,723 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:41:02 INFO - 2015-12-15 08:41:02,723 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:41:02 INFO - 2015-12-15 08:41:02,723 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;107;113;114;114;124;114;113;117;113 08:41:02 INFO - 2015-12-15 08:41:02,723 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;173;132;154;171;140;168;156;131;170;134 08:41:02 INFO - 2015-12-15 08:41:02,723 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;160;162;161;165;167;161;166;161 08:41:02 INFO - 2015-12-15 08:41:02,723 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;73;75;73;139;72;74;72;77 08:41:02 INFO - 2015-12-15 08:41:02,724 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;138;95;104;94;136;95;95;128 08:41:02 INFO - 2015-12-15 08:41:02,724 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;110;110;109;110;113;110;110;110 08:41:02 INFO - 2015-12-15 08:41:02,724 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;148;147;147;147;147;147;147;147 08:41:02 INFO - 2015-12-15 08:41:02,724 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;96;96;96;96;97;96;95 08:41:02 INFO - 2015-12-15 08:41:02,724 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;72;71;71;73;71;71;72;71;72 08:41:02 INFO - 2015-12-15 08:41:02,724 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;69;68;69;68;68;68;69;69 08:41:02 INFO - 2015-12-15 08:41:02,724 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;84;91;84;85;84;84;84;84 08:41:02 INFO - 2015-12-15 08:41:02,724 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;139;128;122;124;123;123;127;125;120 08:41:02 INFO - 2015-12-15 08:41:02,725 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;148;152;152;145;149;135;136;150;150;147 08:41:02 INFO - 2015-12-15 08:41:02,725 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;72;70;71;80;69;70;69;71;69 08:41:02 INFO - 2015-12-15 08:41:02,725 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:41:02 INFO - 2015-12-15 08:41:02,725 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:41:02 INFO - 2015-12-15 08:41:02,725 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,794 08:41:02 INFO - 2015-12-15 08:41:02,725 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:41:02 INFO - 2015-12-15 08:41:02,725 DEBUG : BROWSER_OUTPUT: __startTimestamp1450197662721__endTimestamp 08:41:02 INFO - 2015-12-15 08:41:02,725 DEBUG : BROWSER_OUTPUT: 08:41:02 INFO - 2015-12-15 08:41:02,728 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:41:02 INFO - 2015-12-15 08:41:02,728 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:41:02 INFO - 2015-12-15 08:41:02,729 DEBUG : BROWSER_OUTPUT: 08:41:02 INFO - 2015-12-15 08:41:02,729 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.40 Median:114.00 stddev:4.22 (3.7%) stddev-sans-first:4.47 08:41:02 INFO - 2015-12-15 08:41:02,729 DEBUG : BROWSER_OUTPUT: Values: 115.0 107.0 113.0 114.0 114.0 124.0 114.0 113.0 117.0 113.0 08:41:02 INFO - 2015-12-15 08:41:02,729 DEBUG : BROWSER_OUTPUT: 08:41:02 INFO - 2015-12-15 08:41:02,729 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:152.90 Median:162.00 stddev:17.33 (10.7%) stddev-sans-first:16.79 08:41:02 INFO - 2015-12-15 08:41:02,729 DEBUG : BROWSER_OUTPUT: Values: 173.0 132.0 154.0 171.0 140.0 168.0 156.0 131.0 170.0 134.0 08:41:02 INFO - 2015-12-15 08:41:02,729 DEBUG : BROWSER_OUTPUT: 08:41:02 INFO - 2015-12-15 08:41:02,729 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.80 Median:162.50 stddev:2.39 (1.5%) stddev-sans-first:2.52 08:41:02 INFO - 2015-12-15 08:41:02,729 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 160.0 162.0 161.0 165.0 167.0 161.0 166.0 161.0 08:41:02 INFO - 2015-12-15 08:41:02,729 DEBUG : BROWSER_OUTPUT: 08:41:02 INFO - 2015-12-15 08:41:02,729 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:73.50 stddev:20.75 (28.2%) stddev-sans-first:21.81 08:41:02 INFO - 2015-12-15 08:41:02,729 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 73.0 75.0 73.0 139.0 72.0 74.0 72.0 77.0 08:41:02 INFO - 2015-12-15 08:41:02,729 DEBUG : BROWSER_OUTPUT: 08:41:02 INFO - 2015-12-15 08:41:02,729 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.30 Median:94.00 stddev:18.83 (20.0%) stddev-sans-first:19.34 08:41:02 INFO - 2015-12-15 08:41:02,729 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 138.0 95.0 104.0 94.0 136.0 95.0 95.0 128.0 08:41:02 INFO - 2015-12-15 08:41:02,729 DEBUG : BROWSER_OUTPUT: 08:41:02 INFO - 2015-12-15 08:41:02,730 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:1.06 (1.0%) stddev-sans-first:1.09 08:41:02 INFO - 2015-12-15 08:41:02,730 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 110.0 110.0 109.0 110.0 113.0 110.0 110.0 110.0 08:41:02 INFO - 2015-12-15 08:41:02,730 DEBUG : BROWSER_OUTPUT: 08:41:02 INFO - 2015-12-15 08:41:02,730 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 08:41:02 INFO - 2015-12-15 08:41:02,730 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 148.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 08:41:02 INFO - 2015-12-15 08:41:02,730 DEBUG : BROWSER_OUTPUT: 08:41:02 INFO - 2015-12-15 08:41:02,730 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 08:41:02 INFO - 2015-12-15 08:41:02,730 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 95.0 08:41:02 INFO - 2015-12-15 08:41:02,731 DEBUG : BROWSER_OUTPUT: 08:41:02 INFO - 2015-12-15 08:41:02,731 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.60 Median:72.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 08:41:02 INFO - 2015-12-15 08:41:02,731 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 71.0 71.0 73.0 71.0 71.0 72.0 71.0 72.0 08:41:02 INFO - 2015-12-15 08:41:02,731 DEBUG : BROWSER_OUTPUT: 08:41:02 INFO - 2015-12-15 08:41:02,731 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 08:41:02 INFO - 2015-12-15 08:41:02,731 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 69.0 68.0 69.0 68.0 68.0 68.0 69.0 69.0 08:41:02 INFO - 2015-12-15 08:41:02,731 DEBUG : BROWSER_OUTPUT: 08:41:02 INFO - 2015-12-15 08:41:02,732 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.00 stddev:2.18 (2.6%) stddev-sans-first:2.29 08:41:02 INFO - 2015-12-15 08:41:02,732 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 84.0 91.0 84.0 85.0 84.0 84.0 84.0 84.0 08:41:02 INFO - 2015-12-15 08:41:02,732 DEBUG : BROWSER_OUTPUT: 08:41:02 INFO - 2015-12-15 08:41:02,732 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:126.00 stddev:5.35 (4.2%) stddev-sans-first:5.57 08:41:02 INFO - 2015-12-15 08:41:02,732 DEBUG : BROWSER_OUTPUT: Values: 129.0 139.0 128.0 122.0 124.0 123.0 123.0 127.0 125.0 120.0 08:41:02 INFO - 2015-12-15 08:41:02,732 DEBUG : BROWSER_OUTPUT: 08:41:02 INFO - 2015-12-15 08:41:02,733 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.40 Median:149.50 stddev:6.13 (4.1%) stddev-sans-first:6.48 08:41:02 INFO - 2015-12-15 08:41:02,733 DEBUG : BROWSER_OUTPUT: Values: 148.0 152.0 152.0 145.0 149.0 135.0 136.0 150.0 150.0 147.0 08:41:02 INFO - 2015-12-15 08:41:02,733 DEBUG : BROWSER_OUTPUT: 08:41:02 INFO - 2015-12-15 08:41:02,733 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:71.00 stddev:3.26 (4.6%) stddev-sans-first:3.46 08:41:02 INFO - 2015-12-15 08:41:02,734 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 70.0 71.0 80.0 69.0 70.0 69.0 71.0 69.0 08:41:02 INFO - 2015-12-15 08:41:02,734 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:41:02 INFO - 2015-12-15 08:41:02,734 DEBUG : BROWSER_OUTPUT: 08:41:03 INFO - 2015-12-15 08:41:03,639 INFO : Browser exited with error code: 0 08:41:03 INFO - 2015-12-15 08:41:03,689 INFO : Completed test kraken (00:01:01) 08:41:03 INFO - 2015-12-15 08:41:03,689 INFO : Starting test v8_7 08:41:03 INFO - 2015-12-15 08:41:03,689 DEBUG : operating with platform_type : linux_ 08:41:03 INFO - 2015-12-15 08:41:03,689 INFO : Initialising browser for v8_7 test... 08:41:03 INFO - 2015-12-15 08:41:03,695 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnAch1m/profile http://localhost:55551/getInfo.html 08:41:08 INFO - 2015-12-15 08:41:08,540 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:41:08 INFO - 2015-12-15 08:41:08,540 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:41:08 INFO - 2015-12-15 08:41:08,540 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:41:08 INFO - 2015-12-15 08:41:08,541 DEBUG : BROWSER_OUTPUT: __metrics 08:41:08 INFO - 2015-12-15 08:41:08,665 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] 08:41:09 INFO - 2015-12-15 08:41:09,629 INFO : Browser initialized. 08:41:09 INFO - 2015-12-15 08:41:09,629 INFO : Running cycle 1/1 for v8_7 test... 08:41:09 INFO - 2015-12-15 08:41:09,630 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnAch1m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:41:21 INFO - 2015-12-15 08:41:21,644 DEBUG : BROWSER_OUTPUT: RSS: Main: 142983168 08:41:21 INFO - 2015-12-15 08:41:21,644 DEBUG : BROWSER_OUTPUT: 08:41:43 INFO - 2015-12-15 08:41:43,052 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55551/tests/v8_7/run.html (next: http://localhost:55551/tests/v8_7/run.html) 08:41:43 INFO - 2015-12-15 08:41:43,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 137875456 08:41:43 INFO - 2015-12-15 08:41:43,302 DEBUG : BROWSER_OUTPUT: 08:41:43 INFO - 2015-12-15 08:41:43,302 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:41:43 INFO - 2015-12-15 08:41:43,302 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:41:43 INFO - 2015-12-15 08:41:43,303 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:41:43 INFO - 2015-12-15 08:41:43,303 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:41:43 INFO - 2015-12-15 08:41:43,303 DEBUG : BROWSER_OUTPUT: |0;Richards;165.8374792703151 08:41:43 INFO - 2015-12-15 08:41:43,303 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.5850962454736 08:41:43 INFO - 2015-12-15 08:41:43,303 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.31558513588465 08:41:43 INFO - 2015-12-15 08:41:43,303 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 08:41:43 INFO - 2015-12-15 08:41:43,304 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1063.8297872340424 08:41:43 INFO - 2015-12-15 08:41:43,304 DEBUG : BROWSER_OUTPUT: |5;Earley;699.3006993006993 08:41:43 INFO - 2015-12-15 08:41:43,304 DEBUG : BROWSER_OUTPUT: |6;Boyer;12228.915662650603 08:41:43 INFO - 2015-12-15 08:41:43,304 DEBUG : BROWSER_OUTPUT: |7;RegExp;26179.48717948718 08:41:43 INFO - 2015-12-15 08:41:43,304 DEBUG : BROWSER_OUTPUT: |8;Splay;591.3660555884093 08:41:43 INFO - 2015-12-15 08:41:43,304 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 08:41:43 INFO - 2015-12-15 08:41:43,305 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:41:43 INFO - 2015-12-15 08:41:43,305 DEBUG : BROWSER_OUTPUT: __startTimestamp1450197703301__endTimestamp 08:41:43 INFO - 2015-12-15 08:41:43,305 DEBUG : BROWSER_OUTPUT: 08:41:43 INFO - 2015-12-15 08:41:43,305 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:41:43 INFO - 2015-12-15 08:41:43,305 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:41:43 INFO - 2015-12-15 08:41:43,306 DEBUG : BROWSER_OUTPUT: 08:41:43 INFO - 2015-12-15 08:41:43,306 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.84 Median:165.84 stddev:0.00 (0.0%) 08:41:43 INFO - 2015-12-15 08:41:43,306 DEBUG : BROWSER_OUTPUT: Values: 165.8 08:41:43 INFO - 2015-12-15 08:41:43,306 DEBUG : BROWSER_OUTPUT: 08:41:43 INFO - 2015-12-15 08:41:43,307 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.59 Median:190.59 stddev:0.00 (0.0%) 08:41:43 INFO - 2015-12-15 08:41:43,307 DEBUG : BROWSER_OUTPUT: Values: 190.6 08:41:43 INFO - 2015-12-15 08:41:43,308 DEBUG : BROWSER_OUTPUT: 08:41:43 INFO - 2015-12-15 08:41:43,308 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.32 Median:277.32 stddev:0.00 (0.0%) 08:41:43 INFO - 2015-12-15 08:41:43,308 DEBUG : BROWSER_OUTPUT: Values: 277.3 08:41:43 INFO - 2015-12-15 08:41:43,308 DEBUG : BROWSER_OUTPUT: 08:41:43 INFO - 2015-12-15 08:41:43,308 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 08:41:43 INFO - 2015-12-15 08:41:43,308 DEBUG : BROWSER_OUTPUT: Values: 5186.5 08:41:43 INFO - 2015-12-15 08:41:43,308 DEBUG : BROWSER_OUTPUT: 08:41:43 INFO - 2015-12-15 08:41:43,308 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1063.83 Median:1063.83 stddev:0.00 (0.0%) 08:41:43 INFO - 2015-12-15 08:41:43,309 DEBUG : BROWSER_OUTPUT: Values: 1063.8 08:41:43 INFO - 2015-12-15 08:41:43,309 DEBUG : BROWSER_OUTPUT: 08:41:43 INFO - 2015-12-15 08:41:43,309 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:699.30 Median:699.30 stddev:0.00 (0.0%) 08:41:43 INFO - 2015-12-15 08:41:43,309 DEBUG : BROWSER_OUTPUT: Values: 699.3 08:41:43 INFO - 2015-12-15 08:41:43,309 DEBUG : BROWSER_OUTPUT: 08:41:43 INFO - 2015-12-15 08:41:43,309 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12228.92 Median:12228.92 stddev:0.00 (0.0%) 08:41:43 INFO - 2015-12-15 08:41:43,309 DEBUG : BROWSER_OUTPUT: Values: 12228.9 08:41:43 INFO - 2015-12-15 08:41:43,309 DEBUG : BROWSER_OUTPUT: 08:41:43 INFO - 2015-12-15 08:41:43,309 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26179.49 Median:26179.49 stddev:0.00 (0.0%) 08:41:43 INFO - 2015-12-15 08:41:43,309 DEBUG : BROWSER_OUTPUT: Values: 26179.5 08:41:43 INFO - 2015-12-15 08:41:43,309 DEBUG : BROWSER_OUTPUT: 08:41:43 INFO - 2015-12-15 08:41:43,309 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:591.37 Median:591.37 stddev:0.00 (0.0%) 08:41:43 INFO - 2015-12-15 08:41:43,309 DEBUG : BROWSER_OUTPUT: Values: 591.4 08:41:43 INFO - 2015-12-15 08:41:43,309 DEBUG : BROWSER_OUTPUT: 08:41:43 INFO - 2015-12-15 08:41:43,310 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 08:41:43 INFO - 2015-12-15 08:41:43,310 DEBUG : BROWSER_OUTPUT: Values: 4854.4 08:41:43 INFO - 2015-12-15 08:41:43,310 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:41:43 INFO - 2015-12-15 08:41:43,310 DEBUG : BROWSER_OUTPUT: 08:41:44 INFO - 2015-12-15 08:41:44,237 INFO : Browser exited with error code: 0 08:41:44 INFO - 2015-12-15 08:41:44,252 INFO : Completed test v8_7 (00:00:40) 08:41:44 INFO - 2015-12-15 08:41:44,313 INFO : Completed test suite (00:20:17) 08:41:44 INFO - 2015-12-15 08:41:44,313 DEBUG : Working with test: dromaeo_css 08:41:44 INFO - 2015-12-15 08:41:44,313 DEBUG : Generating results file: dromaeo_css 08:41:44 INFO - 2015-12-15 08:41:44,314 DEBUG : Working with test: kraken 08:41:44 INFO - 2015-12-15 08:41:44,314 DEBUG : Generating results file: kraken 08:41:44 INFO - 2015-12-15 08:41:44,315 INFO : javascript benchmark 08:41:44 INFO - 2015-12-15 08:41:44,315 DEBUG : Working with test: v8_7 08:41:44 INFO - 2015-12-15 08:41:44,315 DEBUG : Generating results file: v8_7 08:41:44 INFO - 2015-12-15 08:41:44,315 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:41:44 INFO - 2015-12-15 08:41:44,383 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 08:41:44 INFO - 2015-12-15 08:41:44,383 DEBUG : process_Request line: dromaeo_css 6268.52 graph.html#tests=[[72,132,43]] 08:41:44 INFO - 2015-12-15 08:41:44,383 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:41:44 INFO - 2015-12-15 08:41:44,426 DEBUG : process_Request line: kraken 1539.60 graph.html#tests=[[232,132,43]] 08:41:44 INFO - 2015-12-15 08:41:44,426 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:41:44 INFO - 2015-12-15 08:41:44,462 DEBUG : process_Request line: v8_7 21391.99 graph.html#tests=[[230,132,43]] 08:41:44 INFO - 2015-12-15 08:41:44,463 INFO : javascript benchmark 08:41:44 INFO - 2015-12-15 08:41:44,467 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2695.6360891279674, 2734.4394399148177, 2775.0, 2788.8187267827575, 2789.8744556494958, 4616.2613981762925, 4819.734914579701, 4827.927581086282, 4845.660803743739, 4888.437829649587, 4670.789814458349, 4733.242681171013, 4733.881652958669, 4769.594584460325, 4820.204666230068, 4437.667174961883, 4473.619742321906, 4485.058137791051, 4523.525029871866, 4554.407926969489, 4464.352668863013, 4490.977545112286, 4549.135664223803, 4561.56665116815, 4590.196715574778, 4197.496300443951, 4314.201872653538, 4331.090471001094, 4408.184485870124, 4427.335899615051, 4436.334549817521, 4481.193385190664, 4482.036362182146, 4489.461264648263, 4524.11779702958, 4223.944013996501, 4477.888052798674, 4479.126570318789, 4487.596116349544, 4494.415725955638, 4595.471520775121, 4669.906601867943, 4773.140834649762, 4780.617550595979, 4787.377640906695, 5104.744762761847, 5177.767000484987, 5178.792848286064, 5194.0910340690225, 5238.895222095537, 4846.539578740014, 5013.1227035268685, 5212.921806172911, 5216.713080780555, 5218.660787048868, 4697.13103075932, 4707.6233901287815, 4714.033623107255, 4724.811007559728, 4842.0, 5314.92027619586, 5314.946850531523, 5315.069862773999, 5340.626156169031, 5369.24830523727, 5084.211947148198, 5092.116944131353, 5093.261477085802, 5110.821121260738, 5151.7166555839785, 4895.8041678332465, 5020.1214787412055, 5068.189089745623, 5150.793968241228, 5189.273501709764, 5106.259592359087, 5107.642465027412, 5110.131277682803, 5118.436971933084, 5160.7935682573025, 5083.467317731585, 5084.6440749147205, 5089.4147173074825, 5102.540771330524, 5116.795328186831, 4094.61101195386, 4148.543660197376, 4192.266353388145, 4228.175505776406, 4267.125239325931, 3735.159589092487, 3761.4921985531605, 3781.1681430085337, 3797.6582107610448, 3807.276617442677, 4451.532589078165, 4490.146872094291, 4497.797599108048, 4510.594046535827, 4540.0, 4855.150348688965, 4949.183384741477, 4958.082754690394, 4974.726390048582, 5113.309703190096, 4408.7575183365225, 4474.39595654589, 4506.639468842484, 4529.909401811945, 4531.116432295737, 4595.333676616872, 4640.32715256286, 4648.7443190624845, 4656.301554766745, 4680.4149481314835, 4653.441587009581, 4755.144074066701, 4771.95228047715, 4900.558949694545, 4947.060058588857, 5231.686098834082, 5246.291750613771, 5249.947500525099, 5251.186066159751, 5287.9471205287455, 4927.285543596086, 4947.505249475023, 4949.727764972961, 4955.752212389294, 4988.0, 4886.755662216946, 5009.423916249532, 5083.212102124176, 5150.97424512875, 5230.895382092413, 5166.844994650167, 5173.017126745906, 5178.482151784791, 5195.038917800219, 5211.244369566316, 5046.823361182341, 5051.318072060225, 5053.924191137209, 5054.772535235997, 5069.847904562869, 4724.811007559659, 4836.032793441396, 4966.205407134841, 5070.188769796815, 5105.897882042413, 4824.396950381202, 4830.589399900907, 4875.414950205856, 4880.755962201804, 4895.094407534618, 4818.6626936114135, 5003.824866129668, 5037.420696619935, 5042.520960508746, 5087.313212716236, 4821.855344339676, 4823.2282834746275, 4824.49342818999, 4834.178189707828, 4842.394700662418], "unit": "score", "name": "dojo.html", "value": 4713.7445558177915}, {"lowerIsBetter": false, "replicates": [564.7486868343584, 571.4285714285714, 575.2866445607447, 575.9884802303955, 581.1776336483874, 33042.66957330426, 34032.65967340326, 34086.659133408655, 34089.488657670154, 34139.31721365578, 39057.60942390575, 39193.41209881854, 39574.0, 39609.40585891207, 39725.0, 7921.445498815086, 8037.196280371974, 8047.275745182932, 8055.556944368057, 8075.676972921076, 7772.0, 7845.843083138334, 7872.055353357605, 7884.4875083119705, 7885.408594355417, 7920.485168464032, 7965.800854978643, 8021.157778433268, 8022.037355517346, 8040.075391330013, 7879.290863822255, 7942.801429964239, 7943.483673561229, 7944.563049032301, 7964.8805267921025, 7830.060392752849, 7937.880931786028, 7970.601469926481, 7976.7208147714555, 7988.360931125496, 36835.26329473422, 37013.814930925444, 37065.814670926746, 37279.0, 37355.0, 2335.8648450357855, 2960.881564737408, 3090.273785660368, 3116.1897906544464, 3143.827089510076, 26442.206733798015, 30652.8467357664, 31671.683283167105, 32022.0, 33271.33457330864, 3166.2875852933134, 3168.984155079233, 3203.8718451262152, 3210.6228013674827, 3260.96739032609, 180049.0, 181642.0, 181798.0, 182812.0, 183303.0, 38140.0, 38631.227375452334, 49863.76158026536, 49983.0, 50262.49737502651, 36265.63734362675, 36452.0, 36488.635113648525, 36579.634203658155, 36657.0, 12069.456874440672, 12091.274523528617, 12237.265764054186, 12260.693482662826, 12304.200226985216, 9236.122568355995, 9259.351845370895, 9265.490398028038, 9270.258379329638, 9272.768180795534, 12841.229526228457, 13393.330333483287, 13424.261665608485, 13478.86521134776, 13520.256385898674, 5441.972790136024, 5573.136163894603, 5579.358373787067, 5593.8321850344555, 5626.690532020778, 887.2103827593447, 916.2532535983286, 956.8373376526007, 984.5372674842812, 1004.1916257412706, 25973.650929586653, 26084.34789130287, 26389.73610263911, 26391.208263751734, 26629.733702662725, 916.4180745226696, 951.70497145885, 957.1816097236901, 1057.5241141486363, 1071.0628200324716, 12928.0, 12977.0, 13125.949924006056, 13147.60557183286, 13148.868511314955, 309381.0, 311055.0, 315626.0, 316343.0, 316726.0, 44327.55672443234, 45171.54828451739, 45252.15356694718, 45417.31874021892, 45620.315695264595, 1223.822545730864, 1229.8032314829763, 1232.1375037473624, 1238.6965193527462, 1238.758442103799, 23970.640440393756, 24072.0, 24197.308969270187, 24354.269371918163, 24378.634320485562, 34855.65144348524, 35472.0, 35577.46633800443, 35906.0, 36211.456828148126, 247432.0, 247653.0, 249670.0, 249724.0, 251342.0, 29053.564196536645, 29431.705682942895, 42539.57460425356, 43146.784266078466, 43799.124017518836, 37555.81222093872, 37556.0, 37648.36461447782, 38190.0, 38467.2306553873, 32663.67336326606, 32843.83578082094, 33336.0, 33747.15632109217, 33776.49335260022, 32812.67187328096, 32921.83539082289, 33053.19888212886, 33055.83472082624, 33110.50334245036, 32975.34049318952, 33446.0, 38476.2304753909, 38867.80566097151, 39550.40674389829, 28222.85888570544, 30014.84992575023, 30371.211407548682, 30762.230944226572, 33873.0, 23685.881570592035, 23800.642990355504, 24045.299841570333, 24110.276691699277, 24178.51642967166], "unit": "score", "name": "ext.html", "value": 16185.24527037985}, {"lowerIsBetter": false, "replicates": [333.87312821127966, 334.50493269960475, 338.5717067909094, 342.49995007289357, 343.05317324185245, 12030.819537706919, 12385.318807465586, 14850.77723834142, 15035.530117306578, 16311.347546098157, 13573.592792216225, 13587.932060339685, 13867.791983120236, 13906.652333691663, 13967.860321396784, 4726.0075384169195, 4761.523847615228, 4833.589144922686, 4948.183549714293, 4955.479674634165, 4971.900561988758, 5021.347224860781, 5168.48315168482, 5169.095408303532, 5176.611754118438, 4845.0, 5028.698278103326, 5121.078205922932, 5134.358205224347, 5148.5623721983675, 5068.239764035406, 5074.112030394666, 5082.288479612857, 5100.33695619569, 5104.234364845266, 4849.248366503162, 5185.585153187736, 5193.480651934814, 5202.375714914235, 5203.98522288154, 18191.0, 18209.180586873623, 18378.632427351513, 18767.436976890716, 18803.24787008518, 1831.157667472964, 1851.1022154255174, 1858.656148612511, 1945.085809669453, 1945.6497830390524, 8988.280937524982, 9177.265818734486, 9197.448153110834, 11702.0, 12253.774622537674, 1743.302678928426, 1795.721663142215, 1802.1619946724704, 1825.3976187858107, 1872.1668857358482, 54788.0, 56560.71719641375, 57310.140347895234, 57507.0, 58479.0, 9987.350822196535, 9992.950035249924, 10002.599896004223, 10055.69832905014, 10094.343867648578, 12360.44378002992, 12405.0, 12416.81374779379, 12469.064820138527, 12512.562060328028, 6903.827404314932, 6932.688029038705, 6953.930460695328, 6958.0, 7001.474889383317, 6537.640429776313, 6544.70548825304, 6557.311482294386, 6559.311272316433, 6589.439897608757, 3938.4639990403766, 4063.918721625551, 4272.6795490338345, 4334.69959012295, 4343.630791382705, 2903.143572646032, 2976.732094111497, 3044.6955304469375, 3142.230153612334, 3154.242981684379, 798.2376830127331, 800.4396922154515, 860.3762272352494, 877.6489404238229, 915.2815040193416, 9977.600895964226, 12894.67763305925, 14768.778468322984, 15031.173285469404, 15212.087274763328, 392.1353415718334, 400.2914840731888, 402.45869305783674, 420.4303169205682, 421.0, 5485.972570137204, 5779.913301300484, 5792.0, 5813.56398270123, 5827.912581311284, 499018.0, 506645.0, 507848.0, 507852.0, 514440.0, 72419.6379018112, 78471.0, 78661.60669196617, 78745.0, 79156.20843791604, 431.4520558890255, 433.3651200990564, 436.7248633361026, 437.5864807756703, 440.48463297941487, 9786.41281523111, 14041.297935102999, 14486.782698259745, 14519.92740036293, 14749.631259218177, 35196.455475378476, 36163.45754813627, 36337.45493817542, 36340.81829590941, 36473.63526364809, 41870.37194442025, 41905.580944190166, 43209.56790432055, 43807.78096109499, 44497.332540012576, 8943.910560894308, 9197.678081267124, 9232.492212928353, 9257.305702072506, 9266.397684150508, 15361.385544578092, 15977.603359496168, 16312.265948032129, 16500.092494912897, 16916.915415423337, 13300.467981281028, 13515.797263041259, 13924.373403196678, 14151.0, 14152.292385380895, 13138.474461021835, 13435.731285374433, 13455.46178152863, 13511.256880871253, 13899.583012509642, 13234.139780914209, 13659.79510307366, 13700.794488082885, 13921.721565568834, 13990.510332138327, 9075.682351117679, 9223.677171298972, 9436.0, 9438.386504877435, 9444.150026497648, 13140.145890517086, 13381.799273010718, 13579.185248885098, 13708.45166193381, 13799.655008624864], "unit": "score", "name": "jquery.html", "value": 7958.15984914674}, {"lowerIsBetter": false, "replicates": [1377.4145987955117, 1406.5006922542498, 1443.9855601443996, 1642.5072478256525, 1722.0958996526822, 5862.32583252926, 5974.074018527135, 7117.430605551556, 7368.926310736891, 7447.404207663388, 6969.128858892638, 7134.678939447725, 7170.462215333845, 7190.496665233436, 7215.314545118205, 2052.6715725483928, 2084.593504266669, 2094.120469402847, 2094.89525523724, 2097.8531502794813, 2006.5986802639457, 2054.6712525995845, 2059.6704527275638, 2062.7937206279403, 2084.333013435701, 2044.47865794223, 2071.533904871407, 2078.355709729981, 2080.3030984620095, 2094.8428867834896, 2059.938201853947, 2077.3352527191305, 2083.197968782015, 2086.4992401823606, 2088.2169186555043, 2056.95886082279, 2074.6887966804948, 2075.8339332853334, 2081.3859911326194, 2089.634313995045, 6876.415504682108, 6973.232944376115, 6997.0, 7030.753923612649, 7043.084399028145, 4090.2433049885567, 4218.8523401680795, 4219.367094935754, 4222.704410691253, 4222.915541689149, 2703.1214855172148, 2737.603047558113, 2789.288731373487, 2790.1071657069747, 2804.8176868503483, 870.9085546017703, 872.97817554561, 891.5185799668236, 903.2548147778043, 930.06993006993, 9754.268429867789, 9758.414495130315, 9760.804783904283, 9771.755706107333, 9776.853347199798, 3790.8673196437994, 3827.4258861171047, 3843.0200298923596, 3898.103436209631, 3916.4712763776524, 8494.575271236414, 8499.915000850036, 8504.65981360751, 8509.74470765878, 8517.95741021291, 4184.91630167401, 4191.91616167675, 4214.1150358425075, 4216.072464057902, 4222.303319952235, 3236.64396916339, 3296.175956010997, 3692.2615476904725, 3801.0, 3836.5779764225913, 3488.267463832573, 3524.3656141894194, 3530.911727206789, 3538.7345949053924, 3582.5669732107367, 1072.702030543036, 1077.6012875236213, 1080.470569420978, 1099.7580532282884, 1122.1976286954866, 1136.8863113688565, 1146.6731981385433, 1160.709822544364, 1172.888575585318, 1210.818377243403, 6600.636964966973, 6637.867242655217, 6640.9667951660895, 6673.366030227217, 6674.566153200027, 976.4531862157214, 1010.1767059846202, 1022.0954455307107, 1071.0681706914877, 1090.3239991205503, 5494.587905907073, 5500.147477141049, 5541.2796336476, 5547.77808887648, 5547.889042219133, 8470.957645211734, 8491.405601607952, 8662.6101825418, 8727.738167854974, 8781.692640757543, 8585.18440748128, 8605.139486051345, 8606.784830379165, 8614.82770344602, 8624.353173511887, 6794.218664853605, 6887.345702158287, 6894.551854129566, 6971.721131154697, 6974.686139123752, 6635.9004614929845, 6660.56706314088, 6662.666866656551, 6669.166354205724, 6680.766173183915, 7694.269044440769, 7818.0618325799, 7863.882041769492, 7883.0, 8006.159353268056, 7969.521828690297, 7972.322352600094, 8033.517988920684, 8077.03075630928, 8174.468659537349, 5099.413567439792, 5180.792768289226, 5531.612787104864, 6008.939910600838, 6045.335013148638, 6546.443552297917, 6853.588784672936, 6887.035814985806, 6889.689963951534, 6890.896636550356, 6432.935670643234, 6485.902711459237, 6583.144191255106, 6647.434968027772, 6697.397234248941, 6383.6808159592765, 6413.070104834679, 6422.839429014312, 6424.293327734039, 6435.581687190318, 6616.206055273398, 6694.163229596301, 6740.224874139537, 6742.887423575055, 6760.797176084725, 6076.058210977306, 6076.270847498328, 6089.117078023751, 6132.2947860996555, 6146.231721034871, 5854.795082172103, 5904.232449781501, 5910.497607703393, 5919.023361145535, 5929.318128415115], "unit": "score", "name": "mootools.html", "value": 4122.185793907995}, {"lowerIsBetter": false, "replicates": [291.3575565877241, 292.6342072409488, 296.93912747886685, 298.18743922810347, 299.83509070011496, 5562.582806289524, 5567.359753628329, 5588.441155884415, 5650.943490565103, 5671.234383358245, 5515.034868897937, 5535.58483113766, 5535.667859928397, 5554.1113421852515, 5559.833205003846, 4282.8715138545895, 4288.3781851631575, 4296.205202037633, 4296.226679197744, 4298.183345164424, 4132.917341653165, 4216.241076606209, 4266.2534056540135, 4266.7866606669695, 4277.379779931924, 4194.0, 4209.03192265779, 4213.199492096507, 4216.894577635553, 4217.641500472463, 4207.368894665809, 4219.135077309144, 4222.8310867565415, 4225.746455212697, 4226.767527785971, 3635.0730563706084, 3637.8181090945345, 3638.472421498894, 3641.10792855752, 3645.7447978641508, 5205.063088644042, 5265.736713164327, 5380.166074258496, 5416.485433883775, 5418.674879507243, 4853.805847766085, 4856.95143048572, 4858.611311095104, 4868.975655121737, 4872.9756351218375, 5892.705364731746, 5907.881842363172, 5910.468057874812, 5921.407859214087, 5933.910991335133, 3973.264945984973, 3976.1451287972936, 3977.602239776028, 3978.622030907059, 3983.4821473208585, 5971.790987315467, 6210.9999999999545, 6214.906776398312, 6215.595986260879, 6215.751369945152, 4007.6593489553716, 4026.3356546169553, 4033.2941735196223, 4035.636792688672, 4047.757134571876, 4097.323941549671, 4097.426360309559, 4098.590140985937, 4100.7334523255895, 4102.774347410861, 4790.257510085942, 4795.160846851787, 4799.784009719501, 4802.975985120122, 4808.110499557523, 5759.568032397503, 5882.647041177543, 5892.086726557391, 5900.4984576310635, 5912.290525137011, 1428.9071210371292, 1454.9127052376891, 1460.5764328344874, 1465.1136062682137, 1465.6482444213311, 954.6038394066524, 955.5031383680447, 956.2780101023822, 971.3589031239349, 971.5190980464574, 5042.647014708935, 5049.065922804293, 5050.797968081236, 5053.8736531587, 5062.012907483006, 6038.516918646497, 6039.094135879654, 6041.365656605993, 6050.364711705296, 6051.062085376773, 5017.3226614406585, 5019.949800502021, 5035.899282014339, 5040.2691609716385, 5047.293378926953, 3225.483922572377, 3295.307985323061, 3297.093299342652, 3312.950305745416, 3319.71782398494, 5686.175504551817, 5726.770929162787, 5750.25246717924, 5756.510696590753, 5756.827295181068, 6168.704572039922, 6333.96833015832, 6361.9045714314325, 6371.681415929185, 6378.872422551616, 5782.59521833476, 5789.2763404574425, 5807.361190269152, 5815.534757219497, 5820.563457740771, 6141.170941922962, 6171.228596425447, 6175.042868355233, 6177.135201071944, 6184.907226391698, 5840.503557197516, 6030.698465076816, 6038.939610604013, 6059.3637668045985, 6061.878762424815, 5775.566832487664, 5813.418658134153, 5817.825465236049, 5828.2423284974375, 5844.211031510692, 4020.979895100506, 4090.181963607231, 4090.3250963590676, 4095.6723462122363, 4098.569650186688, 6000.5799594028, 6164.8767024658355, 6177.0, 6178.752849885954, 6190.350013248724, 5902.321233058082, 5921.822345329647, 5929.466348028698, 5936.3470018297085, 5944.3164036136395, 5904.675242861512, 5933.406659334032, 5933.703314834327, 5940.61386009908, 5954.76180952757, 5679.460451257124, 5754.280714910637, 5761.683107429131, 5797.362290148165, 5808.419158084327, 5960.433758792908, 5973.402659733992, 5981.9401805983125, 5984.611000284967, 5990.430909063632, 5797.449242321973, 5813.244278243801, 5828.825135245949, 5831.912521312099, 5833.7666493341485], "unit": "score", "name": "prototype.html", "value": 4362.7983244907955}, {"lowerIsBetter": false, "replicates": [783.878498832681, 784.0434669702964, 788.3850596534703, 788.4323287233194, 798.0503201190579, 10834.40410777407, 10965.232433729621, 10976.725581860457, 10986.615468458585, 11045.226834121615, 11118.499667514961, 11244.606438774625, 11283.266587671795, 11287.830682539769, 11305.982461578456, 763.3397111498556, 772.1236396689742, 778.6106946526737, 778.9260020298091, 780.6331024418514, 770.3721467004374, 784.7135795434654, 784.8508783331149, 788.2747871957813, 789.124072279769, 813.1705660226565, 818.443458448255, 820.7414664380701, 821.195228675898, 823.3166471828398, 815.8572249856281, 819.5369616166847, 820.2576668115365, 820.2781552233996, 823.1398188892622, 603.4086595136747, 604.0938592111833, 605.9727312270915, 606.6875559087074, 607.1166452811149, 9704.466254356008, 9747.902520974842, 9758.975307592671, 9789.510524473748, 9835.803283934352, 8790.780230494225, 9401.388909720914, 9556.665516706882, 9879.506024698736, 9918.752031199205, 8615.0, 8722.171393717586, 8741.475511469333, 8741.562921853945, 8754.343424243143, 3192.9201769955703, 3240.902772916816, 3272.96727032729, 3290.8683652653867, 3294.0776582556923, 37709.43435848464, 41735.58264417377, 43232.0, 43362.34956475655, 43365.783171083945, 8051.959740201379, 8361.916380836235, 8521.914780852112, 9248.398854074598, 9341.205997490153, 15849.128297943493, 16060.437884674215, 16066.27701753424, 16088.678226435406, 16107.516774496784, 6196.132541444202, 6226.968865155645, 6249.187605611241, 6512.34876512345, 6522.282548919615, 3380.4760262159402, 3420.1449637590604, 3428.3314753622803, 3461.8442170102408, 3534.081138903852, 2640.168346970698, 2651.4962157190457, 2653.6815582130266, 2657.6146458763756, 2659.135780871186, 461.1284671969979, 465.0977104417419, 466.3354719524664, 478.7343024621299, 483.52131389924426, 460.1464283753656, 490.2890808327939, 494.79960615950597, 547.7589860461384, 567.5091046244968, 7285.70857165718, 7430.7399241026305, 7572.280633339824, 7690.884636730453, 7757.4181936355, 557.567884889206, 558.0958846668342, 574.6810520161267, 575.9164921086502, 582.9970850145806, 3215.1479857837694, 3561.679448849616, 3644.9453258201147, 3683.7421380503106, 3737.3459644562095, 48371.5162848374, 48495.27257091076, 48651.27023094657, 48651.513484865405, 48711.269330960065, 40604.39093413601, 40741.1851762969, 42569.57430425656, 43363.34954975678, 43724.0, 41673.79163104165, 42347.57652423498, 42497.57502424998, 42598.0, 43824.56175438269, 7873.645685944261, 8212.753617391489, 8312.25189732927, 8315.667373305, 8354.0, 31870.639759896974, 31962.041138765875, 32103.678963211005, 33107.50338744873, 33235.0, 37567.43648845324, 37840.43239351467, 38409.807950961185, 39100.0, 39149.6085039146, 9952.55213515379, 10009.149222315893, 10185.33795303303, 10675.092617127631, 10708.30396024256, 10609.363438193734, 10738.73153171177, 10956.397398142859, 11112.888871111185, 11148.721281968015, 9985.750356241153, 10080.143187829117, 10081.445520496443, 10456.32033917793, 10670.146388289073, 10049.497525123861, 10052.145567626541, 10141.847872281774, 10256.282060255711, 10784.460776961278, 9860.753481163028, 9934.940909633613, 10186.337888037255, 10223.131033862204, 10248.795024099327, 8530.445521041112, 8558.443701159405, 8775.210231079234, 8989.820203596022, 9352.298577606844, 8269.131741167092, 8471.279941205066, 8561.101084386299, 8727.519986400808, 8760.649574017223], "unit": "score", "name": "yui.html", "value": 5555.972645310808}], "name": "dromaeo_css", "value": 6268.523834991786}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 107.0, 113.0, 114.0, 114.0, 124.0, 114.0, 113.0, 117.0, 113.0], "unit": "score", "name": "ai-astar", "value": 114.4}, {"lowerIsBetter": true, "replicates": [173.0, 132.0, 154.0, 171.0, 140.0, 168.0, 156.0, 131.0, 170.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 152.9}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 160.0, 162.0, 161.0, 165.0, 167.0, 161.0, 166.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.8}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 73.0, 75.0, 73.0, 139.0, 72.0, 74.0, 72.0, 77.0], "unit": "score", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 138.0, 95.0, 104.0, 94.0, 136.0, 95.0, 95.0, 128.0], "unit": "score", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 110.0, 109.0, 110.0, 113.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 71.0, 71.0, 73.0, 71.0, 71.0, 72.0, 71.0, 72.0], "unit": "score", "name": "json-parse-financial", "value": 71.6}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 69.0, 68.0, 69.0, 68.0, 68.0, 68.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 84.0, 91.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.9}, {"lowerIsBetter": true, "replicates": [129.0, 139.0, 128.0, 122.0, 124.0, 123.0, 123.0, 127.0, 125.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.0}, {"lowerIsBetter": true, "replicates": [148.0, 152.0, 152.0, 145.0, 149.0, 135.0, 136.0, 150.0, 150.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.4}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 70.0, 71.0, 80.0, 69.0, 70.0, 69.0, 71.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.2}], "name": "kraken", "value": 1539.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.8374792703151], "unit": "score", "name": "Richards", "value": 212.87106}, {"lowerIsBetter": false, "replicates": [190.5850962454736], "unit": "score", "name": "DeltaBlue", "value": 346.9211459999999}, {"lowerIsBetter": false, "replicates": [277.31558513588465], "unit": "score", "name": "Encrypt", "value": 959.8486860000002}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1063.8297872340424], "unit": "score", "name": "RayTrace", "value": 695.5896600000003}, {"lowerIsBetter": false, "replicates": [699.3006993006993], "unit": "score", "name": "Earley", "value": 953.0420899999998}, {"lowerIsBetter": false, "replicates": [12228.915662650603], "unit": "score", "name": "Boyer", "value": 54.498944827586165}, {"lowerIsBetter": false, "replicates": [26179.48717948718], "unit": "score", "name": "RegExp", "value": 34.79766405484819}, {"lowerIsBetter": false, "replicates": [591.3660555884093], "unit": "score", "name": "Splay", "value": 137.80128099999996}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 21391.987760740252}]} 08:41:44 INFO - RETURN: dromaeo_css: 6268.52 08:41:44 INFO - RETURN: kraken: 1539.60 08:41:44 INFO - RETURN: v8_7: 21391.99 08:41:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21391.99"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1539.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6268.52"}}} 08:41:44 INFO - Return code: 0 08:41:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:41:44 INFO - # TBPL SUCCESS # 08:41:44 INFO - Running post-action listener: _resource_record_post_action 08:41:44 INFO - Running post-run listener: _resource_record_post_run 08:41:45 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 514052096; Read time: 12; Write time: 641000 08:41:45 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 240103424; Read time: 0; Write time: 393660 08:41:45 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 273948672; Read time: 12; Write time: 247340 08:41:45 INFO - Running post-run listener: _upload_blobber_files 08:41:45 INFO - Blob upload gear active. 08:41:45 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:41:45 INFO - Copying logs to upload dir... 08:41:45 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1270.837134 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-15 08:41:45.684420) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-15 08:41:45.688581) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009959 build_url: 'https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.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-15 08:41:45.741861) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 08:41:45.742173) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6ea65ccfe4e6b94e0d4f826f000001d8-1450196294.471656-854085044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 08:41:45.792934) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 08:41:45.793360) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 08:41:45.794052) ========= ========= Total master_lag: 0.25 =========