builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-001 starttime: 1450193119.82 results: success (0) buildid: 20151215055512 builduid: 8b5ab8fea1a44d099ed33d6ce6b298db revision: 8d24d95b8a13a1a50cb58bbb941c5337522e665b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 07:25:19.824798) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 07:25:19.825242) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 07:25:19.825578) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006378 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 07:25:19.848194) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 07:25:19.848492) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 07:25:19.861606) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 07:25:19.861898) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 07:25:19.910887) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 07:25:19.911202) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 07:25:19.911568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 07:25:19.911836) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-15 07:25:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2015-12-15 07:25:20 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.143578 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 07:25:20.068099) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 07:25:20.068415) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020780 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 07:25:20.117818) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-15 07:25:20.118195) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8d24d95b8a13a1a50cb58bbb941c5337522e665b --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 8d24d95b8a13a1a50cb58bbb941c5337522e665b --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=b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-15 07:25:20,811 truncating revision to first 12 chars 2015-12-15 07:25:20,811 Setting DEBUG logging. 2015-12-15 07:25:20,811 attempt 1/10 2015-12-15 07:25:20,811 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8d24d95b8a13?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-15 07:25:22,026 unpacking tar archive at: fx-team-8d24d95b8a13/testing/mozharness/ program finished with exit code 0 elapsedTime=1.490734 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-15 07:25:21.622235) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 07:25:21.622613) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 07:25:21.630902) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 07:25:21.631285) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 07:25:21.631719) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-15 07:25:21.632013) ========= /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=b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:25:22 INFO - MultiFileLogger online at 20151215 07:25:22 in /builds/slave/test 07:25:22 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 07:25:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:25:22 INFO - {'append_to_log': False, 07:25:22 INFO - 'base_work_dir': '/builds/slave/test', 07:25:22 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:25:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:25:22 INFO - 'branch': 'Fx-Team-Non-PGO', 07:25:22 INFO - 'buildbot_json_path': 'buildprops.json', 07:25:22 INFO - 'config_files': ('talos/linux_config.py',), 07:25:22 INFO - 'default_actions': ('clobber', 07:25:22 INFO - 'read-buildbot-config', 07:25:22 INFO - 'download-and-extract', 07:25:22 INFO - 'populate-webroot', 07:25:22 INFO - 'create-virtualenv', 07:25:22 INFO - 'install', 07:25:22 INFO - 'run-tests'), 07:25:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:25:22 INFO - 'download_minidump_stackwalk': True, 07:25:22 INFO - 'download_symbols': 'ondemand', 07:25:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:25:22 INFO - 'tooltool.py': '/tools/tooltool.py', 07:25:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:25:22 INFO - '/tools/misc-python/virtualenv.py')}, 07:25:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:25:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:25:22 INFO - 'installer_path': 'installer.exe', 07:25:22 INFO - 'log_level': 'info', 07:25:22 INFO - 'log_name': 'talos', 07:25:22 INFO - 'log_to_console': True, 07:25:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:25:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:25:22 INFO - 'opt_config_files': (), 07:25:22 INFO - 'pip_index': False, 07:25:22 INFO - 'sps_profile': False, 07:25:22 INFO - 'sps_profile_interval': 0, 07:25:22 INFO - 'suite': 'dromaeojs-e10s', 07:25:22 INFO - 'system_bits': '64', 07:25:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:25:22 INFO - 'title': 'talos-linux64-ix-001', 07:25:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:25:22 INFO - 'use_talos_json': True, 07:25:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:25:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:25:22 INFO - 'work_dir': 'build'} 07:25:22 INFO - ##### 07:25:22 INFO - ##### Running clobber step. 07:25:22 INFO - ##### 07:25:22 INFO - Running pre-action listener: _resource_record_pre_action 07:25:22 INFO - Running main action method: clobber 07:25:22 INFO - rmtree: /builds/slave/test/build 07:25:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:25:23 INFO - Running post-action listener: _resource_record_post_action 07:25:23 INFO - ##### 07:25:23 INFO - ##### Running read-buildbot-config step. 07:25:23 INFO - ##### 07:25:23 INFO - Running pre-action listener: _resource_record_pre_action 07:25:23 INFO - Running main action method: read_buildbot_config 07:25:23 INFO - Using buildbot properties: 07:25:23 INFO - { 07:25:23 INFO - "properties": { 07:25:23 INFO - "buildnumber": 818, 07:25:23 INFO - "product": "firefox", 07:25:23 INFO - "script_repo_revision": "production", 07:25:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:25:23 INFO - "repository": "", 07:25:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 07:25:23 INFO - "buildid": "20151215055512", 07:25:23 INFO - "slavename": "talos-linux64-ix-001", 07:25:23 INFO - "pgo_build": "False", 07:25:23 INFO - "basedir": "/builds/slave/test", 07:25:23 INFO - "project": "", 07:25:23 INFO - "platform": "ubuntu64_hw", 07:25:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:25:23 INFO - "slavebuilddir": "test", 07:25:23 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:25:23 INFO - "branch": "fx-team", 07:25:23 INFO - "repo_path": "integration/fx-team", 07:25:23 INFO - "stage_platform": "linux64", 07:25:23 INFO - "builduid": "8b5ab8fea1a44d099ed33d6ce6b298db", 07:25:23 INFO - "revision": "8d24d95b8a13a1a50cb58bbb941c5337522e665b" 07:25:23 INFO - }, 07:25:23 INFO - "sourcestamp": { 07:25:23 INFO - "repository": "", 07:25:23 INFO - "hasPatch": false, 07:25:23 INFO - "project": "", 07:25:23 INFO - "branch": "fx-team-linux64-talos", 07:25:23 INFO - "changes": [ 07:25:23 INFO - { 07:25:23 INFO - "category": null, 07:25:23 INFO - "files": [ 07:25:23 INFO - { 07:25:23 INFO - "url": null, 07:25:23 INFO - "name": "https://queue.taskcluster.net/v1/task/mXqUEzUFQFaBAzzaoyUQqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 07:25:23 INFO - } 07:25:23 INFO - ], 07:25:23 INFO - "repository": "", 07:25:23 INFO - "rev": "8d24d95b8a13a1a50cb58bbb941c5337522e665b", 07:25:23 INFO - "who": "cbook@mozilla.com", 07:25:23 INFO - "when": 1450192704, 07:25:23 INFO - "number": 7362133, 07:25:23 INFO - "comments": "Merge mozilla-central to fx-team", 07:25:23 INFO - "project": "", 07:25:23 INFO - "at": "Tue 15 Dec 2015 07:18:24", 07:25:23 INFO - "branch": "fx-team-linux64-talos", 07:25:23 INFO - "revlink": "", 07:25:23 INFO - "properties": [ 07:25:23 INFO - [ 07:25:23 INFO - "buildid", 07:25:23 INFO - "20151215055512", 07:25:23 INFO - "Change" 07:25:23 INFO - ], 07:25:23 INFO - [ 07:25:23 INFO - "builduid", 07:25:23 INFO - "8b5ab8fea1a44d099ed33d6ce6b298db", 07:25:23 INFO - "Change" 07:25:23 INFO - ], 07:25:23 INFO - [ 07:25:23 INFO - "pgo_build", 07:25:23 INFO - "False", 07:25:23 INFO - "Change" 07:25:23 INFO - ] 07:25:23 INFO - ], 07:25:23 INFO - "revision": "8d24d95b8a13a1a50cb58bbb941c5337522e665b" 07:25:23 INFO - } 07:25:23 INFO - ], 07:25:23 INFO - "revision": "8d24d95b8a13a1a50cb58bbb941c5337522e665b" 07:25:23 INFO - } 07:25:23 INFO - } 07:25:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/mXqUEzUFQFaBAzzaoyUQqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:25:23 INFO - Running post-action listener: _resource_record_post_action 07:25:23 INFO - ##### 07:25:23 INFO - ##### Running download-and-extract step. 07:25:23 INFO - ##### 07:25:23 INFO - Running pre-action listener: _resource_record_pre_action 07:25:23 INFO - Running main action method: download_and_extract 07:25:23 INFO - mkdir: /builds/slave/test/build/tests 07:25:23 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')]} 07:25:23 INFO - https://queue.taskcluster.net/v1/task/mXqUEzUFQFaBAzzaoyUQqw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:25:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mXqUEzUFQFaBAzzaoyUQqw/artifacts/public/build/test_packages.json 07:25:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mXqUEzUFQFaBAzzaoyUQqw/artifacts/public/build/test_packages.json 07:25:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mXqUEzUFQFaBAzzaoyUQqw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:25:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mXqUEzUFQFaBAzzaoyUQqw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:25:23 INFO - Downloaded 1302 bytes. 07:25:23 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:25:23 INFO - Using the following test package requirements: 07:25:23 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:25:23 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:25:23 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:23 INFO - u'jsshell-linux-x86_64.zip'], 07:25:23 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:25:23 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:25:23 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:25:23 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:25:23 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:25:23 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:25:23 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:25:23 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:25:23 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')]} 07:25:23 INFO - https://queue.taskcluster.net/v1/task/mXqUEzUFQFaBAzzaoyUQqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:25:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mXqUEzUFQFaBAzzaoyUQqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:25:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mXqUEzUFQFaBAzzaoyUQqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:25:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mXqUEzUFQFaBAzzaoyUQqw/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 07:25:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mXqUEzUFQFaBAzzaoyUQqw/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 07:25:24 INFO - Downloaded 21863279 bytes. 07:25:24 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 07:25:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:25:24 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 07:25:26 INFO - Return code: 0 07:25:26 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 07:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:26 INFO - https://queue.taskcluster.net/v1/task/mXqUEzUFQFaBAzzaoyUQqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:25:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mXqUEzUFQFaBAzzaoyUQqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:25:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mXqUEzUFQFaBAzzaoyUQqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:25:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mXqUEzUFQFaBAzzaoyUQqw/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 07:25:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mXqUEzUFQFaBAzzaoyUQqw/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 07:25:26 INFO - Downloaded 21863279 bytes. 07:25:26 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 07:25:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:25:27 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 07:25:28 INFO - Return code: 0 07:25:28 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')]} 07:25:28 INFO - https://queue.taskcluster.net/v1/task/mXqUEzUFQFaBAzzaoyUQqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:25:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mXqUEzUFQFaBAzzaoyUQqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:25:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mXqUEzUFQFaBAzzaoyUQqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:25:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mXqUEzUFQFaBAzzaoyUQqw/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 07:25:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mXqUEzUFQFaBAzzaoyUQqw/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 07:25:29 INFO - Downloaded 11132052 bytes. 07:25:29 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 07:25:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:25:29 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 07:25:29 INFO - Return code: 0 07:25:29 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')]} 07:25:29 INFO - https://queue.taskcluster.net/v1/task/mXqUEzUFQFaBAzzaoyUQqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:25:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mXqUEzUFQFaBAzzaoyUQqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:25:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mXqUEzUFQFaBAzzaoyUQqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:25:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mXqUEzUFQFaBAzzaoyUQqw/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 07:25:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mXqUEzUFQFaBAzzaoyUQqw/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 07:25:31 INFO - Downloaded 57737126 bytes. 07:25:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/mXqUEzUFQFaBAzzaoyUQqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:25:31 INFO - mkdir: /builds/slave/test/properties 07:25:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:25:31 INFO - Writing to file /builds/slave/test/properties/build_url 07:25:31 INFO - Contents: 07:25:31 INFO - build_url:https://queue.taskcluster.net/v1/task/mXqUEzUFQFaBAzzaoyUQqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:25:31 INFO - Running post-action listener: _resource_record_post_action 07:25:31 INFO - Running post-action listener: set_extra_try_arguments 07:25:31 INFO - ##### 07:25:31 INFO - ##### Running populate-webroot step. 07:25:31 INFO - ##### 07:25:31 INFO - Running pre-action listener: _resource_record_pre_action 07:25:31 INFO - Running main action method: populate_webroot 07:25:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:25:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:25:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:25:31 INFO - '--tppagecycles', 07:25:31 INFO - '7'], 07:25:31 INFO - 'tests': ['tsvgm']}}, 07:25:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:25:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:25:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:25:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:25:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:25:31 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:25:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:25:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:31 INFO - 'talos_options': ['--e10s'], 07:25:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:25:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:31 INFO - 'tests': ['damp', 'tps']}, 07:25:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:31 INFO - 'talos_options': ['--e10s'], 07:25:31 INFO - 'tests': ['damp', 'tps']}, 07:25:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:25:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:25:31 INFO - 'other': {'tests': ['a11yr', 07:25:31 INFO - 'ts_paint', 07:25:31 INFO - 'tpaint', 07:25:31 INFO - 'sessionrestore', 07:25:31 INFO - 'sessionrestore_no_auto_restore']}, 07:25:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:25:31 INFO - 'tests': ['a11yr', 07:25:31 INFO - 'ts_paint', 07:25:31 INFO - 'tpaint', 07:25:31 INFO - 'sessionrestore', 07:25:31 INFO - 'sessionrestore_no_auto_restore']}, 07:25:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:25:31 INFO - 'tests': ['a11yr', 07:25:31 INFO - 'ts_paint', 07:25:31 INFO - 'tpaint', 07:25:31 INFO - 'sessionrestore', 07:25:31 INFO - 'sessionrestore_no_auto_restore']}, 07:25:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:25:31 INFO - 'tests': ['a11yr', 07:25:31 INFO - 'ts_paint', 07:25:31 INFO - 'tpaint', 07:25:31 INFO - 'sessionrestore', 07:25:31 INFO - 'sessionrestore_no_auto_restore']}, 07:25:31 INFO - 'other_l64': {'tests': ['a11yr', 07:25:31 INFO - 'ts_paint', 07:25:31 INFO - 'tpaint', 07:25:31 INFO - 'sessionrestore', 07:25:31 INFO - 'sessionrestore_no_auto_restore']}, 07:25:31 INFO - 'other_nol64': {'tests': ['a11yr', 07:25:31 INFO - 'ts_paint', 07:25:31 INFO - 'tpaint', 07:25:31 INFO - 'sessionrestore', 07:25:31 INFO - 'sessionrestore_no_auto_restore']}, 07:25:31 INFO - 'svgr': {'tests': ['tsvgx', 07:25:31 INFO - 'tsvgr_opacity', 07:25:31 INFO - 'tart', 07:25:31 INFO - 'tscrollx', 07:25:31 INFO - 'cart']}, 07:25:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:25:31 INFO - 'tests': ['tsvgx', 07:25:31 INFO - 'tsvgr_opacity', 07:25:31 INFO - 'tart', 07:25:31 INFO - 'tscrollx', 07:25:31 INFO - 'cart']}, 07:25:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:31 INFO - 'tests': ['tp5o']}, 07:25:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:31 INFO - 'talos_options': ['--e10s'], 07:25:31 INFO - 'tests': ['tp5o']}, 07:25:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:31 INFO - 'talos_options': ['--xperf_path', 07:25:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:25:31 INFO - 'tests': ['tp5n']}, 07:25:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:31 INFO - 'talos_options': ['--e10s', 07:25:31 INFO - '--xperf_path', 07:25:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:25:31 INFO - 'tests': ['tp5n']}}, 07:25:31 INFO - 'talos.zip': {'path': '', 07:25:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:25:31 INFO - Running post-action listener: _resource_record_post_action 07:25:31 INFO - ##### 07:25:31 INFO - ##### Running create-virtualenv step. 07:25:31 INFO - ##### 07:25:31 INFO - Running pre-action listener: _resource_record_pre_action 07:25:31 INFO - Running main action method: create_virtualenv 07:25:31 INFO - Creating virtualenv /builds/slave/test/build/venv 07:25:31 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 07:25:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:25:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:25:31 INFO - Using real prefix '/usr' 07:25:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:25:31 INFO - Installing distribute.............................................................................................................................................................................................done. 07:25:33 INFO - Installing pip.................done. 07:25:33 INFO - Return code: 0 07:25:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:25:33 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')]} 07:25:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:33 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')]} 07:25:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:33 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 0x7fc52ea03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd0b0>, '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 0x1afdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afe440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441', '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 07:25:33 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 07:25:33 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 07:25:33 INFO - Using env: {'DISPLAY': ':0', 07:25:33 INFO - 'HOME': '/home/cltbld', 07:25:33 INFO - 'LANG': 'en_US.UTF-8', 07:25:33 INFO - 'LANGUAGE': 'en_US:en', 07:25:33 INFO - 'LOGNAME': 'cltbld', 07:25:33 INFO - 'MAIL': '/var/mail/cltbld', 07:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:33 INFO - 'MOZ_NO_REMOTE': '1', 07:25:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:33 INFO - 'NO_EM_RESTART': '1', 07:25:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:33 INFO - 'PWD': '/builds/slave/test', 07:25:33 INFO - 'SHELL': '/bin/bash', 07:25:33 INFO - 'SHLVL': '1', 07:25:33 INFO - 'TERM': 'linux', 07:25:33 INFO - 'TMOUT': '86400', 07:25:33 INFO - 'USER': 'cltbld', 07:25:33 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441', 07:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:33 INFO - '_': '/tools/buildbot/bin/python'} 07:25:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:34 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 07:25:34 INFO - Cleaning up... 07:25:34 INFO - Return code: 0 07:25:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:34 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 0x7fc52ea03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd0b0>, '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 0x1afdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afe440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441', '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 07:25:34 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 07:25:34 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 07:25:34 INFO - Using env: {'DISPLAY': ':0', 07:25:34 INFO - 'HOME': '/home/cltbld', 07:25:34 INFO - 'LANG': 'en_US.UTF-8', 07:25:34 INFO - 'LANGUAGE': 'en_US:en', 07:25:34 INFO - 'LOGNAME': 'cltbld', 07:25:34 INFO - 'MAIL': '/var/mail/cltbld', 07:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:34 INFO - 'MOZ_NO_REMOTE': '1', 07:25:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:34 INFO - 'NO_EM_RESTART': '1', 07:25:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:34 INFO - 'PWD': '/builds/slave/test', 07:25:34 INFO - 'SHELL': '/bin/bash', 07:25:34 INFO - 'SHLVL': '1', 07:25:34 INFO - 'TERM': 'linux', 07:25:34 INFO - 'TMOUT': '86400', 07:25:34 INFO - 'USER': 'cltbld', 07:25:34 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441', 07:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:34 INFO - '_': '/tools/buildbot/bin/python'} 07:25:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:34 INFO - Downloading/unpacking psutil>=0.7.1 07:25:34 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 07:25:34 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 07:25:34 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 07:25:34 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 07:25:34 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 07:25:34 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 07:25:36 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:25:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:25:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:25:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:25:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:25:37 INFO - Installing collected packages: psutil 07:25:37 INFO - Running setup.py install for psutil 07:25:37 INFO - building 'psutil._psutil_linux' extension 07:25:37 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 07:25:37 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 07:25:37 INFO - building 'psutil._psutil_posix' extension 07:25:37 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 07:25:37 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 07:25:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:25:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:25:37 INFO - Successfully installed psutil 07:25:37 INFO - Cleaning up... 07:25:37 INFO - Return code: 0 07:25:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:25:37 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')]} 07:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:37 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')]} 07:25:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:37 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 0x7fc52ea03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd0b0>, '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 0x1afdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afe440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441', '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 07:25:37 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 07:25:37 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 07:25:37 INFO - Using env: {'DISPLAY': ':0', 07:25:37 INFO - 'HOME': '/home/cltbld', 07:25:37 INFO - 'LANG': 'en_US.UTF-8', 07:25:37 INFO - 'LANGUAGE': 'en_US:en', 07:25:37 INFO - 'LOGNAME': 'cltbld', 07:25:37 INFO - 'MAIL': '/var/mail/cltbld', 07:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:37 INFO - 'MOZ_NO_REMOTE': '1', 07:25:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:37 INFO - 'NO_EM_RESTART': '1', 07:25:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:37 INFO - 'PWD': '/builds/slave/test', 07:25:37 INFO - 'SHELL': '/bin/bash', 07:25:37 INFO - 'SHLVL': '1', 07:25:37 INFO - 'TERM': 'linux', 07:25:37 INFO - 'TMOUT': '86400', 07:25:37 INFO - 'USER': 'cltbld', 07:25:37 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441', 07:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:37 INFO - '_': '/tools/buildbot/bin/python'} 07:25:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:25:37 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 07:25:37 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 07:25:37 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 07:25:37 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 07:25:37 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 07:25:37 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 07:25:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:25:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:25:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:25:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:25:39 INFO - Installing collected packages: mozsystemmonitor 07:25:39 INFO - Running setup.py install for mozsystemmonitor 07:25:39 INFO - Successfully installed mozsystemmonitor 07:25:39 INFO - Cleaning up... 07:25:39 INFO - Return code: 0 07:25:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:25:39 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')]} 07:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:39 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')]} 07:25:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:39 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 0x7fc52ea03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd0b0>, '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 0x1afdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afe440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441', '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 07:25:39 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 07:25:39 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 07:25:39 INFO - Using env: {'DISPLAY': ':0', 07:25:39 INFO - 'HOME': '/home/cltbld', 07:25:39 INFO - 'LANG': 'en_US.UTF-8', 07:25:39 INFO - 'LANGUAGE': 'en_US:en', 07:25:39 INFO - 'LOGNAME': 'cltbld', 07:25:39 INFO - 'MAIL': '/var/mail/cltbld', 07:25:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:39 INFO - 'MOZ_NO_REMOTE': '1', 07:25:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:39 INFO - 'NO_EM_RESTART': '1', 07:25:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:39 INFO - 'PWD': '/builds/slave/test', 07:25:39 INFO - 'SHELL': '/bin/bash', 07:25:39 INFO - 'SHLVL': '1', 07:25:39 INFO - 'TERM': 'linux', 07:25:39 INFO - 'TMOUT': '86400', 07:25:39 INFO - 'USER': 'cltbld', 07:25:39 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441', 07:25:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:39 INFO - '_': '/tools/buildbot/bin/python'} 07:25:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:39 INFO - Downloading/unpacking blobuploader==1.2.4 07:25:39 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 07:25:39 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 07:25:39 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 07:25:39 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 07:25:39 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 07:25:39 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 07:25:42 INFO - Downloading blobuploader-1.2.4.tar.gz 07:25:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:25:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:25:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:25:42 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 07:25:42 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 07:25:42 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 07:25:42 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 07:25:42 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 07:25:42 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 07:25:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:25:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:25:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:25:43 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 07:25:43 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 07:25:43 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 07:25:43 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 07:25:43 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 07:25:43 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 07:25:43 INFO - Downloading docopt-0.6.1.tar.gz 07:25:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:25:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:25:43 INFO - Installing collected packages: blobuploader, requests, docopt 07:25:43 INFO - Running setup.py install for blobuploader 07:25:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:25:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:25:43 INFO - Running setup.py install for requests 07:25:43 INFO - Running setup.py install for docopt 07:25:43 INFO - Successfully installed blobuploader requests docopt 07:25:43 INFO - Cleaning up... 07:25:43 INFO - Return code: 0 07:25:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:43 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 0x7fc52ea03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd0b0>, '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 0x1afdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afe440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441', '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 07:25:43 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 07:25:43 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 07:25:43 INFO - Using env: {'DISPLAY': ':0', 07:25:43 INFO - 'HOME': '/home/cltbld', 07:25:43 INFO - 'LANG': 'en_US.UTF-8', 07:25:43 INFO - 'LANGUAGE': 'en_US:en', 07:25:43 INFO - 'LOGNAME': 'cltbld', 07:25:43 INFO - 'MAIL': '/var/mail/cltbld', 07:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:43 INFO - 'MOZ_NO_REMOTE': '1', 07:25:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:43 INFO - 'NO_EM_RESTART': '1', 07:25:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:43 INFO - 'PWD': '/builds/slave/test', 07:25:43 INFO - 'SHELL': '/bin/bash', 07:25:43 INFO - 'SHLVL': '1', 07:25:43 INFO - 'TERM': 'linux', 07:25:43 INFO - 'TMOUT': '86400', 07:25:43 INFO - 'USER': 'cltbld', 07:25:43 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441', 07:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:43 INFO - '_': '/tools/buildbot/bin/python'} 07:25:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:25:44 INFO - Running setup.py (path:/tmp/pip-ptS2lE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:25:44 INFO - Running setup.py (path:/tmp/pip-TPp_yI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:25:44 INFO - Running setup.py (path:/tmp/pip-oaXfuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:25:44 INFO - Running setup.py (path:/tmp/pip-08FGv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:25:44 INFO - Running setup.py (path:/tmp/pip-Kl_lHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:25:44 INFO - Running setup.py (path:/tmp/pip-McvsYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:25:44 INFO - Running setup.py (path:/tmp/pip-rwZ0xS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:25:44 INFO - Running setup.py (path:/tmp/pip-4NkDBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:25:44 INFO - Running setup.py (path:/tmp/pip-mnd1EL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:25:44 INFO - Running setup.py (path:/tmp/pip-nkxXtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:25:44 INFO - Running setup.py (path:/tmp/pip-28ln__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:25:44 INFO - Running setup.py (path:/tmp/pip-73T8WZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:25:44 INFO - Running setup.py (path:/tmp/pip-UQ4uko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:25:45 INFO - Running setup.py (path:/tmp/pip-KXtyuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:45 INFO - Running setup.py (path:/tmp/pip-ai8bg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:25:45 INFO - Running setup.py (path:/tmp/pip-awEMaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:25:45 INFO - Running setup.py (path:/tmp/pip-DQfxtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:25:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:25:45 INFO - Running setup.py install for manifestparser 07:25:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:25:45 INFO - Running setup.py install for mozcrash 07:25:45 INFO - Running setup.py install for mozdebug 07:25:45 INFO - Running setup.py install for mozdevice 07:25:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:25:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:25:45 INFO - Running setup.py install for mozfile 07:25:45 INFO - Running setup.py install for mozhttpd 07:25:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:25:45 INFO - Running setup.py install for mozinfo 07:25:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:25:46 INFO - Running setup.py install for mozInstall 07:25:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:25:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:25:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:25:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:25:46 INFO - Running setup.py install for mozleak 07:25:46 INFO - Running setup.py install for mozlog 07:25:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:25:46 INFO - Running setup.py install for moznetwork 07:25:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:25:46 INFO - Running setup.py install for mozprocess 07:25:46 INFO - Running setup.py install for mozprofile 07:25:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:25:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:25:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:25:46 INFO - Running setup.py install for mozrunner 07:25:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:25:46 INFO - Running setup.py install for mozscreenshot 07:25:46 INFO - Running setup.py install for moztest 07:25:46 INFO - Running setup.py install for mozversion 07:25:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:25:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:25:47 INFO - Cleaning up... 07:25:47 INFO - Return code: 0 07:25:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:47 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 0x7fc52ea03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd0b0>, '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 0x1afdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afe440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441', '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 07:25:47 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 07:25:47 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 07:25:47 INFO - Using env: {'DISPLAY': ':0', 07:25:47 INFO - 'HOME': '/home/cltbld', 07:25:47 INFO - 'LANG': 'en_US.UTF-8', 07:25:47 INFO - 'LANGUAGE': 'en_US:en', 07:25:47 INFO - 'LOGNAME': 'cltbld', 07:25:47 INFO - 'MAIL': '/var/mail/cltbld', 07:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:47 INFO - 'MOZ_NO_REMOTE': '1', 07:25:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:47 INFO - 'NO_EM_RESTART': '1', 07:25:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:47 INFO - 'PWD': '/builds/slave/test', 07:25:47 INFO - 'SHELL': '/bin/bash', 07:25:47 INFO - 'SHLVL': '1', 07:25:47 INFO - 'TERM': 'linux', 07:25:47 INFO - 'TMOUT': '86400', 07:25:47 INFO - 'USER': 'cltbld', 07:25:47 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441', 07:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:47 INFO - '_': '/tools/buildbot/bin/python'} 07:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:25:47 INFO - Running setup.py (path:/tmp/pip-vPseW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:25:47 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)) 07:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:25:47 INFO - Running setup.py (path:/tmp/pip-oFsf63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:25:47 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)) 07:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:25:47 INFO - Running setup.py (path:/tmp/pip-Sa1KOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:25:47 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)) 07:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:25:47 INFO - Running setup.py (path:/tmp/pip-0KPqeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:25:47 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)) 07:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:25:47 INFO - Running setup.py (path:/tmp/pip-nZpkzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:25:47 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)) 07:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:25:47 INFO - Running setup.py (path:/tmp/pip-0gdblm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:25:47 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)) 07:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:25:47 INFO - Running setup.py (path:/tmp/pip-8vCDS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:25:47 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)) 07:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:25:47 INFO - Running setup.py (path:/tmp/pip-QSjvKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:25:47 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)) 07:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:25:47 INFO - Running setup.py (path:/tmp/pip-aEohEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:25:47 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)) 07:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:25:47 INFO - Running setup.py (path:/tmp/pip-N6Vm1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:25:48 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)) 07:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:25:48 INFO - Running setup.py (path:/tmp/pip-Dh9tpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:25:48 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)) 07:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:25:48 INFO - Running setup.py (path:/tmp/pip-kqlWa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:25:48 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)) 07:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:25:48 INFO - Running setup.py (path:/tmp/pip-jlZNG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:25:48 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)) 07:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:25:48 INFO - Running setup.py (path:/tmp/pip-l6VSOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:25:48 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)) 07:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:48 INFO - Running setup.py (path:/tmp/pip-wlRg2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:48 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)) 07:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:25:48 INFO - Running setup.py (path:/tmp/pip-jDVUZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:25:48 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)) 07:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:25:48 INFO - Running setup.py (path:/tmp/pip-VeMDQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:25:48 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)) 07:25:48 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)) 07:25:48 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)) 07:25:48 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)) 07:25:48 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)) 07:25:48 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)) 07:25:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:25:48 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 07:25:48 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 07:25:48 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 07:25:48 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 07:25:48 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 07:25:48 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 07:25:50 INFO - Downloading blessings-1.5.1.tar.gz 07:25:50 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 07:25:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:25:50 INFO - Installing collected packages: blessings 07:25:50 INFO - Running setup.py install for blessings 07:25:50 INFO - Successfully installed blessings 07:25:50 INFO - Cleaning up... 07:25:50 INFO - Return code: 0 07:25:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:25:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:25:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:25:50 INFO - Reading from file tmpfile_stdout 07:25:50 INFO - Current package versions: 07:25:50 INFO - argparse == 1.2.1 07:25:50 INFO - blessings == 1.5.1 07:25:50 INFO - blobuploader == 1.2.4 07:25:50 INFO - docopt == 0.6.1 07:25:50 INFO - manifestparser == 1.1 07:25:50 INFO - mozInstall == 1.12 07:25:50 INFO - mozcrash == 0.16 07:25:50 INFO - mozdebug == 0.1 07:25:50 INFO - mozdevice == 0.47 07:25:50 INFO - mozfile == 1.2 07:25:50 INFO - mozhttpd == 0.7 07:25:50 INFO - mozinfo == 0.9 07:25:50 INFO - mozleak == 0.1 07:25:50 INFO - mozlog == 3.1 07:25:50 INFO - moznetwork == 0.27 07:25:50 INFO - mozprocess == 0.22 07:25:50 INFO - mozprofile == 0.27 07:25:50 INFO - mozrunner == 6.11 07:25:50 INFO - mozscreenshot == 0.1 07:25:50 INFO - mozsystemmonitor == 0.0 07:25:50 INFO - moztest == 0.7 07:25:50 INFO - mozversion == 1.4 07:25:50 INFO - psutil == 3.1.1 07:25:50 INFO - requests == 1.2.3 07:25:50 INFO - wsgiref == 0.1.2 07:25:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25: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')]} 07:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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')]} 07:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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', '-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 0x7fc52ea03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd0b0>, '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 0x1afdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afe440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441', '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 07:25:50 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 07:25:50 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 07:25:50 INFO - Using env: {'DISPLAY': ':0', 07:25:50 INFO - 'HOME': '/home/cltbld', 07:25:50 INFO - 'LANG': 'en_US.UTF-8', 07:25:50 INFO - 'LANGUAGE': 'en_US:en', 07:25:50 INFO - 'LOGNAME': 'cltbld', 07:25:50 INFO - 'MAIL': '/var/mail/cltbld', 07:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:50 INFO - 'MOZ_NO_REMOTE': '1', 07:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:50 INFO - 'NO_EM_RESTART': '1', 07:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:50 INFO - 'PWD': '/builds/slave/test', 07:25:50 INFO - 'SHELL': '/bin/bash', 07:25:50 INFO - 'SHLVL': '1', 07:25:50 INFO - 'TERM': 'linux', 07:25:50 INFO - 'TMOUT': '86400', 07:25:50 INFO - 'USER': 'cltbld', 07:25:50 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441', 07:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:50 INFO - '_': '/tools/buildbot/bin/python'} 07:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:50 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)) 07:25:50 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)) 07:25:50 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)) 07:25:50 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)) 07:25:50 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)) 07:25:50 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)) 07:25:50 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)) 07:25:50 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)) 07:25:50 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)) 07:25:50 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)) 07:25:50 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)) 07:25:50 INFO - Cleaning up... 07:25:50 INFO - Return code: 0 07:25:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:25: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')]} 07:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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')]} 07:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc52ea03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd0b0>, '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 0x1afdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afe440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441', '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 07:25: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', 'jsonschema'] in /builds/slave/test/build 07:25: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 jsonschema 07:25:50 INFO - Using env: {'DISPLAY': ':0', 07:25:50 INFO - 'HOME': '/home/cltbld', 07:25:50 INFO - 'LANG': 'en_US.UTF-8', 07:25:50 INFO - 'LANGUAGE': 'en_US:en', 07:25:50 INFO - 'LOGNAME': 'cltbld', 07:25:50 INFO - 'MAIL': '/var/mail/cltbld', 07:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:50 INFO - 'MOZ_NO_REMOTE': '1', 07:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:50 INFO - 'NO_EM_RESTART': '1', 07:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:50 INFO - 'PWD': '/builds/slave/test', 07:25:50 INFO - 'SHELL': '/bin/bash', 07:25:50 INFO - 'SHLVL': '1', 07:25:50 INFO - 'TERM': 'linux', 07:25:50 INFO - 'TMOUT': '86400', 07:25:50 INFO - 'USER': 'cltbld', 07:25:50 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441', 07:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:50 INFO - '_': '/tools/buildbot/bin/python'} 07:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:51 INFO - Downloading/unpacking jsonschema 07:25:51 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 07:25:51 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 07:25:51 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 07:25:51 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 07:25:51 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 07:25:51 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 07:25:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:25:52 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 07:25:52 INFO - Downloading/unpacking functools32 (from jsonschema) 07:25:52 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 07:25:52 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 07:25:52 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 07:25:52 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 07:25:52 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 07:25:52 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 07:25:52 INFO - Downloading functools32-3.2.3-2.tar.gz 07:25:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:25:53 INFO - warning: no files found matching '*.txt' 07:25:53 INFO - no previously-included directories found matching 'build' 07:25:53 INFO - no previously-included directories found matching 'dist' 07:25:53 INFO - no previously-included directories found matching '.git*' 07:25:53 INFO - Installing collected packages: jsonschema, functools32 07:25:53 INFO - Running setup.py install for functools32 07:25:53 INFO - warning: no files found matching '*.txt' 07:25:53 INFO - no previously-included directories found matching 'build' 07:25:53 INFO - no previously-included directories found matching 'dist' 07:25:53 INFO - no previously-included directories found matching '.git*' 07:25:53 INFO - Successfully installed jsonschema functools32 07:25:53 INFO - Cleaning up... 07:25:53 INFO - Return code: 0 07:25:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:25: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')]} 07:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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')]} 07:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc52ea03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd0b0>, '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 0x1afdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afe440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441', '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 07:25: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', 'flake8'] in /builds/slave/test/build 07:25: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 flake8 07:25:53 INFO - Using env: {'DISPLAY': ':0', 07:25:53 INFO - 'HOME': '/home/cltbld', 07:25:53 INFO - 'LANG': 'en_US.UTF-8', 07:25:53 INFO - 'LANGUAGE': 'en_US:en', 07:25:53 INFO - 'LOGNAME': 'cltbld', 07:25:53 INFO - 'MAIL': '/var/mail/cltbld', 07:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:53 INFO - 'MOZ_NO_REMOTE': '1', 07:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:53 INFO - 'NO_EM_RESTART': '1', 07:25:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:53 INFO - 'PWD': '/builds/slave/test', 07:25:53 INFO - 'SHELL': '/bin/bash', 07:25:53 INFO - 'SHLVL': '1', 07:25:53 INFO - 'TERM': 'linux', 07:25:53 INFO - 'TMOUT': '86400', 07:25:53 INFO - 'USER': 'cltbld', 07:25:53 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441', 07:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:53 INFO - '_': '/tools/buildbot/bin/python'} 07:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:53 INFO - Downloading/unpacking flake8 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:25:55 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 07:25:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:25:55 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 07:25:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25:55 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 07:25:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:25:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:25:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:25:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:25:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:25:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:25:55 INFO - no previously-included directories found matching 'docs/_build' 07:25:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:25:55 INFO - Running setup.py install for pep8 07:25:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:25:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:25:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:25:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:25:55 INFO - no previously-included directories found matching 'docs/_build' 07:25:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:25:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:25:55 INFO - Cleaning up... 07:25:56 INFO - Return code: 0 07:25:56 INFO - Running post-action listener: _resource_record_post_action 07:25:56 INFO - Running post-action listener: _start_resource_monitoring 07:25:56 INFO - Starting resource monitoring. 07:25:56 INFO - ##### 07:25:56 INFO - ##### Running install step. 07:25:56 INFO - ##### 07:25:56 INFO - Running pre-action listener: _resource_record_pre_action 07:25:56 INFO - Running main action method: install 07:25:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:25:56 INFO - Reading from file tmpfile_stdout 07:25:56 INFO - Detecting whether we're running mozinstall >=1.0... 07:25:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:25:56 INFO - Reading from file tmpfile_stdout 07:25:56 INFO - Output received: 07:25:56 INFO - Usage: mozinstall [options] installer 07:25:56 INFO - Options: 07:25:56 INFO - -h, --help show this help message and exit 07:25:56 INFO - -d DEST, --destination=DEST 07:25:56 INFO - Directory to install application into. [default: 07:25:56 INFO - "/builds/slave/test"] 07:25:56 INFO - --app=APP Application being installed. [default: firefox] 07:25:56 INFO - mkdir: /builds/slave/test/build/application 07:25:56 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'] 07:25:56 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 07:26:10 INFO - Reading from file tmpfile_stdout 07:26:10 INFO - Output received: 07:26:10 INFO - /builds/slave/test/build/application/firefox/firefox 07:26:10 INFO - Running post-action listener: _resource_record_post_action 07:26:10 INFO - ##### 07:26:10 INFO - ##### Running run-tests step. 07:26:10 INFO - ##### 07:26:10 INFO - Running pre-action listener: _resource_record_pre_action 07:26:10 INFO - Running main action method: run_tests 07:26:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:26:10 INFO - Python 2.7.3 07:26:10 INFO - Return code: 0 07:26:10 INFO - grabbing minidump binary from tooltool 07:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:26:10 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 0x1afd0b0>, '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 0x1afdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afe440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:26:10 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 07:26:10 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 07:26:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:26:10 INFO - Return code: 0 07:26:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:26:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:26:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:26:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:26:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:26:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:26:11 INFO - Return code: 0 07:26:11 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/mXqUEzUFQFaBAzzaoyUQqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost'] in /builds/slave/test/build 07:26:11 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/mXqUEzUFQFaBAzzaoyUQqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost 07:26:11 INFO - Using env: {'DISPLAY': ':0', 07:26:11 INFO - 'HOME': '/home/cltbld', 07:26:11 INFO - 'LANG': 'en_US.UTF-8', 07:26:11 INFO - 'LANGUAGE': 'en_US:en', 07:26:11 INFO - 'LOGNAME': 'cltbld', 07:26:11 INFO - 'MAIL': '/var/mail/cltbld', 07:26:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:26:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:11 INFO - 'MOZ_NO_REMOTE': '1', 07:26:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:11 INFO - 'NO_EM_RESTART': '1', 07:26:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:11 INFO - 'PWD': '/builds/slave/test', 07:26:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:26:11 INFO - 'SHELL': '/bin/bash', 07:26:11 INFO - 'SHLVL': '1', 07:26:11 INFO - 'TERM': 'linux', 07:26:11 INFO - 'TMOUT': '86400', 07:26:11 INFO - 'USER': 'cltbld', 07:26:11 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441', 07:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:11 INFO - '_': '/tools/buildbot/bin/python'} 07:26:11 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/mXqUEzUFQFaBAzzaoyUQqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost'] with output_timeout 3600 07:26:12 INFO - mozversion INFO | application_buildid: 20151215055512 07:26:12 INFO - mozversion INFO | application_changeset: 8d24d95b8a13a1a50cb58bbb941c5337522e665b 07:26:12 INFO - mozversion INFO | application_display_name: Nightly 07:26:12 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:26:12 INFO - mozversion INFO | application_name: Firefox 07:26:12 INFO - mozversion INFO | application_remotingname: firefox 07:26:12 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 07:26:12 INFO - mozversion INFO | application_vendor: Mozilla 07:26:12 INFO - mozversion INFO | application_version: 46.0a1 07:26:12 INFO - mozversion INFO | platform_buildid: 20151215055512 07:26:12 INFO - mozversion INFO | platform_changeset: 8d24d95b8a13a1a50cb58bbb941c5337522e665b 07:26:12 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 07:26:12 INFO - mozversion INFO | platform_version: 46.0a1 07:26:12 INFO - 2015-12-15 07:26:12,082 DEBUG : using testdate: 1450193172 07:26:12 INFO - 2015-12-15 07:26:12,082 DEBUG : actual date: 1450193172 07:26:12 INFO - 2015-12-15 07:26:12,095 INFO : starting webserver on 'localhost:56850' 07:26:12 INFO - 2015-12-15 07:26:12,096 INFO : Starting test suite talos-linux64-ix-001.e 07:26:12 INFO - 2015-12-15 07:26:12,096 INFO : Starting test dromaeo_css 07:26:12 INFO - 2015-12-15 07:26:12,096 DEBUG : operating with platform_type : linux_ 07:26:12 INFO - 2015-12-15 07:26:12,097 INFO : Initialising browser for dromaeo_css test... 07:26:12 INFO - 2015-12-15 07:26:12,109 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCkhxi7/profile http://localhost:56850/getInfo.html 07:26:17 INFO - 2015-12-15 07:26:17,152 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:26:17 INFO - 2015-12-15 07:26:17,152 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:26:17 INFO - 2015-12-15 07:26:17,152 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:26:17 INFO - 2015-12-15 07:26:17,152 DEBUG : BROWSER_OUTPUT: __metrics 07:26:17 INFO - 2015-12-15 07:26:17,257 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] 07:26:18 INFO - 2015-12-15 07:26:18,382 INFO : Browser initialized. 07:26:18 INFO - 2015-12-15 07:26:18,383 INFO : Running cycle 1/1 for dromaeo_css test... 07:26:18 INFO - 2015-12-15 07:26:18,383 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCkhxi7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:26:30 INFO - 2015-12-15 07:26:30,488 DEBUG : BROWSER_OUTPUT: RSS: Main: 142671872 07:26:30 INFO - 2015-12-15 07:26:30,488 DEBUG : BROWSER_OUTPUT: 07:27:20 INFO - 2015-12-15 07:27:20,128 DEBUG : BROWSER_OUTPUT: 1450193240127 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] 07:29:32 INFO - 2015-12-15 07:29:32,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56850/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56850/tests/dromaeo/cssquery-ext.html) 07:29:33 INFO - 2015-12-15 07:29:33,251 DEBUG : BROWSER_OUTPUT: RSS: Main: 146984960 07:29:33 INFO - 2015-12-15 07:29:33,251 DEBUG : BROWSER_OUTPUT: 07:32:35 INFO - 2015-12-15 07:32:35,335 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56850/tests/dromaeo/cssquery-ext.html (next: http://localhost:56850/tests/dromaeo/cssquery-jquery.html) 07:32:35 INFO - 2015-12-15 07:32:35,929 DEBUG : BROWSER_OUTPUT: RSS: Main: 144850944 07:32:35 INFO - 2015-12-15 07:32:35,929 DEBUG : BROWSER_OUTPUT: 07:35:37 INFO - 2015-12-15 07:35:37,665 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56850/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56850/tests/dromaeo/cssquery-mootools.html) 07:35:38 INFO - 2015-12-15 07:35:38,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 144912384 07:35:38 INFO - 2015-12-15 07:35:38,253 DEBUG : BROWSER_OUTPUT: 07:38:40 INFO - 2015-12-15 07:38:40,018 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56850/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56850/tests/dromaeo/cssquery-prototype.html) 07:38:40 INFO - 2015-12-15 07:38:40,612 DEBUG : BROWSER_OUTPUT: RSS: Main: 144371712 07:38:40 INFO - 2015-12-15 07:38:40,612 DEBUG : BROWSER_OUTPUT: 07:41:43 INFO - 2015-12-15 07:41:43,155 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56850/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56850/tests/dromaeo/cssquery-yui.html) 07:41:43 INFO - 2015-12-15 07:41:43,781 DEBUG : BROWSER_OUTPUT: RSS: Main: 143892480 07:41:43 INFO - 2015-12-15 07:41:43,782 DEBUG : BROWSER_OUTPUT: 07:44:46 INFO - 2015-12-15 07:44:46,246 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56850/tests/dromaeo/cssquery-yui.html (next: http://localhost:56850/tests/dromaeo/cssquery-dojo.html) 07:44:46 INFO - 2015-12-15 07:44:46,496 DEBUG : BROWSER_OUTPUT: RSS: Main: 146755584 07:44:46 INFO - 2015-12-15 07:44:46,497 DEBUG : BROWSER_OUTPUT: 07:44:46 INFO - 2015-12-15 07:44:46,498 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:44:46 INFO - 2015-12-15 07:44:46,498 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:44:46 INFO - 2015-12-15 07:44:46,498 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:44:46 INFO - 2015-12-15 07:44:46,498 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:44:46 INFO - 2015-12-15 07:44:46,499 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2692.380752426942;2721.2244510314563;2764.1016669582377;2770.5705615629586;2782.360057186847;4617.930731039029;4752.5960293375065;4758.2148945424005;4782;4796.328514008042;4701.788419521121;4705.200115980291;4736.97631511842;4809.615230781538;4863.659543831925;4365.432493775805;4407.338899165119;4439.422875026258;4454.3318502224765;4505.707129036602;4234.06850492891;4454.510003899569;4459.308807134899;4468.664850136237;4480.350349199364;4375.890602734941;4459.598636122764;4469.971906461532;4484.8878778030485;4501.347304640842;4393.275109606911;4418.9337159942625;4421.646268298528;4454.0646464242545;4456.22016147173;4208.263553878059;4286.828526858922;4329.134173165379;4398.450193725785;4411.470623525165;4677.228257337535;4712.31671407644;4724.7401392923375;4751.121042607094;4775.450823155347;5120.718360490171;5121.539061484485;5137.614678899097;5137.922931156036;5151.45909679482;4918;4995.650304478688;5060.645754797166;5160.6129540284255;5224.582033437316;4730.361401210827;4800.7119572825395;4813.927791083137;4823.083614113307;4867.099586576494;5261.657992230493;5298.97350513245;5302.708351040653;5313.734313284321;5331.013762453958;4790.185668436374;4882.707037577757;4929.457759646436;4984.451710311862;5040.1179793535985;5151.922721159186;5201.739913004335;5202.92195617066;5208.166693329049;5265.868353291122;4892.877678058077;5141.331626888556;5145.9485405146215;5146.536811686966;5151.381834179848;4955.925661115086;4982.402111746541;5038.64729468941;5042.924356134661;5099.515546023122;4262.232798096373;4269.765162916007;4277.016286254179;4300.548442413564;4312.116016216668;3623.1304486923477;3721.683656889141;3763.717721170923;3774.037620406779;3798.772073675588;4343.869683909425;4399.6040356368085;4420.204363214588;4430.357598148251;4441.977790111029;5116.155834287375;5120.8719782005;5122.718250496258;5126.333576635014;5156.535911767884;4254.681048874859;4321.740695558214;4339.1104823511105;4411.448568928884;4474.843380481668;4487.977560112178;4510;4519.299508576176;4536.6824322297125;4569.908601827945;4870.293807397908;4876.853694389245;4898.779554920108;4922.876928076755;4950.232713929347;4870.172070748053;4965.602751779777;4980.825671101494;5120.359955005624;5167.767450464663;4782.545658162469;4790.065937142223;4864.586510146536;4867.367242258484;4869.95130048695;5067.41724701664;5126.743662816919;5126.79492820283;5132.255822905732;5178;4857.927131092966;4962.082014827269;5170.896582068262;5173.689578625294;5192.350956130484;4867.050925069578;4874.829380971649;4878.390201224847;4981.053599816023;4985.5762260208285;4997.900041999067;5019.7239151847;5037.949620503748;5053.444121146745;5095.566876815364;4875.1224779540025;4907;4917.606591472602;4930.950690493192;4955.702657840541;4718.3394324795245;4886.120498310338;4889.339939108175;4961.206207006861;4961.70229786214;4910.06708725341;4922.483139270468;4929.088118698052;4937.308776771183;5016 07:44:46 INFO - 2015-12-15 07:44:46,500 DEBUG : BROWSER_OUTPUT: |1;ext.html;528.9841304760859;531.2429787552737;533.685125775792;548.8435795798196;550.4990458682598;31542.369152616964;31839.84080079602;32028.519572206435;32067.19832004201;32070.198245043885;37075.44386834193;37357.06607334818;37673;38026;38061;7868.25251601097;8034.156413576548;8038.839223215532;8045.517268963852;8051.516908985451;7872.488288261245;7971.720989765359;7977.641006154708;7999.480033797814;8002.799930001738;7879.1726868678825;7896.091949425832;7923.445358824856;7937.801554961115;7940.722074727386;7593.392528597699;7630.122535908358;7639.350655194316;7655.578943158124;7666.731664391719;7799.5710235937;7911.446198766089;7916.881246781303;7919.366450683931;7920.168382319831;35499;35910.46134307988;35943.4608480873;35955.46066808974;35987.4601880972;2972.583838262645;3003.065670944693;3019.607451031352;3053.282478617523;3079.8460076996284;26676.33309167267;27228.45543089147;27354.45291094167;27481.038163664376;27780.58329125065;2979.575013283929;3061.4183305171946;3091.458994675945;3126.1559378967777;3148.5592017117624;211699;211835;212690.93654531782;213476;213737;50651.17511486152;53862;54158.18762718562;54177.1873421899;54321;45631;64580;65368.67315663486;65594.34405655978;65616.34383656198;11988.700282493008;11993.400329983466;12047.216930899638;12075;12075.215111017756;9472.526373681289;9513.809723805485;9514.714558563253;9523.952380238054;9552.61789528425;18820.811791881904;19037.714434283498;19139.330123445612;19182.808171918383;19333.51666208328;7579.5073320234005;7788.104367997639;7850.528968261922;7851.097123830718;7973.322267607203;889.8309321229075;899.5142622983647;913.1781396742851;933.6872147830417;975.8731364922514;25879.74120258811;25947.962081516904;25972.220833375028;29142.562861557093;30294.697053029628;959.2086528613921;988.7775250568708;997.6258902911409;1005.5123265216364;1065.477915821242;12623.810642840364;15224.543263702106;15267.770983435257;15373.923130384277;15699.372025119095;304474;309039;310101;311062;311771;45897.31154032692;46050;46130.00154989915;46134.30798538025;46136;1184.691980085184;1195.9461824217758;1200.933948632816;1203.6810245285183;1208.8186771984272;26165.410545456383;26194.60708089342;26440.338991525365;26614.600780988687;26631.866840665672;38312.233755325295;38575.807120964215;38985;39029.804850976696;39127.41308880312;245633;245799.771001151;246981;247239;248009;28486.287842803267;41531.584684152775;41926.371104432845;41954;42012.3698144522;36702;36864.81567592145;37351.25297494089;37919.62080379271;38113;31757.523637145925;32218.35563288768;32534.51198231981;32645.836770815993;32979;32782;36247;38435.42346864855;38463.14970525722;38612.227755445296;31875.521867172476;31954;32440.35119297648;32574;32599;28927.56608650914;29266.7073329264;29615.434262394785;30178.396432070796;33168.6281556012;23250.651240231073;23537;23648.408789780395;23650.64524032175;23768.168114116615 07:44:46 INFO - 2015-12-15 07:44:46,501 DEBUG : BROWSER_OUTPUT: |2;jquery.html;336.5893609796048;338.95085212644165;340.4467739922626;340.89210067281334;343.61171875780366;10352.741181470466;10738.9059133469;14772.556823295305;14868;15688.294026768808;14986.325615347308;15053.17207553587;15101.169435681033;15427.305771240293;15802.683946321067;5668.518175955039;5830.591858569902;6397.296297407282;6612.900806487906;6627.60234385936;6535.57518761279;6571.375719306682;6573.112629794964;6573.704183311763;6574.506911981596;6331.55679102463;6364.872702545947;6520.152380190569;6538.705758240867;6580.210374755012;6486.870262594769;6593.307702691221;6608.735650573972;6623.437007854338;6637.535372523926;6393.392627700361;6395.744170233185;6396.392342727433;6403.583767055126;6409.519286053564;19421;21248.893755531277;21708.69747815136;21752.673709894363;21889.67165492519;1983.4644645945514;2108;2130.3289463818846;2147.538279269949;2159.946001349963;13994.300284985811;14018.299085045706;14073.71852562943;14297;14482.49311274111;1885.481492589535;1898.1742941820353;1900.5628705397835;1969.1827891425041;1997.121266642687;61911.69044154751;64226.678866605835;64798;65512.672436637986;66300.33699663039;15359.308831102628;15463.149526775911;15564.92217538905;15568.299426525607;15754.133522656364;22999.770002300098;23068.19261325879;23262.185823496096;23269.06923723066;23287.18494852672;8167.183281671785;8194.631241594143;8195.098539160688;8253;8292.543910084883;6752.628605426748;6753.628550429676;6777.796666100025;6790;6800.31996800316;7568.5458872467825;7577.939088527611;7586.848263034708;7640.197779233212;7654.2345765424125;1678.5048410718623;2959.5856580078807;3006.428778532072;3012.11742660837;3026.8800543798934;790.6244533846377;817.4237162800212;824.1675907333636;865.7662431143556;879.6965047058754;14159.504417345344;14339.99620026609;14720.969532132862;14936.775948360782;14952.925235373754;831.7255305749088;854.6495936665937;866.5320726807579;902.6073657958809;946.195733626412;8469.40714150016;8475.152484751476;8546.102659220816;8556.57217139153;8639.438436501607;519281;525213;526533;528025.1178649858;540916;68677.65661171662;74579.25420745723;74893.62553187199;75140.24859751442;77938.61030694924;1026.5996261458038;1042.8227201375785;1053.2995557954027;1054.847047178155;1074.9946250268856;14424.639384015483;14479.203643799692;14523.128612283297;14541.127532348093;15000.924995374953;32716.8207948013;32796.67203327936;33343;33682;33801.49297760487;42393.576064238965;42903.57096428996;43128.78435607802;45173.32240016468;46063.309050364944;8779;8890.422122562013;8935.910640893508;9009.684661036832;9035.322350823846;11955.760884782081;15813.604659883595;16279.51161465158;16344.346226150821;16387.18064096814;9994.950025249827;10536.525856336637;11801.704957376134;12995.935020325216;13098.476060957837;12415;12553.121281510206;12710;12993.220406775623;13078.411471483616;2337.953240935206;11765.941170294094;12392.698766629735;12924.224546527239;13714.451421943011;8619;8630.345343473382;8656.134386561294;8659.696910608098;8708.042115367178;12249.816252756395;13421.731565368833;13428.597142085753;13455.125416847874;14044.859551404765 07:44:46 INFO - 2015-12-15 07:44:46,505 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1473;1632.2410079313117;1696.7285234362505;1706.2833609883844;1719.2435328455479;7119.537230080041;7187.209406965243;7373.373263272628;7397.556146631206;7407.185209626937;7203.207647158808;7220.747273845416;7304.671289791959;7325.12098548175;7329.486935914488;2071.751389833222;2089.9059542320633;2091.5607722378318;2092.3199960013058;2100.8130406320456;2079.8336133109315;2091.1530830013867;2106.926257580985;2116.9682454763115;2120.4592828828704;1733.6272701369203;1758.1560850791627;2039.612473630013;2059.042545216474;2063.6801295799173;2017.7175195472646;2018.1523760020752;2027.1891243502569;2027.3107143571256;2032.2175962254491;2021.1511165310606;2048.3342913553006;2061.3403710812545;2070.1822780001967;2084.8436367272516;7129.786106416764;7222.494425390225;7257.745978890714;7281.672324745399;7283.635818209122;4136.255474014676;4164.333706606959;4170.812313445872;4185.058361868555;4188.204241194194;2749.312671832042;2783.958240626392;2812.4937511247967;2820.689724130344;2839.1198728394265;901.0944001278673;1570.8193557740778;1592.1004632382667;1649.4170505884153;1677.3290683726484;9235.030321816246;9398.483083430408;9424.104710052534;9432.528373581363;9452.716418507525;3701.5373078365205;3769.6795772359656;3824.330742120118;3825.4261860721112;3829.6744776694295;7626.694932202649;7738.303552680286;7751.651175697107;7759.030121234846;7767.883481747778;4142.71001029925;4150.543440221573;4155.937660935088;4160.646345060643;4161.854335098257;3814.3324918139215;3825.5218097737784;3825.923481530354;3839.884803455901;3844.5770965193806;3123.109913674592;3134.968650313513;3167.7307428868803;3188.984055079756;3191.505316675919;925.4724806860025;941.1294552538874;942.0673533202081;967.4098799732158;968.1673760565908;839.3788596438714;885.0574138542431;909.5679552212779;952.4523399045577;984.886738025122;6757.493188010821;6823.727050917908;6841.17905851301;6848.246692863781;6860.348266914635;577.2726364780323;593.3888095261888;596.6718304932269;600.5315853634172;738.985220295591;5132.640715149903;5155.9742201288755;5286.286351342596;5286.735663216824;5289.920651190235;8392.874106888401;8702.347323950602;8780.736577902673;8786.60460279289;8826.823463530693;8615.095414981462;8683.522406267715;8694.956525217334;8709.390342676079;8720.520371379509;6674.16572928384;6846;6870.7595234166565;6884.347756538395;6924.826879328057;6565.244996825426;6602.372774586406;6604.8348791280605;6633.469322454095;6639.734410623521;7635.809104772425;7821.256980586835;7837.25546073145;7839.78483335084;7930.405219608437;7890.921090789248;7994.52032878006;8083.757487275391;8101.513909165469;8106.513609183232;6044.637321760709;6061.787837425669;6070.817875463743;6139.754409823736;6142.785002525069;6943.236244013256;6972.546784458994;6990.370866622028;6992.370686638227;6999.755008574879;6304.275008373912;6362.968185159045;6369.9681501592195;6466.902996455151;6538.607683539003;6289.7169627365965;6412.839679008062;6482.740690372521;6489.221293444628;6569.37590928861;6527.706253218712;6606.372394622503;6620.900686489803;6634;6658.3674550917585;6085.756569737338;6101.38986101404;6113.5414843887775;6132.41742034506;6153.507719382349;6100.420460056288;6127.540434467522;6144.78493252734;6150;6153.2616086068165 07:44:46 INFO - 2015-12-15 07:44:46,505 DEBUG : BROWSER_OUTPUT: |4;prototype.html;281.64794007490633;294.3773918163085;295.20442407711226;298.2454390392308;298.7833820480152;5521.668699878011;5553.055980483323;5586.6368686035485;5613.43865613439;5615.129654903497;5485.040117979348;5496.7526461309235;5503.3120859892515;5505.201745746875;5509.201165830952;4257.276263035292;4265;4270.701050926436;4277.615014648681;4283.957160428403;4128.607782260696;4165.56261592533;4183.560726123744;4188.350805625133;4200.1599680063955;4117.855875044374;4163.625273725364;4176.227397931392;4178.185253875496;4180.393842892779;4175.144095460439;4175.62419382257;4177.791110444466;4187.853425130136;4197.412362269285;3609.06164397256;3618.8733394331334;3623.166671665532;3628.4738712886747;3635.1820840310984;5240.7379631018675;5336.9733151334385;5357.571394288448;5372.006178856885;5428.077226871442;4802.351682522884;4806.639502037361;4809.1343558159515;4812.7352995585225;4813.253945638432;5819.505342045931;5860.619059761145;5871.735771890275;5873.119032145212;5880;3936.6063393660693;3942.921141577181;3949.032487040665;3951.0714981979213;3954.584768599313;5965.4631083202285;6040.12418199363;6128.203333566652;6158.0147176452;6163.907541386883;4030.334994725896;4057.087155390014;4060.837566497307;4060.939085913714;4064.878053658395;4117.526484454266;4119.134981653886;4120.8145633445965;4121.381792731055;4130.855420060284;4780.995990841962;4789.3294938708605;4789.401324834395;4792.616590672737;4797.7601119943865;5725.427457254241;5754.136879468113;5815.680137592473;5831.970840145772;5845.795397161079;1426.6290764401124;1443.6102252391795;1444.241773069126;1445.2701385800103;1445.71808497342;923.5751554285104;932.2402242172608;933.2114363362947;937.0863408176973;941.5904081724472;5073.365829271341;5075.5178258065425;5079.263506791494;5116.948830511647;5117.71852548106;5998.70006499682;6023.728932198062;6051.515878729691;6103.05402662588;6152.2924863640355;5121.540360997098;5124.5131712487255;5144.6913185209005;5150.381954165524;5154.561862241677;3250.414925313419;3280.491523813813;3281.671832816747;3291.637919828817;3295.5715756951445;5779.335376431764;5783.88432231353;5803.158542011384;5806.622569533051;5812;6099.939000610026;6294.527910406646;6300.0234963580715;6302.2122234719745;6303.779367722108;5778.88442231153;5782.739776710058;5784.8264552062665;5794.478496935211;5800.88398232033;6093.390660934048;6098.695065246631;6100.938990610214;6114.052321890114;6114.449699527064;5862.560307977004;5933.465988061095;5968.373320801254;5970.671613061149;5988.880222395441;5776.9133462998925;5779.104238842818;5781.913271300849;5788.479036886532;5806.44838740319;3986.9202615948097;4041.5958404160524;4042.7372220805555;4043.8180281887976;4052.8986775330854;5954.553408494294;6081.331053584191;6086.269647642134;6092.573519853745;6097.32929377777;5837.854053648693;5841.1238314253205;5846.56150788684;5847.795327163529;5873.559483038704;5848.561357898089;5853.531717462678;5857.150713146655;5878.588498805043;5885.852853678693;5718.628289161191;5732.054211055296;5751.827445176651;5753.05074662676;5754.482096611325;5718.1708652246025;5929;5960.552958528215;5964.314103877936;5966.970165149147;5740.622250659895;5780.971095144498;5783.768649253982;5804.970975145097;5815.389384114607 07:44:46 INFO - 2015-12-15 07:44:46,508 DEBUG : BROWSER_OUTPUT: |5;yui.html;660.4650233311015;667.6394746836709;729.1796728680234;788.8422315536892;792.4294507954273;10839.512221950012;11142.554297828086;11151.219414640978;11162.665120046402;11171;12356.691082722913;12756.107072504929;12773.105882588223;12780.744385112292;12793.872061279384;781.2539025230919;783.4554984285924;789.4039999800143;796.2475460689651;798.1938242375214;787.3661702329651;793.4763056382789;798.3812545277399;798.9840203195932;799.1648727080186;812.475953010308;815.8694608862584;817.8732296494053;818.8771684247351;819.1194465949098;813.7558732380262;815.5473712089788;815.8613035783931;817.1624085312543;818.0183779464667;594.2393736017904;599.5563283170466;605.4550904186224;605.7334772699998;606.6633018674634;11573.826392604118;11659.708507287301;11672.066234701204;11673.357965311905;11674.591389301419;10796.082333001705;10879.292845965067;11040.117835567622;11441.084713222923;11826.467808948619;9107.362484626012;9152.725418237464;9257.213136883372;9351.812963740755;9462.763430914214;3100.472919603673;3118.781685282031;3135.216195951012;3148.134263077649;3200.1839530919465;41174.79412602918;41185.382219266736;41721;41983.580164198574;42022;9171.81656366869;9236.72289831306;9242.768930776785;9355.672551460666;9381.765455863659;15576.688466230838;15695.450659227101;15748;15813.1302778346;15815.841841581438;6086.573939824169;6191.071339299051;6210.472109870711;6217.440430361289;6234.189555357865;3510.596281427617;3564.0733409313248;3573.6069032406413;3586.8385922633543;3616.72874534411;2611.4646497467975;2635.512430200419;2643.2730998975435;2651.496215719007;2654.230273220783;453.2136742751324;460.7926433105116;470.17484315027593;474.54917828062787;479.46300143839125;466.22141024489184;473.758383224558;494.45609829187606;563.7681665560681;570.6005795942774;7521.247875212544;7653.4642575020325;7685.846283074307;7909;7968;439.9780010999437;445.2541992163114;467.4390731122666;489.9441703129761;524.4991033562939;3586.7668601540818;3680.926381472409;3860.654351567225;3929.4498770171626;4212.68404869636;54291.72854135704;54716.179257311174;55247;55829.44170558324;55935;45850;47022.76488617535;48441.5155848437;48583.028339433724;48992.265116023285;41802.79098604488;41853.58146418497;42048.159036819095;42508.78745606314;42866.571334286884;8408.83182336362;8588.742337729878;8607.698730544402;8828.602712878064;8831.514266715392;31310.37379252448;31443.68556314499;31947.6805231954;32066.679333206368;32145;36429.81785091058;38291.6170838288;41008.79495602503;41838.79080604578;43679;10509.054185123376;10524.31591946521;10893.564257429614;10937.671869843918;11231.55073797039;11417.543298267976;11566.884331156582;11664.872837439181;12137.514499419924;12528;10500.389680461947;10547.841782373118;10670;11033.172512061788;11123.555057797921;10553.525091370753;10776.67669969902;10957.780844383227;11180.832287515856;11347.432628368713;9345.672901448417;9430.575624096795;9439.622415103318;9491.952540237531;9667.274954378308;8538.359623028422;8577.185167409087;8612.741617751477;8767.606159728888;9229.769255768659;8277.255047045795;8759.868601971102;8977.7755556109;9034.683786067457;9077 07:44:46 INFO - 2015-12-15 07:44:46,508 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:44:46 INFO - 2015-12-15 07:44:46,508 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:44:46 INFO - 2015-12-15 07:44:46,508 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,321 07:44:46 INFO - 2015-12-15 07:44:46,508 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:44:46 INFO - 2015-12-15 07:44:46,509 DEBUG : BROWSER_OUTPUT: __startTimestamp1450194286496__endTimestamp 07:44:46 INFO - 2015-12-15 07:44:46,509 DEBUG : BROWSER_OUTPUT: 07:44:46 INFO - 2015-12-15 07:44:46,509 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:44:46 INFO - 2015-12-15 07:44:46,509 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:44:46 INFO - 2015-12-15 07:44:46,509 DEBUG : BROWSER_OUTPUT: 07:44:46 INFO - 2015-12-15 07:44:46,509 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4718.58 Median:4867.37 stddev:491.69 (10.1%) stddev-sans-first:466.80 07:44:46 INFO - 2015-12-15 07:44:46,509 DEBUG : BROWSER_OUTPUT: Values: 2692.4 2721.2 2764.1 2770.6 2782.4 4617.9 4752.6 4758.2 4782.0 4796.3 4701.8 4705.2 4737.0 4809.6 4863.7 4365.4 4407.3 4439.4 4454.3 4505.7 4234.1 4454.5 4459.3 4468.7 4480.4 4375.9 4459.6 4470.0 4484.9 4501.3 4393.3 4418.9 4421.6 4454.1 4456.2 4208.3 4286.8 4329.1 4398.5 4411.5 4677.2 4712.3 4724.7 4751.1 4775.5 5120.7 5121.5 5137.6 5137.9 5151.5 4918.0 4995.7 5060.6 5160.6 5224.6 4730.4 4800.7 4813.9 4823.1 4867.1 5261.7 5299.0 5302.7 5313.7 5331.0 4790.2 4882.7 4929.5 4984.5 5040.1 5151.9 5201.7 5202.9 5208.2 5265.9 4892.9 5141.3 5145.9 5146.5 5151.4 4955.9 4982.4 5038.6 5042.9 5099.5 4262.2 4269.8 4277.0 4300.5 4312.1 3623.1 3721.7 3763.7 3774.0 3798.8 4343.9 4399.6 4420.2 4430.4 4442.0 5116.2 5120.9 5122.7 5126.3 5156.5 4254.7 4321.7 4339.1 4411.4 4474.8 4488.0 4510.0 4519.3 4536.7 4569.9 4870.3 4876.9 4898.8 4922.9 4950.2 4870.2 4965.6 4980.8 5120.4 5167.8 4782.5 4790.1 4864.6 4867.4 4870.0 5067.4 5126.7 5126.8 5132.3 5178.0 4857.9 4962.1 5170.9 5173.7 5192.4 4867.1 4874.8 4878.4 4981.1 4985.6 4997.9 5019.7 5037.9 5053.4 5095.6 4875.1 4907.0 4917.6 4931.0 4955.7 4718.3 4886.1 4889.3 4961.2 4961.7 4910.1 4922.5 4929.1 4937.3 5016.0 07:44:46 INFO - 2015-12-15 07:44:46,509 DEBUG : BROWSER_OUTPUT: 07:44:46 INFO - 2015-12-15 07:44:46,509 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41650.91 Median:35926.96 stddev:67821.88 (188.8%) stddev-sans-first:67941.86 07:44:46 INFO - 2015-12-15 07:44:46,509 DEBUG : BROWSER_OUTPUT: Values: 529.0 531.2 533.7 548.8 550.5 31542.4 31839.8 32028.5 32067.2 32070.2 37075.4 37357.1 37673.0 38026.0 38061.0 7868.3 8034.2 8038.8 8045.5 8051.5 7872.5 7971.7 7977.6 7999.5 8002.8 7879.2 7896.1 7923.4 7937.8 7940.7 7593.4 7630.1 7639.4 7655.6 7666.7 7799.6 7911.4 7916.9 7919.4 7920.2 35499.0 35910.5 35943.5 35955.5 35987.5 2972.6 3003.1 3019.6 3053.3 3079.8 26676.3 27228.5 27354.5 27481.0 27780.6 2979.6 3061.4 3091.5 3126.2 3148.6 211699.0 211835.0 212690.9 213476.0 213737.0 50651.2 53862.0 54158.2 54177.2 54321.0 45631.0 64580.0 65368.7 65594.3 65616.3 11988.7 11993.4 12047.2 12075.0 12075.2 9472.5 9513.8 9514.7 9524.0 9552.6 18820.8 19037.7 19139.3 19182.8 19333.5 7579.5 7788.1 7850.5 7851.1 7973.3 889.8 899.5 913.2 933.7 975.9 25879.7 25948.0 25972.2 29142.6 30294.7 959.2 988.8 997.6 1005.5 1065.5 12623.8 15224.5 15267.8 15373.9 15699.4 304474.0 309039.0 310101.0 311062.0 311771.0 45897.3 46050.0 46130.0 46134.3 46136.0 1184.7 1195.9 1200.9 1203.7 1208.8 26165.4 26194.6 26440.3 26614.6 26631.9 38312.2 38575.8 38985.0 39029.8 39127.4 245633.0 245799.8 246981.0 247239.0 248009.0 28486.3 41531.6 41926.4 41954.0 42012.4 36702.0 36864.8 37351.3 37919.6 38113.0 31757.5 32218.4 32534.5 32645.8 32979.0 32782.0 36247.0 38435.4 38463.1 38612.2 31875.5 31954.0 32440.4 32574.0 32599.0 28927.6 29266.7 29615.4 30178.4 33168.6 23250.7 23537.0 23648.4 23650.6 23768.2 07:44:46 INFO - 2015-12-15 07:44:46,509 DEBUG : BROWSER_OUTPUT: 07:44:46 INFO - 2015-12-15 07:44:46,509 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28623.64 Median:17070.97 stddev:86167.27 (504.8%) stddev-sans-first:86382.81 07:44:46 INFO - 2015-12-15 07:44:46,510 DEBUG : BROWSER_OUTPUT: Values: 336.6 339.0 340.4 340.9 343.6 10352.7 10738.9 14772.6 14868.0 15688.3 14986.3 15053.2 15101.2 15427.3 15802.7 5668.5 5830.6 6397.3 6612.9 6627.6 6535.6 6571.4 6573.1 6573.7 6574.5 6331.6 6364.9 6520.2 6538.7 6580.2 6486.9 6593.3 6608.7 6623.4 6637.5 6393.4 6395.7 6396.4 6403.6 6409.5 19421.0 21248.9 21708.7 21752.7 21889.7 1983.5 2108.0 2130.3 2147.5 2159.9 13994.3 14018.3 14073.7 14297.0 14482.5 1885.5 1898.2 1900.6 1969.2 1997.1 61911.7 64226.7 64798.0 65512.7 66300.3 15359.3 15463.1 15564.9 15568.3 15754.1 22999.8 23068.2 23262.2 23269.1 23287.2 8167.2 8194.6 8195.1 8253.0 8292.5 6752.6 6753.6 6777.8 6790.0 6800.3 7568.5 7577.9 7586.8 7640.2 7654.2 1678.5 2959.6 3006.4 3012.1 3026.9 790.6 817.4 824.2 865.8 879.7 14159.5 14340.0 14721.0 14936.8 14952.9 831.7 854.6 866.5 902.6 946.2 8469.4 8475.2 8546.1 8556.6 8639.4 519281.0 525213.0 526533.0 528025.1 540916.0 68677.7 74579.3 74893.6 75140.2 77938.6 1026.6 1042.8 1053.3 1054.8 1075.0 14424.6 14479.2 14523.1 14541.1 15000.9 32716.8 32796.7 33343.0 33682.0 33801.5 42393.6 42903.6 43128.8 45173.3 46063.3 8779.0 8890.4 8935.9 9009.7 9035.3 11955.8 15813.6 16279.5 16344.3 16387.2 9995.0 10536.5 11801.7 12995.9 13098.5 12415.0 12553.1 12710.0 12993.2 13078.4 2338.0 11765.9 12392.7 12924.2 13714.5 8619.0 8630.3 8656.1 8659.7 8708.0 12249.8 13421.7 13428.6 13455.1 14044.9 07:44:46 INFO - 2015-12-15 07:44:46,510 DEBUG : BROWSER_OUTPUT: 07:44:46 INFO - 2015-12-15 07:44:46,510 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5004.79 Median:6366.47 stddev:2603.41 (40.9%) stddev-sans-first:2597.18 07:44:46 INFO - 2015-12-15 07:44:46,510 DEBUG : BROWSER_OUTPUT: Values: 1473.0 1632.2 1696.7 1706.3 1719.2 7119.5 7187.2 7373.4 7397.6 7407.2 7203.2 7220.7 7304.7 7325.1 7329.5 2071.8 2089.9 2091.6 2092.3 2100.8 2079.8 2091.2 2106.9 2117.0 2120.5 1733.6 1758.2 2039.6 2059.0 2063.7 2017.7 2018.2 2027.2 2027.3 2032.2 2021.2 2048.3 2061.3 2070.2 2084.8 7129.8 7222.5 7257.7 7281.7 7283.6 4136.3 4164.3 4170.8 4185.1 4188.2 2749.3 2784.0 2812.5 2820.7 2839.1 901.1 1570.8 1592.1 1649.4 1677.3 9235.0 9398.5 9424.1 9432.5 9452.7 3701.5 3769.7 3824.3 3825.4 3829.7 7626.7 7738.3 7751.7 7759.0 7767.9 4142.7 4150.5 4155.9 4160.6 4161.9 3814.3 3825.5 3825.9 3839.9 3844.6 3123.1 3135.0 3167.7 3189.0 3191.5 925.5 941.1 942.1 967.4 968.2 839.4 885.1 909.6 952.5 984.9 6757.5 6823.7 6841.2 6848.2 6860.3 577.3 593.4 596.7 600.5 739.0 5132.6 5156.0 5286.3 5286.7 5289.9 8392.9 8702.3 8780.7 8786.6 8826.8 8615.1 8683.5 8695.0 8709.4 8720.5 6674.2 6846.0 6870.8 6884.3 6924.8 6565.2 6602.4 6604.8 6633.5 6639.7 7635.8 7821.3 7837.3 7839.8 7930.4 7890.9 7994.5 8083.8 8101.5 8106.5 6044.6 6061.8 6070.8 6139.8 6142.8 6943.2 6972.5 6990.4 6992.4 6999.8 6304.3 6363.0 6370.0 6466.9 6538.6 6289.7 6412.8 6482.7 6489.2 6569.4 6527.7 6606.4 6620.9 6634.0 6658.4 6085.8 6101.4 6113.5 6132.4 6153.5 6100.4 6127.5 6144.8 6150.0 6153.3 07:44:46 INFO - 2015-12-15 07:44:46,510 DEBUG : BROWSER_OUTPUT: 07:44:46 INFO - 2015-12-15 07:44:46,510 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4818.87 Median:5537.36 stddev:1457.35 (26.3%) stddev-sans-first:1421.09 07:44:46 INFO - 2015-12-15 07:44:46,510 DEBUG : BROWSER_OUTPUT: Values: 281.6 294.4 295.2 298.2 298.8 5521.7 5553.1 5586.6 5613.4 5615.1 5485.0 5496.8 5503.3 5505.2 5509.2 4257.3 4265.0 4270.7 4277.6 4284.0 4128.6 4165.6 4183.6 4188.4 4200.2 4117.9 4163.6 4176.2 4178.2 4180.4 4175.1 4175.6 4177.8 4187.9 4197.4 3609.1 3618.9 3623.2 3628.5 3635.2 5240.7 5337.0 5357.6 5372.0 5428.1 4802.4 4806.6 4809.1 4812.7 4813.3 5819.5 5860.6 5871.7 5873.1 5880.0 3936.6 3942.9 3949.0 3951.1 3954.6 5965.5 6040.1 6128.2 6158.0 6163.9 4030.3 4057.1 4060.8 4060.9 4064.9 4117.5 4119.1 4120.8 4121.4 4130.9 4781.0 4789.3 4789.4 4792.6 4797.8 5725.4 5754.1 5815.7 5832.0 5845.8 1426.6 1443.6 1444.2 1445.3 1445.7 923.6 932.2 933.2 937.1 941.6 5073.4 5075.5 5079.3 5116.9 5117.7 5998.7 6023.7 6051.5 6103.1 6152.3 5121.5 5124.5 5144.7 5150.4 5154.6 3250.4 3280.5 3281.7 3291.6 3295.6 5779.3 5783.9 5803.2 5806.6 5812.0 6099.9 6294.5 6300.0 6302.2 6303.8 5778.9 5782.7 5784.8 5794.5 5800.9 6093.4 6098.7 6100.9 6114.1 6114.4 5862.6 5933.5 5968.4 5970.7 5988.9 5776.9 5779.1 5781.9 5788.5 5806.4 3986.9 4041.6 4042.7 4043.8 4052.9 5954.6 6081.3 6086.3 6092.6 6097.3 5837.9 5841.1 5846.6 5847.8 5873.6 5848.6 5853.5 5857.2 5878.6 5885.9 5718.6 5732.1 5751.8 5753.1 5754.5 5718.2 5929.0 5960.6 5964.3 5967.0 5740.6 5781.0 5783.8 5805.0 5815.4 07:44:46 INFO - 2015-12-15 07:44:46,510 DEBUG : BROWSER_OUTPUT: 07:44:46 INFO - 2015-12-15 07:44:46,510 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12583.77 Median:466.83 stddev:14673.64 (3143.2%) stddev-sans-first:14687.48 07:44:46 INFO - 2015-12-15 07:44:46,511 DEBUG : BROWSER_OUTPUT: Values: 660.5 667.6 729.2 788.8 792.4 10839.5 11142.6 11151.2 11162.7 11171.0 12356.7 12756.1 12773.1 12780.7 12793.9 781.3 783.5 789.4 796.2 798.2 787.4 793.5 798.4 799.0 799.2 812.5 815.9 817.9 818.9 819.1 813.8 815.5 815.9 817.2 818.0 594.2 599.6 605.5 605.7 606.7 11573.8 11659.7 11672.1 11673.4 11674.6 10796.1 10879.3 11040.1 11441.1 11826.5 9107.4 9152.7 9257.2 9351.8 9462.8 3100.5 3118.8 3135.2 3148.1 3200.2 41174.8 41185.4 41721.0 41983.6 42022.0 9171.8 9236.7 9242.8 9355.7 9381.8 15576.7 15695.5 15748.0 15813.1 15815.8 6086.6 6191.1 6210.5 6217.4 6234.2 3510.6 3564.1 3573.6 3586.8 3616.7 2611.5 2635.5 2643.3 2651.5 2654.2 453.2 460.8 470.2 474.5 479.5 466.2 473.8 494.5 563.8 570.6 7521.2 7653.5 7685.8 7909.0 7968.0 440.0 445.3 467.4 489.9 524.5 3586.8 3680.9 3860.7 3929.4 4212.7 54291.7 54716.2 55247.0 55829.4 55935.0 45850.0 47022.8 48441.5 48583.0 48992.3 41802.8 41853.6 42048.2 42508.8 42866.6 8408.8 8588.7 8607.7 8828.6 8831.5 31310.4 31443.7 31947.7 32066.7 32145.0 36429.8 38291.6 41008.8 41838.8 43679.0 10509.1 10524.3 10893.6 10937.7 11231.6 11417.5 11566.9 11664.9 12137.5 12528.0 10500.4 10547.8 10670.0 11033.2 11123.6 10553.5 10776.7 10957.8 11180.8 11347.4 9345.7 9430.6 9439.6 9492.0 9667.3 8538.4 8577.2 8612.7 8767.6 9229.8 8277.3 8759.9 8977.8 9034.7 9077.0 07:44:46 INFO - 2015-12-15 07:44:46,511 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:44:46 INFO - 2015-12-15 07:44:46,511 DEBUG : BROWSER_OUTPUT: 07:44:47 INFO - 2015-12-15 07:44:47,214 INFO : Browser exited with error code: 0 07:44:47 INFO - 2015-12-15 07:44:47,233 INFO : Completed test dromaeo_css (00:18:35) 07:44:47 INFO - 2015-12-15 07:44:47,233 INFO : Starting test kraken 07:44:47 INFO - 2015-12-15 07:44:47,233 DEBUG : operating with platform_type : linux_ 07:44:47 INFO - 2015-12-15 07:44:47,233 INFO : Initialising browser for kraken test... 07:44:47 INFO - 2015-12-15 07:44:47,239 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqp5f9G/profile http://localhost:56850/getInfo.html 07:44:52 INFO - 2015-12-15 07:44:52,243 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:44:52 INFO - 2015-12-15 07:44:52,243 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:44:52 INFO - 2015-12-15 07:44:52,243 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:44:52 INFO - 2015-12-15 07:44:52,243 DEBUG : BROWSER_OUTPUT: __metrics 07:44:52 INFO - 2015-12-15 07:44:52,364 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] 07:44:53 INFO - 2015-12-15 07:44:53,286 INFO : Browser initialized. 07:44:53 INFO - 2015-12-15 07:44:53,287 INFO : Running cycle 1/1 for kraken test... 07:44:53 INFO - 2015-12-15 07:44:53,287 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqp5f9G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:45:05 INFO - 2015-12-15 07:45:05,391 DEBUG : BROWSER_OUTPUT: RSS: Main: 143175680 07:45:05 INFO - 2015-12-15 07:45:05,392 DEBUG : BROWSER_OUTPUT: 07:45:07 INFO - 2015-12-15 07:45:07,987 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56850/tests/kraken/driver.html?testName=audio-beat-detection) 07:45:08 INFO - 2015-12-15 07:45:08,609 DEBUG : BROWSER_OUTPUT: RSS: Main: 143618048 07:45:08 INFO - 2015-12-15 07:45:08,609 DEBUG : BROWSER_OUTPUT: 07:45:11 INFO - 2015-12-15 07:45:11,318 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56850/tests/kraken/driver.html?testName=audio-dft) 07:45:11 INFO - 2015-12-15 07:45:11,912 DEBUG : BROWSER_OUTPUT: RSS: Main: 142573568 07:45:11 INFO - 2015-12-15 07:45:11,912 DEBUG : BROWSER_OUTPUT: 07:45:14 INFO - 2015-12-15 07:45:14,834 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56850/tests/kraken/driver.html?testName=audio-fft) 07:45:15 INFO - 2015-12-15 07:45:15,420 DEBUG : BROWSER_OUTPUT: RSS: Main: 139755520 07:45:15 INFO - 2015-12-15 07:45:15,420 DEBUG : BROWSER_OUTPUT: 07:45:17 INFO - 2015-12-15 07:45:17,532 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56850/tests/kraken/driver.html?testName=audio-oscillator) 07:45:18 INFO - 2015-12-15 07:45:18,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 138518528 07:45:18 INFO - 2015-12-15 07:45:18,116 DEBUG : BROWSER_OUTPUT: 07:45:20 INFO - 2015-12-15 07:45:20,378 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56850/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:45:20 INFO - 2015-12-15 07:45:20,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 139968512 07:45:20 INFO - 2015-12-15 07:45:20,965 DEBUG : BROWSER_OUTPUT: 07:45:24 INFO - 2015-12-15 07:45:24,055 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56850/tests/kraken/driver.html?testName=imaging-darkroom) 07:45:24 INFO - 2015-12-15 07:45:24,656 DEBUG : BROWSER_OUTPUT: RSS: Main: 141127680 07:45:24 INFO - 2015-12-15 07:45:24,656 DEBUG : BROWSER_OUTPUT: 07:45:28 INFO - 2015-12-15 07:45:28,150 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56850/tests/kraken/driver.html?testName=imaging-desaturate) 07:45:28 INFO - 2015-12-15 07:45:28,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 138993664 07:45:28 INFO - 2015-12-15 07:45:28,744 DEBUG : BROWSER_OUTPUT: 07:45:31 INFO - 2015-12-15 07:45:31,669 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56850/tests/kraken/driver.html?testName=json-parse-financial) 07:45:32 INFO - 2015-12-15 07:45:32,262 DEBUG : BROWSER_OUTPUT: RSS: Main: 139894784 07:45:32 INFO - 2015-12-15 07:45:32,262 DEBUG : BROWSER_OUTPUT: 07:45:34 INFO - 2015-12-15 07:45:34,037 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56850/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:45:34 INFO - 2015-12-15 07:45:34,618 DEBUG : BROWSER_OUTPUT: RSS: Main: 141139968 07:45:34 INFO - 2015-12-15 07:45:34,618 DEBUG : BROWSER_OUTPUT: 07:45:36 INFO - 2015-12-15 07:45:36,523 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56850/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:45:37 INFO - 2015-12-15 07:45:37,145 DEBUG : BROWSER_OUTPUT: RSS: Main: 140230656 07:45:37 INFO - 2015-12-15 07:45:37,145 DEBUG : BROWSER_OUTPUT: 07:45:39 INFO - 2015-12-15 07:45:39,284 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56850/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:45:39 INFO - 2015-12-15 07:45:39,886 DEBUG : BROWSER_OUTPUT: RSS: Main: 140464128 07:45:39 INFO - 2015-12-15 07:45:39,886 DEBUG : BROWSER_OUTPUT: 07:45:42 INFO - 2015-12-15 07:45:42,442 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56850/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:45:43 INFO - 2015-12-15 07:45:43,043 DEBUG : BROWSER_OUTPUT: RSS: Main: 141213696 07:45:43 INFO - 2015-12-15 07:45:43,043 DEBUG : BROWSER_OUTPUT: 07:45:45 INFO - 2015-12-15 07:45:45,684 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56850/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:45:46 INFO - 2015-12-15 07:45:46,277 DEBUG : BROWSER_OUTPUT: RSS: Main: 141127680 07:45:46 INFO - 2015-12-15 07:45:46,278 DEBUG : BROWSER_OUTPUT: 07:45:48 INFO - 2015-12-15 07:45:48,060 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56850/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56850/tests/kraken/driver.html?testName=ai-astar) 07:45:48 INFO - 2015-12-15 07:45:48,310 DEBUG : BROWSER_OUTPUT: RSS: Main: 141389824 07:45:48 INFO - 2015-12-15 07:45:48,310 DEBUG : BROWSER_OUTPUT: 07:45:48 INFO - 2015-12-15 07:45:48,314 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:45:48 INFO - 2015-12-15 07:45:48,314 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:45:48 INFO - 2015-12-15 07:45:48,314 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:45:48 INFO - 2015-12-15 07:45:48,314 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:45:48 INFO - 2015-12-15 07:45:48,315 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;110;115;116;115;125;115;113;115;114 07:45:48 INFO - 2015-12-15 07:45:48,315 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;139;156;169;131;154;149;141;164;132 07:45:48 INFO - 2015-12-15 07:45:48,315 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;164;163;163;166;168;167;162;164;162 07:45:48 INFO - 2015-12-15 07:45:48,315 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;72;74;74;132;74;79;73;73;87 07:45:48 INFO - 2015-12-15 07:45:48,315 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;96;132;94;95;95;133;95;97;141 07:45:48 INFO - 2015-12-15 07:45:48,316 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;112;111;115;110;110;110;110;111;109 07:45:48 INFO - 2015-12-15 07:45:48,316 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;148;147;148;148;147;146;148;147 07:45:48 INFO - 2015-12-15 07:45:48,316 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;97;97;97;95;96;96;96 07:45:48 INFO - 2015-12-15 07:45:48,316 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;77;71;71;72;71;70;74;71;69 07:45:48 INFO - 2015-12-15 07:45:48,316 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;69;68;69;68;68;68;68 07:45:48 INFO - 2015-12-15 07:45:48,316 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;83;86;85;83;83;85;83;86 07:45:48 INFO - 2015-12-15 07:45:48,316 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;131;121;132;132;130;124;122;123;134 07:45:48 INFO - 2015-12-15 07:45:48,317 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;151;147;157;151;144;149;149;150;150 07:45:48 INFO - 2015-12-15 07:45:48,317 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;76;72;71;72;70;74;70;72;71;70 07:45:48 INFO - 2015-12-15 07:45:48,317 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:45:48 INFO - 2015-12-15 07:45:48,317 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:45:48 INFO - 2015-12-15 07:45:48,317 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,785 07:45:48 INFO - 2015-12-15 07:45:48,317 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:45:48 INFO - 2015-12-15 07:45:48,317 DEBUG : BROWSER_OUTPUT: __startTimestamp1450194348312__endTimestamp 07:45:48 INFO - 2015-12-15 07:45:48,318 DEBUG : BROWSER_OUTPUT: 07:45:48 INFO - 2015-12-15 07:45:48,321 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:45:48 INFO - 2015-12-15 07:45:48,321 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:45:48 INFO - 2015-12-15 07:45:48,321 DEBUG : BROWSER_OUTPUT: 07:45:48 INFO - 2015-12-15 07:45:48,321 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.20 Median:115.00 stddev:3.82 (3.3%) stddev-sans-first:4.03 07:45:48 INFO - 2015-12-15 07:45:48,321 DEBUG : BROWSER_OUTPUT: Values: 114.0 110.0 115.0 116.0 115.0 125.0 115.0 113.0 115.0 114.0 07:45:48 INFO - 2015-12-15 07:45:48,321 DEBUG : BROWSER_OUTPUT: 07:45:48 INFO - 2015-12-15 07:45:48,321 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.00 Median:154.50 stddev:12.96 (8.4%) stddev-sans-first:13.56 07:45:48 INFO - 2015-12-15 07:45:48,321 DEBUG : BROWSER_OUTPUT: Values: 155.0 139.0 156.0 169.0 131.0 154.0 149.0 141.0 164.0 132.0 07:45:48 INFO - 2015-12-15 07:45:48,321 DEBUG : BROWSER_OUTPUT: 07:45:48 INFO - 2015-12-15 07:45:48,321 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:2.10 (1.3%) stddev-sans-first:2.18 07:45:48 INFO - 2015-12-15 07:45:48,322 DEBUG : BROWSER_OUTPUT: Values: 163.0 164.0 163.0 163.0 166.0 168.0 167.0 162.0 164.0 162.0 07:45:48 INFO - 2015-12-15 07:45:48,322 DEBUG : BROWSER_OUTPUT: 07:45:48 INFO - 2015-12-15 07:45:48,322 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.30 Median:74.00 stddev:18.35 (24.8%) stddev-sans-first:19.33 07:45:48 INFO - 2015-12-15 07:45:48,322 DEBUG : BROWSER_OUTPUT: Values: 75.0 72.0 74.0 74.0 132.0 74.0 79.0 73.0 73.0 87.0 07:45:48 INFO - 2015-12-15 07:45:48,322 DEBUG : BROWSER_OUTPUT: 07:45:48 INFO - 2015-12-15 07:45:48,322 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.20 Median:95.00 stddev:19.57 (20.6%) stddev-sans-first:20.17 07:45:48 INFO - 2015-12-15 07:45:48,322 DEBUG : BROWSER_OUTPUT: Values: 94.0 96.0 132.0 94.0 95.0 95.0 133.0 95.0 97.0 141.0 07:45:48 INFO - 2015-12-15 07:45:48,322 DEBUG : BROWSER_OUTPUT: 07:45:48 INFO - 2015-12-15 07:45:48,322 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.80 Median:110.50 stddev:1.69 (1.5%) stddev-sans-first:1.76 07:45:48 INFO - 2015-12-15 07:45:48,322 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 111.0 115.0 110.0 110.0 110.0 110.0 111.0 109.0 07:45:48 INFO - 2015-12-15 07:45:48,322 DEBUG : BROWSER_OUTPUT: 07:45:48 INFO - 2015-12-15 07:45:48,322 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 07:45:48 INFO - 2015-12-15 07:45:48,322 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 148.0 147.0 148.0 148.0 147.0 146.0 148.0 147.0 07:45:48 INFO - 2015-12-15 07:45:48,322 DEBUG : BROWSER_OUTPUT: 07:45:48 INFO - 2015-12-15 07:45:48,322 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 07:45:48 INFO - 2015-12-15 07:45:48,323 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 97.0 97.0 97.0 95.0 96.0 96.0 96.0 07:45:48 INFO - 2015-12-15 07:45:48,323 DEBUG : BROWSER_OUTPUT: 07:45:48 INFO - 2015-12-15 07:45:48,323 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.80 Median:71.50 stddev:2.25 (3.1%) stddev-sans-first:2.39 07:45:48 INFO - 2015-12-15 07:45:48,323 DEBUG : BROWSER_OUTPUT: Values: 72.0 77.0 71.0 71.0 72.0 71.0 70.0 74.0 71.0 69.0 07:45:48 INFO - 2015-12-15 07:45:48,323 DEBUG : BROWSER_OUTPUT: 07:45:48 INFO - 2015-12-15 07:45:48,323 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 07:45:48 INFO - 2015-12-15 07:45:48,323 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 69.0 68.0 69.0 68.0 68.0 68.0 68.0 07:45:48 INFO - 2015-12-15 07:45:48,323 DEBUG : BROWSER_OUTPUT: 07:45:48 INFO - 2015-12-15 07:45:48,323 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.50 stddev:1.23 (1.5%) stddev-sans-first:1.30 07:45:48 INFO - 2015-12-15 07:45:48,323 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 83.0 86.0 85.0 83.0 83.0 85.0 83.0 86.0 07:45:48 INFO - 2015-12-15 07:45:48,323 DEBUG : BROWSER_OUTPUT: 07:45:48 INFO - 2015-12-15 07:45:48,323 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:130.50 stddev:4.92 (3.8%) stddev-sans-first:5.07 07:45:48 INFO - 2015-12-15 07:45:48,323 DEBUG : BROWSER_OUTPUT: Values: 124.0 131.0 121.0 132.0 132.0 130.0 124.0 122.0 123.0 134.0 07:45:48 INFO - 2015-12-15 07:45:48,323 DEBUG : BROWSER_OUTPUT: 07:45:48 INFO - 2015-12-15 07:45:48,323 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.70 Median:150.00 stddev:4.74 (3.2%) stddev-sans-first:3.49 07:45:48 INFO - 2015-12-15 07:45:48,323 DEBUG : BROWSER_OUTPUT: Values: 139.0 151.0 147.0 157.0 151.0 144.0 149.0 149.0 150.0 150.0 07:45:48 INFO - 2015-12-15 07:45:48,324 DEBUG : BROWSER_OUTPUT: 07:45:48 INFO - 2015-12-15 07:45:48,324 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:72.00 stddev:1.93 (2.7%) stddev-sans-first:1.32 07:45:48 INFO - 2015-12-15 07:45:48,324 DEBUG : BROWSER_OUTPUT: Values: 76.0 72.0 71.0 72.0 70.0 74.0 70.0 72.0 71.0 70.0 07:45:48 INFO - 2015-12-15 07:45:48,324 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:45:48 INFO - 2015-12-15 07:45:48,324 DEBUG : BROWSER_OUTPUT: 07:45:49 INFO - 2015-12-15 07:45:49,254 INFO : Browser exited with error code: 0 07:45:49 INFO - 2015-12-15 07:45:49,305 INFO : Completed test kraken (00:01:02) 07:45:49 INFO - 2015-12-15 07:45:49,305 INFO : Starting test v8_7 07:45:49 INFO - 2015-12-15 07:45:49,305 DEBUG : operating with platform_type : linux_ 07:45:49 INFO - 2015-12-15 07:45:49,305 INFO : Initialising browser for v8_7 test... 07:45:49 INFO - 2015-12-15 07:45:49,312 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf0sk1_/profile http://localhost:56850/getInfo.html 07:45:54 INFO - 2015-12-15 07:45:54,541 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:45:54 INFO - 2015-12-15 07:45:54,542 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:45:54 INFO - 2015-12-15 07:45:54,542 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:45:54 INFO - 2015-12-15 07:45:54,542 DEBUG : BROWSER_OUTPUT: __metrics 07:45:54 INFO - 2015-12-15 07:45:54,686 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] 07:45:55 INFO - 2015-12-15 07:45:55,658 INFO : Browser initialized. 07:45:55 INFO - 2015-12-15 07:45:55,659 INFO : Running cycle 1/1 for v8_7 test... 07:45:55 INFO - 2015-12-15 07:45:55,659 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf0sk1_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:46:07 INFO - 2015-12-15 07:46:07,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 142798848 07:46:07 INFO - 2015-12-15 07:46:07,689 DEBUG : BROWSER_OUTPUT: 07:46:29 INFO - 2015-12-15 07:46:29,209 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56850/tests/v8_7/run.html (next: http://localhost:56850/tests/v8_7/run.html) 07:46:29 INFO - 2015-12-15 07:46:29,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 137609216 07:46:29 INFO - 2015-12-15 07:46:29,468 DEBUG : BROWSER_OUTPUT: 07:46:29 INFO - 2015-12-15 07:46:29,468 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:46:29 INFO - 2015-12-15 07:46:29,468 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:46:29 INFO - 2015-12-15 07:46:29,468 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:46:29 INFO - 2015-12-15 07:46:29,468 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:46:29 INFO - 2015-12-15 07:46:29,468 DEBUG : BROWSER_OUTPUT: |0;Richards;167.19612104999163 07:46:29 INFO - 2015-12-15 07:46:29,469 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.49434242255612 07:46:29 INFO - 2015-12-15 07:46:29,469 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.77777777777777 07:46:29 INFO - 2015-12-15 07:46:29,469 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5175.257731958763 07:46:29 INFO - 2015-12-15 07:46:29,469 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1044.932079414838 07:46:29 INFO - 2015-12-15 07:46:29,469 DEBUG : BROWSER_OUTPUT: |5;Earley;742.3904974016333 07:46:29 INFO - 2015-12-15 07:46:29,469 DEBUG : BROWSER_OUTPUT: |6;Boyer;12419.753086419752 07:46:29 INFO - 2015-12-15 07:46:29,469 DEBUG : BROWSER_OUTPUT: |7;RegExp;28000 07:46:29 INFO - 2015-12-15 07:46:29,469 DEBUG : BROWSER_OUTPUT: |8;Splay;673.3466933867735 07:46:29 INFO - 2015-12-15 07:46:29,469 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 07:46:29 INFO - 2015-12-15 07:46:29,469 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:46:29 INFO - 2015-12-15 07:46:29,469 DEBUG : BROWSER_OUTPUT: __startTimestamp1450194389462__endTimestamp 07:46:29 INFO - 2015-12-15 07:46:29,469 DEBUG : BROWSER_OUTPUT: 07:46:29 INFO - 2015-12-15 07:46:29,469 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:46:29 INFO - 2015-12-15 07:46:29,469 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:46:29 INFO - 2015-12-15 07:46:29,469 DEBUG : BROWSER_OUTPUT: 07:46:29 INFO - 2015-12-15 07:46:29,470 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.20 Median:167.20 stddev:0.00 (0.0%) 07:46:29 INFO - 2015-12-15 07:46:29,470 DEBUG : BROWSER_OUTPUT: Values: 167.2 07:46:29 INFO - 2015-12-15 07:46:29,470 DEBUG : BROWSER_OUTPUT: 07:46:29 INFO - 2015-12-15 07:46:29,470 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.49 Median:185.49 stddev:0.00 (0.0%) 07:46:29 INFO - 2015-12-15 07:46:29,470 DEBUG : BROWSER_OUTPUT: Values: 185.5 07:46:29 INFO - 2015-12-15 07:46:29,470 DEBUG : BROWSER_OUTPUT: 07:46:29 INFO - 2015-12-15 07:46:29,470 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.78 Median:277.78 stddev:0.00 (0.0%) 07:46:29 INFO - 2015-12-15 07:46:29,470 DEBUG : BROWSER_OUTPUT: Values: 277.8 07:46:29 INFO - 2015-12-15 07:46:29,470 DEBUG : BROWSER_OUTPUT: 07:46:29 INFO - 2015-12-15 07:46:29,471 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 07:46:29 INFO - 2015-12-15 07:46:29,471 DEBUG : BROWSER_OUTPUT: Values: 5175.3 07:46:29 INFO - 2015-12-15 07:46:29,471 DEBUG : BROWSER_OUTPUT: 07:46:29 INFO - 2015-12-15 07:46:29,471 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1044.93 Median:1044.93 stddev:0.00 (0.0%) 07:46:29 INFO - 2015-12-15 07:46:29,471 DEBUG : BROWSER_OUTPUT: Values: 1044.9 07:46:29 INFO - 2015-12-15 07:46:29,471 DEBUG : BROWSER_OUTPUT: 07:46:29 INFO - 2015-12-15 07:46:29,471 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:742.39 Median:742.39 stddev:0.00 (0.0%) 07:46:29 INFO - 2015-12-15 07:46:29,471 DEBUG : BROWSER_OUTPUT: Values: 742.4 07:46:29 INFO - 2015-12-15 07:46:29,471 DEBUG : BROWSER_OUTPUT: 07:46:29 INFO - 2015-12-15 07:46:29,471 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12419.75 Median:12419.75 stddev:0.00 (0.0%) 07:46:29 INFO - 2015-12-15 07:46:29,471 DEBUG : BROWSER_OUTPUT: Values: 12419.8 07:46:29 INFO - 2015-12-15 07:46:29,471 DEBUG : BROWSER_OUTPUT: 07:46:29 INFO - 2015-12-15 07:46:29,471 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28000.00 Median:28000.00 stddev:0.00 (0.0%) 07:46:29 INFO - 2015-12-15 07:46:29,471 DEBUG : BROWSER_OUTPUT: Values: 28000.0 07:46:29 INFO - 2015-12-15 07:46:29,471 DEBUG : BROWSER_OUTPUT: 07:46:29 INFO - 2015-12-15 07:46:29,471 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:673.35 Median:673.35 stddev:0.00 (0.0%) 07:46:29 INFO - 2015-12-15 07:46:29,472 DEBUG : BROWSER_OUTPUT: Values: 673.3 07:46:29 INFO - 2015-12-15 07:46:29,472 DEBUG : BROWSER_OUTPUT: 07:46:29 INFO - 2015-12-15 07:46:29,472 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 07:46:29 INFO - 2015-12-15 07:46:29,472 DEBUG : BROWSER_OUTPUT: Values: 4840.6 07:46:29 INFO - 2015-12-15 07:46:29,472 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:46:29 INFO - 2015-12-15 07:46:29,472 DEBUG : BROWSER_OUTPUT: 07:46:30 INFO - 2015-12-15 07:46:30,426 INFO : Browser exited with error code: 0 07:46:30 INFO - 2015-12-15 07:46:30,441 INFO : Completed test v8_7 (00:00:41) 07:46:30 INFO - 2015-12-15 07:46:30,443 INFO : Completed test suite (00:20:18) 07:46:30 INFO - 2015-12-15 07:46:30,444 DEBUG : Working with test: dromaeo_css 07:46:30 INFO - 2015-12-15 07:46:30,444 DEBUG : Generating results file: dromaeo_css 07:46:30 INFO - 2015-12-15 07:46:30,444 DEBUG : Working with test: kraken 07:46:30 INFO - 2015-12-15 07:46:30,444 DEBUG : Generating results file: kraken 07:46:30 INFO - 2015-12-15 07:46:30,444 INFO : javascript benchmark 07:46:30 INFO - 2015-12-15 07:46:30,444 DEBUG : Working with test: v8_7 07:46:30 INFO - 2015-12-15 07:46:30,444 DEBUG : Generating results file: v8_7 07:46:30 INFO - 2015-12-15 07:46:30,444 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:46:30 INFO - 2015-12-15 07:46:30,497 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 07:46:30 INFO - 2015-12-15 07:46:30,497 DEBUG : process_Request line: dromaeo_css 6469.91 graph.html#tests=[[72,132,43]] 07:46:30 INFO - 2015-12-15 07:46:30,497 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:46:30 INFO - 2015-12-15 07:46:30,602 DEBUG : process_Request line: kraken 1543.10 graph.html#tests=[[232,132,43]] 07:46:30 INFO - 2015-12-15 07:46:30,602 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:46:30 INFO - 2015-12-15 07:46:30,649 DEBUG : process_Request line: v8_7 20905.48 graph.html#tests=[[230,132,43]] 07:46:30 INFO - 2015-12-15 07:46:30,650 INFO : javascript benchmark 07:46:30 INFO - 2015-12-15 07:46:30,654 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2692.380752426942, 2721.2244510314563, 2764.1016669582377, 2770.5705615629586, 2782.360057186847, 4617.930731039029, 4752.5960293375065, 4758.2148945424005, 4782.0, 4796.328514008042, 4701.788419521121, 4705.200115980291, 4736.97631511842, 4809.615230781538, 4863.659543831925, 4365.432493775805, 4407.338899165119, 4439.422875026258, 4454.3318502224765, 4505.707129036602, 4234.06850492891, 4454.510003899569, 4459.308807134899, 4468.664850136237, 4480.350349199364, 4375.890602734941, 4459.598636122764, 4469.971906461532, 4484.8878778030485, 4501.347304640842, 4393.275109606911, 4418.9337159942625, 4421.646268298528, 4454.0646464242545, 4456.22016147173, 4208.263553878059, 4286.828526858922, 4329.134173165379, 4398.450193725785, 4411.470623525165, 4677.228257337535, 4712.31671407644, 4724.7401392923375, 4751.121042607094, 4775.450823155347, 5120.718360490171, 5121.539061484485, 5137.614678899097, 5137.922931156036, 5151.45909679482, 4918.0, 4995.650304478688, 5060.645754797166, 5160.6129540284255, 5224.582033437316, 4730.361401210827, 4800.7119572825395, 4813.927791083137, 4823.083614113307, 4867.099586576494, 5261.657992230493, 5298.97350513245, 5302.708351040653, 5313.734313284321, 5331.013762453958, 4790.185668436374, 4882.707037577757, 4929.457759646436, 4984.451710311862, 5040.1179793535985, 5151.922721159186, 5201.739913004335, 5202.92195617066, 5208.166693329049, 5265.868353291122, 4892.877678058077, 5141.331626888556, 5145.9485405146215, 5146.536811686966, 5151.381834179848, 4955.925661115086, 4982.402111746541, 5038.64729468941, 5042.924356134661, 5099.515546023122, 4262.232798096373, 4269.765162916007, 4277.016286254179, 4300.548442413564, 4312.116016216668, 3623.1304486923477, 3721.683656889141, 3763.717721170923, 3774.037620406779, 3798.772073675588, 4343.869683909425, 4399.6040356368085, 4420.204363214588, 4430.357598148251, 4441.977790111029, 5116.155834287375, 5120.8719782005, 5122.718250496258, 5126.333576635014, 5156.535911767884, 4254.681048874859, 4321.740695558214, 4339.1104823511105, 4411.448568928884, 4474.843380481668, 4487.977560112178, 4510.0, 4519.299508576176, 4536.6824322297125, 4569.908601827945, 4870.293807397908, 4876.853694389245, 4898.779554920108, 4922.876928076755, 4950.232713929347, 4870.172070748053, 4965.602751779777, 4980.825671101494, 5120.359955005624, 5167.767450464663, 4782.545658162469, 4790.065937142223, 4864.586510146536, 4867.367242258484, 4869.95130048695, 5067.41724701664, 5126.743662816919, 5126.79492820283, 5132.255822905732, 5178.0, 4857.927131092966, 4962.082014827269, 5170.896582068262, 5173.689578625294, 5192.350956130484, 4867.050925069578, 4874.829380971649, 4878.390201224847, 4981.053599816023, 4985.5762260208285, 4997.900041999067, 5019.7239151847, 5037.949620503748, 5053.444121146745, 5095.566876815364, 4875.1224779540025, 4907.0, 4917.606591472602, 4930.950690493192, 4955.702657840541, 4718.3394324795245, 4886.120498310338, 4889.339939108175, 4961.206207006861, 4961.70229786214, 4910.06708725341, 4922.483139270468, 4929.088118698052, 4937.308776771183, 5016.0], "unit": "score", "name": "dojo.html", "value": 4688.1649038901}, {"lowerIsBetter": false, "replicates": [528.9841304760859, 531.2429787552737, 533.685125775792, 548.8435795798196, 550.4990458682598, 31542.369152616964, 31839.84080079602, 32028.519572206435, 32067.19832004201, 32070.198245043885, 37075.44386834193, 37357.06607334818, 37673.0, 38026.0, 38061.0, 7868.25251601097, 8034.156413576548, 8038.839223215532, 8045.517268963852, 8051.516908985451, 7872.488288261245, 7971.720989765359, 7977.641006154708, 7999.480033797814, 8002.799930001738, 7879.1726868678825, 7896.091949425832, 7923.445358824856, 7937.801554961115, 7940.722074727386, 7593.392528597699, 7630.122535908358, 7639.350655194316, 7655.578943158124, 7666.731664391719, 7799.5710235937, 7911.446198766089, 7916.881246781303, 7919.366450683931, 7920.168382319831, 35499.0, 35910.46134307988, 35943.4608480873, 35955.46066808974, 35987.4601880972, 2972.583838262645, 3003.065670944693, 3019.607451031352, 3053.282478617523, 3079.8460076996284, 26676.33309167267, 27228.45543089147, 27354.45291094167, 27481.038163664376, 27780.58329125065, 2979.575013283929, 3061.4183305171946, 3091.458994675945, 3126.1559378967777, 3148.5592017117624, 211699.0, 211835.0, 212690.93654531782, 213476.0, 213737.0, 50651.17511486152, 53862.0, 54158.18762718562, 54177.1873421899, 54321.0, 45631.0, 64580.0, 65368.67315663486, 65594.34405655978, 65616.34383656198, 11988.700282493008, 11993.400329983466, 12047.216930899638, 12075.0, 12075.215111017756, 9472.526373681289, 9513.809723805485, 9514.714558563253, 9523.952380238054, 9552.61789528425, 18820.811791881904, 19037.714434283498, 19139.330123445612, 19182.808171918383, 19333.51666208328, 7579.5073320234005, 7788.104367997639, 7850.528968261922, 7851.097123830718, 7973.322267607203, 889.8309321229075, 899.5142622983647, 913.1781396742851, 933.6872147830417, 975.8731364922514, 25879.74120258811, 25947.962081516904, 25972.220833375028, 29142.562861557093, 30294.697053029628, 959.2086528613921, 988.7775250568708, 997.6258902911409, 1005.5123265216364, 1065.477915821242, 12623.810642840364, 15224.543263702106, 15267.770983435257, 15373.923130384277, 15699.372025119095, 304474.0, 309039.0, 310101.0, 311062.0, 311771.0, 45897.31154032692, 46050.0, 46130.00154989915, 46134.30798538025, 46136.0, 1184.691980085184, 1195.9461824217758, 1200.933948632816, 1203.6810245285183, 1208.8186771984272, 26165.410545456383, 26194.60708089342, 26440.338991525365, 26614.600780988687, 26631.866840665672, 38312.233755325295, 38575.807120964215, 38985.0, 39029.804850976696, 39127.41308880312, 245633.0, 245799.771001151, 246981.0, 247239.0, 248009.0, 28486.287842803267, 41531.584684152775, 41926.371104432845, 41954.0, 42012.3698144522, 36702.0, 36864.81567592145, 37351.25297494089, 37919.62080379271, 38113.0, 31757.523637145925, 32218.35563288768, 32534.51198231981, 32645.836770815993, 32979.0, 32782.0, 36247.0, 38435.42346864855, 38463.14970525722, 38612.227755445296, 31875.521867172476, 31954.0, 32440.35119297648, 32574.0, 32599.0, 28927.56608650914, 29266.7073329264, 29615.434262394785, 30178.396432070796, 33168.6281556012, 23250.651240231073, 23537.0, 23648.408789780395, 23650.64524032175, 23768.168114116615], "unit": "score", "name": "ext.html", "value": 16841.975323796632}, {"lowerIsBetter": false, "replicates": [336.5893609796048, 338.95085212644165, 340.4467739922626, 340.89210067281334, 343.61171875780366, 10352.741181470466, 10738.9059133469, 14772.556823295305, 14868.0, 15688.294026768808, 14986.325615347308, 15053.17207553587, 15101.169435681033, 15427.305771240293, 15802.683946321067, 5668.518175955039, 5830.591858569902, 6397.296297407282, 6612.900806487906, 6627.60234385936, 6535.57518761279, 6571.375719306682, 6573.112629794964, 6573.704183311763, 6574.506911981596, 6331.55679102463, 6364.872702545947, 6520.152380190569, 6538.705758240867, 6580.210374755012, 6486.870262594769, 6593.307702691221, 6608.735650573972, 6623.437007854338, 6637.535372523926, 6393.392627700361, 6395.744170233185, 6396.392342727433, 6403.583767055126, 6409.519286053564, 19421.0, 21248.893755531277, 21708.69747815136, 21752.673709894363, 21889.67165492519, 1983.4644645945514, 2108.0, 2130.3289463818846, 2147.538279269949, 2159.946001349963, 13994.300284985811, 14018.299085045706, 14073.71852562943, 14297.0, 14482.49311274111, 1885.481492589535, 1898.1742941820353, 1900.5628705397835, 1969.1827891425041, 1997.121266642687, 61911.69044154751, 64226.678866605835, 64798.0, 65512.672436637986, 66300.33699663039, 15359.308831102628, 15463.149526775911, 15564.92217538905, 15568.299426525607, 15754.133522656364, 22999.770002300098, 23068.19261325879, 23262.185823496096, 23269.06923723066, 23287.18494852672, 8167.183281671785, 8194.631241594143, 8195.098539160688, 8253.0, 8292.543910084883, 6752.628605426748, 6753.628550429676, 6777.796666100025, 6790.0, 6800.31996800316, 7568.5458872467825, 7577.939088527611, 7586.848263034708, 7640.197779233212, 7654.2345765424125, 1678.5048410718623, 2959.5856580078807, 3006.428778532072, 3012.11742660837, 3026.8800543798934, 790.6244533846377, 817.4237162800212, 824.1675907333636, 865.7662431143556, 879.6965047058754, 14159.504417345344, 14339.99620026609, 14720.969532132862, 14936.775948360782, 14952.925235373754, 831.7255305749088, 854.6495936665937, 866.5320726807579, 902.6073657958809, 946.195733626412, 8469.40714150016, 8475.152484751476, 8546.102659220816, 8556.57217139153, 8639.438436501607, 519281.0, 525213.0, 526533.0, 528025.1178649858, 540916.0, 68677.65661171662, 74579.25420745723, 74893.62553187199, 75140.24859751442, 77938.61030694924, 1026.5996261458038, 1042.8227201375785, 1053.2995557954027, 1054.847047178155, 1074.9946250268856, 14424.639384015483, 14479.203643799692, 14523.128612283297, 14541.127532348093, 15000.924995374953, 32716.8207948013, 32796.67203327936, 33343.0, 33682.0, 33801.49297760487, 42393.576064238965, 42903.57096428996, 43128.78435607802, 45173.32240016468, 46063.309050364944, 8779.0, 8890.422122562013, 8935.910640893508, 9009.684661036832, 9035.322350823846, 11955.760884782081, 15813.604659883595, 16279.51161465158, 16344.346226150821, 16387.18064096814, 9994.950025249827, 10536.525856336637, 11801.704957376134, 12995.935020325216, 13098.476060957837, 12415.0, 12553.121281510206, 12710.0, 12993.220406775623, 13078.411471483616, 2337.953240935206, 11765.941170294094, 12392.698766629735, 12924.224546527239, 13714.451421943011, 8619.0, 8630.345343473382, 8656.134386561294, 8659.696910608098, 8708.042115367178, 12249.816252756395, 13421.731565368833, 13428.597142085753, 13455.125416847874, 14044.859551404765], "unit": "score", "name": "jquery.html", "value": 9208.924312586876}, {"lowerIsBetter": false, "replicates": [1473.0, 1632.2410079313117, 1696.7285234362505, 1706.2833609883844, 1719.2435328455479, 7119.537230080041, 7187.209406965243, 7373.373263272628, 7397.556146631206, 7407.185209626937, 7203.207647158808, 7220.747273845416, 7304.671289791959, 7325.12098548175, 7329.486935914488, 2071.751389833222, 2089.9059542320633, 2091.5607722378318, 2092.3199960013058, 2100.8130406320456, 2079.8336133109315, 2091.1530830013867, 2106.926257580985, 2116.9682454763115, 2120.4592828828704, 1733.6272701369203, 1758.1560850791627, 2039.612473630013, 2059.042545216474, 2063.6801295799173, 2017.7175195472646, 2018.1523760020752, 2027.1891243502569, 2027.3107143571256, 2032.2175962254491, 2021.1511165310606, 2048.3342913553006, 2061.3403710812545, 2070.1822780001967, 2084.8436367272516, 7129.786106416764, 7222.494425390225, 7257.745978890714, 7281.672324745399, 7283.635818209122, 4136.255474014676, 4164.333706606959, 4170.812313445872, 4185.058361868555, 4188.204241194194, 2749.312671832042, 2783.958240626392, 2812.4937511247967, 2820.689724130344, 2839.1198728394265, 901.0944001278673, 1570.8193557740778, 1592.1004632382667, 1649.4170505884153, 1677.3290683726484, 9235.030321816246, 9398.483083430408, 9424.104710052534, 9432.528373581363, 9452.716418507525, 3701.5373078365205, 3769.6795772359656, 3824.330742120118, 3825.4261860721112, 3829.6744776694295, 7626.694932202649, 7738.303552680286, 7751.651175697107, 7759.030121234846, 7767.883481747778, 4142.71001029925, 4150.543440221573, 4155.937660935088, 4160.646345060643, 4161.854335098257, 3814.3324918139215, 3825.5218097737784, 3825.923481530354, 3839.884803455901, 3844.5770965193806, 3123.109913674592, 3134.968650313513, 3167.7307428868803, 3188.984055079756, 3191.505316675919, 925.4724806860025, 941.1294552538874, 942.0673533202081, 967.4098799732158, 968.1673760565908, 839.3788596438714, 885.0574138542431, 909.5679552212779, 952.4523399045577, 984.886738025122, 6757.493188010821, 6823.727050917908, 6841.17905851301, 6848.246692863781, 6860.348266914635, 577.2726364780323, 593.3888095261888, 596.6718304932269, 600.5315853634172, 738.985220295591, 5132.640715149903, 5155.9742201288755, 5286.286351342596, 5286.735663216824, 5289.920651190235, 8392.874106888401, 8702.347323950602, 8780.736577902673, 8786.60460279289, 8826.823463530693, 8615.095414981462, 8683.522406267715, 8694.956525217334, 8709.390342676079, 8720.520371379509, 6674.16572928384, 6846.0, 6870.7595234166565, 6884.347756538395, 6924.826879328057, 6565.244996825426, 6602.372774586406, 6604.8348791280605, 6633.469322454095, 6639.734410623521, 7635.809104772425, 7821.256980586835, 7837.25546073145, 7839.78483335084, 7930.405219608437, 7890.921090789248, 7994.52032878006, 8083.757487275391, 8101.513909165469, 8106.513609183232, 6044.637321760709, 6061.787837425669, 6070.817875463743, 6139.754409823736, 6142.785002525069, 6943.236244013256, 6972.546784458994, 6990.370866622028, 6992.370686638227, 6999.755008574879, 6304.275008373912, 6362.968185159045, 6369.9681501592195, 6466.902996455151, 6538.607683539003, 6289.7169627365965, 6412.839679008062, 6482.740690372521, 6489.221293444628, 6569.37590928861, 6527.706253218712, 6606.372394622503, 6620.900686489803, 6634.0, 6658.3674550917585, 6085.756569737338, 6101.38986101404, 6113.5414843887775, 6132.41742034506, 6153.507719382349, 6100.420460056288, 6127.540434467522, 6144.78493252734, 6150.0, 6153.2616086068165], "unit": "score", "name": "mootools.html", "value": 4079.8774589629174}, {"lowerIsBetter": false, "replicates": [281.64794007490633, 294.3773918163085, 295.20442407711226, 298.2454390392308, 298.7833820480152, 5521.668699878011, 5553.055980483323, 5586.6368686035485, 5613.43865613439, 5615.129654903497, 5485.040117979348, 5496.7526461309235, 5503.3120859892515, 5505.201745746875, 5509.201165830952, 4257.276263035292, 4265.0, 4270.701050926436, 4277.615014648681, 4283.957160428403, 4128.607782260696, 4165.56261592533, 4183.560726123744, 4188.350805625133, 4200.1599680063955, 4117.855875044374, 4163.625273725364, 4176.227397931392, 4178.185253875496, 4180.393842892779, 4175.144095460439, 4175.62419382257, 4177.791110444466, 4187.853425130136, 4197.412362269285, 3609.06164397256, 3618.8733394331334, 3623.166671665532, 3628.4738712886747, 3635.1820840310984, 5240.7379631018675, 5336.9733151334385, 5357.571394288448, 5372.006178856885, 5428.077226871442, 4802.351682522884, 4806.639502037361, 4809.1343558159515, 4812.7352995585225, 4813.253945638432, 5819.505342045931, 5860.619059761145, 5871.735771890275, 5873.119032145212, 5880.0, 3936.6063393660693, 3942.921141577181, 3949.032487040665, 3951.0714981979213, 3954.584768599313, 5965.4631083202285, 6040.12418199363, 6128.203333566652, 6158.0147176452, 6163.907541386883, 4030.334994725896, 4057.087155390014, 4060.837566497307, 4060.939085913714, 4064.878053658395, 4117.526484454266, 4119.134981653886, 4120.8145633445965, 4121.381792731055, 4130.855420060284, 4780.995990841962, 4789.3294938708605, 4789.401324834395, 4792.616590672737, 4797.7601119943865, 5725.427457254241, 5754.136879468113, 5815.680137592473, 5831.970840145772, 5845.795397161079, 1426.6290764401124, 1443.6102252391795, 1444.241773069126, 1445.2701385800103, 1445.71808497342, 923.5751554285104, 932.2402242172608, 933.2114363362947, 937.0863408176973, 941.5904081724472, 5073.365829271341, 5075.5178258065425, 5079.263506791494, 5116.948830511647, 5117.71852548106, 5998.70006499682, 6023.728932198062, 6051.515878729691, 6103.05402662588, 6152.2924863640355, 5121.540360997098, 5124.5131712487255, 5144.6913185209005, 5150.381954165524, 5154.561862241677, 3250.414925313419, 3280.491523813813, 3281.671832816747, 3291.637919828817, 3295.5715756951445, 5779.335376431764, 5783.88432231353, 5803.158542011384, 5806.622569533051, 5812.0, 6099.939000610026, 6294.527910406646, 6300.0234963580715, 6302.2122234719745, 6303.779367722108, 5778.88442231153, 5782.739776710058, 5784.8264552062665, 5794.478496935211, 5800.88398232033, 6093.390660934048, 6098.695065246631, 6100.938990610214, 6114.052321890114, 6114.449699527064, 5862.560307977004, 5933.465988061095, 5968.373320801254, 5970.671613061149, 5988.880222395441, 5776.9133462998925, 5779.104238842818, 5781.913271300849, 5788.479036886532, 5806.44838740319, 3986.9202615948097, 4041.5958404160524, 4042.7372220805555, 4043.8180281887976, 4052.8986775330854, 5954.553408494294, 6081.331053584191, 6086.269647642134, 6092.573519853745, 6097.32929377777, 5837.854053648693, 5841.1238314253205, 5846.56150788684, 5847.795327163529, 5873.559483038704, 5848.561357898089, 5853.531717462678, 5857.150713146655, 5878.588498805043, 5885.852853678693, 5718.628289161191, 5732.054211055296, 5751.827445176651, 5753.05074662676, 5754.482096611325, 5718.1708652246025, 5929.0, 5960.552958528215, 5964.314103877936, 5966.970165149147, 5740.622250659895, 5780.971095144498, 5783.768649253982, 5804.970975145097, 5815.389384114607], "unit": "score", "name": "prototype.html", "value": 4337.070189266033}, {"lowerIsBetter": false, "replicates": [660.4650233311015, 667.6394746836709, 729.1796728680234, 788.8422315536892, 792.4294507954273, 10839.512221950012, 11142.554297828086, 11151.219414640978, 11162.665120046402, 11171.0, 12356.691082722913, 12756.107072504929, 12773.105882588223, 12780.744385112292, 12793.872061279384, 781.2539025230919, 783.4554984285924, 789.4039999800143, 796.2475460689651, 798.1938242375214, 787.3661702329651, 793.4763056382789, 798.3812545277399, 798.9840203195932, 799.1648727080186, 812.475953010308, 815.8694608862584, 817.8732296494053, 818.8771684247351, 819.1194465949098, 813.7558732380262, 815.5473712089788, 815.8613035783931, 817.1624085312543, 818.0183779464667, 594.2393736017904, 599.5563283170466, 605.4550904186224, 605.7334772699998, 606.6633018674634, 11573.826392604118, 11659.708507287301, 11672.066234701204, 11673.357965311905, 11674.591389301419, 10796.082333001705, 10879.292845965067, 11040.117835567622, 11441.084713222923, 11826.467808948619, 9107.362484626012, 9152.725418237464, 9257.213136883372, 9351.812963740755, 9462.763430914214, 3100.472919603673, 3118.781685282031, 3135.216195951012, 3148.134263077649, 3200.1839530919465, 41174.79412602918, 41185.382219266736, 41721.0, 41983.580164198574, 42022.0, 9171.81656366869, 9236.72289831306, 9242.768930776785, 9355.672551460666, 9381.765455863659, 15576.688466230838, 15695.450659227101, 15748.0, 15813.1302778346, 15815.841841581438, 6086.573939824169, 6191.071339299051, 6210.472109870711, 6217.440430361289, 6234.189555357865, 3510.596281427617, 3564.0733409313248, 3573.6069032406413, 3586.8385922633543, 3616.72874534411, 2611.4646497467975, 2635.512430200419, 2643.2730998975435, 2651.496215719007, 2654.230273220783, 453.2136742751324, 460.7926433105116, 470.17484315027593, 474.54917828062787, 479.46300143839125, 466.22141024489184, 473.758383224558, 494.45609829187606, 563.7681665560681, 570.6005795942774, 7521.247875212544, 7653.4642575020325, 7685.846283074307, 7909.0, 7968.0, 439.9780010999437, 445.2541992163114, 467.4390731122666, 489.9441703129761, 524.4991033562939, 3586.7668601540818, 3680.926381472409, 3860.654351567225, 3929.4498770171626, 4212.68404869636, 54291.72854135704, 54716.179257311174, 55247.0, 55829.44170558324, 55935.0, 45850.0, 47022.76488617535, 48441.5155848437, 48583.028339433724, 48992.265116023285, 41802.79098604488, 41853.58146418497, 42048.159036819095, 42508.78745606314, 42866.571334286884, 8408.83182336362, 8588.742337729878, 8607.698730544402, 8828.602712878064, 8831.514266715392, 31310.37379252448, 31443.68556314499, 31947.6805231954, 32066.679333206368, 32145.0, 36429.81785091058, 38291.6170838288, 41008.79495602503, 41838.79080604578, 43679.0, 10509.054185123376, 10524.31591946521, 10893.564257429614, 10937.671869843918, 11231.55073797039, 11417.543298267976, 11566.884331156582, 11664.872837439181, 12137.514499419924, 12528.0, 10500.389680461947, 10547.841782373118, 10670.0, 11033.172512061788, 11123.555057797921, 10553.525091370753, 10776.67669969902, 10957.780844383227, 11180.832287515856, 11347.432628368713, 9345.672901448417, 9430.575624096795, 9439.622415103318, 9491.952540237531, 9667.274954378308, 8538.359623028422, 8577.185167409087, 8612.741617751477, 8767.606159728888, 9229.769255768659, 8277.255047045795, 8759.868601971102, 8977.7755556109, 9034.683786067457, 9077.0], "unit": "score", "name": "yui.html", "value": 5700.283522034536}], "name": "dromaeo_css", "value": 6469.912457269633}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 110.0, 115.0, 116.0, 115.0, 125.0, 115.0, 113.0, 115.0, 114.0], "unit": "score", "name": "ai-astar", "value": 115.2}, {"lowerIsBetter": true, "replicates": [155.0, 139.0, 156.0, 169.0, 131.0, 154.0, 149.0, 141.0, 164.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 149.0}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 163.0, 163.0, 166.0, 168.0, 167.0, 162.0, 164.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.2}, {"lowerIsBetter": true, "replicates": [75.0, 72.0, 74.0, 74.0, 132.0, 74.0, 79.0, 73.0, 73.0, 87.0], "unit": "score", "name": "audio-fft", "value": 81.3}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 132.0, 94.0, 95.0, 95.0, 133.0, 95.0, 97.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 107.2}, {"lowerIsBetter": true, "replicates": [110.0, 112.0, 111.0, 115.0, 110.0, 110.0, 110.0, 110.0, 111.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.8}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 147.0, 148.0, 148.0, 147.0, 146.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 97.0, 97.0, 97.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [72.0, 77.0, 71.0, 71.0, 72.0, 71.0, 70.0, 74.0, 71.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 71.8}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 83.0, 86.0, 85.0, 83.0, 83.0, 85.0, 83.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [124.0, 131.0, 121.0, 132.0, 132.0, 130.0, 124.0, 122.0, 123.0, 134.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.3}, {"lowerIsBetter": true, "replicates": [139.0, 151.0, 147.0, 157.0, 151.0, 144.0, 149.0, 149.0, 150.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.7}, {"lowerIsBetter": true, "replicates": [76.0, 72.0, 71.0, 72.0, 70.0, 74.0, 70.0, 72.0, 71.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.8}], "name": "kraken", "value": 1543.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.19612104999163], "unit": "score", "name": "Richards", "value": 211.14126199999998}, {"lowerIsBetter": false, "replicates": [185.49434242255612], "unit": "score", "name": "DeltaBlue", "value": 356.44213800000017}, {"lowerIsBetter": false, "replicates": [277.77777777777777], "unit": "score", "name": "Encrypt", "value": 958.2516000000002}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1044.932079414838], "unit": "score", "name": "RayTrace", "value": 708.1694730000004}, {"lowerIsBetter": false, "replicates": [742.3904974016333], "unit": "score", "name": "Earley", "value": 897.725661}, {"lowerIsBetter": false, "replicates": [12419.753086419752], "unit": "score", "name": "Boyer", "value": 53.66153379721673}, {"lowerIsBetter": false, "replicates": [28000.0], "unit": "score", "name": "RegExp", "value": 32.53517857142855}, {"lowerIsBetter": false, "replicates": [673.3466933867735], "unit": "score", "name": "Splay", "value": 121.0238363095238}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20905.481423672576}]} 07:46:30 INFO - RETURN: dromaeo_css: 6469.91 07:46:30 INFO - RETURN: kraken: 1543.10 07:46:30 INFO - RETURN: v8_7: 20905.48 07:46:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20905.48"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1543.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6469.91"}}} 07:46:30 INFO - Return code: 0 07:46:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:46:30 INFO - # TBPL SUCCESS # 07:46:30 INFO - Running post-action listener: _resource_record_post_action 07:46:30 INFO - Running post-run listener: _resource_record_post_run 07:46:31 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 2125824; Write bytes: 506228736; Read time: 892; Write time: 605144 07:46:31 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 232218624; Read time: 0; Write time: 379528 07:46:31 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 2125824; Write bytes: 273805312; Read time: 892; Write time: 225596 07:46:31 INFO - Running post-run listener: _upload_blobber_files 07:46:31 INFO - Blob upload gear active. 07:46:31 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:46:31 INFO - Copying logs to upload dir... 07:46:31 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.620650 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-15 07:46:31.272086) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-15 07:46:31.277397) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/mXqUEzUFQFaBAzzaoyUQqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010165 build_url: 'https://queue.taskcluster.net/v1/task/mXqUEzUFQFaBAzzaoyUQqw/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 07:46:31.328052) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 07:46:31.328401) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450193118.940597-1320038441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 07:46:31.377621) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 07:46:31.377923) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 07:46:31.378208) ========= ========= Total master_lag: 0.22 =========