builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-059 starttime: 1449264182.84 results: success (0) buildid: 20151204115212 builduid: 44fc70f56232404e95a37bbf72b93913 revision: 378ef42875ed296adb790020ebeee26490c026d8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 13:23:02.843453) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 13:23:02.843857) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 13:23:02.844155) ========= 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=5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006272 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 13:23:02.870295) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 13:23:02.873654) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 13:23:02.887723) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:23:02.888080) ========= 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=5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004710 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:23:02.937209) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 13:23:02.940651) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 13:23:02.941051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:23:02.941366) ========= 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=5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-04 13:23:03-- 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% 43.8M=0s 2015-12-04 13:23:03 (43.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114527 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:23:03.075516) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:23:03.076130) ========= 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=5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019228 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:23:03.129145) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:23:03.132526) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 378ef42875ed296adb790020ebeee26490c026d8 --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 378ef42875ed296adb790020ebeee26490c026d8 --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=5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-04 13:23:03,510 truncating revision to first 12 chars 2015-12-04 13:23:03,510 Setting DEBUG logging. 2015-12-04 13:23:03,510 attempt 1/10 2015-12-04 13:23:03,510 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/378ef42875ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-04 13:23:03,826 unpacking tar archive at: fx-team-378ef42875ed/testing/mozharness/ program finished with exit code 0 elapsedTime=0.685152 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:23:03.834144) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 13:23:03.834631) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 13:23:03.849094) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 13:23:03.849431) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 13:23:03.849839) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-04 13:23:03.850241) ========= /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=5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:23:04 INFO - MultiFileLogger online at 20151204 13:23:04 in /builds/slave/test 13:23:04 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 13:23:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:23:04 INFO - {'append_to_log': False, 13:23:04 INFO - 'base_work_dir': '/builds/slave/test', 13:23:04 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:23:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:23:04 INFO - 'branch': 'Fx-Team-Non-PGO', 13:23:04 INFO - 'buildbot_json_path': 'buildprops.json', 13:23:04 INFO - 'config_files': ('talos/linux_config.py',), 13:23:04 INFO - 'default_actions': ('clobber', 13:23:04 INFO - 'read-buildbot-config', 13:23:04 INFO - 'download-and-extract', 13:23:04 INFO - 'populate-webroot', 13:23:04 INFO - 'create-virtualenv', 13:23:04 INFO - 'install', 13:23:04 INFO - 'run-tests'), 13:23:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:23:04 INFO - 'download_minidump_stackwalk': True, 13:23:04 INFO - 'download_symbols': 'ondemand', 13:23:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:23:04 INFO - 'tooltool.py': '/tools/tooltool.py', 13:23:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:23:04 INFO - '/tools/misc-python/virtualenv.py')}, 13:23:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:23:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:23:04 INFO - 'installer_path': 'installer.exe', 13:23:04 INFO - 'log_level': 'info', 13:23:04 INFO - 'log_name': 'talos', 13:23:04 INFO - 'log_to_console': True, 13:23:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:23:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:23:04 INFO - 'opt_config_files': (), 13:23:04 INFO - 'pip_index': False, 13:23:04 INFO - 'sps_profile': False, 13:23:04 INFO - 'sps_profile_interval': 0, 13:23:04 INFO - 'suite': 'dromaeojs-e10s', 13:23:04 INFO - 'system_bits': '64', 13:23:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:23:04 INFO - 'title': 'talos-linux64-ix-059', 13:23:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:23:04 INFO - 'use_talos_json': True, 13:23:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:23:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:23:04 INFO - 'work_dir': 'build'} 13:23:04 INFO - ##### 13:23:04 INFO - ##### Running clobber step. 13:23:04 INFO - ##### 13:23:04 INFO - Running pre-action listener: _resource_record_pre_action 13:23:04 INFO - Running main action method: clobber 13:23:04 INFO - rmtree: /builds/slave/test/build 13:23:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:23:04 INFO - Running post-action listener: _resource_record_post_action 13:23:04 INFO - ##### 13:23:04 INFO - ##### Running read-buildbot-config step. 13:23:04 INFO - ##### 13:23:04 INFO - Running pre-action listener: _resource_record_pre_action 13:23:04 INFO - Running main action method: read_buildbot_config 13:23:04 INFO - Using buildbot properties: 13:23:04 INFO - { 13:23:04 INFO - "properties": { 13:23:04 INFO - "buildnumber": 543, 13:23:04 INFO - "product": "firefox", 13:23:04 INFO - "script_repo_revision": "production", 13:23:04 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 13:23:04 INFO - "repository": "", 13:23:04 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 13:23:04 INFO - "buildid": "20151204115212", 13:23:04 INFO - "slavename": "talos-linux64-ix-059", 13:23:04 INFO - "pgo_build": "False", 13:23:04 INFO - "basedir": "/builds/slave/test", 13:23:04 INFO - "project": "", 13:23:04 INFO - "platform": "ubuntu64_hw", 13:23:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:23:04 INFO - "slavebuilddir": "test", 13:23:04 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:23:04 INFO - "branch": "fx-team", 13:23:04 INFO - "repo_path": "integration/fx-team", 13:23:04 INFO - "stage_platform": "linux64", 13:23:04 INFO - "builduid": "44fc70f56232404e95a37bbf72b93913", 13:23:04 INFO - "revision": "378ef42875ed296adb790020ebeee26490c026d8" 13:23:04 INFO - }, 13:23:04 INFO - "sourcestamp": { 13:23:04 INFO - "repository": "", 13:23:04 INFO - "hasPatch": false, 13:23:04 INFO - "project": "", 13:23:04 INFO - "branch": "fx-team-linux64-talos", 13:23:04 INFO - "changes": [ 13:23:04 INFO - { 13:23:04 INFO - "category": null, 13:23:04 INFO - "files": [ 13:23:04 INFO - { 13:23:04 INFO - "url": null, 13:23:04 INFO - "name": "https://queue.taskcluster.net/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 13:23:04 INFO - } 13:23:04 INFO - ], 13:23:04 INFO - "repository": "", 13:23:04 INFO - "rev": "378ef42875ed296adb790020ebeee26490c026d8", 13:23:04 INFO - "who": "dtownsend@mozilla.com", 13:23:04 INFO - "when": 1449260986, 13:23:04 INFO - "number": 6745819, 13:23:04 INFO - "comments": "Bug 1227981: Test that referencing a DTD from the inline options of an add-on works. r=rhelmer", 13:23:04 INFO - "project": "", 13:23:04 INFO - "at": "Fri 04 Dec 2015 12:29:46", 13:23:04 INFO - "branch": "fx-team-linux64-talos", 13:23:04 INFO - "revlink": "", 13:23:04 INFO - "properties": [ 13:23:04 INFO - [ 13:23:04 INFO - "buildid", 13:23:04 INFO - "20151204115212", 13:23:04 INFO - "Change" 13:23:04 INFO - ], 13:23:04 INFO - [ 13:23:04 INFO - "builduid", 13:23:04 INFO - "44fc70f56232404e95a37bbf72b93913", 13:23:04 INFO - "Change" 13:23:04 INFO - ], 13:23:04 INFO - [ 13:23:04 INFO - "pgo_build", 13:23:04 INFO - "False", 13:23:04 INFO - "Change" 13:23:04 INFO - ] 13:23:04 INFO - ], 13:23:04 INFO - "revision": "378ef42875ed296adb790020ebeee26490c026d8" 13:23:04 INFO - } 13:23:04 INFO - ], 13:23:04 INFO - "revision": "378ef42875ed296adb790020ebeee26490c026d8" 13:23:04 INFO - } 13:23:04 INFO - } 13:23:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 13:23:04 INFO - Running post-action listener: _resource_record_post_action 13:23:04 INFO - ##### 13:23:04 INFO - ##### Running download-and-extract step. 13:23:04 INFO - ##### 13:23:04 INFO - Running pre-action listener: _resource_record_pre_action 13:23:04 INFO - Running main action method: download_and_extract 13:23:04 INFO - mkdir: /builds/slave/test/build/tests 13:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:04 INFO - https://queue.taskcluster.net/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:23:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/test_packages.json 13:23:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/test_packages.json 13:23:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 13:23:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 13:23:05 INFO - Downloaded 1302 bytes. 13:23:05 INFO - Reading from file /builds/slave/test/build/test_packages.json 13:23:05 INFO - Using the following test package requirements: 13:23:05 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:23:05 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:23:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:23:05 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:23:05 INFO - u'jsshell-linux-x86_64.zip'], 13:23:05 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:23:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:23:05 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:23:05 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:23:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:23:05 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:23:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:23:05 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:23:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:23:05 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:23:05 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:23:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:23:05 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:05 INFO - https://queue.taskcluster.net/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:23:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:23:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:23:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:23:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:23:06 INFO - Downloaded 21849117 bytes. 13:23:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 13:23:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:23:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:23:07 INFO - Return code: 0 13:23:07 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:07 INFO - https://queue.taskcluster.net/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:23:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:23:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:23:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:23:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:23:10 INFO - Downloaded 21849117 bytes. 13:23:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 13:23:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:23:10 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:23:11 INFO - Return code: 0 13:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:11 INFO - https://queue.taskcluster.net/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:23:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:23:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:23:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:23:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:23:12 INFO - Downloaded 11132001 bytes. 13:23:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 13:23:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:23:12 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 13:23:12 INFO - Return code: 0 13:23:12 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')]} 13:23:12 INFO - https://queue.taskcluster.net/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:23:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:23:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:23:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:23:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:23:14 INFO - Downloaded 57704806 bytes. 13:23:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:23:14 INFO - mkdir: /builds/slave/test/properties 13:23:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:23:14 INFO - Writing to file /builds/slave/test/properties/build_url 13:23:14 INFO - Contents: 13:23:14 INFO - build_url:https://queue.taskcluster.net/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:23:14 INFO - Running post-action listener: _resource_record_post_action 13:23:14 INFO - Running post-action listener: set_extra_try_arguments 13:23:14 INFO - ##### 13:23:14 INFO - ##### Running populate-webroot step. 13:23:14 INFO - ##### 13:23:14 INFO - Running pre-action listener: _resource_record_pre_action 13:23:14 INFO - Running main action method: populate_webroot 13:23:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:23:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:23:14 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 13:23:14 INFO - '../fennec_ids.txt'], 13:23:14 INFO - 'tests': ['tcheck2']}, 13:23:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:23:14 INFO - '--tppagecycles', 13:23:14 INFO - '7'], 13:23:14 INFO - 'tests': ['tsvgm']}}, 13:23:14 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:23:14 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:23:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:23:14 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:23:14 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:23:14 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:23:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:23:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:14 INFO - 'talos_options': ['--e10s'], 13:23:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:23:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:14 INFO - 'tests': ['damp', 'tps']}, 13:23:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:14 INFO - 'talos_options': ['--e10s'], 13:23:14 INFO - 'tests': ['damp', 'tps']}, 13:23:14 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:23:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:23:14 INFO - 'other': {'tests': ['a11yr', 13:23:14 INFO - 'ts_paint', 13:23:14 INFO - 'tpaint', 13:23:14 INFO - 'sessionrestore', 13:23:14 INFO - 'sessionrestore_no_auto_restore']}, 13:23:14 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:23:14 INFO - 'tests': ['a11yr', 13:23:14 INFO - 'ts_paint', 13:23:14 INFO - 'tpaint', 13:23:14 INFO - 'sessionrestore', 13:23:14 INFO - 'sessionrestore_no_auto_restore']}, 13:23:14 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:23:14 INFO - 'tests': ['a11yr', 13:23:14 INFO - 'ts_paint', 13:23:14 INFO - 'tpaint', 13:23:14 INFO - 'sessionrestore', 13:23:14 INFO - 'sessionrestore_no_auto_restore']}, 13:23:14 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:23:14 INFO - 'tests': ['a11yr', 13:23:14 INFO - 'ts_paint', 13:23:14 INFO - 'tpaint', 13:23:14 INFO - 'sessionrestore', 13:23:14 INFO - 'sessionrestore_no_auto_restore']}, 13:23:14 INFO - 'other_l64': {'tests': ['a11yr', 13:23:14 INFO - 'ts_paint', 13:23:14 INFO - 'tpaint', 13:23:14 INFO - 'sessionrestore', 13:23:14 INFO - 'sessionrestore_no_auto_restore']}, 13:23:14 INFO - 'other_nol64': {'tests': ['a11yr', 13:23:14 INFO - 'ts_paint', 13:23:14 INFO - 'tpaint', 13:23:14 INFO - 'sessionrestore', 13:23:14 INFO - 'sessionrestore_no_auto_restore']}, 13:23:14 INFO - 'svgr': {'tests': ['tsvgx', 13:23:14 INFO - 'tsvgr_opacity', 13:23:14 INFO - 'tart', 13:23:14 INFO - 'tscrollx', 13:23:14 INFO - 'cart']}, 13:23:14 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:23:14 INFO - 'tests': ['tsvgx', 13:23:14 INFO - 'tsvgr_opacity', 13:23:14 INFO - 'tart', 13:23:14 INFO - 'tscrollx', 13:23:14 INFO - 'cart']}, 13:23:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:14 INFO - 'tests': ['tp5o']}, 13:23:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:14 INFO - 'talos_options': ['--e10s'], 13:23:14 INFO - 'tests': ['tp5o']}, 13:23:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:14 INFO - 'talos_options': ['--xperf_path', 13:23:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:23:14 INFO - 'tests': ['tp5n']}, 13:23:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:14 INFO - 'talos_options': ['--e10s', 13:23:14 INFO - '--xperf_path', 13:23:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:23:14 INFO - 'tests': ['tp5n']}}, 13:23:14 INFO - 'talos.zip': {'path': '', 13:23:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:23:14 INFO - Running post-action listener: _resource_record_post_action 13:23:14 INFO - ##### 13:23:14 INFO - ##### Running create-virtualenv step. 13:23:14 INFO - ##### 13:23:14 INFO - Running pre-action listener: _resource_record_pre_action 13:23:14 INFO - Running main action method: create_virtualenv 13:23:14 INFO - Creating virtualenv /builds/slave/test/build/venv 13:23:14 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 13:23:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:23:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:23:14 INFO - Using real prefix '/usr' 13:23:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:23:14 INFO - Installing distribute.............................................................................................................................................................................................done. 13:23:17 INFO - Installing pip.................done. 13:23:17 INFO - Return code: 0 13:23:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:23:17 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')]} 13:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:17 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')]} 13:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:17 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 0x7f0b18121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2974240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a030b0>, '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 0x2a03fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a04440>, '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': '5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727', '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 13:23:17 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 13:23:17 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 13:23:17 INFO - Using env: {'DISPLAY': ':0', 13:23:17 INFO - 'HOME': '/home/cltbld', 13:23:17 INFO - 'LANG': 'en_US.UTF-8', 13:23:17 INFO - 'LANGUAGE': 'en_US:en', 13:23:17 INFO - 'LOGNAME': 'cltbld', 13:23:17 INFO - 'MAIL': '/var/mail/cltbld', 13:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:17 INFO - 'MOZ_NO_REMOTE': '1', 13:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:17 INFO - 'NO_EM_RESTART': '1', 13:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:17 INFO - 'PWD': '/builds/slave/test', 13:23:17 INFO - 'SHELL': '/bin/bash', 13:23:17 INFO - 'SHLVL': '1', 13:23:17 INFO - 'TERM': 'linux', 13:23:17 INFO - 'TMOUT': '86400', 13:23:17 INFO - 'USER': 'cltbld', 13:23:17 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727', 13:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:17 INFO - '_': '/tools/buildbot/bin/python'} 13:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:17 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 13:23:17 INFO - Cleaning up... 13:23:17 INFO - Return code: 0 13:23:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:23:17 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')]} 13:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:17 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')]} 13:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:17 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 0x7f0b18121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2974240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a030b0>, '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 0x2a03fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a04440>, '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': '5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727', '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 13:23:17 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 13:23:17 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 13:23:17 INFO - Using env: {'DISPLAY': ':0', 13:23:17 INFO - 'HOME': '/home/cltbld', 13:23:17 INFO - 'LANG': 'en_US.UTF-8', 13:23:17 INFO - 'LANGUAGE': 'en_US:en', 13:23:17 INFO - 'LOGNAME': 'cltbld', 13:23:17 INFO - 'MAIL': '/var/mail/cltbld', 13:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:17 INFO - 'MOZ_NO_REMOTE': '1', 13:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:17 INFO - 'NO_EM_RESTART': '1', 13:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:17 INFO - 'PWD': '/builds/slave/test', 13:23:17 INFO - 'SHELL': '/bin/bash', 13:23:17 INFO - 'SHLVL': '1', 13:23:17 INFO - 'TERM': 'linux', 13:23:17 INFO - 'TMOUT': '86400', 13:23:17 INFO - 'USER': 'cltbld', 13:23:17 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727', 13:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:17 INFO - '_': '/tools/buildbot/bin/python'} 13:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:17 INFO - Downloading/unpacking psutil>=0.7.1 13:23:17 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 13:23:17 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 13:23:17 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 13:23:17 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 13:23:17 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 13:23:17 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 13:23:19 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 13:23:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:23:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:23:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:23:19 INFO - Installing collected packages: psutil 13:23:19 INFO - Running setup.py install for psutil 13:23:19 INFO - building 'psutil._psutil_linux' extension 13:23:19 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 13:23:19 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 13:23:19 INFO - building 'psutil._psutil_posix' extension 13:23:19 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 13:23:19 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 13:23:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:23:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:23:19 INFO - Successfully installed psutil 13:23:19 INFO - Cleaning up... 13:23:19 INFO - Return code: 0 13:23:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:23:19 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')]} 13:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:19 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')]} 13:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:19 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 0x7f0b18121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2974240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a030b0>, '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 0x2a03fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a04440>, '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': '5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727', '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 13:23:19 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 13:23:19 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 13:23:19 INFO - Using env: {'DISPLAY': ':0', 13:23:19 INFO - 'HOME': '/home/cltbld', 13:23:19 INFO - 'LANG': 'en_US.UTF-8', 13:23:19 INFO - 'LANGUAGE': 'en_US:en', 13:23:19 INFO - 'LOGNAME': 'cltbld', 13:23:19 INFO - 'MAIL': '/var/mail/cltbld', 13:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:19 INFO - 'MOZ_NO_REMOTE': '1', 13:23:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:19 INFO - 'NO_EM_RESTART': '1', 13:23:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:19 INFO - 'PWD': '/builds/slave/test', 13:23:19 INFO - 'SHELL': '/bin/bash', 13:23:19 INFO - 'SHLVL': '1', 13:23:19 INFO - 'TERM': 'linux', 13:23:19 INFO - 'TMOUT': '86400', 13:23:19 INFO - 'USER': 'cltbld', 13:23:19 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727', 13:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:19 INFO - '_': '/tools/buildbot/bin/python'} 13:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:23:20 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 13:23:20 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 13:23:20 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 13:23:20 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 13:23:20 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 13:23:20 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 13:23:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:23:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:23:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:23:21 INFO - Installing collected packages: mozsystemmonitor 13:23:21 INFO - Running setup.py install for mozsystemmonitor 13:23:21 INFO - Successfully installed mozsystemmonitor 13:23:21 INFO - Cleaning up... 13:23:21 INFO - Return code: 0 13:23:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:23:21 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')]} 13:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:21 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')]} 13:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:21 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 0x7f0b18121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2974240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a030b0>, '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 0x2a03fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a04440>, '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': '5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727', '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 13:23:21 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 13:23:21 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 13:23:21 INFO - Using env: {'DISPLAY': ':0', 13:23:21 INFO - 'HOME': '/home/cltbld', 13:23:21 INFO - 'LANG': 'en_US.UTF-8', 13:23:21 INFO - 'LANGUAGE': 'en_US:en', 13:23:21 INFO - 'LOGNAME': 'cltbld', 13:23:21 INFO - 'MAIL': '/var/mail/cltbld', 13:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:21 INFO - 'MOZ_NO_REMOTE': '1', 13:23:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:21 INFO - 'NO_EM_RESTART': '1', 13:23:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:21 INFO - 'PWD': '/builds/slave/test', 13:23:21 INFO - 'SHELL': '/bin/bash', 13:23:21 INFO - 'SHLVL': '1', 13:23:21 INFO - 'TERM': 'linux', 13:23:21 INFO - 'TMOUT': '86400', 13:23:21 INFO - 'USER': 'cltbld', 13:23:21 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727', 13:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:21 INFO - '_': '/tools/buildbot/bin/python'} 13:23:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:22 INFO - Downloading/unpacking blobuploader==1.2.4 13:23:22 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 13:23:22 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 13:23:22 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 13:23:22 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 13:23:22 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 13:23:22 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 13:23:23 INFO - Downloading blobuploader-1.2.4.tar.gz 13:23:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:23:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:23:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:23:23 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 13:23:23 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 13:23:23 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 13:23:23 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 13:23:23 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 13:23:23 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 13:23:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:23:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:23:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:23:24 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 13:23:24 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 13:23:24 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 13:23:24 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 13:23:24 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 13:23:24 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 13:23:24 INFO - Downloading docopt-0.6.1.tar.gz 13:23:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:23:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:23:24 INFO - Installing collected packages: blobuploader, requests, docopt 13:23:24 INFO - Running setup.py install for blobuploader 13:23:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:23:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:23:24 INFO - Running setup.py install for requests 13:23:25 INFO - Running setup.py install for docopt 13:23:25 INFO - Successfully installed blobuploader requests docopt 13:23:25 INFO - Cleaning up... 13:23:25 INFO - Return code: 0 13:23:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:25 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 0x7f0b18121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2974240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a030b0>, '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 0x2a03fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a04440>, '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': '5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727', '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 13:23:25 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 13:23:25 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 13:23:25 INFO - Using env: {'DISPLAY': ':0', 13:23:25 INFO - 'HOME': '/home/cltbld', 13:23:25 INFO - 'LANG': 'en_US.UTF-8', 13:23:25 INFO - 'LANGUAGE': 'en_US:en', 13:23:25 INFO - 'LOGNAME': 'cltbld', 13:23:25 INFO - 'MAIL': '/var/mail/cltbld', 13:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:25 INFO - 'MOZ_NO_REMOTE': '1', 13:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:25 INFO - 'NO_EM_RESTART': '1', 13:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:25 INFO - 'PWD': '/builds/slave/test', 13:23:25 INFO - 'SHELL': '/bin/bash', 13:23:25 INFO - 'SHLVL': '1', 13:23:25 INFO - 'TERM': 'linux', 13:23:25 INFO - 'TMOUT': '86400', 13:23:25 INFO - 'USER': 'cltbld', 13:23:25 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727', 13:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:25 INFO - '_': '/tools/buildbot/bin/python'} 13:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:23:25 INFO - Running setup.py (path:/tmp/pip-bZnugq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:23:25 INFO - Running setup.py (path:/tmp/pip-vs9JjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:23:25 INFO - Running setup.py (path:/tmp/pip-7inIFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:23:25 INFO - Running setup.py (path:/tmp/pip-tCSaXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:23:25 INFO - Running setup.py (path:/tmp/pip-plzgTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:23:25 INFO - Running setup.py (path:/tmp/pip-M_lBzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:23:25 INFO - Running setup.py (path:/tmp/pip-nWGjp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:23:25 INFO - Running setup.py (path:/tmp/pip-O1OLdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:23:25 INFO - Running setup.py (path:/tmp/pip-1euaYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:23:26 INFO - Running setup.py (path:/tmp/pip-nCJ7f6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:23:26 INFO - Running setup.py (path:/tmp/pip-MliuGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:23:26 INFO - Running setup.py (path:/tmp/pip-GdnPwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:23:26 INFO - Running setup.py (path:/tmp/pip-lZ8FVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:23:26 INFO - Running setup.py (path:/tmp/pip-Mj8sFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:26 INFO - Running setup.py (path:/tmp/pip-zlnKtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:23:26 INFO - Running setup.py (path:/tmp/pip-s0EKxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:23:26 INFO - Running setup.py (path:/tmp/pip-la9eCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:23:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:23:26 INFO - Running setup.py install for manifestparser 13:23:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:23:26 INFO - Running setup.py install for mozcrash 13:23:26 INFO - Running setup.py install for mozdebug 13:23:26 INFO - Running setup.py install for mozdevice 13:23:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:23:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:23:27 INFO - Running setup.py install for mozfile 13:23:27 INFO - Running setup.py install for mozhttpd 13:23:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:23:27 INFO - Running setup.py install for mozinfo 13:23:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:23:27 INFO - Running setup.py install for mozInstall 13:23:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:23:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:23:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:23:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:23:27 INFO - Running setup.py install for mozleak 13:23:27 INFO - Running setup.py install for mozlog 13:23:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:23:27 INFO - Running setup.py install for moznetwork 13:23:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:23:27 INFO - Running setup.py install for mozprocess 13:23:27 INFO - Running setup.py install for mozprofile 13:23:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:23:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:23:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:23:27 INFO - Running setup.py install for mozrunner 13:23:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:23:28 INFO - Running setup.py install for mozscreenshot 13:23:28 INFO - Running setup.py install for moztest 13:23:28 INFO - Running setup.py install for mozversion 13:23:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:23:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:23:28 INFO - Cleaning up... 13:23:28 INFO - Return code: 0 13:23:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23: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')]} 13:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23: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')]} 13:23:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:28 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 0x7f0b18121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2974240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a030b0>, '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 0x2a03fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a04440>, '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': '5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727', '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 13:23:28 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 13:23:28 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 13:23:28 INFO - Using env: {'DISPLAY': ':0', 13:23:28 INFO - 'HOME': '/home/cltbld', 13:23:28 INFO - 'LANG': 'en_US.UTF-8', 13:23:28 INFO - 'LANGUAGE': 'en_US:en', 13:23:28 INFO - 'LOGNAME': 'cltbld', 13:23:28 INFO - 'MAIL': '/var/mail/cltbld', 13:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:28 INFO - 'MOZ_NO_REMOTE': '1', 13:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:28 INFO - 'NO_EM_RESTART': '1', 13:23:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:28 INFO - 'PWD': '/builds/slave/test', 13:23:28 INFO - 'SHELL': '/bin/bash', 13:23:28 INFO - 'SHLVL': '1', 13:23:28 INFO - 'TERM': 'linux', 13:23:28 INFO - 'TMOUT': '86400', 13:23:28 INFO - 'USER': 'cltbld', 13:23:28 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727', 13:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:28 INFO - '_': '/tools/buildbot/bin/python'} 13:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:23:28 INFO - Running setup.py (path:/tmp/pip-gsaHA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:23:28 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)) 13:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:23:28 INFO - Running setup.py (path:/tmp/pip-ByNJnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:23:28 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)) 13:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:23:28 INFO - Running setup.py (path:/tmp/pip-mw9w41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:23:28 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)) 13:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:23:28 INFO - Running setup.py (path:/tmp/pip-q6omRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:23:28 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)) 13:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:23:28 INFO - Running setup.py (path:/tmp/pip-pfC6lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:23:28 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)) 13:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:23:28 INFO - Running setup.py (path:/tmp/pip-QAz2Ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:23:29 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)) 13:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:23:29 INFO - Running setup.py (path:/tmp/pip-fO3vop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:23:29 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)) 13:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:23:29 INFO - Running setup.py (path:/tmp/pip-aYzA9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:23:29 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)) 13:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:23:29 INFO - Running setup.py (path:/tmp/pip-_KFEl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:23:29 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)) 13:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:23:29 INFO - Running setup.py (path:/tmp/pip-Qz0xJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:23:29 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)) 13:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:23:29 INFO - Running setup.py (path:/tmp/pip-kkIROb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:23:29 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)) 13:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:23:29 INFO - Running setup.py (path:/tmp/pip-Oy4FmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:23:29 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)) 13:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:23:29 INFO - Running setup.py (path:/tmp/pip-gvwPag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:23:29 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)) 13:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:23:29 INFO - Running setup.py (path:/tmp/pip-03YU6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:23:29 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)) 13:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:29 INFO - Running setup.py (path:/tmp/pip-tykKS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:29 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)) 13:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:23:29 INFO - Running setup.py (path:/tmp/pip-OEneb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:23:29 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)) 13:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:23:29 INFO - Running setup.py (path:/tmp/pip-UHMIa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:23:29 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)) 13:23:29 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)) 13:23:29 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)) 13:23:29 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)) 13:23:29 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)) 13:23:29 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)) 13:23:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:23:29 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 13:23:29 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 13:23:29 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 13:23:29 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 13:23:29 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 13:23:29 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 13:23:31 INFO - Downloading blessings-1.5.1.tar.gz 13:23:31 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 13:23:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:23:31 INFO - Installing collected packages: blessings 13:23:31 INFO - Running setup.py install for blessings 13:23:31 INFO - Successfully installed blessings 13:23:31 INFO - Cleaning up... 13:23:31 INFO - Return code: 0 13:23:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:23:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:23:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:23:31 INFO - Reading from file tmpfile_stdout 13:23:31 INFO - Current package versions: 13:23:31 INFO - argparse == 1.2.1 13:23:31 INFO - blessings == 1.5.1 13:23:31 INFO - blobuploader == 1.2.4 13:23:31 INFO - docopt == 0.6.1 13:23:31 INFO - manifestparser == 1.1 13:23:31 INFO - mozInstall == 1.12 13:23:31 INFO - mozcrash == 0.16 13:23:31 INFO - mozdebug == 0.1 13:23:31 INFO - mozdevice == 0.47 13:23:31 INFO - mozfile == 1.2 13:23:31 INFO - mozhttpd == 0.7 13:23:31 INFO - mozinfo == 0.9 13:23:31 INFO - mozleak == 0.1 13:23:31 INFO - mozlog == 3.1 13:23:31 INFO - moznetwork == 0.27 13:23:31 INFO - mozprocess == 0.22 13:23:31 INFO - mozprofile == 0.27 13:23:31 INFO - mozrunner == 6.11 13:23:31 INFO - mozscreenshot == 0.1 13:23:31 INFO - mozsystemmonitor == 0.0 13:23:31 INFO - moztest == 0.7 13:23:31 INFO - mozversion == 1.4 13:23:31 INFO - psutil == 3.1.1 13:23:31 INFO - requests == 1.2.3 13:23:31 INFO - wsgiref == 0.1.2 13:23:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:31 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 0x7f0b18121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2974240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a030b0>, '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 0x2a03fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a04440>, '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': '5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727', '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 13:23:31 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 13:23:31 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 13:23:31 INFO - Using env: {'DISPLAY': ':0', 13:23:31 INFO - 'HOME': '/home/cltbld', 13:23:31 INFO - 'LANG': 'en_US.UTF-8', 13:23:31 INFO - 'LANGUAGE': 'en_US:en', 13:23:31 INFO - 'LOGNAME': 'cltbld', 13:23:31 INFO - 'MAIL': '/var/mail/cltbld', 13:23:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:31 INFO - 'MOZ_NO_REMOTE': '1', 13:23:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:31 INFO - 'NO_EM_RESTART': '1', 13:23:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:31 INFO - 'PWD': '/builds/slave/test', 13:23:31 INFO - 'SHELL': '/bin/bash', 13:23:31 INFO - 'SHLVL': '1', 13:23:31 INFO - 'TERM': 'linux', 13:23:31 INFO - 'TMOUT': '86400', 13:23:31 INFO - 'USER': 'cltbld', 13:23:31 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727', 13:23:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:31 INFO - '_': '/tools/buildbot/bin/python'} 13:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:32 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)) 13:23:32 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)) 13:23:32 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)) 13:23:32 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)) 13:23:32 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)) 13:23:32 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)) 13:23:32 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)) 13:23:32 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)) 13:23:32 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)) 13:23:32 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)) 13:23:32 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)) 13:23:32 INFO - Cleaning up... 13:23:32 INFO - Return code: 0 13:23:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:32 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 0x7f0b18121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2974240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a030b0>, '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 0x2a03fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a04440>, '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': '5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727', '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 13:23:32 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 13:23:32 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 13:23:32 INFO - Using env: {'DISPLAY': ':0', 13:23:32 INFO - 'HOME': '/home/cltbld', 13:23:32 INFO - 'LANG': 'en_US.UTF-8', 13:23:32 INFO - 'LANGUAGE': 'en_US:en', 13:23:32 INFO - 'LOGNAME': 'cltbld', 13:23:32 INFO - 'MAIL': '/var/mail/cltbld', 13:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:32 INFO - 'MOZ_NO_REMOTE': '1', 13:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:32 INFO - 'NO_EM_RESTART': '1', 13:23:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:32 INFO - 'PWD': '/builds/slave/test', 13:23:32 INFO - 'SHELL': '/bin/bash', 13:23:32 INFO - 'SHLVL': '1', 13:23:32 INFO - 'TERM': 'linux', 13:23:32 INFO - 'TMOUT': '86400', 13:23:32 INFO - 'USER': 'cltbld', 13:23:32 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727', 13:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:32 INFO - '_': '/tools/buildbot/bin/python'} 13:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:32 INFO - Downloading/unpacking jsonschema 13:23:32 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 13:23:32 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 13:23:32 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 13:23:32 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 13:23:32 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 13:23:32 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 13:23:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:23:34 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 13:23:34 INFO - Downloading/unpacking functools32 (from jsonschema) 13:23: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 13:23: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 13:23: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 13:23: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 13:23: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 13:23: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 13:23:34 INFO - Downloading functools32-3.2.3-2.tar.gz 13:23:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:23:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:23:34 INFO - warning: no files found matching '*.txt' 13:23:34 INFO - no previously-included directories found matching 'build' 13:23:34 INFO - no previously-included directories found matching 'dist' 13:23:34 INFO - no previously-included directories found matching '.git*' 13:23:34 INFO - Installing collected packages: jsonschema, functools32 13:23:34 INFO - Running setup.py install for functools32 13:23:34 INFO - warning: no files found matching '*.txt' 13:23:34 INFO - no previously-included directories found matching 'build' 13:23:34 INFO - no previously-included directories found matching 'dist' 13:23:34 INFO - no previously-included directories found matching '.git*' 13:23:34 INFO - Successfully installed jsonschema functools32 13:23:34 INFO - Cleaning up... 13:23:34 INFO - Return code: 0 13:23:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:23: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')]} 13:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23: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')]} 13:23:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0b18121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2974240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a030b0>, '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 0x2a03fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a04440>, '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': '5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727', '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 13:23: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', 'flake8'] in /builds/slave/test/build 13:23: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 flake8 13:23:34 INFO - Using env: {'DISPLAY': ':0', 13:23:34 INFO - 'HOME': '/home/cltbld', 13:23:34 INFO - 'LANG': 'en_US.UTF-8', 13:23:34 INFO - 'LANGUAGE': 'en_US:en', 13:23:34 INFO - 'LOGNAME': 'cltbld', 13:23:34 INFO - 'MAIL': '/var/mail/cltbld', 13:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:34 INFO - 'MOZ_NO_REMOTE': '1', 13:23:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:34 INFO - 'NO_EM_RESTART': '1', 13:23:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:34 INFO - 'PWD': '/builds/slave/test', 13:23:34 INFO - 'SHELL': '/bin/bash', 13:23:34 INFO - 'SHLVL': '1', 13:23:34 INFO - 'TERM': 'linux', 13:23:34 INFO - 'TMOUT': '86400', 13:23:34 INFO - 'USER': 'cltbld', 13:23:34 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727', 13:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:34 INFO - '_': '/tools/buildbot/bin/python'} 13:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:34 INFO - Downloading/unpacking flake8 13:23: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 13:23: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 13:23: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 13:23: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 13:23: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 13:23: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 13:23:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:23:36 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 13:23:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:23:36 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 13:23:36 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 13:23:36 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 13:23:36 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 13:23:36 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 13:23:36 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 13:23:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:23:36 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 13:23:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:23:36 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 13:23:36 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 13:23:36 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 13:23:36 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 13:23:36 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 13:23:36 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 13:23:36 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 13:23:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:23:36 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 13:23:36 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 13:23:36 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 13:23:36 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 13:23:36 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 13:23:36 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 13:23:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:23:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:23:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:23:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:23:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:23:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:23:37 INFO - no previously-included directories found matching 'docs/_build' 13:23:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:23:37 INFO - Running setup.py install for pep8 13:23:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:23:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:23:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:23:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:23:37 INFO - no previously-included directories found matching 'docs/_build' 13:23:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:23:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:23:37 INFO - Cleaning up... 13:23:37 INFO - Return code: 0 13:23:37 INFO - Running post-action listener: _resource_record_post_action 13:23:37 INFO - Running post-action listener: _start_resource_monitoring 13:23:37 INFO - Starting resource monitoring. 13:23:37 INFO - ##### 13:23:37 INFO - ##### Running install step. 13:23:37 INFO - ##### 13:23:37 INFO - Running pre-action listener: _resource_record_pre_action 13:23:37 INFO - Running main action method: install 13:23:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:23:37 INFO - Reading from file tmpfile_stdout 13:23:37 INFO - Detecting whether we're running mozinstall >=1.0... 13:23:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:23:37 INFO - Reading from file tmpfile_stdout 13:23:37 INFO - Output received: 13:23:37 INFO - Usage: mozinstall [options] installer 13:23:37 INFO - Options: 13:23:37 INFO - -h, --help show this help message and exit 13:23:37 INFO - -d DEST, --destination=DEST 13:23:37 INFO - Directory to install application into. [default: 13:23:37 INFO - "/builds/slave/test"] 13:23:37 INFO - --app=APP Application being installed. [default: firefox] 13:23:37 INFO - mkdir: /builds/slave/test/build/application 13:23:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:23:52 INFO - Reading from file tmpfile_stdout 13:23:52 INFO - Output received: 13:23:52 INFO - /builds/slave/test/build/application/firefox/firefox 13:23:52 INFO - Running post-action listener: _resource_record_post_action 13:23:52 INFO - ##### 13:23:52 INFO - ##### Running run-tests step. 13:23:52 INFO - ##### 13:23:52 INFO - Running pre-action listener: _resource_record_pre_action 13:23:52 INFO - Running main action method: run_tests 13:23:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:23:52 INFO - Python 2.7.3 13:23:52 INFO - Return code: 0 13:23:52 INFO - grabbing minidump binary from tooltool 13:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:52 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 0x2a030b0>, '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 0x2a03fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a04440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:23:52 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 13:23:52 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 13:23:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:23:52 INFO - Return code: 0 13:23:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:23:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:23:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:23:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:23:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:23:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:23:53 INFO - Return code: 0 13:23:53 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/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost'] in /builds/slave/test/build 13:23:53 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/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost 13:23:53 INFO - Using env: {'DISPLAY': ':0', 13:23:53 INFO - 'HOME': '/home/cltbld', 13:23:53 INFO - 'LANG': 'en_US.UTF-8', 13:23:53 INFO - 'LANGUAGE': 'en_US:en', 13:23:53 INFO - 'LOGNAME': 'cltbld', 13:23:53 INFO - 'MAIL': '/var/mail/cltbld', 13:23:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:23:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:53 INFO - 'MOZ_NO_REMOTE': '1', 13:23:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:23:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:53 INFO - 'NO_EM_RESTART': '1', 13:23:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:53 INFO - 'PWD': '/builds/slave/test', 13:23:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:23:53 INFO - 'SHELL': '/bin/bash', 13:23:53 INFO - 'SHLVL': '1', 13:23:53 INFO - 'TERM': 'linux', 13:23:53 INFO - 'TMOUT': '86400', 13:23:53 INFO - 'USER': 'cltbld', 13:23:53 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727', 13:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:53 INFO - '_': '/tools/buildbot/bin/python'} 13:23:53 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/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost'] with output_timeout 3600 13:23:53 INFO - mozversion INFO | application_buildid: 20151204115212 13:23:53 INFO - mozversion INFO | application_changeset: 378ef42875ed296adb790020ebeee26490c026d8 13:23:53 INFO - mozversion INFO | application_display_name: Nightly 13:23:53 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:23:53 INFO - mozversion INFO | application_name: Firefox 13:23:53 INFO - mozversion INFO | application_remotingname: firefox 13:23:53 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 13:23:53 INFO - mozversion INFO | application_vendor: Mozilla 13:23:53 INFO - mozversion INFO | application_version: 45.0a1 13:23:53 INFO - mozversion INFO | platform_buildid: 20151204115212 13:23:53 INFO - mozversion INFO | platform_changeset: 378ef42875ed296adb790020ebeee26490c026d8 13:23:53 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 13:23:53 INFO - mozversion INFO | platform_version: 45.0a1 13:23:53 INFO - 2015-12-04 13:23:53,409 DEBUG : using testdate: 1449264233 13:23:53 INFO - 2015-12-04 13:23:53,409 DEBUG : actual date: 1449264233 13:23:53 INFO - 2015-12-04 13:23:53,420 INFO : starting webserver on 'localhost:52430' 13:23:53 INFO - 2015-12-04 13:23:53,421 INFO : Starting test suite talos-linux64-ix-059.e 13:23:53 INFO - 2015-12-04 13:23:53,421 INFO : Starting test dromaeo_css 13:23:53 INFO - 2015-12-04 13:23:53,421 DEBUG : operating with platform_type : linux_ 13:23:53 INFO - 2015-12-04 13:23:53,422 INFO : Initialising browser for dromaeo_css test... 13:23:53 INFO - 2015-12-04 13:23:53,434 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA9pSkx/profile http://localhost:52430/getInfo.html 13:23:58 INFO - 2015-12-04 13:23:58,119 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:23:58 INFO - 2015-12-04 13:23:58,119 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:23:58 INFO - 2015-12-04 13:23:58,119 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:23:58 INFO - 2015-12-04 13:23:58,119 DEBUG : BROWSER_OUTPUT: __metrics 13:23:58 INFO - 2015-12-04 13:23:58,227 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] 13:23:59 INFO - 2015-12-04 13:23:59,107 INFO : Browser initialized. 13:23:59 INFO - 2015-12-04 13:23:59,108 INFO : Running cycle 1/1 for dromaeo_css test... 13:23:59 INFO - 2015-12-04 13:23:59,108 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA9pSkx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:24:11 INFO - 2015-12-04 13:24:11,161 DEBUG : BROWSER_OUTPUT: RSS: Main: 143474688 13:24:11 INFO - 2015-12-04 13:24:11,162 DEBUG : BROWSER_OUTPUT: 13:25:00 INFO - 2015-12-04 13:25:00,789 DEBUG : BROWSER_OUTPUT: 1449264300789 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] 13:27:13 INFO - 2015-12-04 13:27:13,444 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52430/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52430/tests/dromaeo/cssquery-ext.html) 13:27:14 INFO - 2015-12-04 13:27:14,651 DEBUG : BROWSER_OUTPUT: RSS: Main: 147169280 13:27:14 INFO - 2015-12-04 13:27:14,651 DEBUG : BROWSER_OUTPUT: 13:30:16 INFO - 2015-12-04 13:30:16,718 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52430/tests/dromaeo/cssquery-ext.html (next: http://localhost:52430/tests/dromaeo/cssquery-jquery.html) 13:30:17 INFO - 2015-12-04 13:30:17,305 DEBUG : BROWSER_OUTPUT: RSS: Main: 142860288 13:30:17 INFO - 2015-12-04 13:30:17,305 DEBUG : BROWSER_OUTPUT: 13:33:19 INFO - 2015-12-04 13:33:19,069 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52430/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52430/tests/dromaeo/cssquery-mootools.html) 13:33:19 INFO - 2015-12-04 13:33:19,670 DEBUG : BROWSER_OUTPUT: RSS: Main: 146698240 13:33:19 INFO - 2015-12-04 13:33:19,670 DEBUG : BROWSER_OUTPUT: 13:36:21 INFO - 2015-12-04 13:36:21,433 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52430/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52430/tests/dromaeo/cssquery-prototype.html) 13:36:22 INFO - 2015-12-04 13:36:22,039 DEBUG : BROWSER_OUTPUT: RSS: Main: 143613952 13:36:22 INFO - 2015-12-04 13:36:22,039 DEBUG : BROWSER_OUTPUT: 13:39:24 INFO - 2015-12-04 13:39:24,687 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52430/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52430/tests/dromaeo/cssquery-yui.html) 13:39:25 INFO - 2015-12-04 13:39:25,309 DEBUG : BROWSER_OUTPUT: RSS: Main: 144220160 13:39:25 INFO - 2015-12-04 13:39:25,309 DEBUG : BROWSER_OUTPUT: 13:42:27 INFO - 2015-12-04 13:42:27,756 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52430/tests/dromaeo/cssquery-yui.html (next: http://localhost:52430/tests/dromaeo/cssquery-dojo.html) 13:42:28 INFO - 2015-12-04 13:42:28,006 DEBUG : BROWSER_OUTPUT: RSS: Main: 147877888 13:42:28 INFO - 2015-12-04 13:42:28,006 DEBUG : BROWSER_OUTPUT: 13:42:28 INFO - 2015-12-04 13:42:28,009 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:42:28 INFO - 2015-12-04 13:42:28,009 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:42:28 INFO - 2015-12-04 13:42:28,009 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:42:28 INFO - 2015-12-04 13:42:28,010 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:42:28 INFO - 2015-12-04 13:42:28,010 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2663.5871439926814;2718.8504632245217;2744.3002034481206;2749.752522272995;2759.558470644697;4624.375709279247;4803.759812009399;4807.23084306511;4848.321235027099;4851.369321988141;4729.810807567702;4765;4804.063207674496;4864.100141473821;4865.245886887538;4362.258416069276;4420.4253447051915;4522.751248681321;4523.2988886722615;4567.474740404846;4232.132412855372;4389;4402.097569998159;4420.602145806893;4519.209138400784;4320.481542214954;4369.825206991716;4462.754548499831;4479.3504941783585;4499.762565294537;4473.060657261979;4473.194824931544;4476.37330773692;4480.036792089716;4530.501644819067;4239.576042395766;4324.437823083011;4446.288593824973;4456.532064133284;4470.307102399133;4623.006053698437;4679.9298010529865;4715.952840471586;4846.345743324641;4858.489858564835;5152.819651312186;5216.556592689626;5218.086834803932;5220.817271395483;5227.163653815372;5220.634555581111;5227.712475813829;5231.267622532849;5239.764210610493;5289.074411977888;4639.39687840582;4717.693349932243;4767.61859051275;4781.378420805273;4834.250691142808;5313.335833020872;5321.494458026481;5337.6797392156595;5345.278387417727;5401.702906340189;4802.207635740064;5067.949320506821;5104.081265372269;5116.897662046738;5119.411267704188;5139.460356662571;5143.228515722672;5199.038177937094;5213.530782229617;5269.367675878842;5064.265681476165;5164.715940623227;5170.560502357266;5173.40505841833;5218.608604354688;4856.077345304451;4974.204127339608;5107.310513080761;5136.640435169577;5157.097507936096;4134.855280065183;4203.957960420356;4207.621314081747;4214.936775948363;4247.044415006599;3788.431735239681;3792.4500947362476;3808.086059345737;3829.5021647185686;3854.036490877281;4292.935605965913;4338.175746608134;4404.581564751344;4497.123061003138;4538.160440318552;5231.555317797954;5235.397929238186;5240.161574148118;5263.578913686896;5267.236250743621;4506.098780243964;4524.841630542981;4539.046800171935;4569.657275704269;4570.428696412949;4362.825486980549;4485.192665320208;4539.114872599811;4630.86107416778;4662.323963025342;4866.440359358719;4871.244957031666;4881.585065269492;4886.95113048865;4915.0415668944215;5140.794368225379;5142.97428512855;5152.76812543429;5158.845234642967;5185.948140518546;4734.810607575659;4823.131836269506;4840.201366774583;4918.704877707349;4963.602911766978;5064.29099926018;5078.97460512695;5087.2623469595965;5099.439061703136;5134.691918484903;5007.173816320412;5165.251038599307;5167.715775632226;5174.7930082796265;5182.481751824938;4935.75321233944;4942.357493525818;4959.851204463727;4967.130752118437;5059.266406371129;5027.095122877917;5040.092783299041;5042.243663450512;5045.798168073383;5094.974525127351;4887.362733484322;4925.605951523941;4941.950580494149;4960.032793605213;4962.801487940442;4844.249141383091;4909.975450122869;4992.80028798844;5154.819581314636;5157.948420515747;4989.825356112518;4992.700437973734;5000.899982000413;5017.197248440232;5064.392272927273 13:42:28 INFO - 2015-12-04 13:42:28,011 DEBUG : BROWSER_OUTPUT: |1;ext.html;557.552080864016;574.5604612471459;576.9019266724656;578.4100217777869;585.5227989188811;37011.074723131904;37285.254294914084;37702;37740.81129594348;37758;39763.60236397635;40323.79838100813;40333;40446.7977660112;40510.392344114865;7966.880496792553;8121.75634730959;8122.147174546676;8123.593820308991;8127.431079824415;7859.724909628164;7873.370130389584;7893.644785984616;7935.722249721261;7982.920170798305;7940.880886786703;7991;8007.959960200191;8033.959830200841;8052.59737013147;7955.602219889011;8019.919800802005;8030.357571394304;8039.115697273295;8049.798755031113;7885.448018638697;7949.443538952276;8016.15830337812;8017.198280171994;8038.236367545132;36910.630893690985;37078.62921370806;37128;37438.43842342367;37445.06387340311;2509.4855554611445;2596.9480610387686;2675.4782817350624;2919.5182794838825;3126.390353880994;26668.866655666596;26794.86602566994;26997.460050798873;27144.728552714416;27475;3397.2016576104843;3413.1808365992233;3485.9651403485896;3532.540769699948;3565.8038807865555;211837;213169;214676;214889;215163;51799.482005180216;53016;55034;55097.724511377186;55157.448425516035;65519.344806552275;67152;67316.32683673198;67327.32672673308;67375.66312168408;13563.660908477366;13864.584062478141;13871.583852484442;13874.583762487142;13881.861181388258;10627.309224900357;10770.623028194132;10800.513976870903;10816.621418250323;10816.78366432667;18971.71542426865;19119.235230590897;19175.137118829687;19203.711944320847;19232.423027309203;7489.138749043821;7524.548527088283;7595.240475952471;7646.120696119906;7653.846923061507;891.5364010714392;898.5327629632554;984.9608662860751;1025.5436330832708;1084.2789544952675;25940.61089083665;26332.8683356582;26486.47027059448;26875.86562067177;27604.861975689993;887.5650931043742;931.0317270039219;944.9480278584743;984.7341217871135;1014.2545229256491;12666.240025598494;14125.434982600786;14259.144451332953;14681.706365872837;14737.705245895022;264985;266892;269751;269847;270500;46653.30020049702;46834;47211.76394118008;47262.52737472581;47600.285995710095;1184.218415845555;1228.8341073954903;1236.542479282689;1243.3286025546286;1257.1011726615513;26220.606690900033;26698.065567705038;26873.193804185907;27200.591991120546;27207.86396068086;38989.2202155961;39022;39180.804095979336;39433.60566394414;39505.604943950195;180418;181019;181566;181587;182076;28871.711282886903;29217.26956826011;30090.548641769954;30110.548341775328;30181.396372072875;34931.82534087415;35361.29277414489;35768;35828.462573060904;36276.81861590675;30405;30545.694543054284;30781.846090769403;33439;34225.315493689486;32501.34997300088;32979.8351008253;33440;33501.66498334985;33527.83236083804;32895.506567401986;33574;34078.318433630695;34206.14484637904;34242;27365.589516156877;29344.266393339483;30020.549691754204;30062;30503.54244686287;23245.186418475274;23992.64011039871;24261.150859719826;24349.39126521851;24938.750612493644 13:42:28 INFO - 2015-12-04 13:42:28,012 DEBUG : BROWSER_OUTPUT: |2;jquery.html;322.20094166467146;326.2008080203499;331.8307663091824;331.8772054339894;335.6710423784691;14991.850081499182;15376.231188440575;15517.224138793057;16169;16709.749353759675;10090.798184036315;10339.741506462342;12418.875811241885;13189.07676462648;13192.670183245424;4691.850496628323;4829.3480380148585;4842.539958703917;4844.176489996691;5243.370795504545;5184.300119483878;5228.372595288571;5230.320058392404;5235.633505654606;5237.7381130943495;5201.55786758126;5213.1919552469235;5379.731013449332;5498.3127109111365;5567.387587365387;5294.100002999499;5386.2997810284605;5424.620276580601;5467.371252305976;5498.670079795225;4877.463479017305;4898.779554920037;4900.411950565955;4937.654364194508;4949.876253093666;17023.48929532116;17550.736738948926;17704.468865933915;17934.192961316643;18990.62018759617;1729.2304924308687;1730.108993868159;1747.589316510619;1785.366195000782;1785.7767779027622;8861.42400743956;9052.366334356597;9808.803823923552;12550.74898502034;12832.165909215872;1677.6896274189314;1685.4606525911713;1691.9848091145338;1718.3813827022261;1723.5949551855304;57833.710831445576;57860.71069644625;58258.70870645662;58557.70721146367;59246;9728.221742260603;9747.805043899083;9763.07250811186;10078.848817267746;10110.747231319128;12644.620661380173;12674.683132921751;12702.80945785814;12707.93646031764;12716.427760750788;7118.323759242864;7198.100237470317;7218.242084581148;7251.347378735939;7283.817904552428;6588.8023359299295;6616.338366163345;6626.039224312544;6651.23510796255;6886.51794374389;3975.0857302820514;4008.9799551002056;4104.302268614343;4143.482064741907;4214.431051808028;1588.285271627772;1647.2258038721782;1697.4652984309903;1723.1384307846076;1739.869509786771;798.8177497304023;855.2986551028097;954.5847556313026;957.5499515227832;983.1250187333279;13239.404226809816;14401.495947641783;14624.049436786574;15958.20208989569;16181.919090404472;837.4891316297054;846.251067804997;868.2402897464718;885.7874110213502;899.2940541674753;8916.643334266686;9021.278297736166;9131.497767622712;9168.129027742354;9364.719058428258;423845;425090;433855;438924;440725;68850.31149688539;69228.6538567314;69438.30561694318;69751.3024869755;69828.30171698218;1062.792755412687;1063.574570171922;1094.2395035450445;1115.5426275227119;1117.3407689463256;14340.56978290653;14453.277336133362;14521.346539405964;14582.708345833236;14766.704665906407;31926;32448.837755812016;32638.34723305473;32966.67033329636;33696.3260734779;41776;41849.79075104605;42267;42384.78807605942;45069.774651126536;9234.492102934402;9311.906880931376;9325.06749325062;9362.110599493037;9394.812103758024;16038.198090095682;16059;16593.170341482637;16686.749698754287;16807.91596042012;12584.811227831407;12847.550335738204;13350.599482015556;13595.52415665447;13597.184168949894;12428.316442595744;12435.813462797883;12799.488020479077;13298.401571929093;13505.054646174673;13469.12450690702;13533.323333833467;13824.723505530033;13918.443262269397;14005.229712365917;8294.212049855254;8577.442466239923;8671.653133874826;8672.219500245008;9208.861867071866;13666.794998074838;13774.931125344308;13781.379837907518;13862.376193071537;14384.136951782926 13:42:28 INFO - 2015-12-04 13:42:28,016 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1414.1373762005176;1423.2812429722987;1527.434849105831;1693.9407120750773;1776.0409378935376;7295.525790823593;7429.851402971937;7592.278733520307;7621.847563048743;7634.961825190873;7389.889151662729;7409.629518524066;7420.517666351683;7476.177620461758;7496.3628091612145;2055.8560900736993;2086.2280956046284;2086.457521044532;2089.780573039824;2094.2984100326407;2043.4584835018732;2061.5258490547185;2083.8437117216195;2084.635188841954;2085.14509051289;1663.783708117943;1687.7890263717036;2024.1903238704563;2043.2542122125467;2086.426232785981;1987.9503012424732;1988.6818109102546;2006.8595198336122;2007.738993930787;2014.5366565689974;2037.7147199392098;2039.4391542325832;2085.113826623679;2097.056324653912;2097.171617211193;7259.564426134449;7284.125904891394;7287.817804554876;7303.379212766921;7316;4116.91766164675;4139.275626765304;4140.979295103505;4161.396597493377;4178.540360560336;2573.832700874456;2584.315156483515;2628.9079882204032;2632.118240389472;2652.071774878796;828.6933834481221;829.6432534010373;846.1327139681814;867.1805144138791;885.8626912828522;9280.1647851693;9292.070792920655;9307.76730581741;9310.162085412278;9334;3587.766795158306;3639.344917914748;3676.5036720042986;3682.6869716073898;3689.0592898810633;7564.924350756422;7582.582957937367;7601.08786945559;7618.238176182448;7624.161342252348;4125.1131006833075;4133.8966525836495;4143.1713657268665;4153.273177193979;4157.251694694924;3809.5999920008;3835.328817456934;3842.481265029185;3852.4413959975645;3852.5954774748807;3171.0486853944185;3186.776925615231;3189.744820414361;3205.406999705062;3233.6281327647152;919.0992827029548;922.5710044829052;922.8154369126202;922.9030951750104;926.893407258174;918.2195134135931;918.8529835226466;929.3680297397834;972.7276362618478;988.5897352598735;6870.072540207108;6891.75878844238;6945.2707465715375;7012.649367531603;7013.824654383579;1019.9337043092323;1034.0486752188006;1064.8311859071648;1080.2762149359949;1103.5916710817048;5418.566514678895;5434.347878254634;5462.890742185214;5473.2063850741415;5487.341519017744;8478.236958673626;8626.698065567674;8694.782630434163;8777;8871.423357481743;8636.352273579507;8651.437656552303;8708.08565100668;8711.60797764102;8726.95636521826;6689.130413046273;6783.253842077466;6789.830254243585;6843.555168914104;6873.828154296182;6489.707963141575;6506.674666266762;6516.478681705357;6551.0173473979285;6552.705128269335;7443.846203838414;7608.087029556488;7643.808904777425;7661.348785353307;7736.303732663862;7573.659185336784;7786.922130778619;7919.247671471201;7975.880361794461;8000.119986801331;5814.360420353673;5824.330202026652;5830.53355731549;5847.415258474289;5851.683371241436;6503;6650.301718319701;6663.400293973566;6669.833254168685;6676.165479315086;6438.8390290243115;6451;6528.347165283623;6545.967270163619;6639.506111124958;5439.5648348132845;5896.351401345934;5933.169356290209;5999.9100013498955;6090.543209259412;6110.480609148094;6125.540584456095;6166.969165154145;6188.969055154876;6213.596116252429;5709.8287051388525;5787.768489260382;5798.333191682842;5802.4197580241635;5816;5757.625754325955;5777.16231146473;5790.218320526675;5812.796552120655;5816.214811000461 13:42:28 INFO - 2015-12-04 13:42:28,016 DEBUG : BROWSER_OUTPUT: |4;prototype.html;282.06776603326006;287.08277054809867;289.40960440700974;289.55842340430854;292.65028291192027;5330.573554115671;5576.386597474279;5591.7204139793;5651.943480565194;5677.630953987988;5569.777208911639;5581.609287349887;5589.133684278943;5591.6365436246715;5612.971935140329;4162.063535704473;4186.267403204442;4199.076203235283;4204.32730763078;4205.453291072156;4191.832326706928;4197.7271477354025;4206.47419072616;4206.726562773425;4209.768462734548;3981.9601803981877;4138.730982486129;4156.43888075109;4159.646430053449;4168.520620128678;4120.793960302003;4133.111381053073;4138.586141385867;4146.419501269825;4150.315197992328;3552.769070010441;3553.2538166984964;3561.12752375667;3561.5726112866623;3569.23261498779;5289.841304760864;5329.173978033411;5337.973310133463;5345.01117293302;5350.464953504657;4674.929876051862;4713.481517033124;4778.235482322812;4783.019481006385;4783.712977221343;5640.674441506243;5767.711614419304;5784.2769653793275;5807.332156801937;5819.272590926134;3899.1032062625754;3903.33643280643;3906.5507466641416;3910.882673519799;3910.904946614952;6067.817965461043;6138.83362161188;6150.692465376714;6154.384561543855;6163.476104531121;3985;3999.7600143991453;4008.318585840414;4023.195360927826;4100.856470023535;4159.10579225468;4176.331786914079;4180.644645205191;4222.873313800591;4230.471191101113;4853.563179313808;4859.34398856157;4861.590138859691;4865.270209468608;4876.073546026244;5844.9415505845245;5851.975904216745;5856.502197313191;5861.0915308127305;5877.794277200277;1438.539667306473;1466.8679818816358;1468.2658670664669;1487.7545205041047;1488.5013520470764;992.1021475564626;996.7308826616772;1009.4649835587151;1010.9898901011043;1011.2516737614112;4985;5005.1491246488185;5036.370453693288;5062.215356619657;5064.974675126675;5895.233619629421;5920;5974.3726908674835;5976.850578735566;6001.609895356788;4993.525615066563;4995.375578052744;5010.549050585465;5013.348264725562;5025.79896804131;3183.7293830024705;3198.792078514889;3243.383757086146;3246.935061298761;3284.1132894118455;5721.39925307845;5728.54171666274;5754.798582049608;5785.247917770663;5809.0705487122705;6257.405546473078;6283.842903927439;6287.748490060438;6303.779367722108;6320.336364681734;5668.376478587435;5755.971220143872;5780.393058728857;5798.1302804579655;5808.448197421239;6091.203095086871;6111.297200821962;6116.17431646722;6117.3270940197435;6133.723982420891;5955.731992060281;5986.341502434816;5990;5990.31111422192;5996.4902983245165;5771.220885180447;5780.884382312246;5785.768569257182;5790.449907258803;5810.5351571875;3940.9014774630864;3980.442738016738;4040.7777572232635;4050.4126901599693;4051.8784436466954;5968.582199246011;6074.878502429839;6092;6096.1465394845645;6103.786367477117;5838.357780644211;5853.2976042875125;5881.705914704162;5889.116632504987;5895.380984996686;5821.476067153976;5822.2140011099655;5864.179014937998;5867.266591676041;5883.470487656132;5605.439456054362;5720.08478643415;5726.599138060295;5731.684757338387;5749.13762935563;5911.201987731773;5925.585209035326;5930.110483427347;5930.644161350333;5936.703164841654;5705.914411283751;5729.427057294237;5742.052561327334;5757.309122905278;5766.538676905921 13:42:28 INFO - 2015-12-04 13:42:28,016 DEBUG : BROWSER_OUTPUT: |5;yui.html;787.4960025583624;794.9046114466263;795.3875515852793;799.720097965712;825.257268458387;10845.83731244032;11277.605283815068;11296.435178241096;13100.344982750872;13265;13485.258310792902;13537.390817413216;13560.389782459788;13564.253966031863;13588;639.4532674563251;648.2124219073825;794.0471434278874;815.955122468264;819.0376307838296;797.214743477674;797.2665148063767;803.9477433966773;806.435495153392;808.9312408445289;845.9450135741157;863.1799790199304;865.7402779166225;865.9956700216491;868.9000764912053;849.4308813095241;858.3047731337605;860.8149247911698;862.4782006885806;863.9740807775777;627.3256249531771;631.8957372033609;637.8022812928007;638.1894993358455;640.9006603976344;11842.28946263227;12056.095792815573;12076.577319793852;12091.697707557294;12095.516179352815;11027.283226590245;11255.212135150543;11555;11614.883851161465;11769.88230117705;9041.90958090424;9460.810783784285;9491.620335186584;9610.423374597547;9715.174210192143;3325;3334.883279085245;3338.098713347407;3375.628680845105;3378.5101160331615;42600.57399425997;42649.147017059484;42985.14029719419;43001.99999999969;43037.56962430367;9455.621775128919;9546.284028697875;9625.422474651403;9662.516874156265;9672.75818104553;16131.274092665624;16132.75800862988;16215.432459863849;16245.837541624669;16252.918735406483;6045.72794224261;6118.990366589463;6162.445379915829;6180.907286390708;6289.96855015722;3585.103724068983;3607.3687104757087;3651;3664.4587227027573;3757.49273848027;2594.260635718811;2607.6088586711767;2615.0585789115903;2626.487834872182;2629.842209467438;448.24694513218105;459.6621483209838;459.97470139142666;467.57684295712437;475.26096919290836;398.458096988096;551.6941360252275;564.6640249051808;614.3978900677362;649.5161104976822;7514.511556748794;7554.896701487871;7616.276453736886;7722.150563438017;7789.260020298176;446.34164607204764;454.3502791008823;461.66298602020714;465.8043621678903;587.952963762898;3357.764956453074;3607.7654952428006;3610.6389361063684;3643.544556930384;3694.6674799268194;47413;47498.5250147501;48100.27849582259;48154.75922620364;48205.27692084621;44847.77576112164;45679.543204567526;46859.5314046862;46905.29642055304;46924.7653761729;40772.79613601972;41482.79258603688;41886.58113418888;43799.90500237456;44183.55816441859;7486.43851711113;7864.297638921958;8197.385196110436;8301.11007863484;8349.081601024003;32009.35981280408;32216.83891580527;32613.510797338535;32856.50715239321;32996.1750956228;39083.2183356337;39946.800265998485;39968.800156000194;42763.572364277206;42801.785991069846;10181.389116653025;10230.232732545237;10346.430946298025;10581.36511809294;10600.310979786289;11568.942155289169;11616.593419230625;11656;11788.76422471563;11941.940290298493;9506.667266645634;9593.058049072635;10005.649802256887;10050.69847904564;10472.895271047191;10765.3540787553;10780.191485638452;10991.147370248347;11027.558897644005;11073.667789966314;10596.629117980834;10640.89359106399;10684.145268378667;10776.622818201326;10881.455927203766;9579.377340473126;9675;9744.561494732612;9850.556724947251;9913.256505762241;8584.484930903916;9398.812023759623;9422.95288523553;9582.520873956135;9648.228141748783 13:42:28 INFO - 2015-12-04 13:42:28,016 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:42:28 INFO - 2015-12-04 13:42:28,016 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:42:28 INFO - 2015-12-04 13:42:28,016 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,329 13:42:28 INFO - 2015-12-04 13:42:28,016 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:42:28 INFO - 2015-12-04 13:42:28,016 DEBUG : BROWSER_OUTPUT: __startTimestamp1449265348007__endTimestamp 13:42:28 INFO - 2015-12-04 13:42:28,016 DEBUG : BROWSER_OUTPUT: 13:42:28 INFO - 2015-12-04 13:42:28,016 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:42:28 INFO - 2015-12-04 13:42:28,016 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:42:28 INFO - 2015-12-04 13:42:28,017 DEBUG : BROWSER_OUTPUT: 13:42:28 INFO - 2015-12-04 13:42:28,017 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4760.18 Median:4871.24 stddev:508.50 (10.4%) stddev-sans-first:482.73 13:42:28 INFO - 2015-12-04 13:42:28,018 DEBUG : BROWSER_OUTPUT: Values: 2663.6 2718.9 2744.3 2749.8 2759.6 4624.4 4803.8 4807.2 4848.3 4851.4 4729.8 4765.0 4804.1 4864.1 4865.2 4362.3 4420.4 4522.8 4523.3 4567.5 4232.1 4389.0 4402.1 4420.6 4519.2 4320.5 4369.8 4462.8 4479.4 4499.8 4473.1 4473.2 4476.4 4480.0 4530.5 4239.6 4324.4 4446.3 4456.5 4470.3 4623.0 4679.9 4716.0 4846.3 4858.5 5152.8 5216.6 5218.1 5220.8 5227.2 5220.6 5227.7 5231.3 5239.8 5289.1 4639.4 4717.7 4767.6 4781.4 4834.3 5313.3 5321.5 5337.7 5345.3 5401.7 4802.2 5067.9 5104.1 5116.9 5119.4 5139.5 5143.2 5199.0 5213.5 5269.4 5064.3 5164.7 5170.6 5173.4 5218.6 4856.1 4974.2 5107.3 5136.6 5157.1 4134.9 4204.0 4207.6 4214.9 4247.0 3788.4 3792.5 3808.1 3829.5 3854.0 4292.9 4338.2 4404.6 4497.1 4538.2 5231.6 5235.4 5240.2 5263.6 5267.2 4506.1 4524.8 4539.0 4569.7 4570.4 4362.8 4485.2 4539.1 4630.9 4662.3 4866.4 4871.2 4881.6 4887.0 4915.0 5140.8 5143.0 5152.8 5158.8 5185.9 4734.8 4823.1 4840.2 4918.7 4963.6 5064.3 5079.0 5087.3 5099.4 5134.7 5007.2 5165.3 5167.7 5174.8 5182.5 4935.8 4942.4 4959.9 4967.1 5059.3 5027.1 5040.1 5042.2 5045.8 5095.0 4887.4 4925.6 4942.0 4960.0 4962.8 4844.2 4910.0 4992.8 5154.8 5157.9 4989.8 4992.7 5000.9 5017.2 5064.4 13:42:28 INFO - 2015-12-04 13:42:28,018 DEBUG : BROWSER_OUTPUT: 13:42:28 INFO - 2015-12-04 13:42:28,018 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38879.01 Median:18745.75 stddev:58413.66 (311.6%) stddev-sans-first:58506.65 13:42:28 INFO - 2015-12-04 13:42:28,018 DEBUG : BROWSER_OUTPUT: Values: 557.6 574.6 576.9 578.4 585.5 37011.1 37285.3 37702.0 37740.8 37758.0 39763.6 40323.8 40333.0 40446.8 40510.4 7966.9 8121.8 8122.1 8123.6 8127.4 7859.7 7873.4 7893.6 7935.7 7982.9 7940.9 7991.0 8008.0 8034.0 8052.6 7955.6 8019.9 8030.4 8039.1 8049.8 7885.4 7949.4 8016.2 8017.2 8038.2 36910.6 37078.6 37128.0 37438.4 37445.1 2509.5 2596.9 2675.5 2919.5 3126.4 26668.9 26794.9 26997.5 27144.7 27475.0 3397.2 3413.2 3486.0 3532.5 3565.8 211837.0 213169.0 214676.0 214889.0 215163.0 51799.5 53016.0 55034.0 55097.7 55157.4 65519.3 67152.0 67316.3 67327.3 67375.7 13563.7 13864.6 13871.6 13874.6 13881.9 10627.3 10770.6 10800.5 10816.6 10816.8 18971.7 19119.2 19175.1 19203.7 19232.4 7489.1 7524.5 7595.2 7646.1 7653.8 891.5 898.5 985.0 1025.5 1084.3 25940.6 26332.9 26486.5 26875.9 27604.9 887.6 931.0 944.9 984.7 1014.3 12666.2 14125.4 14259.1 14681.7 14737.7 264985.0 266892.0 269751.0 269847.0 270500.0 46653.3 46834.0 47211.8 47262.5 47600.3 1184.2 1228.8 1236.5 1243.3 1257.1 26220.6 26698.1 26873.2 27200.6 27207.9 38989.2 39022.0 39180.8 39433.6 39505.6 180418.0 181019.0 181566.0 181587.0 182076.0 28871.7 29217.3 30090.5 30110.5 30181.4 34931.8 35361.3 35768.0 35828.5 36276.8 30405.0 30545.7 30781.8 33439.0 34225.3 32501.3 32979.8 33440.0 33501.7 33527.8 32895.5 33574.0 34078.3 34206.1 34242.0 27365.6 29344.3 30020.5 30062.0 30503.5 23245.2 23992.6 24261.2 24349.4 24938.8 13:42:28 INFO - 2015-12-04 13:42:28,018 DEBUG : BROWSER_OUTPUT: 13:42:28 INFO - 2015-12-04 13:42:28,018 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24809.31 Median:4056.64 stddev:70724.40 (1743.4%) stddev-sans-first:70898.90 13:42:28 INFO - 2015-12-04 13:42:28,018 DEBUG : BROWSER_OUTPUT: Values: 322.2 326.2 331.8 331.9 335.7 14991.9 15376.2 15517.2 16169.0 16709.7 10090.8 10339.7 12418.9 13189.1 13192.7 4691.9 4829.3 4842.5 4844.2 5243.4 5184.3 5228.4 5230.3 5235.6 5237.7 5201.6 5213.2 5379.7 5498.3 5567.4 5294.1 5386.3 5424.6 5467.4 5498.7 4877.5 4898.8 4900.4 4937.7 4949.9 17023.5 17550.7 17704.5 17934.2 18990.6 1729.2 1730.1 1747.6 1785.4 1785.8 8861.4 9052.4 9808.8 12550.7 12832.2 1677.7 1685.5 1692.0 1718.4 1723.6 57833.7 57860.7 58258.7 58557.7 59246.0 9728.2 9747.8 9763.1 10078.8 10110.7 12644.6 12674.7 12702.8 12707.9 12716.4 7118.3 7198.1 7218.2 7251.3 7283.8 6588.8 6616.3 6626.0 6651.2 6886.5 3975.1 4009.0 4104.3 4143.5 4214.4 1588.3 1647.2 1697.5 1723.1 1739.9 798.8 855.3 954.6 957.5 983.1 13239.4 14401.5 14624.0 15958.2 16181.9 837.5 846.3 868.2 885.8 899.3 8916.6 9021.3 9131.5 9168.1 9364.7 423845.0 425090.0 433855.0 438924.0 440725.0 68850.3 69228.7 69438.3 69751.3 69828.3 1062.8 1063.6 1094.2 1115.5 1117.3 14340.6 14453.3 14521.3 14582.7 14766.7 31926.0 32448.8 32638.3 32966.7 33696.3 41776.0 41849.8 42267.0 42384.8 45069.8 9234.5 9311.9 9325.1 9362.1 9394.8 16038.2 16059.0 16593.2 16686.7 16807.9 12584.8 12847.6 13350.6 13595.5 13597.2 12428.3 12435.8 12799.5 13298.4 13505.1 13469.1 13533.3 13824.7 13918.4 14005.2 8294.2 8577.4 8671.7 8672.2 9208.9 13666.8 13774.9 13781.4 13862.4 14384.1 13:42:28 INFO - 2015-12-04 13:42:28,018 DEBUG : BROWSER_OUTPUT: 13:42:28 INFO - 2015-12-04 13:42:28,018 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4927.17 Median:6118.01 stddev:2583.63 (42.2%) stddev-sans-first:2577.39 13:42:28 INFO - 2015-12-04 13:42:28,020 DEBUG : BROWSER_OUTPUT: Values: 1414.1 1423.3 1527.4 1693.9 1776.0 7295.5 7429.9 7592.3 7621.8 7635.0 7389.9 7409.6 7420.5 7476.2 7496.4 2055.9 2086.2 2086.5 2089.8 2094.3 2043.5 2061.5 2083.8 2084.6 2085.1 1663.8 1687.8 2024.2 2043.3 2086.4 1988.0 1988.7 2006.9 2007.7 2014.5 2037.7 2039.4 2085.1 2097.1 2097.2 7259.6 7284.1 7287.8 7303.4 7316.0 4116.9 4139.3 4141.0 4161.4 4178.5 2573.8 2584.3 2628.9 2632.1 2652.1 828.7 829.6 846.1 867.2 885.9 9280.2 9292.1 9307.8 9310.2 9334.0 3587.8 3639.3 3676.5 3682.7 3689.1 7564.9 7582.6 7601.1 7618.2 7624.2 4125.1 4133.9 4143.2 4153.3 4157.3 3809.6 3835.3 3842.5 3852.4 3852.6 3171.0 3186.8 3189.7 3205.4 3233.6 919.1 922.6 922.8 922.9 926.9 918.2 918.9 929.4 972.7 988.6 6870.1 6891.8 6945.3 7012.6 7013.8 1019.9 1034.0 1064.8 1080.3 1103.6 5418.6 5434.3 5462.9 5473.2 5487.3 8478.2 8626.7 8694.8 8777.0 8871.4 8636.4 8651.4 8708.1 8711.6 8727.0 6689.1 6783.3 6789.8 6843.6 6873.8 6489.7 6506.7 6516.5 6551.0 6552.7 7443.8 7608.1 7643.8 7661.3 7736.3 7573.7 7786.9 7919.2 7975.9 8000.1 5814.4 5824.3 5830.5 5847.4 5851.7 6503.0 6650.3 6663.4 6669.8 6676.2 6438.8 6451.0 6528.3 6546.0 6639.5 5439.6 5896.4 5933.2 5999.9 6090.5 6110.5 6125.5 6167.0 6189.0 6213.6 5709.8 5787.8 5798.3 5802.4 5816.0 5757.6 5777.2 5790.2 5812.8 5816.2 13:42:28 INFO - 2015-12-04 13:42:28,020 DEBUG : BROWSER_OUTPUT: 13:42:28 INFO - 2015-12-04 13:42:28,020 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4806.92 Median:5579.00 stddev:1453.96 (26.1%) stddev-sans-first:1417.82 13:42:28 INFO - 2015-12-04 13:42:28,020 DEBUG : BROWSER_OUTPUT: Values: 282.1 287.1 289.4 289.6 292.7 5330.6 5576.4 5591.7 5651.9 5677.6 5569.8 5581.6 5589.1 5591.6 5613.0 4162.1 4186.3 4199.1 4204.3 4205.5 4191.8 4197.7 4206.5 4206.7 4209.8 3982.0 4138.7 4156.4 4159.6 4168.5 4120.8 4133.1 4138.6 4146.4 4150.3 3552.8 3553.3 3561.1 3561.6 3569.2 5289.8 5329.2 5338.0 5345.0 5350.5 4674.9 4713.5 4778.2 4783.0 4783.7 5640.7 5767.7 5784.3 5807.3 5819.3 3899.1 3903.3 3906.6 3910.9 3910.9 6067.8 6138.8 6150.7 6154.4 6163.5 3985.0 3999.8 4008.3 4023.2 4100.9 4159.1 4176.3 4180.6 4222.9 4230.5 4853.6 4859.3 4861.6 4865.3 4876.1 5844.9 5852.0 5856.5 5861.1 5877.8 1438.5 1466.9 1468.3 1487.8 1488.5 992.1 996.7 1009.5 1011.0 1011.3 4985.0 5005.1 5036.4 5062.2 5065.0 5895.2 5920.0 5974.4 5976.9 6001.6 4993.5 4995.4 5010.5 5013.3 5025.8 3183.7 3198.8 3243.4 3246.9 3284.1 5721.4 5728.5 5754.8 5785.2 5809.1 6257.4 6283.8 6287.7 6303.8 6320.3 5668.4 5756.0 5780.4 5798.1 5808.4 6091.2 6111.3 6116.2 6117.3 6133.7 5955.7 5986.3 5990.0 5990.3 5996.5 5771.2 5780.9 5785.8 5790.4 5810.5 3940.9 3980.4 4040.8 4050.4 4051.9 5968.6 6074.9 6092.0 6096.1 6103.8 5838.4 5853.3 5881.7 5889.1 5895.4 5821.5 5822.2 5864.2 5867.3 5883.5 5605.4 5720.1 5726.6 5731.7 5749.1 5911.2 5925.6 5930.1 5930.6 5936.7 5705.9 5729.4 5742.1 5757.3 5766.5 13:42:28 INFO - 2015-12-04 13:42:28,020 DEBUG : BROWSER_OUTPUT: 13:42:28 INFO - 2015-12-04 13:42:28,020 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12529.93 Median:22648.01 stddev:14152.20 (62.5%) stddev-sans-first:14164.42 13:42:28 INFO - 2015-12-04 13:42:28,020 DEBUG : BROWSER_OUTPUT: Values: 787.5 794.9 795.4 799.7 825.3 10845.8 11277.6 11296.4 13100.3 13265.0 13485.3 13537.4 13560.4 13564.3 13588.0 639.5 648.2 794.0 816.0 819.0 797.2 797.3 803.9 806.4 808.9 845.9 863.2 865.7 866.0 868.9 849.4 858.3 860.8 862.5 864.0 627.3 631.9 637.8 638.2 640.9 11842.3 12056.1 12076.6 12091.7 12095.5 11027.3 11255.2 11555.0 11614.9 11769.9 9041.9 9460.8 9491.6 9610.4 9715.2 3325.0 3334.9 3338.1 3375.6 3378.5 42600.6 42649.1 42985.1 43002.0 43037.6 9455.6 9546.3 9625.4 9662.5 9672.8 16131.3 16132.8 16215.4 16245.8 16252.9 6045.7 6119.0 6162.4 6180.9 6290.0 3585.1 3607.4 3651.0 3664.5 3757.5 2594.3 2607.6 2615.1 2626.5 2629.8 448.2 459.7 460.0 467.6 475.3 398.5 551.7 564.7 614.4 649.5 7514.5 7554.9 7616.3 7722.2 7789.3 446.3 454.4 461.7 465.8 588.0 3357.8 3607.8 3610.6 3643.5 3694.7 47413.0 47498.5 48100.3 48154.8 48205.3 44847.8 45679.5 46859.5 46905.3 46924.8 40772.8 41482.8 41886.6 43799.9 44183.6 7486.4 7864.3 8197.4 8301.1 8349.1 32009.4 32216.8 32613.5 32856.5 32996.2 39083.2 39946.8 39968.8 42763.6 42801.8 10181.4 10230.2 10346.4 10581.4 10600.3 11568.9 11616.6 11656.0 11788.8 11941.9 9506.7 9593.1 10005.6 10050.7 10472.9 10765.4 10780.2 10991.1 11027.6 11073.7 10596.6 10640.9 10684.1 10776.6 10881.5 9579.4 9675.0 9744.6 9850.6 9913.3 8584.5 9398.8 9423.0 9582.5 9648.2 13:42:28 INFO - 2015-12-04 13:42:28,020 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:42:28 INFO - 2015-12-04 13:42:28,020 DEBUG : BROWSER_OUTPUT: 13:42:28 INFO - 2015-12-04 13:42:28,711 INFO : Browser exited with error code: 0 13:42:28 INFO - 2015-12-04 13:42:28,730 INFO : Completed test dromaeo_css (00:18:35) 13:42:28 INFO - 2015-12-04 13:42:28,730 INFO : Starting test kraken 13:42:28 INFO - 2015-12-04 13:42:28,730 DEBUG : operating with platform_type : linux_ 13:42:28 INFO - 2015-12-04 13:42:28,730 INFO : Initialising browser for kraken test... 13:42:28 INFO - 2015-12-04 13:42:28,736 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVWhD2J/profile http://localhost:52430/getInfo.html 13:42:33 INFO - 2015-12-04 13:42:33,364 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:42:33 INFO - 2015-12-04 13:42:33,364 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:42:33 INFO - 2015-12-04 13:42:33,364 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:42:33 INFO - 2015-12-04 13:42:33,364 DEBUG : BROWSER_OUTPUT: __metrics 13:42:33 INFO - 2015-12-04 13:42:33,501 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] 13:42:34 INFO - 2015-12-04 13:42:34,427 INFO : Browser initialized. 13:42:34 INFO - 2015-12-04 13:42:34,428 INFO : Running cycle 1/1 for kraken test... 13:42:34 INFO - 2015-12-04 13:42:34,428 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVWhD2J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:42:46 INFO - 2015-12-04 13:42:46,428 DEBUG : BROWSER_OUTPUT: RSS: Main: 142909440 13:42:46 INFO - 2015-12-04 13:42:46,428 DEBUG : BROWSER_OUTPUT: 13:42:48 INFO - 2015-12-04 13:42:48,992 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52430/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52430/tests/kraken/driver.html?testName=audio-beat-detection) 13:42:49 INFO - 2015-12-04 13:42:49,614 DEBUG : BROWSER_OUTPUT: RSS: Main: 144285696 13:42:49 INFO - 2015-12-04 13:42:49,614 DEBUG : BROWSER_OUTPUT: 13:42:52 INFO - 2015-12-04 13:42:52,371 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52430/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52430/tests/kraken/driver.html?testName=audio-dft) 13:42:52 INFO - 2015-12-04 13:42:52,966 DEBUG : BROWSER_OUTPUT: RSS: Main: 144896000 13:42:52 INFO - 2015-12-04 13:42:52,966 DEBUG : BROWSER_OUTPUT: 13:42:55 INFO - 2015-12-04 13:42:55,878 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52430/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52430/tests/kraken/driver.html?testName=audio-fft) 13:42:56 INFO - 2015-12-04 13:42:56,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 138547200 13:42:56 INFO - 2015-12-04 13:42:56,459 DEBUG : BROWSER_OUTPUT: 13:42:58 INFO - 2015-12-04 13:42:58,552 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52430/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52430/tests/kraken/driver.html?testName=audio-oscillator) 13:42:59 INFO - 2015-12-04 13:42:59,133 DEBUG : BROWSER_OUTPUT: RSS: Main: 139862016 13:42:59 INFO - 2015-12-04 13:42:59,134 DEBUG : BROWSER_OUTPUT: 13:43:01 INFO - 2015-12-04 13:43:01,416 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52430/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52430/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:43:02 INFO - 2015-12-04 13:43:02,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 140632064 13:43:02 INFO - 2015-12-04 13:43:02,002 DEBUG : BROWSER_OUTPUT: 13:43:05 INFO - 2015-12-04 13:43:05,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52430/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52430/tests/kraken/driver.html?testName=imaging-darkroom) 13:43:05 INFO - 2015-12-04 13:43:05,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 141164544 13:43:05 INFO - 2015-12-04 13:43:05,676 DEBUG : BROWSER_OUTPUT: 13:43:09 INFO - 2015-12-04 13:43:09,143 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52430/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52430/tests/kraken/driver.html?testName=imaging-desaturate) 13:43:09 INFO - 2015-12-04 13:43:09,752 DEBUG : BROWSER_OUTPUT: RSS: Main: 139182080 13:43:09 INFO - 2015-12-04 13:43:09,752 DEBUG : BROWSER_OUTPUT: 13:43:12 INFO - 2015-12-04 13:43:12,630 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52430/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52430/tests/kraken/driver.html?testName=json-parse-financial) 13:43:13 INFO - 2015-12-04 13:43:13,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 139419648 13:43:13 INFO - 2015-12-04 13:43:13,218 DEBUG : BROWSER_OUTPUT: 13:43:14 INFO - 2015-12-04 13:43:14,974 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52430/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52430/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:43:15 INFO - 2015-12-04 13:43:15,567 DEBUG : BROWSER_OUTPUT: RSS: Main: 141000704 13:43:15 INFO - 2015-12-04 13:43:15,568 DEBUG : BROWSER_OUTPUT: 13:43:17 INFO - 2015-12-04 13:43:17,444 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52430/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52430/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:43:18 INFO - 2015-12-04 13:43:18,065 DEBUG : BROWSER_OUTPUT: RSS: Main: 140992512 13:43:18 INFO - 2015-12-04 13:43:18,065 DEBUG : BROWSER_OUTPUT: 13:43:20 INFO - 2015-12-04 13:43:20,272 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52430/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52430/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:43:20 INFO - 2015-12-04 13:43:20,857 DEBUG : BROWSER_OUTPUT: RSS: Main: 141381632 13:43:20 INFO - 2015-12-04 13:43:20,857 DEBUG : BROWSER_OUTPUT: 13:43:23 INFO - 2015-12-04 13:43:23,446 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52430/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:43:24 INFO - 2015-12-04 13:43:24,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 142200832 13:43:24 INFO - 2015-12-04 13:43:24,052 DEBUG : BROWSER_OUTPUT: 13:43:26 INFO - 2015-12-04 13:43:26,635 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:43:27 INFO - 2015-12-04 13:43:27,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 141008896 13:43:27 INFO - 2015-12-04 13:43:27,238 DEBUG : BROWSER_OUTPUT: 13:43:29 INFO - 2015-12-04 13:43:29,014 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52430/tests/kraken/driver.html?testName=ai-astar) 13:43:29 INFO - 2015-12-04 13:43:29,264 DEBUG : BROWSER_OUTPUT: RSS: Main: 141062144 13:43:29 INFO - 2015-12-04 13:43:29,264 DEBUG : BROWSER_OUTPUT: 13:43:29 INFO - 2015-12-04 13:43:29,267 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:43:29 INFO - 2015-12-04 13:43:29,267 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:43:29 INFO - 2015-12-04 13:43:29,268 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:43:29 INFO - 2015-12-04 13:43:29,268 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:43:29 INFO - 2015-12-04 13:43:29,268 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;107;111;111;111;124;112;111;111;111 13:43:29 INFO - 2015-12-04 13:43:29,268 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;169;130;148;177;132;152;154;138;169;135 13:43:29 INFO - 2015-12-04 13:43:29,268 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;165;164;162;164;171;163;162;164 13:43:29 INFO - 2015-12-04 13:43:29,268 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;74;73;74;152;73;79;74;76;145 13:43:29 INFO - 2015-12-04 13:43:29,268 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;145;94;94;94;133;95;95;130 13:43:29 INFO - 2015-12-04 13:43:29,268 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;111;111;110;113;111;110;110;109;109 13:43:29 INFO - 2015-12-04 13:43:29,268 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;149;148;147;148;148;147;147;148 13:43:29 INFO - 2015-12-04 13:43:29,268 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;104;97;97;96;96;96;97;96;96 13:43:29 INFO - 2015-12-04 13:43:29,268 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;75;71;73;73;76;71;71;72;72 13:43:29 INFO - 2015-12-04 13:43:29,268 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;69;68;67;69;68;68;69;69 13:43:29 INFO - 2015-12-04 13:43:29,269 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;84;85;83;83;86;83;102;98 13:43:29 INFO - 2015-12-04 13:43:29,269 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;119;127;130;125;144;125;130;137;133 13:43:29 INFO - 2015-12-04 13:43:29,269 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;143;152;141;144;142;144;158;144;131 13:43:29 INFO - 2015-12-04 13:43:29,269 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;68;67;76;69;68;69;69;69 13:43:29 INFO - 2015-12-04 13:43:29,269 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:43:29 INFO - 2015-12-04 13:43:29,269 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:43:29 INFO - 2015-12-04 13:43:29,269 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,786 13:43:29 INFO - 2015-12-04 13:43:29,269 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:43:29 INFO - 2015-12-04 13:43:29,269 DEBUG : BROWSER_OUTPUT: __startTimestamp1449265409266__endTimestamp 13:43:29 INFO - 2015-12-04 13:43:29,269 DEBUG : BROWSER_OUTPUT: 13:43:29 INFO - 2015-12-04 13:43:29,272 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:43:29 INFO - 2015-12-04 13:43:29,273 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:43:29 INFO - 2015-12-04 13:43:29,273 DEBUG : BROWSER_OUTPUT: 13:43:29 INFO - 2015-12-04 13:43:29,273 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.00 Median:111.00 stddev:4.42 (4.0%) stddev-sans-first:4.68 13:43:29 INFO - 2015-12-04 13:43:29,273 DEBUG : BROWSER_OUTPUT: Values: 111.0 107.0 111.0 111.0 111.0 124.0 112.0 111.0 111.0 111.0 13:43:29 INFO - 2015-12-04 13:43:29,273 DEBUG : BROWSER_OUTPUT: 13:43:29 INFO - 2015-12-04 13:43:29,274 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.40 Median:153.00 stddev:16.89 (11.0%) stddev-sans-first:16.52 13:43:29 INFO - 2015-12-04 13:43:29,274 DEBUG : BROWSER_OUTPUT: Values: 169.0 130.0 148.0 177.0 132.0 152.0 154.0 138.0 169.0 135.0 13:43:29 INFO - 2015-12-04 13:43:29,274 DEBUG : BROWSER_OUTPUT: 13:43:29 INFO - 2015-12-04 13:43:29,274 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:2.67 (1.6%) stddev-sans-first:2.80 13:43:29 INFO - 2015-12-04 13:43:29,274 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 165.0 164.0 162.0 164.0 171.0 163.0 162.0 164.0 13:43:29 INFO - 2015-12-04 13:43:29,274 DEBUG : BROWSER_OUTPUT: 13:43:29 INFO - 2015-12-04 13:43:29,275 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.10 Median:74.00 stddev:31.42 (42.5%) stddev-sans-first:32.64 13:43:29 INFO - 2015-12-04 13:43:29,275 DEBUG : BROWSER_OUTPUT: Values: 71.0 74.0 73.0 74.0 152.0 73.0 79.0 74.0 76.0 145.0 13:43:29 INFO - 2015-12-04 13:43:29,275 DEBUG : BROWSER_OUTPUT: 13:43:29 INFO - 2015-12-04 13:43:29,275 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.00 Median:94.50 stddev:20.36 (21.5%) stddev-sans-first:21.13 13:43:29 INFO - 2015-12-04 13:43:29,275 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 145.0 94.0 94.0 94.0 133.0 95.0 95.0 130.0 13:43:29 INFO - 2015-12-04 13:43:29,275 DEBUG : BROWSER_OUTPUT: 13:43:29 INFO - 2015-12-04 13:43:29,275 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.50 Median:111.00 stddev:1.18 (1.1%) stddev-sans-first:1.24 13:43:29 INFO - 2015-12-04 13:43:29,275 DEBUG : BROWSER_OUTPUT: Values: 111.0 111.0 111.0 110.0 113.0 111.0 110.0 110.0 109.0 109.0 13:43:29 INFO - 2015-12-04 13:43:29,275 DEBUG : BROWSER_OUTPUT: 13:43:29 INFO - 2015-12-04 13:43:29,275 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 13:43:29 INFO - 2015-12-04 13:43:29,275 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 149.0 148.0 147.0 148.0 148.0 147.0 147.0 148.0 13:43:29 INFO - 2015-12-04 13:43:29,276 DEBUG : BROWSER_OUTPUT: 13:43:29 INFO - 2015-12-04 13:43:29,276 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:97.10 Median:96.00 stddev:2.47 (2.6%) stddev-sans-first:2.59 13:43:29 INFO - 2015-12-04 13:43:29,276 DEBUG : BROWSER_OUTPUT: Values: 96.0 104.0 97.0 97.0 96.0 96.0 96.0 97.0 96.0 96.0 13:43:29 INFO - 2015-12-04 13:43:29,276 DEBUG : BROWSER_OUTPUT: 13:43:29 INFO - 2015-12-04 13:43:29,276 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.60 Median:72.50 stddev:1.71 (2.4%) stddev-sans-first:1.80 13:43:29 INFO - 2015-12-04 13:43:29,276 DEBUG : BROWSER_OUTPUT: Values: 72.0 75.0 71.0 73.0 73.0 76.0 71.0 71.0 72.0 72.0 13:43:29 INFO - 2015-12-04 13:43:29,276 DEBUG : BROWSER_OUTPUT: 13:43:29 INFO - 2015-12-04 13:43:29,277 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.84 (1.2%) stddev-sans-first:0.88 13:43:29 INFO - 2015-12-04 13:43:29,277 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 68.0 67.0 69.0 68.0 68.0 69.0 69.0 13:43:29 INFO - 2015-12-04 13:43:29,277 DEBUG : BROWSER_OUTPUT: 13:43:29 INFO - 2015-12-04 13:43:29,277 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:83.50 stddev:7.13 (8.5%) stddev-sans-first:7.35 13:43:29 INFO - 2015-12-04 13:43:29,277 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 84.0 85.0 83.0 83.0 86.0 83.0 102.0 98.0 13:43:29 INFO - 2015-12-04 13:43:29,277 DEBUG : BROWSER_OUTPUT: 13:43:29 INFO - 2015-12-04 13:43:29,277 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:130.00 stddev:7.50 (5.8%) stddev-sans-first:7.37 13:43:29 INFO - 2015-12-04 13:43:29,277 DEBUG : BROWSER_OUTPUT: Values: 121.0 119.0 127.0 130.0 125.0 144.0 125.0 130.0 137.0 133.0 13:43:29 INFO - 2015-12-04 13:43:29,278 DEBUG : BROWSER_OUTPUT: 13:43:29 INFO - 2015-12-04 13:43:29,278 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.60 Median:144.00 stddev:7.06 (4.9%) stddev-sans-first:7.43 13:43:29 INFO - 2015-12-04 13:43:29,278 DEBUG : BROWSER_OUTPUT: Values: 147.0 143.0 152.0 141.0 144.0 142.0 144.0 158.0 144.0 131.0 13:43:29 INFO - 2015-12-04 13:43:29,278 DEBUG : BROWSER_OUTPUT: 13:43:29 INFO - 2015-12-04 13:43:29,278 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:2.45 (3.6%) stddev-sans-first:2.60 13:43:29 INFO - 2015-12-04 13:43:29,278 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 67.0 76.0 69.0 68.0 69.0 69.0 69.0 13:43:29 INFO - 2015-12-04 13:43:29,278 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:43:29 INFO - 2015-12-04 13:43:29,279 DEBUG : BROWSER_OUTPUT: 13:43:30 INFO - 2015-12-04 13:43:30,187 INFO : Browser exited with error code: 0 13:43:30 INFO - 2015-12-04 13:43:30,238 INFO : Completed test kraken (00:01:01) 13:43:30 INFO - 2015-12-04 13:43:30,238 INFO : Starting test v8_7 13:43:30 INFO - 2015-12-04 13:43:30,238 DEBUG : operating with platform_type : linux_ 13:43:30 INFO - 2015-12-04 13:43:30,239 INFO : Initialising browser for v8_7 test... 13:43:30 INFO - 2015-12-04 13:43:30,245 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuRRp7f/profile http://localhost:52430/getInfo.html 13:43:34 INFO - 2015-12-04 13:43:34,686 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:43:34 INFO - 2015-12-04 13:43:34,686 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:43:34 INFO - 2015-12-04 13:43:34,686 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:43:34 INFO - 2015-12-04 13:43:34,686 DEBUG : BROWSER_OUTPUT: __metrics 13:43:34 INFO - 2015-12-04 13:43:34,803 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] 13:43:35 INFO - 2015-12-04 13:43:35,755 INFO : Browser initialized. 13:43:35 INFO - 2015-12-04 13:43:35,756 INFO : Running cycle 1/1 for v8_7 test... 13:43:35 INFO - 2015-12-04 13:43:35,756 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuRRp7f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:43:47 INFO - 2015-12-04 13:43:47,839 DEBUG : BROWSER_OUTPUT: RSS: Main: 143265792 13:43:47 INFO - 2015-12-04 13:43:47,840 DEBUG : BROWSER_OUTPUT: 13:44:09 INFO - 2015-12-04 13:44:09,272 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52430/tests/v8_7/run.html (next: http://localhost:52430/tests/v8_7/run.html) 13:44:09 INFO - 2015-12-04 13:44:09,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 138678272 13:44:09 INFO - 2015-12-04 13:44:09,531 DEBUG : BROWSER_OUTPUT: 13:44:09 INFO - 2015-12-04 13:44:09,531 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:44:09 INFO - 2015-12-04 13:44:09,531 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:44:09 INFO - 2015-12-04 13:44:09,531 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:44:09 INFO - 2015-12-04 13:44:09,532 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:44:09 INFO - 2015-12-04 13:44:09,532 DEBUG : BROWSER_OUTPUT: |0;Richards;165.72754391779912 13:44:09 INFO - 2015-12-04 13:44:09,532 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.60402436773123 13:44:09 INFO - 2015-12-04 13:44:09,532 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.39251040221916 13:44:09 INFO - 2015-12-04 13:44:09,532 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5128.205128205128 13:44:09 INFO - 2015-12-04 13:44:09,533 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1071.8113612004288 13:44:09 INFO - 2015-12-04 13:44:09,533 DEBUG : BROWSER_OUTPUT: |5;Earley;716.8458781362007 13:44:09 INFO - 2015-12-04 13:44:09,533 DEBUG : BROWSER_OUTPUT: |6;Boyer;12228.915662650603 13:44:09 INFO - 2015-12-04 13:44:09,533 DEBUG : BROWSER_OUTPUT: |7;RegExp;25717.94871794872 13:44:09 INFO - 2015-12-04 13:44:09,534 DEBUG : BROWSER_OUTPUT: |8;Splay;599.880023995201 13:44:09 INFO - 2015-12-04 13:44:09,534 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 13:44:09 INFO - 2015-12-04 13:44:09,534 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:44:09 INFO - 2015-12-04 13:44:09,534 DEBUG : BROWSER_OUTPUT: __startTimestamp1449265449524__endTimestamp 13:44:09 INFO - 2015-12-04 13:44:09,534 DEBUG : BROWSER_OUTPUT: 13:44:09 INFO - 2015-12-04 13:44:09,535 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:44:09 INFO - 2015-12-04 13:44:09,535 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:44:09 INFO - 2015-12-04 13:44:09,535 DEBUG : BROWSER_OUTPUT: 13:44:09 INFO - 2015-12-04 13:44:09,535 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.73 Median:165.73 stddev:0.00 (0.0%) 13:44:09 INFO - 2015-12-04 13:44:09,535 DEBUG : BROWSER_OUTPUT: Values: 165.7 13:44:09 INFO - 2015-12-04 13:44:09,535 DEBUG : BROWSER_OUTPUT: 13:44:09 INFO - 2015-12-04 13:44:09,535 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.60 Median:184.60 stddev:0.00 (0.0%) 13:44:09 INFO - 2015-12-04 13:44:09,535 DEBUG : BROWSER_OUTPUT: Values: 184.6 13:44:09 INFO - 2015-12-04 13:44:09,536 DEBUG : BROWSER_OUTPUT: 13:44:09 INFO - 2015-12-04 13:44:09,536 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.39 Median:277.39 stddev:0.00 (0.0%) 13:44:09 INFO - 2015-12-04 13:44:09,536 DEBUG : BROWSER_OUTPUT: Values: 277.4 13:44:09 INFO - 2015-12-04 13:44:09,536 DEBUG : BROWSER_OUTPUT: 13:44:09 INFO - 2015-12-04 13:44:09,536 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5128.21 Median:5128.21 stddev:0.00 (0.0%) 13:44:09 INFO - 2015-12-04 13:44:09,536 DEBUG : BROWSER_OUTPUT: Values: 5128.2 13:44:09 INFO - 2015-12-04 13:44:09,536 DEBUG : BROWSER_OUTPUT: 13:44:09 INFO - 2015-12-04 13:44:09,536 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1071.81 Median:1071.81 stddev:0.00 (0.0%) 13:44:09 INFO - 2015-12-04 13:44:09,536 DEBUG : BROWSER_OUTPUT: Values: 1071.8 13:44:09 INFO - 2015-12-04 13:44:09,536 DEBUG : BROWSER_OUTPUT: 13:44:09 INFO - 2015-12-04 13:44:09,536 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:716.85 Median:716.85 stddev:0.00 (0.0%) 13:44:09 INFO - 2015-12-04 13:44:09,536 DEBUG : BROWSER_OUTPUT: Values: 716.8 13:44:09 INFO - 2015-12-04 13:44:09,537 DEBUG : BROWSER_OUTPUT: 13:44:09 INFO - 2015-12-04 13:44:09,537 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12228.92 Median:12228.92 stddev:0.00 (0.0%) 13:44:09 INFO - 2015-12-04 13:44:09,537 DEBUG : BROWSER_OUTPUT: Values: 12228.9 13:44:09 INFO - 2015-12-04 13:44:09,537 DEBUG : BROWSER_OUTPUT: 13:44:09 INFO - 2015-12-04 13:44:09,537 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25717.95 Median:25717.95 stddev:0.00 (0.0%) 13:44:09 INFO - 2015-12-04 13:44:09,537 DEBUG : BROWSER_OUTPUT: Values: 25717.9 13:44:09 INFO - 2015-12-04 13:44:09,537 DEBUG : BROWSER_OUTPUT: 13:44:09 INFO - 2015-12-04 13:44:09,537 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:599.88 Median:599.88 stddev:0.00 (0.0%) 13:44:09 INFO - 2015-12-04 13:44:09,537 DEBUG : BROWSER_OUTPUT: Values: 599.9 13:44:09 INFO - 2015-12-04 13:44:09,537 DEBUG : BROWSER_OUTPUT: 13:44:09 INFO - 2015-12-04 13:44:09,537 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 13:44:09 INFO - 2015-12-04 13:44:09,537 DEBUG : BROWSER_OUTPUT: Values: 4830.9 13:44:09 INFO - 2015-12-04 13:44:09,537 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:44:09 INFO - 2015-12-04 13:44:09,537 DEBUG : BROWSER_OUTPUT: 13:44:10 INFO - 2015-12-04 13:44:10,443 INFO : Browser exited with error code: 0 13:44:10 INFO - 2015-12-04 13:44:10,460 INFO : Completed test v8_7 (00:00:40) 13:44:10 INFO - 2015-12-04 13:44:10,512 INFO : Completed test suite (00:20:17) 13:44:10 INFO - 2015-12-04 13:44:10,513 DEBUG : Working with test: dromaeo_css 13:44:10 INFO - 2015-12-04 13:44:10,513 DEBUG : Generating results file: dromaeo_css 13:44:10 INFO - 2015-12-04 13:44:10,514 DEBUG : Working with test: kraken 13:44:10 INFO - 2015-12-04 13:44:10,514 DEBUG : Generating results file: kraken 13:44:10 INFO - 2015-12-04 13:44:10,514 INFO : javascript benchmark 13:44:10 INFO - 2015-12-04 13:44:10,514 DEBUG : Working with test: v8_7 13:44:10 INFO - 2015-12-04 13:44:10,515 DEBUG : Generating results file: v8_7 13:44:10 INFO - 2015-12-04 13:44:10,515 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:44:10 INFO - 2015-12-04 13:44:10,568 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 13:44:10 INFO - 2015-12-04 13:44:10,568 DEBUG : process_Request line: dromaeo_css 6356.35 graph.html#tests=[[72,132,43]] 13:44:10 INFO - 2015-12-04 13:44:10,569 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:44:10 INFO - 2015-12-04 13:44:10,601 DEBUG : process_Request line: kraken 1548.80 graph.html#tests=[[232,132,43]] 13:44:10 INFO - 2015-12-04 13:44:10,601 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:44:10 INFO - 2015-12-04 13:44:10,628 DEBUG : process_Request line: v8_7 21432.83 graph.html#tests=[[230,132,43]] 13:44:10 INFO - 2015-12-04 13:44:10,629 INFO : javascript benchmark 13:44:10 INFO - 2015-12-04 13:44:10,633 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2663.5871439926814, 2718.8504632245217, 2744.3002034481206, 2749.752522272995, 2759.558470644697, 4624.375709279247, 4803.759812009399, 4807.23084306511, 4848.321235027099, 4851.369321988141, 4729.810807567702, 4765.0, 4804.063207674496, 4864.100141473821, 4865.245886887538, 4362.258416069276, 4420.4253447051915, 4522.751248681321, 4523.2988886722615, 4567.474740404846, 4232.132412855372, 4389.0, 4402.097569998159, 4420.602145806893, 4519.209138400784, 4320.481542214954, 4369.825206991716, 4462.754548499831, 4479.3504941783585, 4499.762565294537, 4473.060657261979, 4473.194824931544, 4476.37330773692, 4480.036792089716, 4530.501644819067, 4239.576042395766, 4324.437823083011, 4446.288593824973, 4456.532064133284, 4470.307102399133, 4623.006053698437, 4679.9298010529865, 4715.952840471586, 4846.345743324641, 4858.489858564835, 5152.819651312186, 5216.556592689626, 5218.086834803932, 5220.817271395483, 5227.163653815372, 5220.634555581111, 5227.712475813829, 5231.267622532849, 5239.764210610493, 5289.074411977888, 4639.39687840582, 4717.693349932243, 4767.61859051275, 4781.378420805273, 4834.250691142808, 5313.335833020872, 5321.494458026481, 5337.6797392156595, 5345.278387417727, 5401.702906340189, 4802.207635740064, 5067.949320506821, 5104.081265372269, 5116.897662046738, 5119.411267704188, 5139.460356662571, 5143.228515722672, 5199.038177937094, 5213.530782229617, 5269.367675878842, 5064.265681476165, 5164.715940623227, 5170.560502357266, 5173.40505841833, 5218.608604354688, 4856.077345304451, 4974.204127339608, 5107.310513080761, 5136.640435169577, 5157.097507936096, 4134.855280065183, 4203.957960420356, 4207.621314081747, 4214.936775948363, 4247.044415006599, 3788.431735239681, 3792.4500947362476, 3808.086059345737, 3829.5021647185686, 3854.036490877281, 4292.935605965913, 4338.175746608134, 4404.581564751344, 4497.123061003138, 4538.160440318552, 5231.555317797954, 5235.397929238186, 5240.161574148118, 5263.578913686896, 5267.236250743621, 4506.098780243964, 4524.841630542981, 4539.046800171935, 4569.657275704269, 4570.428696412949, 4362.825486980549, 4485.192665320208, 4539.114872599811, 4630.86107416778, 4662.323963025342, 4866.440359358719, 4871.244957031666, 4881.585065269492, 4886.95113048865, 4915.0415668944215, 5140.794368225379, 5142.97428512855, 5152.76812543429, 5158.845234642967, 5185.948140518546, 4734.810607575659, 4823.131836269506, 4840.201366774583, 4918.704877707349, 4963.602911766978, 5064.29099926018, 5078.97460512695, 5087.2623469595965, 5099.439061703136, 5134.691918484903, 5007.173816320412, 5165.251038599307, 5167.715775632226, 5174.7930082796265, 5182.481751824938, 4935.75321233944, 4942.357493525818, 4959.851204463727, 4967.130752118437, 5059.266406371129, 5027.095122877917, 5040.092783299041, 5042.243663450512, 5045.798168073383, 5094.974525127351, 4887.362733484322, 4925.605951523941, 4941.950580494149, 4960.032793605213, 4962.801487940442, 4844.249141383091, 4909.975450122869, 4992.80028798844, 5154.819581314636, 5157.948420515747, 4989.825356112518, 4992.700437973734, 5000.899982000413, 5017.197248440232, 5064.392272927273], "unit": "ms", "name": "dojo.html", "value": 4727.90851092199}, {"lowerIsBetter": false, "replicates": [557.552080864016, 574.5604612471459, 576.9019266724656, 578.4100217777869, 585.5227989188811, 37011.074723131904, 37285.254294914084, 37702.0, 37740.81129594348, 37758.0, 39763.60236397635, 40323.79838100813, 40333.0, 40446.7977660112, 40510.392344114865, 7966.880496792553, 8121.75634730959, 8122.147174546676, 8123.593820308991, 8127.431079824415, 7859.724909628164, 7873.370130389584, 7893.644785984616, 7935.722249721261, 7982.920170798305, 7940.880886786703, 7991.0, 8007.959960200191, 8033.959830200841, 8052.59737013147, 7955.602219889011, 8019.919800802005, 8030.357571394304, 8039.115697273295, 8049.798755031113, 7885.448018638697, 7949.443538952276, 8016.15830337812, 8017.198280171994, 8038.236367545132, 36910.630893690985, 37078.62921370806, 37128.0, 37438.43842342367, 37445.06387340311, 2509.4855554611445, 2596.9480610387686, 2675.4782817350624, 2919.5182794838825, 3126.390353880994, 26668.866655666596, 26794.86602566994, 26997.460050798873, 27144.728552714416, 27475.0, 3397.2016576104843, 3413.1808365992233, 3485.9651403485896, 3532.540769699948, 3565.8038807865555, 211837.0, 213169.0, 214676.0, 214889.0, 215163.0, 51799.482005180216, 53016.0, 55034.0, 55097.724511377186, 55157.448425516035, 65519.344806552275, 67152.0, 67316.32683673198, 67327.32672673308, 67375.66312168408, 13563.660908477366, 13864.584062478141, 13871.583852484442, 13874.583762487142, 13881.861181388258, 10627.309224900357, 10770.623028194132, 10800.513976870903, 10816.621418250323, 10816.78366432667, 18971.71542426865, 19119.235230590897, 19175.137118829687, 19203.711944320847, 19232.423027309203, 7489.138749043821, 7524.548527088283, 7595.240475952471, 7646.120696119906, 7653.846923061507, 891.5364010714392, 898.5327629632554, 984.9608662860751, 1025.5436330832708, 1084.2789544952675, 25940.61089083665, 26332.8683356582, 26486.47027059448, 26875.86562067177, 27604.861975689993, 887.5650931043742, 931.0317270039219, 944.9480278584743, 984.7341217871135, 1014.2545229256491, 12666.240025598494, 14125.434982600786, 14259.144451332953, 14681.706365872837, 14737.705245895022, 264985.0, 266892.0, 269751.0, 269847.0, 270500.0, 46653.30020049702, 46834.0, 47211.76394118008, 47262.52737472581, 47600.285995710095, 1184.218415845555, 1228.8341073954903, 1236.542479282689, 1243.3286025546286, 1257.1011726615513, 26220.606690900033, 26698.065567705038, 26873.193804185907, 27200.591991120546, 27207.86396068086, 38989.2202155961, 39022.0, 39180.804095979336, 39433.60566394414, 39505.604943950195, 180418.0, 181019.0, 181566.0, 181587.0, 182076.0, 28871.711282886903, 29217.26956826011, 30090.548641769954, 30110.548341775328, 30181.396372072875, 34931.82534087415, 35361.29277414489, 35768.0, 35828.462573060904, 36276.81861590675, 30405.0, 30545.694543054284, 30781.846090769403, 33439.0, 34225.315493689486, 32501.34997300088, 32979.8351008253, 33440.0, 33501.66498334985, 33527.83236083804, 32895.506567401986, 33574.0, 34078.318433630695, 34206.14484637904, 34242.0, 27365.589516156877, 29344.266393339483, 30020.549691754204, 30062.0, 30503.54244686287, 23245.186418475274, 23992.64011039871, 24261.150859719826, 24349.39126521851, 24938.750612493644], "unit": "ms", "name": "ext.html", "value": 16799.3463283718}, {"lowerIsBetter": false, "replicates": [322.20094166467146, 326.2008080203499, 331.8307663091824, 331.8772054339894, 335.6710423784691, 14991.850081499182, 15376.231188440575, 15517.224138793057, 16169.0, 16709.749353759675, 10090.798184036315, 10339.741506462342, 12418.875811241885, 13189.07676462648, 13192.670183245424, 4691.850496628323, 4829.3480380148585, 4842.539958703917, 4844.176489996691, 5243.370795504545, 5184.300119483878, 5228.372595288571, 5230.320058392404, 5235.633505654606, 5237.7381130943495, 5201.55786758126, 5213.1919552469235, 5379.731013449332, 5498.3127109111365, 5567.387587365387, 5294.100002999499, 5386.2997810284605, 5424.620276580601, 5467.371252305976, 5498.670079795225, 4877.463479017305, 4898.779554920037, 4900.411950565955, 4937.654364194508, 4949.876253093666, 17023.48929532116, 17550.736738948926, 17704.468865933915, 17934.192961316643, 18990.62018759617, 1729.2304924308687, 1730.108993868159, 1747.589316510619, 1785.366195000782, 1785.7767779027622, 8861.42400743956, 9052.366334356597, 9808.803823923552, 12550.74898502034, 12832.165909215872, 1677.6896274189314, 1685.4606525911713, 1691.9848091145338, 1718.3813827022261, 1723.5949551855304, 57833.710831445576, 57860.71069644625, 58258.70870645662, 58557.70721146367, 59246.0, 9728.221742260603, 9747.805043899083, 9763.07250811186, 10078.848817267746, 10110.747231319128, 12644.620661380173, 12674.683132921751, 12702.80945785814, 12707.93646031764, 12716.427760750788, 7118.323759242864, 7198.100237470317, 7218.242084581148, 7251.347378735939, 7283.817904552428, 6588.8023359299295, 6616.338366163345, 6626.039224312544, 6651.23510796255, 6886.51794374389, 3975.0857302820514, 4008.9799551002056, 4104.302268614343, 4143.482064741907, 4214.431051808028, 1588.285271627772, 1647.2258038721782, 1697.4652984309903, 1723.1384307846076, 1739.869509786771, 798.8177497304023, 855.2986551028097, 954.5847556313026, 957.5499515227832, 983.1250187333279, 13239.404226809816, 14401.495947641783, 14624.049436786574, 15958.20208989569, 16181.919090404472, 837.4891316297054, 846.251067804997, 868.2402897464718, 885.7874110213502, 899.2940541674753, 8916.643334266686, 9021.278297736166, 9131.497767622712, 9168.129027742354, 9364.719058428258, 423845.0, 425090.0, 433855.0, 438924.0, 440725.0, 68850.31149688539, 69228.6538567314, 69438.30561694318, 69751.3024869755, 69828.30171698218, 1062.792755412687, 1063.574570171922, 1094.2395035450445, 1115.5426275227119, 1117.3407689463256, 14340.56978290653, 14453.277336133362, 14521.346539405964, 14582.708345833236, 14766.704665906407, 31926.0, 32448.837755812016, 32638.34723305473, 32966.67033329636, 33696.3260734779, 41776.0, 41849.79075104605, 42267.0, 42384.78807605942, 45069.774651126536, 9234.492102934402, 9311.906880931376, 9325.06749325062, 9362.110599493037, 9394.812103758024, 16038.198090095682, 16059.0, 16593.170341482637, 16686.749698754287, 16807.91596042012, 12584.811227831407, 12847.550335738204, 13350.599482015556, 13595.52415665447, 13597.184168949894, 12428.316442595744, 12435.813462797883, 12799.488020479077, 13298.401571929093, 13505.054646174673, 13469.12450690702, 13533.323333833467, 13824.723505530033, 13918.443262269397, 14005.229712365917, 8294.212049855254, 8577.442466239923, 8671.653133874826, 8672.219500245008, 9208.861867071866, 13666.794998074838, 13774.931125344308, 13781.379837907518, 13862.376193071537, 14384.136951782926], "unit": "ms", "name": "jquery.html", "value": 8242.829343122408}, {"lowerIsBetter": false, "replicates": [1414.1373762005176, 1423.2812429722987, 1527.434849105831, 1693.9407120750773, 1776.0409378935376, 7295.525790823593, 7429.851402971937, 7592.278733520307, 7621.847563048743, 7634.961825190873, 7389.889151662729, 7409.629518524066, 7420.517666351683, 7476.177620461758, 7496.3628091612145, 2055.8560900736993, 2086.2280956046284, 2086.457521044532, 2089.780573039824, 2094.2984100326407, 2043.4584835018732, 2061.5258490547185, 2083.8437117216195, 2084.635188841954, 2085.14509051289, 1663.783708117943, 1687.7890263717036, 2024.1903238704563, 2043.2542122125467, 2086.426232785981, 1987.9503012424732, 1988.6818109102546, 2006.8595198336122, 2007.738993930787, 2014.5366565689974, 2037.7147199392098, 2039.4391542325832, 2085.113826623679, 2097.056324653912, 2097.171617211193, 7259.564426134449, 7284.125904891394, 7287.817804554876, 7303.379212766921, 7316.0, 4116.91766164675, 4139.275626765304, 4140.979295103505, 4161.396597493377, 4178.540360560336, 2573.832700874456, 2584.315156483515, 2628.9079882204032, 2632.118240389472, 2652.071774878796, 828.6933834481221, 829.6432534010373, 846.1327139681814, 867.1805144138791, 885.8626912828522, 9280.1647851693, 9292.070792920655, 9307.76730581741, 9310.162085412278, 9334.0, 3587.766795158306, 3639.344917914748, 3676.5036720042986, 3682.6869716073898, 3689.0592898810633, 7564.924350756422, 7582.582957937367, 7601.08786945559, 7618.238176182448, 7624.161342252348, 4125.1131006833075, 4133.8966525836495, 4143.1713657268665, 4153.273177193979, 4157.251694694924, 3809.5999920008, 3835.328817456934, 3842.481265029185, 3852.4413959975645, 3852.5954774748807, 3171.0486853944185, 3186.776925615231, 3189.744820414361, 3205.406999705062, 3233.6281327647152, 919.0992827029548, 922.5710044829052, 922.8154369126202, 922.9030951750104, 926.893407258174, 918.2195134135931, 918.8529835226466, 929.3680297397834, 972.7276362618478, 988.5897352598735, 6870.072540207108, 6891.75878844238, 6945.2707465715375, 7012.649367531603, 7013.824654383579, 1019.9337043092323, 1034.0486752188006, 1064.8311859071648, 1080.2762149359949, 1103.5916710817048, 5418.566514678895, 5434.347878254634, 5462.890742185214, 5473.2063850741415, 5487.341519017744, 8478.236958673626, 8626.698065567674, 8694.782630434163, 8777.0, 8871.423357481743, 8636.352273579507, 8651.437656552303, 8708.08565100668, 8711.60797764102, 8726.95636521826, 6689.130413046273, 6783.253842077466, 6789.830254243585, 6843.555168914104, 6873.828154296182, 6489.707963141575, 6506.674666266762, 6516.478681705357, 6551.0173473979285, 6552.705128269335, 7443.846203838414, 7608.087029556488, 7643.808904777425, 7661.348785353307, 7736.303732663862, 7573.659185336784, 7786.922130778619, 7919.247671471201, 7975.880361794461, 8000.119986801331, 5814.360420353673, 5824.330202026652, 5830.53355731549, 5847.415258474289, 5851.683371241436, 6503.0, 6650.301718319701, 6663.400293973566, 6669.833254168685, 6676.165479315086, 6438.8390290243115, 6451.0, 6528.347165283623, 6545.967270163619, 6639.506111124958, 5439.5648348132845, 5896.351401345934, 5933.169356290209, 5999.9100013498955, 6090.543209259412, 6110.480609148094, 6125.540584456095, 6166.969165154145, 6188.969055154876, 6213.596116252429, 5709.8287051388525, 5787.768489260382, 5798.333191682842, 5802.4197580241635, 5816.0, 5757.625754325955, 5777.16231146473, 5790.218320526675, 5812.796552120655, 5816.214811000461], "unit": "ms", "name": "mootools.html", "value": 4020.3213591392514}, {"lowerIsBetter": false, "replicates": [282.06776603326006, 287.08277054809867, 289.40960440700974, 289.55842340430854, 292.65028291192027, 5330.573554115671, 5576.386597474279, 5591.7204139793, 5651.943480565194, 5677.630953987988, 5569.777208911639, 5581.609287349887, 5589.133684278943, 5591.6365436246715, 5612.971935140329, 4162.063535704473, 4186.267403204442, 4199.076203235283, 4204.32730763078, 4205.453291072156, 4191.832326706928, 4197.7271477354025, 4206.47419072616, 4206.726562773425, 4209.768462734548, 3981.9601803981877, 4138.730982486129, 4156.43888075109, 4159.646430053449, 4168.520620128678, 4120.793960302003, 4133.111381053073, 4138.586141385867, 4146.419501269825, 4150.315197992328, 3552.769070010441, 3553.2538166984964, 3561.12752375667, 3561.5726112866623, 3569.23261498779, 5289.841304760864, 5329.173978033411, 5337.973310133463, 5345.01117293302, 5350.464953504657, 4674.929876051862, 4713.481517033124, 4778.235482322812, 4783.019481006385, 4783.712977221343, 5640.674441506243, 5767.711614419304, 5784.2769653793275, 5807.332156801937, 5819.272590926134, 3899.1032062625754, 3903.33643280643, 3906.5507466641416, 3910.882673519799, 3910.904946614952, 6067.817965461043, 6138.83362161188, 6150.692465376714, 6154.384561543855, 6163.476104531121, 3985.0, 3999.7600143991453, 4008.318585840414, 4023.195360927826, 4100.856470023535, 4159.10579225468, 4176.331786914079, 4180.644645205191, 4222.873313800591, 4230.471191101113, 4853.563179313808, 4859.34398856157, 4861.590138859691, 4865.270209468608, 4876.073546026244, 5844.9415505845245, 5851.975904216745, 5856.502197313191, 5861.0915308127305, 5877.794277200277, 1438.539667306473, 1466.8679818816358, 1468.2658670664669, 1487.7545205041047, 1488.5013520470764, 992.1021475564626, 996.7308826616772, 1009.4649835587151, 1010.9898901011043, 1011.2516737614112, 4985.0, 5005.1491246488185, 5036.370453693288, 5062.215356619657, 5064.974675126675, 5895.233619629421, 5920.0, 5974.3726908674835, 5976.850578735566, 6001.609895356788, 4993.525615066563, 4995.375578052744, 5010.549050585465, 5013.348264725562, 5025.79896804131, 3183.7293830024705, 3198.792078514889, 3243.383757086146, 3246.935061298761, 3284.1132894118455, 5721.39925307845, 5728.54171666274, 5754.798582049608, 5785.247917770663, 5809.0705487122705, 6257.405546473078, 6283.842903927439, 6287.748490060438, 6303.779367722108, 6320.336364681734, 5668.376478587435, 5755.971220143872, 5780.393058728857, 5798.1302804579655, 5808.448197421239, 6091.203095086871, 6111.297200821962, 6116.17431646722, 6117.3270940197435, 6133.723982420891, 5955.731992060281, 5986.341502434816, 5990.0, 5990.31111422192, 5996.4902983245165, 5771.220885180447, 5780.884382312246, 5785.768569257182, 5790.449907258803, 5810.5351571875, 3940.9014774630864, 3980.442738016738, 4040.7777572232635, 4050.4126901599693, 4051.8784436466954, 5968.582199246011, 6074.878502429839, 6092.0, 6096.1465394845645, 6103.786367477117, 5838.357780644211, 5853.2976042875125, 5881.705914704162, 5889.116632504987, 5895.380984996686, 5821.476067153976, 5822.2140011099655, 5864.179014937998, 5867.266591676041, 5883.470487656132, 5605.439456054362, 5720.08478643415, 5726.599138060295, 5731.684757338387, 5749.13762935563, 5911.201987731773, 5925.585209035326, 5930.110483427347, 5930.644161350333, 5936.703164841654, 5705.914411283751, 5729.427057294237, 5742.052561327334, 5757.309122905278, 5766.538676905921], "unit": "ms", "name": "prototype.html", "value": 4331.511881728423}, {"lowerIsBetter": false, "replicates": [787.4960025583624, 794.9046114466263, 795.3875515852793, 799.720097965712, 825.257268458387, 10845.83731244032, 11277.605283815068, 11296.435178241096, 13100.344982750872, 13265.0, 13485.258310792902, 13537.390817413216, 13560.389782459788, 13564.253966031863, 13588.0, 639.4532674563251, 648.2124219073825, 794.0471434278874, 815.955122468264, 819.0376307838296, 797.214743477674, 797.2665148063767, 803.9477433966773, 806.435495153392, 808.9312408445289, 845.9450135741157, 863.1799790199304, 865.7402779166225, 865.9956700216491, 868.9000764912053, 849.4308813095241, 858.3047731337605, 860.8149247911698, 862.4782006885806, 863.9740807775777, 627.3256249531771, 631.8957372033609, 637.8022812928007, 638.1894993358455, 640.9006603976344, 11842.28946263227, 12056.095792815573, 12076.577319793852, 12091.697707557294, 12095.516179352815, 11027.283226590245, 11255.212135150543, 11555.0, 11614.883851161465, 11769.88230117705, 9041.90958090424, 9460.810783784285, 9491.620335186584, 9610.423374597547, 9715.174210192143, 3325.0, 3334.883279085245, 3338.098713347407, 3375.628680845105, 3378.5101160331615, 42600.57399425997, 42649.147017059484, 42985.14029719419, 43001.99999999969, 43037.56962430367, 9455.621775128919, 9546.284028697875, 9625.422474651403, 9662.516874156265, 9672.75818104553, 16131.274092665624, 16132.75800862988, 16215.432459863849, 16245.837541624669, 16252.918735406483, 6045.72794224261, 6118.990366589463, 6162.445379915829, 6180.907286390708, 6289.96855015722, 3585.103724068983, 3607.3687104757087, 3651.0, 3664.4587227027573, 3757.49273848027, 2594.260635718811, 2607.6088586711767, 2615.0585789115903, 2626.487834872182, 2629.842209467438, 448.24694513218105, 459.6621483209838, 459.97470139142666, 467.57684295712437, 475.26096919290836, 398.458096988096, 551.6941360252275, 564.6640249051808, 614.3978900677362, 649.5161104976822, 7514.511556748794, 7554.896701487871, 7616.276453736886, 7722.150563438017, 7789.260020298176, 446.34164607204764, 454.3502791008823, 461.66298602020714, 465.8043621678903, 587.952963762898, 3357.764956453074, 3607.7654952428006, 3610.6389361063684, 3643.544556930384, 3694.6674799268194, 47413.0, 47498.5250147501, 48100.27849582259, 48154.75922620364, 48205.27692084621, 44847.77576112164, 45679.543204567526, 46859.5314046862, 46905.29642055304, 46924.7653761729, 40772.79613601972, 41482.79258603688, 41886.58113418888, 43799.90500237456, 44183.55816441859, 7486.43851711113, 7864.297638921958, 8197.385196110436, 8301.11007863484, 8349.081601024003, 32009.35981280408, 32216.83891580527, 32613.510797338535, 32856.50715239321, 32996.1750956228, 39083.2183356337, 39946.800265998485, 39968.800156000194, 42763.572364277206, 42801.785991069846, 10181.389116653025, 10230.232732545237, 10346.430946298025, 10581.36511809294, 10600.310979786289, 11568.942155289169, 11616.593419230625, 11656.0, 11788.76422471563, 11941.940290298493, 9506.667266645634, 9593.058049072635, 10005.649802256887, 10050.69847904564, 10472.895271047191, 10765.3540787553, 10780.191485638452, 10991.147370248347, 11027.558897644005, 11073.667789966314, 10596.629117980834, 10640.89359106399, 10684.145268378667, 10776.622818201326, 10881.455927203766, 9579.377340473126, 9675.0, 9744.561494732612, 9850.556724947251, 9913.256505762241, 8584.484930903916, 9398.812023759623, 9422.95288523553, 9582.520873956135, 9648.228141748783], "unit": "ms", "name": "yui.html", "value": 5784.487985502984}], "name": "dromaeo_css", "value": 6356.349870392171}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 111.0, 111.0, 111.0, 124.0, 112.0, 111.0, 111.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 112.0}, {"lowerIsBetter": true, "replicates": [169.0, 130.0, 148.0, 177.0, 132.0, 152.0, 154.0, 138.0, 169.0, 135.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 165.0, 164.0, 162.0, 164.0, 171.0, 163.0, 162.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [71.0, 74.0, 73.0, 74.0, 152.0, 73.0, 79.0, 74.0, 76.0, 145.0], "unit": "ms", "name": "audio-fft", "value": 89.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 145.0, 94.0, 94.0, 94.0, 133.0, 95.0, 95.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 107.0}, {"lowerIsBetter": true, "replicates": [111.0, 111.0, 111.0, 110.0, 113.0, 111.0, 110.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.5}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 149.0, 148.0, 147.0, 148.0, 148.0, 147.0, 147.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [96.0, 104.0, 97.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 97.1}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 71.0, 73.0, 73.0, 76.0, 71.0, 71.0, 72.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 72.6}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 68.0, 67.0, 69.0, 68.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 84.0, 85.0, 83.0, 83.0, 86.0, 83.0, 102.0, 98.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.8}, {"lowerIsBetter": true, "replicates": [121.0, 119.0, 127.0, 130.0, 125.0, 144.0, 125.0, 130.0, 137.0, 133.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 129.1}, {"lowerIsBetter": true, "replicates": [147.0, 143.0, 152.0, 141.0, 144.0, 142.0, 144.0, 158.0, 144.0, 131.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.6}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 67.0, 76.0, 69.0, 68.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1548.7999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.72754391779912], "unit": "score", "name": "Richards", "value": 213.01226799999995}, {"lowerIsBetter": false, "replicates": [184.60402436773123], "unit": "score", "name": "DeltaBlue", "value": 358.16120599999994}, {"lowerIsBetter": false, "replicates": [277.39251040221916], "unit": "score", "name": "Encrypt", "value": 959.5825049999997}, {"lowerIsBetter": false, "replicates": [5128.205128205128], "unit": "score", "name": "Decrypt", "value": 51.90529499999997}, {"lowerIsBetter": false, "replicates": [1071.8113612004288], "unit": "score", "name": "RayTrace", "value": 690.4097369999998}, {"lowerIsBetter": false, "replicates": [716.8458781362007], "unit": "score", "name": "Earley", "value": 929.7158849999997}, {"lowerIsBetter": false, "replicates": [12228.915662650603], "unit": "score", "name": "Boyer", "value": 54.498944827586165}, {"lowerIsBetter": false, "replicates": [25717.94871794872], "unit": "score", "name": "RegExp", "value": 35.42214855433696}, {"lowerIsBetter": false, "replicates": [599.880023995201], "unit": "score", "name": "Splay", "value": 135.84549700000002}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21432.82964103107}]} 13:44:10 INFO - RETURN: dromaeo_css: 6356.35 13:44:10 INFO - RETURN: kraken: 1548.80 13:44:10 INFO - RETURN: v8_7: 21432.83 13:44:10 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21432.83"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1548.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6356.35"}}} 13:44:10 INFO - Return code: 0 13:44:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:44:10 INFO - # TBPL SUCCESS # 13:44:10 INFO - Running post-action listener: _resource_record_post_action 13:44:10 INFO - Running post-run listener: _resource_record_post_run 13:44:11 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 506777600; Read time: 0; Write time: 431980 13:44:11 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 231141376; Read time: 0; Write time: 304552 13:44:11 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 274743296; Read time: 0; Write time: 126880 13:44:11 INFO - Running post-run listener: _upload_blobber_files 13:44:11 INFO - Blob upload gear active. 13:44:11 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:44:11 INFO - Copying logs to upload dir... 13:44:11 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1267.698809 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-04 13:44:11.554204) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 13:44:11.557721) ========= 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=5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010058 build_url: 'https://queue.taskcluster.net/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 13:44:11.609921) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:44:11.610265) ========= 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=5752742a61d0f534093fa7a9000001cb-1449264182.82116-371679727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004577 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:44:11.660716) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 13:44:11.661101) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 13:44:11.661450) ========= ========= Total master_lag: 0.23 =========