builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-047 starttime: 1450109613.39 results: success (0) buildid: 20151214065331 builduid: 97d8ac10d1ce4120a29b36fdcd3258f1 revision: afc8558eac72996c2d24f3257ee045bd1ee2a196 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-14 08:13:33.394835) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-14 08:13:33.395233) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-14 08:13:33.395914) ========= 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=f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006350 basedir: '/builds/slave/test' ========= master_lag: 0.09 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-14 08:13:33.487511) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-14 08:13:33.487793) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-14 08:13:33.776934) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2015-12-14 08:13:33.777202) ========= 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=f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 1.18 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2015-12-14 08:13:34.959977) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-14 08:13:34.960289) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-14 08:13:34.960674) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 08:13:34.960949) ========= 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=f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-14 08:13:35-- 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.6M=0s 2015-12-14 08:13:35 (43.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.185374 ========= master_lag: 0.34 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 08:13:35.485215) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 08:13:35.485576) ========= 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=f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019788 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 08:13:35.569419) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 08:13:35.569780) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev afc8558eac72996c2d24f3257ee045bd1ee2a196 --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 afc8558eac72996c2d24f3257ee045bd1ee2a196 --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=f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-14 08:13:35,644 truncating revision to first 12 chars 2015-12-14 08:13:35,644 Setting DEBUG logging. 2015-12-14 08:13:35,644 attempt 1/10 2015-12-14 08:13:35,644 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/afc8558eac72?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-14 08:13:35,992 unpacking tar archive at: fx-team-afc8558eac72/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642215 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 08:13:36.243575) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-14 08:13:36.243893) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-14 08:13:36.254142) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-14 08:13:36.254535) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-14 08:13:36.254977) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-12-14 08:13:36.255436) ========= /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=f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:13:36 INFO - MultiFileLogger online at 20151214 08:13:36 in /builds/slave/test 08:13:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:13:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:13:36 INFO - {'append_to_log': False, 08:13:36 INFO - 'base_work_dir': '/builds/slave/test', 08:13:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:13:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:13:36 INFO - 'branch': 'Fx-Team-Non-PGO', 08:13:36 INFO - 'buildbot_json_path': 'buildprops.json', 08:13:36 INFO - 'config_files': ('talos/linux_config.py',), 08:13:36 INFO - 'default_actions': ('clobber', 08:13:36 INFO - 'read-buildbot-config', 08:13:36 INFO - 'download-and-extract', 08:13:36 INFO - 'populate-webroot', 08:13:36 INFO - 'create-virtualenv', 08:13:36 INFO - 'install', 08:13:36 INFO - 'run-tests'), 08:13:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:13:36 INFO - 'download_minidump_stackwalk': True, 08:13:36 INFO - 'download_symbols': 'ondemand', 08:13:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:13:36 INFO - 'tooltool.py': '/tools/tooltool.py', 08:13:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:13:36 INFO - '/tools/misc-python/virtualenv.py')}, 08:13:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:13:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:13:36 INFO - 'installer_path': 'installer.exe', 08:13:36 INFO - 'log_level': 'info', 08:13:36 INFO - 'log_name': 'talos', 08:13:36 INFO - 'log_to_console': True, 08:13:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:13:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:13:36 INFO - 'opt_config_files': (), 08:13:36 INFO - 'pip_index': False, 08:13:36 INFO - 'sps_profile': False, 08:13:36 INFO - 'sps_profile_interval': 0, 08:13:36 INFO - 'suite': 'dromaeojs-e10s', 08:13:36 INFO - 'system_bits': '64', 08:13:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:13:36 INFO - 'title': 'talos-linux64-ix-047', 08:13:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:13:36 INFO - 'use_talos_json': True, 08:13:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:13:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:13:36 INFO - 'work_dir': 'build'} 08:13:36 INFO - ##### 08:13:36 INFO - ##### Running clobber step. 08:13:36 INFO - ##### 08:13:36 INFO - Running pre-action listener: _resource_record_pre_action 08:13:36 INFO - Running main action method: clobber 08:13:36 INFO - rmtree: /builds/slave/test/build 08:13:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:13:37 INFO - Running post-action listener: _resource_record_post_action 08:13:37 INFO - ##### 08:13:37 INFO - ##### Running read-buildbot-config step. 08:13:37 INFO - ##### 08:13:37 INFO - Running pre-action listener: _resource_record_pre_action 08:13:37 INFO - Running main action method: read_buildbot_config 08:13:37 INFO - Using buildbot properties: 08:13:37 INFO - { 08:13:37 INFO - "properties": { 08:13:37 INFO - "buildnumber": 571, 08:13:37 INFO - "product": "firefox", 08:13:37 INFO - "script_repo_revision": "production", 08:13:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:13:37 INFO - "repository": "", 08:13:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 08:13:37 INFO - "buildid": "20151214065331", 08:13:37 INFO - "slavename": "talos-linux64-ix-047", 08:13:37 INFO - "pgo_build": "False", 08:13:37 INFO - "basedir": "/builds/slave/test", 08:13:37 INFO - "project": "", 08:13:37 INFO - "platform": "ubuntu64_hw", 08:13:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:13:37 INFO - "slavebuilddir": "test", 08:13:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:13:37 INFO - "branch": "fx-team", 08:13:37 INFO - "repo_path": "integration/fx-team", 08:13:37 INFO - "stage_platform": "linux64", 08:13:37 INFO - "builduid": "97d8ac10d1ce4120a29b36fdcd3258f1", 08:13:37 INFO - "revision": "afc8558eac72996c2d24f3257ee045bd1ee2a196" 08:13:37 INFO - }, 08:13:37 INFO - "sourcestamp": { 08:13:37 INFO - "repository": "", 08:13:37 INFO - "hasPatch": false, 08:13:37 INFO - "project": "", 08:13:37 INFO - "branch": "fx-team-linux64-talos", 08:13:37 INFO - "changes": [ 08:13:37 INFO - { 08:13:37 INFO - "category": null, 08:13:37 INFO - "files": [ 08:13:37 INFO - { 08:13:37 INFO - "url": null, 08:13:37 INFO - "name": "https://queue.taskcluster.net/v1/task/r0RmFnevTy6wwdkjDI82rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 08:13:37 INFO - } 08:13:37 INFO - ], 08:13:37 INFO - "repository": "", 08:13:37 INFO - "rev": "afc8558eac72996c2d24f3257ee045bd1ee2a196", 08:13:37 INFO - "who": "cbook@mozilla.com", 08:13:37 INFO - "when": 1450109559, 08:13:37 INFO - "number": 7357500, 08:13:37 INFO - "comments": "Merge mozilla-central to fx-team", 08:13:37 INFO - "project": "", 08:13:37 INFO - "at": "Mon 14 Dec 2015 08:12:39", 08:13:37 INFO - "branch": "fx-team-linux64-talos", 08:13:37 INFO - "revlink": "", 08:13:37 INFO - "properties": [ 08:13:37 INFO - [ 08:13:37 INFO - "buildid", 08:13:37 INFO - "20151214065331", 08:13:37 INFO - "Change" 08:13:37 INFO - ], 08:13:37 INFO - [ 08:13:37 INFO - "builduid", 08:13:37 INFO - "97d8ac10d1ce4120a29b36fdcd3258f1", 08:13:37 INFO - "Change" 08:13:37 INFO - ], 08:13:37 INFO - [ 08:13:37 INFO - "pgo_build", 08:13:37 INFO - "False", 08:13:37 INFO - "Change" 08:13:37 INFO - ] 08:13:37 INFO - ], 08:13:37 INFO - "revision": "afc8558eac72996c2d24f3257ee045bd1ee2a196" 08:13:37 INFO - } 08:13:37 INFO - ], 08:13:37 INFO - "revision": "afc8558eac72996c2d24f3257ee045bd1ee2a196" 08:13:37 INFO - } 08:13:37 INFO - } 08:13:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/r0RmFnevTy6wwdkjDI82rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 08:13:37 INFO - Running post-action listener: _resource_record_post_action 08:13:37 INFO - ##### 08:13:37 INFO - ##### Running download-and-extract step. 08:13:37 INFO - ##### 08:13:37 INFO - Running pre-action listener: _resource_record_pre_action 08:13:37 INFO - Running main action method: download_and_extract 08:13:37 INFO - mkdir: /builds/slave/test/build/tests 08:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:37 INFO - https://queue.taskcluster.net/v1/task/r0RmFnevTy6wwdkjDI82rQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:13:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r0RmFnevTy6wwdkjDI82rQ/artifacts/public/build/test_packages.json 08:13:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r0RmFnevTy6wwdkjDI82rQ/artifacts/public/build/test_packages.json 08:13:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r0RmFnevTy6wwdkjDI82rQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:13:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r0RmFnevTy6wwdkjDI82rQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:13:45 INFO - Downloaded 1302 bytes. 08:13:45 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:13:45 INFO - Using the following test package requirements: 08:13:45 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:13:45 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:13:45 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:45 INFO - u'jsshell-linux-x86_64.zip'], 08:13:45 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:13:45 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:13:45 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:13:45 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:13:45 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:13:45 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:13:45 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:13:45 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:13:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:45 INFO - https://queue.taskcluster.net/v1/task/r0RmFnevTy6wwdkjDI82rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:13:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r0RmFnevTy6wwdkjDI82rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:13:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r0RmFnevTy6wwdkjDI82rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:13:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r0RmFnevTy6wwdkjDI82rQ/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 08:13:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r0RmFnevTy6wwdkjDI82rQ/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 08:13:47 INFO - Downloaded 21869925 bytes. 08:13:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 08:13:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:13:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:13:48 INFO - Return code: 0 08:13:48 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:13:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:48 INFO - https://queue.taskcluster.net/v1/task/r0RmFnevTy6wwdkjDI82rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:13:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r0RmFnevTy6wwdkjDI82rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:13:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r0RmFnevTy6wwdkjDI82rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:13:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r0RmFnevTy6wwdkjDI82rQ/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 08:13:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r0RmFnevTy6wwdkjDI82rQ/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 08:13:53 INFO - Downloaded 21869925 bytes. 08:13:53 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 08:13:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:13:53 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 08:13:55 INFO - Return code: 0 08:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:55 INFO - https://queue.taskcluster.net/v1/task/r0RmFnevTy6wwdkjDI82rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:13:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r0RmFnevTy6wwdkjDI82rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:13:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r0RmFnevTy6wwdkjDI82rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:13:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r0RmFnevTy6wwdkjDI82rQ/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 08:13:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r0RmFnevTy6wwdkjDI82rQ/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 08:13:56 INFO - Downloaded 11132038 bytes. 08:13:56 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 08:13:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:13:56 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 08:13:56 INFO - Return code: 0 08:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:56 INFO - https://queue.taskcluster.net/v1/task/r0RmFnevTy6wwdkjDI82rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:13:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r0RmFnevTy6wwdkjDI82rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:13:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r0RmFnevTy6wwdkjDI82rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:13:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r0RmFnevTy6wwdkjDI82rQ/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 08:13:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r0RmFnevTy6wwdkjDI82rQ/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 08:13:57 INFO - Downloaded 57746593 bytes. 08:13:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/r0RmFnevTy6wwdkjDI82rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:13:57 INFO - mkdir: /builds/slave/test/properties 08:13:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:13:57 INFO - Writing to file /builds/slave/test/properties/build_url 08:13:57 INFO - Contents: 08:13:57 INFO - build_url:https://queue.taskcluster.net/v1/task/r0RmFnevTy6wwdkjDI82rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:13:57 INFO - Running post-action listener: _resource_record_post_action 08:13:57 INFO - Running post-action listener: set_extra_try_arguments 08:13:57 INFO - ##### 08:13:57 INFO - ##### Running populate-webroot step. 08:13:57 INFO - ##### 08:13:57 INFO - Running pre-action listener: _resource_record_pre_action 08:13:57 INFO - Running main action method: populate_webroot 08:13:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:13:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:13:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:13:57 INFO - '--tppagecycles', 08:13:57 INFO - '7'], 08:13:57 INFO - 'tests': ['tsvgm']}}, 08:13:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:13:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:13:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:13:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:13:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:13:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:13:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:13:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:57 INFO - 'talos_options': ['--e10s'], 08:13:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:13:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:57 INFO - 'tests': ['damp', 'tps']}, 08:13:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:57 INFO - 'talos_options': ['--e10s'], 08:13:57 INFO - 'tests': ['damp', 'tps']}, 08:13:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:13:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:13:57 INFO - 'other': {'tests': ['a11yr', 08:13:57 INFO - 'ts_paint', 08:13:57 INFO - 'tpaint', 08:13:57 INFO - 'sessionrestore', 08:13:57 INFO - 'sessionrestore_no_auto_restore']}, 08:13:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:13:57 INFO - 'tests': ['a11yr', 08:13:57 INFO - 'ts_paint', 08:13:57 INFO - 'tpaint', 08:13:57 INFO - 'sessionrestore', 08:13:57 INFO - 'sessionrestore_no_auto_restore']}, 08:13:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:13:57 INFO - 'tests': ['a11yr', 08:13:57 INFO - 'ts_paint', 08:13:57 INFO - 'tpaint', 08:13:57 INFO - 'sessionrestore', 08:13:57 INFO - 'sessionrestore_no_auto_restore']}, 08:13:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:13:57 INFO - 'tests': ['a11yr', 08:13:57 INFO - 'ts_paint', 08:13:57 INFO - 'tpaint', 08:13:57 INFO - 'sessionrestore', 08:13:57 INFO - 'sessionrestore_no_auto_restore']}, 08:13:57 INFO - 'other_l64': {'tests': ['a11yr', 08:13:57 INFO - 'ts_paint', 08:13:57 INFO - 'tpaint', 08:13:57 INFO - 'sessionrestore', 08:13:57 INFO - 'sessionrestore_no_auto_restore']}, 08:13:57 INFO - 'other_nol64': {'tests': ['a11yr', 08:13:57 INFO - 'ts_paint', 08:13:57 INFO - 'tpaint', 08:13:57 INFO - 'sessionrestore', 08:13:57 INFO - 'sessionrestore_no_auto_restore']}, 08:13:57 INFO - 'svgr': {'tests': ['tsvgx', 08:13:57 INFO - 'tsvgr_opacity', 08:13:57 INFO - 'tart', 08:13:57 INFO - 'tscrollx', 08:13:57 INFO - 'cart']}, 08:13:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:13:57 INFO - 'tests': ['tsvgx', 08:13:57 INFO - 'tsvgr_opacity', 08:13:57 INFO - 'tart', 08:13:57 INFO - 'tscrollx', 08:13:57 INFO - 'cart']}, 08:13:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:57 INFO - 'tests': ['tp5o']}, 08:13:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:57 INFO - 'talos_options': ['--e10s'], 08:13:57 INFO - 'tests': ['tp5o']}, 08:13:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:57 INFO - 'talos_options': ['--xperf_path', 08:13:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:13:57 INFO - 'tests': ['tp5n']}, 08:13:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:57 INFO - 'talos_options': ['--e10s', 08:13:57 INFO - '--xperf_path', 08:13:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:13:57 INFO - 'tests': ['tp5n']}}, 08:13:57 INFO - 'talos.zip': {'path': '', 08:13:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:13:57 INFO - Running post-action listener: _resource_record_post_action 08:13:57 INFO - ##### 08:13:57 INFO - ##### Running create-virtualenv step. 08:13:57 INFO - ##### 08:13:57 INFO - Running pre-action listener: _resource_record_pre_action 08:13:57 INFO - Running main action method: create_virtualenv 08:13:57 INFO - Creating virtualenv /builds/slave/test/build/venv 08:13:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:13:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:13:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:13:57 INFO - Using real prefix '/usr' 08:13:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:13:58 INFO - Installing distribute.............................................................................................................................................................................................done. 08:14:01 INFO - Installing pip.................done. 08:14:01 INFO - Return code: 0 08:14:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5eca79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a90b0>, '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 0x22a9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aa440>, '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': 'f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:14:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:14:01 INFO - Using env: {'DISPLAY': ':0', 08:14:01 INFO - 'HOME': '/home/cltbld', 08:14:01 INFO - 'LANG': 'en_US.UTF-8', 08:14:01 INFO - 'LANGUAGE': 'en_US:en', 08:14:01 INFO - 'LOGNAME': 'cltbld', 08:14:01 INFO - 'MAIL': '/var/mail/cltbld', 08:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:01 INFO - 'MOZ_NO_REMOTE': '1', 08:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:01 INFO - 'NO_EM_RESTART': '1', 08:14:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:01 INFO - 'PWD': '/builds/slave/test', 08:14:01 INFO - 'SHELL': '/bin/bash', 08:14:01 INFO - 'SHLVL': '1', 08:14:01 INFO - 'TERM': 'linux', 08:14:01 INFO - 'TMOUT': '86400', 08:14:01 INFO - 'USER': 'cltbld', 08:14:01 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119', 08:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:01 INFO - '_': '/tools/buildbot/bin/python'} 08:14:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:14:01 INFO - Cleaning up... 08:14:01 INFO - Return code: 0 08:14:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe5eca79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a90b0>, '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 0x22a9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aa440>, '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': 'f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:14:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:14:01 INFO - Using env: {'DISPLAY': ':0', 08:14:01 INFO - 'HOME': '/home/cltbld', 08:14:01 INFO - 'LANG': 'en_US.UTF-8', 08:14:01 INFO - 'LANGUAGE': 'en_US:en', 08:14:01 INFO - 'LOGNAME': 'cltbld', 08:14:01 INFO - 'MAIL': '/var/mail/cltbld', 08:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:01 INFO - 'MOZ_NO_REMOTE': '1', 08:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:01 INFO - 'NO_EM_RESTART': '1', 08:14:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:01 INFO - 'PWD': '/builds/slave/test', 08:14:01 INFO - 'SHELL': '/bin/bash', 08:14:01 INFO - 'SHLVL': '1', 08:14:01 INFO - 'TERM': 'linux', 08:14:01 INFO - 'TMOUT': '86400', 08:14:01 INFO - 'USER': 'cltbld', 08:14:01 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119', 08:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:01 INFO - '_': '/tools/buildbot/bin/python'} 08:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:02 INFO - Downloading/unpacking psutil>=0.7.1 08:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:03 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:14:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:14:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:04 INFO - Installing collected packages: psutil 08:14:04 INFO - Running setup.py install for psutil 08:14:04 INFO - building 'psutil._psutil_linux' extension 08:14:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:14:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:14:05 INFO - building 'psutil._psutil_posix' extension 08:14:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:14:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:14:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:05 INFO - Successfully installed psutil 08:14:05 INFO - Cleaning up... 08:14:05 INFO - Return code: 0 08:14:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe5eca79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a90b0>, '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 0x22a9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aa440>, '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': 'f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:14:05 INFO - Using env: {'DISPLAY': ':0', 08:14:05 INFO - 'HOME': '/home/cltbld', 08:14:05 INFO - 'LANG': 'en_US.UTF-8', 08:14:05 INFO - 'LANGUAGE': 'en_US:en', 08:14:05 INFO - 'LOGNAME': 'cltbld', 08:14:05 INFO - 'MAIL': '/var/mail/cltbld', 08:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:05 INFO - 'MOZ_NO_REMOTE': '1', 08:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:05 INFO - 'NO_EM_RESTART': '1', 08:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:05 INFO - 'PWD': '/builds/slave/test', 08:14:05 INFO - 'SHELL': '/bin/bash', 08:14:05 INFO - 'SHLVL': '1', 08:14:05 INFO - 'TERM': 'linux', 08:14:05 INFO - 'TMOUT': '86400', 08:14:05 INFO - 'USER': 'cltbld', 08:14:05 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119', 08:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:05 INFO - '_': '/tools/buildbot/bin/python'} 08:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:14:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:14:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:14:07 INFO - Installing collected packages: mozsystemmonitor 08:14:07 INFO - Running setup.py install for mozsystemmonitor 08:14:07 INFO - Successfully installed mozsystemmonitor 08:14:07 INFO - Cleaning up... 08:14:07 INFO - Return code: 0 08:14:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe5eca79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a90b0>, '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 0x22a9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aa440>, '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': 'f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:14:07 INFO - Using env: {'DISPLAY': ':0', 08:14:07 INFO - 'HOME': '/home/cltbld', 08:14:07 INFO - 'LANG': 'en_US.UTF-8', 08:14:07 INFO - 'LANGUAGE': 'en_US:en', 08:14:07 INFO - 'LOGNAME': 'cltbld', 08:14:07 INFO - 'MAIL': '/var/mail/cltbld', 08:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:07 INFO - 'MOZ_NO_REMOTE': '1', 08:14:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:07 INFO - 'NO_EM_RESTART': '1', 08:14:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:07 INFO - 'PWD': '/builds/slave/test', 08:14:07 INFO - 'SHELL': '/bin/bash', 08:14:07 INFO - 'SHLVL': '1', 08:14:07 INFO - 'TERM': 'linux', 08:14:07 INFO - 'TMOUT': '86400', 08:14:07 INFO - 'USER': 'cltbld', 08:14:07 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119', 08:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:07 INFO - '_': '/tools/buildbot/bin/python'} 08:14:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:07 INFO - Downloading/unpacking blobuploader==1.2.4 08:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:09 INFO - Downloading blobuploader-1.2.4.tar.gz 08:14:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:14:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:14:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:14:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:14:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:10 INFO - Downloading docopt-0.6.1.tar.gz 08:14:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:14:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:14:10 INFO - Installing collected packages: blobuploader, requests, docopt 08:14:10 INFO - Running setup.py install for blobuploader 08:14:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:14:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:14:10 INFO - Running setup.py install for requests 08:14:10 INFO - Running setup.py install for docopt 08:14:10 INFO - Successfully installed blobuploader requests docopt 08:14:10 INFO - Cleaning up... 08:14:10 INFO - Return code: 0 08:14:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:10 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 0x7fe5eca79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a90b0>, '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 0x22a9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aa440>, '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': 'f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:14:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:14:10 INFO - Using env: {'DISPLAY': ':0', 08:14:10 INFO - 'HOME': '/home/cltbld', 08:14:10 INFO - 'LANG': 'en_US.UTF-8', 08:14:10 INFO - 'LANGUAGE': 'en_US:en', 08:14:10 INFO - 'LOGNAME': 'cltbld', 08:14:10 INFO - 'MAIL': '/var/mail/cltbld', 08:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:10 INFO - 'MOZ_NO_REMOTE': '1', 08:14:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:10 INFO - 'NO_EM_RESTART': '1', 08:14:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:10 INFO - 'PWD': '/builds/slave/test', 08:14:10 INFO - 'SHELL': '/bin/bash', 08:14:10 INFO - 'SHLVL': '1', 08:14:10 INFO - 'TERM': 'linux', 08:14:10 INFO - 'TMOUT': '86400', 08:14:10 INFO - 'USER': 'cltbld', 08:14:10 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119', 08:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:10 INFO - '_': '/tools/buildbot/bin/python'} 08:14:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:10 INFO - Running setup.py (path:/tmp/pip-atccCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:11 INFO - Running setup.py (path:/tmp/pip-9lhTlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:11 INFO - Running setup.py (path:/tmp/pip-3hDBAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:11 INFO - Running setup.py (path:/tmp/pip-4ZOMYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:11 INFO - Running setup.py (path:/tmp/pip-PmRnHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:11 INFO - Running setup.py (path:/tmp/pip-8hRaOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:11 INFO - Running setup.py (path:/tmp/pip-GUDYPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:11 INFO - Running setup.py (path:/tmp/pip-ztVBzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:11 INFO - Running setup.py (path:/tmp/pip-LGHWuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:11 INFO - Running setup.py (path:/tmp/pip-Yivwk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:11 INFO - Running setup.py (path:/tmp/pip-lXpI_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:11 INFO - Running setup.py (path:/tmp/pip-tDEWeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:11 INFO - Running setup.py (path:/tmp/pip-ohq1xD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:11 INFO - Running setup.py (path:/tmp/pip-I5h1Do-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:11 INFO - Running setup.py (path:/tmp/pip-vp4kHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:12 INFO - Running setup.py (path:/tmp/pip-TPWR2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:12 INFO - Running setup.py (path:/tmp/pip-M5CmHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:14:12 INFO - Running setup.py install for manifestparser 08:14:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:14:12 INFO - Running setup.py install for mozcrash 08:14:12 INFO - Running setup.py install for mozdebug 08:14:12 INFO - Running setup.py install for mozdevice 08:14:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:14:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:14:12 INFO - Running setup.py install for mozfile 08:14:12 INFO - Running setup.py install for mozhttpd 08:14:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:14:12 INFO - Running setup.py install for mozinfo 08:14:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:14:12 INFO - Running setup.py install for mozInstall 08:14:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:14:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:14:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:14:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:14:12 INFO - Running setup.py install for mozleak 08:14:13 INFO - Running setup.py install for mozlog 08:14:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:14:13 INFO - Running setup.py install for moznetwork 08:14:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:14:13 INFO - Running setup.py install for mozprocess 08:14:13 INFO - Running setup.py install for mozprofile 08:14:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:14:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:14:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:14:13 INFO - Running setup.py install for mozrunner 08:14:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:14:13 INFO - Running setup.py install for mozscreenshot 08:14:13 INFO - Running setup.py install for moztest 08:14:13 INFO - Running setup.py install for mozversion 08:14:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:14:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:14:13 INFO - Cleaning up... 08:14:13 INFO - Return code: 0 08:14:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fe5eca79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a90b0>, '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 0x22a9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aa440>, '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': 'f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:14:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:14:13 INFO - Using env: {'DISPLAY': ':0', 08:14:13 INFO - 'HOME': '/home/cltbld', 08:14:13 INFO - 'LANG': 'en_US.UTF-8', 08:14:13 INFO - 'LANGUAGE': 'en_US:en', 08:14:13 INFO - 'LOGNAME': 'cltbld', 08:14:13 INFO - 'MAIL': '/var/mail/cltbld', 08:14:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:13 INFO - 'MOZ_NO_REMOTE': '1', 08:14:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:13 INFO - 'NO_EM_RESTART': '1', 08:14:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:13 INFO - 'PWD': '/builds/slave/test', 08:14:13 INFO - 'SHELL': '/bin/bash', 08:14:13 INFO - 'SHLVL': '1', 08:14:13 INFO - 'TERM': 'linux', 08:14:13 INFO - 'TMOUT': '86400', 08:14:13 INFO - 'USER': 'cltbld', 08:14:13 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119', 08:14:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:13 INFO - '_': '/tools/buildbot/bin/python'} 08:14:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:14 INFO - Running setup.py (path:/tmp/pip-FGzgwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:14 INFO - Running setup.py (path:/tmp/pip-8qnox3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:14 INFO - Running setup.py (path:/tmp/pip-cXUdbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:14 INFO - Running setup.py (path:/tmp/pip-ZCHTAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:14 INFO - Running setup.py (path:/tmp/pip-aGwAWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:14 INFO - Running setup.py (path:/tmp/pip-cp43gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:14 INFO - Running setup.py (path:/tmp/pip-aBPtbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:14 INFO - Running setup.py (path:/tmp/pip-q0Wmw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:14 INFO - Running setup.py (path:/tmp/pip-leC_Po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:14 INFO - Running setup.py (path:/tmp/pip-HeUhd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:14 INFO - Running setup.py (path:/tmp/pip-lHKGQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:14 INFO - Running setup.py (path:/tmp/pip-6028An-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:15 INFO - Running setup.py (path:/tmp/pip-BA6U2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:15 INFO - Running setup.py (path:/tmp/pip-EAxPy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:15 INFO - Running setup.py (path:/tmp/pip-F9mEnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:15 INFO - Running setup.py (path:/tmp/pip-E6kBUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:15 INFO - Running setup.py (path:/tmp/pip-chLa2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:14:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:14:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:14:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:14:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:14:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:14:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:17 INFO - Downloading blessings-1.5.1.tar.gz 08:14:17 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 08:14:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:14:17 INFO - Installing collected packages: blessings 08:14:17 INFO - Running setup.py install for blessings 08:14:17 INFO - Successfully installed blessings 08:14:17 INFO - Cleaning up... 08:14:17 INFO - Return code: 0 08:14:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:14:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:17 INFO - Reading from file tmpfile_stdout 08:14:17 INFO - Current package versions: 08:14:17 INFO - argparse == 1.2.1 08:14:17 INFO - blessings == 1.5.1 08:14:17 INFO - blobuploader == 1.2.4 08:14:17 INFO - docopt == 0.6.1 08:14:17 INFO - manifestparser == 1.1 08:14:17 INFO - mozInstall == 1.12 08:14:17 INFO - mozcrash == 0.16 08:14:17 INFO - mozdebug == 0.1 08:14:17 INFO - mozdevice == 0.47 08:14:17 INFO - mozfile == 1.2 08:14:17 INFO - mozhttpd == 0.7 08:14:17 INFO - mozinfo == 0.9 08:14:17 INFO - mozleak == 0.1 08:14:17 INFO - mozlog == 3.1 08:14:17 INFO - moznetwork == 0.27 08:14:17 INFO - mozprocess == 0.22 08:14:17 INFO - mozprofile == 0.27 08:14:17 INFO - mozrunner == 6.11 08:14:17 INFO - mozscreenshot == 0.1 08:14:17 INFO - mozsystemmonitor == 0.0 08:14:17 INFO - moztest == 0.7 08:14:17 INFO - mozversion == 1.4 08:14:17 INFO - psutil == 3.1.1 08:14:17 INFO - requests == 1.2.3 08:14:17 INFO - wsgiref == 0.1.2 08:14:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14: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')]} 08:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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')]} 08:14:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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', '-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 0x7fe5eca79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a90b0>, '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 0x22a9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aa440>, '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': 'f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:14:17 INFO - Using env: {'DISPLAY': ':0', 08:14:17 INFO - 'HOME': '/home/cltbld', 08:14:17 INFO - 'LANG': 'en_US.UTF-8', 08:14:17 INFO - 'LANGUAGE': 'en_US:en', 08:14:17 INFO - 'LOGNAME': 'cltbld', 08:14:17 INFO - 'MAIL': '/var/mail/cltbld', 08:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:17 INFO - 'MOZ_NO_REMOTE': '1', 08:14:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:17 INFO - 'NO_EM_RESTART': '1', 08:14:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:17 INFO - 'PWD': '/builds/slave/test', 08:14:17 INFO - 'SHELL': '/bin/bash', 08:14:17 INFO - 'SHLVL': '1', 08:14:17 INFO - 'TERM': 'linux', 08:14:17 INFO - 'TMOUT': '86400', 08:14:17 INFO - 'USER': 'cltbld', 08:14:17 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119', 08:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:17 INFO - '_': '/tools/buildbot/bin/python'} 08:14:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:14:17 INFO - Cleaning up... 08:14:17 INFO - Return code: 0 08:14:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:14: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')]} 08:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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')]} 08:14:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5eca79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a90b0>, '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 0x22a9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aa440>, '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': 'f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14: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', 'jsonschema'] in /builds/slave/test/build 08:14: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 jsonschema 08:14:17 INFO - Using env: {'DISPLAY': ':0', 08:14:17 INFO - 'HOME': '/home/cltbld', 08:14:17 INFO - 'LANG': 'en_US.UTF-8', 08:14:17 INFO - 'LANGUAGE': 'en_US:en', 08:14:17 INFO - 'LOGNAME': 'cltbld', 08:14:17 INFO - 'MAIL': '/var/mail/cltbld', 08:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:17 INFO - 'MOZ_NO_REMOTE': '1', 08:14:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:17 INFO - 'NO_EM_RESTART': '1', 08:14:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:17 INFO - 'PWD': '/builds/slave/test', 08:14:17 INFO - 'SHELL': '/bin/bash', 08:14:17 INFO - 'SHLVL': '1', 08:14:17 INFO - 'TERM': 'linux', 08:14:17 INFO - 'TMOUT': '86400', 08:14:17 INFO - 'USER': 'cltbld', 08:14:17 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119', 08:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:17 INFO - '_': '/tools/buildbot/bin/python'} 08:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:18 INFO - Downloading/unpacking jsonschema 08:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:14:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 08:14:19 INFO - Downloading/unpacking functools32 (from jsonschema) 08:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:19 INFO - Downloading functools32-3.2.3-2.tar.gz 08:14:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:14:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:14:19 INFO - warning: no files found matching '*.txt' 08:14:19 INFO - no previously-included directories found matching 'build' 08:14:19 INFO - no previously-included directories found matching 'dist' 08:14:19 INFO - no previously-included directories found matching '.git*' 08:14:19 INFO - Installing collected packages: jsonschema, functools32 08:14:20 INFO - Running setup.py install for functools32 08:14:20 INFO - warning: no files found matching '*.txt' 08:14:20 INFO - no previously-included directories found matching 'build' 08:14:20 INFO - no previously-included directories found matching 'dist' 08:14:20 INFO - no previously-included directories found matching '.git*' 08:14:20 INFO - Successfully installed jsonschema functools32 08:14:20 INFO - Cleaning up... 08:14:20 INFO - Return code: 0 08:14:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:20 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 0x7fe5eca79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a90b0>, '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 0x22a9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aa440>, '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': 'f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:14:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:14:20 INFO - Using env: {'DISPLAY': ':0', 08:14:20 INFO - 'HOME': '/home/cltbld', 08:14:20 INFO - 'LANG': 'en_US.UTF-8', 08:14:20 INFO - 'LANGUAGE': 'en_US:en', 08:14:20 INFO - 'LOGNAME': 'cltbld', 08:14:20 INFO - 'MAIL': '/var/mail/cltbld', 08:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:20 INFO - 'MOZ_NO_REMOTE': '1', 08:14:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:20 INFO - 'NO_EM_RESTART': '1', 08:14:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:20 INFO - 'PWD': '/builds/slave/test', 08:14:20 INFO - 'SHELL': '/bin/bash', 08:14:20 INFO - 'SHLVL': '1', 08:14:20 INFO - 'TERM': 'linux', 08:14:20 INFO - 'TMOUT': '86400', 08:14:20 INFO - 'USER': 'cltbld', 08:14:20 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119', 08:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:20 INFO - '_': '/tools/buildbot/bin/python'} 08:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:20 INFO - Downloading/unpacking flake8 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:14:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 08:14:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:14:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 08:14:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 08:14:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:14:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:14:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:14:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:14:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:14:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:14:22 INFO - no previously-included directories found matching 'docs/_build' 08:14:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:14:22 INFO - Running setup.py install for pep8 08:14:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:14:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:14:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:14:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:14:22 INFO - no previously-included directories found matching 'docs/_build' 08:14:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:14:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:14:22 INFO - Cleaning up... 08:14:22 INFO - Return code: 0 08:14:22 INFO - Running post-action listener: _resource_record_post_action 08:14:22 INFO - Running post-action listener: _start_resource_monitoring 08:14:22 INFO - Starting resource monitoring. 08:14:22 INFO - ##### 08:14:22 INFO - ##### Running install step. 08:14:22 INFO - ##### 08:14:22 INFO - Running pre-action listener: _resource_record_pre_action 08:14:22 INFO - Running main action method: install 08:14:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:23 INFO - Reading from file tmpfile_stdout 08:14:23 INFO - Detecting whether we're running mozinstall >=1.0... 08:14:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:14:23 INFO - Reading from file tmpfile_stdout 08:14:23 INFO - Output received: 08:14:23 INFO - Usage: mozinstall [options] installer 08:14:23 INFO - Options: 08:14:23 INFO - -h, --help show this help message and exit 08:14:23 INFO - -d DEST, --destination=DEST 08:14:23 INFO - Directory to install application into. [default: 08:14:23 INFO - "/builds/slave/test"] 08:14:23 INFO - --app=APP Application being installed. [default: firefox] 08:14:23 INFO - mkdir: /builds/slave/test/build/application 08:14:23 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'] 08:14:23 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 08:14:37 INFO - Reading from file tmpfile_stdout 08:14:37 INFO - Output received: 08:14:37 INFO - /builds/slave/test/build/application/firefox/firefox 08:14:37 INFO - Running post-action listener: _resource_record_post_action 08:14:37 INFO - ##### 08:14:37 INFO - ##### Running run-tests step. 08:14:37 INFO - ##### 08:14:37 INFO - Running pre-action listener: _resource_record_pre_action 08:14:37 INFO - Running main action method: run_tests 08:14:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:14:37 INFO - Python 2.7.3 08:14:37 INFO - Return code: 0 08:14:37 INFO - grabbing minidump binary from tooltool 08:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:37 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 0x22a90b0>, '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 0x22a9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aa440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:14:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:14:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:14:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:14:37 INFO - Return code: 0 08:14:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:14:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:14:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:14:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:14:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:14:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:14:38 INFO - Return code: 0 08:14:38 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/r0RmFnevTy6wwdkjDI82rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] in /builds/slave/test/build 08:14:38 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/r0RmFnevTy6wwdkjDI82rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost 08:14:38 INFO - Using env: {'DISPLAY': ':0', 08:14:38 INFO - 'HOME': '/home/cltbld', 08:14:38 INFO - 'LANG': 'en_US.UTF-8', 08:14:38 INFO - 'LANGUAGE': 'en_US:en', 08:14:38 INFO - 'LOGNAME': 'cltbld', 08:14:38 INFO - 'MAIL': '/var/mail/cltbld', 08:14:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:14:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:38 INFO - 'MOZ_NO_REMOTE': '1', 08:14:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:38 INFO - 'NO_EM_RESTART': '1', 08:14:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:38 INFO - 'PWD': '/builds/slave/test', 08:14:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:14:38 INFO - 'SHELL': '/bin/bash', 08:14:38 INFO - 'SHLVL': '1', 08:14:38 INFO - 'TERM': 'linux', 08:14:38 INFO - 'TMOUT': '86400', 08:14:38 INFO - 'USER': 'cltbld', 08:14:38 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119', 08:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:38 INFO - '_': '/tools/buildbot/bin/python'} 08:14:38 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/r0RmFnevTy6wwdkjDI82rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] with output_timeout 3600 08:14:39 INFO - mozversion INFO | application_buildid: 20151214065331 08:14:39 INFO - mozversion INFO | application_changeset: afc8558eac72996c2d24f3257ee045bd1ee2a196 08:14:39 INFO - mozversion INFO | application_display_name: Nightly 08:14:39 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:14:39 INFO - mozversion INFO | application_name: Firefox 08:14:39 INFO - mozversion INFO | application_remotingname: firefox 08:14:39 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 08:14:39 INFO - mozversion INFO | application_vendor: Mozilla 08:14:39 INFO - mozversion INFO | application_version: 45.0a1 08:14:39 INFO - mozversion INFO | platform_buildid: 20151214065331 08:14:39 INFO - mozversion INFO | platform_changeset: afc8558eac72996c2d24f3257ee045bd1ee2a196 08:14:39 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 08:14:39 INFO - mozversion INFO | platform_version: 45.0a1 08:14:39 INFO - 2015-12-14 08:14:39,080 DEBUG : using testdate: 1450109679 08:14:39 INFO - 2015-12-14 08:14:39,080 DEBUG : actual date: 1450109679 08:14:39 INFO - 2015-12-14 08:14:39,087 INFO : starting webserver on 'localhost:48310' 08:14:39 INFO - 2015-12-14 08:14:39,087 INFO : Starting test suite talos-linux64-ix-047.e 08:14:39 INFO - 2015-12-14 08:14:39,087 INFO : Starting test dromaeo_css 08:14:39 INFO - 2015-12-14 08:14:39,087 DEBUG : operating with platform_type : linux_ 08:14:39 INFO - 2015-12-14 08:14:39,088 INFO : Initialising browser for dromaeo_css test... 08:14:39 INFO - 2015-12-14 08:14:39,102 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7kO1di/profile http://localhost:48310/getInfo.html 08:14:46 INFO - 2015-12-14 08:14:46,767 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:14:46 INFO - 2015-12-14 08:14:46,767 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:14:46 INFO - 2015-12-14 08:14:46,767 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:14:46 INFO - 2015-12-14 08:14:46,767 DEBUG : BROWSER_OUTPUT: __metrics 08:14:46 INFO - 2015-12-14 08:14:46,891 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:14:48 INFO - 2015-12-14 08:14:48,194 INFO : Browser initialized. 08:14:48 INFO - 2015-12-14 08:14:48,194 INFO : Running cycle 1/1 for dromaeo_css test... 08:14:48 INFO - 2015-12-14 08:14:48,194 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7kO1di/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:15:00 INFO - 2015-12-14 08:15:00,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 142766080 08:15:00 INFO - 2015-12-14 08:15:00,228 DEBUG : BROWSER_OUTPUT: 08:15:49 INFO - 2015-12-14 08:15:49,870 DEBUG : BROWSER_OUTPUT: 1450109749868 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:18:00 INFO - 2015-12-14 08:18:00,694 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48310/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48310/tests/dromaeo/cssquery-ext.html) 08:18:01 INFO - 2015-12-14 08:18:01,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 144064512 08:18:01 INFO - 2015-12-14 08:18:01,921 DEBUG : BROWSER_OUTPUT: 08:21:04 INFO - 2015-12-14 08:21:04,051 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48310/tests/dromaeo/cssquery-ext.html (next: http://localhost:48310/tests/dromaeo/cssquery-jquery.html) 08:21:04 INFO - 2015-12-14 08:21:04,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 144859136 08:21:04 INFO - 2015-12-14 08:21:04,652 DEBUG : BROWSER_OUTPUT: 08:24:06 INFO - 2015-12-14 08:24:06,419 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48310/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48310/tests/dromaeo/cssquery-mootools.html) 08:24:07 INFO - 2015-12-14 08:24:07,020 DEBUG : BROWSER_OUTPUT: RSS: Main: 146132992 08:24:07 INFO - 2015-12-14 08:24:07,020 DEBUG : BROWSER_OUTPUT: 08:27:08 INFO - 2015-12-14 08:27:08,783 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48310/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48310/tests/dromaeo/cssquery-prototype.html) 08:27:09 INFO - 2015-12-14 08:27:09,385 DEBUG : BROWSER_OUTPUT: RSS: Main: 143503360 08:27:09 INFO - 2015-12-14 08:27:09,385 DEBUG : BROWSER_OUTPUT: 08:30:12 INFO - 2015-12-14 08:30:12,018 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48310/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48310/tests/dromaeo/cssquery-yui.html) 08:30:12 INFO - 2015-12-14 08:30:12,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 143667200 08:30:12 INFO - 2015-12-14 08:30:12,652 DEBUG : BROWSER_OUTPUT: 08:33:15 INFO - 2015-12-14 08:33:15,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48310/tests/dromaeo/cssquery-yui.html (next: http://localhost:48310/tests/dromaeo/cssquery-dojo.html) 08:33:15 INFO - 2015-12-14 08:33:15,565 DEBUG : BROWSER_OUTPUT: RSS: Main: 146620416 08:33:15 INFO - 2015-12-14 08:33:15,565 DEBUG : BROWSER_OUTPUT: 08:33:15 INFO - 2015-12-14 08:33:15,565 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:33:15 INFO - 2015-12-14 08:33:15,565 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:33:15 INFO - 2015-12-14 08:33:15,566 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:33:15 INFO - 2015-12-14 08:33:15,566 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:33:15 INFO - 2015-12-14 08:33:15,566 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2642.1677171690917;2698.1096238241385;2728.0724553651753;2743.958840617391;2745.2999485131295;4649.442066951962;4802.831900883465;4828.975855120724;4839.588634966032;4867.440244371894;4719.504452032538;4747.240441529356;4775.90448191036;4855.490173531782;4906.435759887614;4309.590588894058;4440.178566965122;4493.932591011121;4504.8198072077075;4538.364628951949;128.96948455313307;4341.804618792146;4467.932981005288;4485.34962430449;4507.098580283956;4382.9342559861625;4442.800073996646;4482.932756008662;4488.955110448903;4494.595486406239;4472.508024117345;4473.530279320657;4481.170983368054;4523.411956445641;4564.178447879381;4195.811188496495;4268.402423660659;4290.935635965463;4419.977900110511;4471.932921006188;4669.089527542131;4669.41632295963;4678.228092364756;4722.3152642866935;4753.168195565762;5057.848264552069;5065;5075.6447048706605;5123.641345105844;5156.381234251876;4850.102730994742;4900.191468407708;4995.350604421402;5088.236764485357;5139.7687104080405;4694.554017368345;4700.4359476862655;4704.788284527204;4709.7174169549935;4766.594839438617;5226.63413561047;5241.24002019705;5246.396664383645;5261.842144735664;5290.68255904647;4831.178699621002;4889.657723959289;4958.181899986534;4968.627352948471;4997.475265097185;5112.539871411516;5183.740812959337;5193.714345710947;5198.6880787152895;5234.869128271824;4736.218523943579;5062;5074.264231686385;5074.934263804568;5117.795288188505;4945.530174633404;4969.90060198794;4998.650094493423;4999.200127979506;5008.098542262355;4155.792210389468;4200.138971510833;4203.180379825966;4230.048239146167;4240.067185219247;3707.073231692077;3712.6101759315425;3723.3298006359114;3753.8123093845197;3754.267917756066;4382.145481631115;4384.4300240969105;4389.407429996973;4390.8024138913825;4422.71252368595;4822.638302127354;4935.383077115361;5020.2720605511995;5090.440051594322;5123.615728820353;4373.256546387058;4403.185410699031;4407.096545208225;4428.689991700615;4461.308497182942;4343.587359200871;4513.796879140446;4527.09458108373;4529.9547004530195;4549.158405694957;4738.218193998021;4770.284457331428;4822.156122678447;4823.589994850477;4857.2228443449585;5111.386633603991;5150.278960945546;5157.07172708916;5158.484151584811;5205.6356055075785;4690.061987602425;4813.807447702193;4852.490488498657;4864.902701945871;4902.117618828503;4905.23968784839;4964.776585053609;4992.700437973734;4993.750312484434;5030.195168772979;5115.335006449138;5136.563392111712;5137.280780690781;5151.562117220078;5196.766145523385;4789.760511974457;4821.566059054702;4893.828715994923;4950.851474455772;4952.851414457572;4936.136176169228;4959.603231741524;4979.427365852828;4984.22744474607;5030.698158110525;4836.443808961873;4863;4874;4892;4945.035718034948;4788.592969597623;4886.340344053508;4909.631777616764;5031.94329190874;5084.288199651977;4893.217085266483;4902.8774280643265;4907.0431265904235;4914.8771280718265;4963.950360496493 08:33:15 INFO - 2015-12-14 08:33:15,566 DEBUG : BROWSER_OUTPUT: |1;ext.html;531.9761859035913;583.067092651757;583.2854752927664;590.2621722846442;600.9429104235099;36134.63865361346;36836.26327473449;37039.074023149435;37156.25687486252;37180.442293365624;40981.38527922076;41288.38067428984;41458.37812432808;41701.58298417015;41723.58276417235;7962.601869906496;8060.838783224332;8095.919040809605;8112.959435202816;8115.310198633094;7809.531428114303;7937.3650107991225;7958.283754462097;8001.799955001114;8027.638756255982;7968.083670377894;8065.6773729051065;8069.838603227932;8074.9596252018655;8078.313343365821;7897.486663366892;8000.199980002011;8009.719659811908;8017.358611311081;8073.596320183968;7858.764237072897;7939.603019848984;7967.721129760488;7982.161873003309;7995.040595128622;37156.814215929015;37183.62816371856;37486.81256593727;37667;37679.24641507182;2901.6518017837993;2930.3846192299643;2940.985295073532;2941.3676059647278;2955.8374289414073;27847.443051139067;28239.717602823916;28520.857395713098;28728;28858.278543036384;3441.638627944055;3493.6366259689303;3514.297140571896;3600.981995090008;3612.4581312803025;222493;223217;223879.8806005976;224228.99999999837;224627;53082.46917530775;53377.46622533802;53442;53516;53533;49310.75344623254;50309.74845125751;63980;64866;65010.67494662497;13421.530246441327;13492.988025897901;13517.188968661912;13555.118917270345;13609.11540749848;9591.040895910493;9607.807843843084;9646.565904534313;9664.178544823628;9796.902030979742;18500.16749246287;18677.533061673566;18694.81305186958;18720;18742.062896855103;7550.244975502405;7885.645145968445;7904.288614024766;7927.3658107351275;7995;811.6225954930985;833.7290380626321;878.6573236437795;990.8216521026285;1013.7769690668041;25597.23208303754;26396.340091497867;26518.46963060728;26650;26656.46687066248;927.1470247372433;985.9753506162403;1014.4116412480744;1027.0038063078803;1149.2070471374725;14306.213158276187;14382.28088595566;14403.135811851322;14838;14870;266455;271980;272796;273613;275199;45908;45971.77014114975;46021.30968035415;46035.30947035797;46049.53950460452;1202.2305724336431;1202.2546021466571;1233.802591585342;1244.116677159209;1355.2681551962028;25886.35284117912;26671.33321666974;27053.86473067622;27177.1846844595;27297.590536141575;37274.44088338732;37322.626773731914;37685.81157094197;37714.81142594379;37765;174427;174582;174901;174923.12538437225;175258;26697;29378;29500.262493437836;29633.40733185281;29925.700742993162;34154.65845341515;34231.31537369289;34472.20552362125;34497.827510862284;34976.65023349734;28958.855205723838;29253.41493170167;29544.261393465335;29724.554131688474;29871.103866884027;29440.411191775616;29460.558091628212;29532;29753.702462975092;29809.701902980694;31832.204194894388;32259;32275.677243228205;32294.515582265816;32356.83821580877;27520.862395687895;28705;29885.252868678457;30170.69829301679;30423.54364684487;23187.420314492272;23795.881020594785;24091.156809511584;24120.396990075387;25162.496750065264 08:33:15 INFO - 2015-12-14 08:33:15,567 DEBUG : BROWSER_OUTPUT: |2;jquery.html;326.80555069733515;328.998355008225;329.49422636253354;331.16050811193617;331.53916056681203;10439.060484556388;10724;15014.924925375371;15591;15706;15557.688846223096;15680.451184208527;15804.288807003684;15916.52250432486;15946;5430.294061771964;5466.9179962300595;5536.584756143286;5582.246396736449;5591.133374326986;5452.972735136319;5513.558915286768;5514.944850551483;5515.062439385294;5522.088855338884;5524.806631767869;5631.549476041927;6176.444120029197;6337.904931426009;6412.903806442907;6326.65203413812;6343.524235682319;6380.936190638104;6507.609543427409;6723;6412.102305677209;6449.871002579969;6452.064450654629;6453.16108905844;6471.482281417475;20196.49508762278;21326.253581124587;21384.144634214612;21669.67495487569;22412;1887.669657809878;1897.791242963273;1990.7511561054869;2001.3395579458743;2003.4790954351975;13724.519641812489;13868.361488765313;13928;14120;14120.870330373647;1771.4951238896851;1778.510909499885;1853.9258429662932;1854.9072546372763;1860.8697391182623;60974.390256097315;63586.6820665903;65282.673586632234;65936.67031664858;66363.3363666362;9332.160105590394;9478.57346419399;9550.904490955141;9578.952105239428;9619.18236949853;12468.75062498745;12540.372981350896;12542.24746515212;12555.811662825065;12654.240745555297;7028.543144695681;7050.189228238715;7096.609686467191;7145.606991615407;7198.676059577227;6676.232233293136;6746.055552222692;6757.425618822455;6771.93228067713;6806.659667016728;4168.979155104205;4249;4257.87226383209;4268.9786551067045;4277.272863613193;1651.157909466157;1696.253648394727;1711.3753479979719;1765.2497688482345;1771.1941066814568;363.39494741256044;782.2881178127876;813.5728742410164;844.7254642241296;963.1957315641378;9481.762955926157;9675.90324096764;9723.562439690231;9786.657466988763;9943.850842237372;381.1025036040086;389.8713424569885;391.9157381163064;403.93537034074404;405.1208876737428;8807.559622018873;9060.95469522648;9242.953785231166;9327.440353578808;9484.90515094854;455347;459937;465447;489109;491035;73310.26689733141;74148.62925685337;77219;77498.6125069371;77547.224527754;1104.127739086129;1106.043272569222;1114.225613198819;1127.4475507001673;1129.7119234595125;14407.927960360132;14748.63128421755;14880.851191487947;15015.249237538297;15140.167290799112;34781.39139564594;35072.64927350694;35226.11934701653;35480.645193548764;35794;45242.32136518021;46631.30053049275;47560.7621961888;47731.5226847741;49520;8600.440971336842;8820.691275805317;9217.907820921704;9222.631094756403;9224.953875230582;15496.302666380265;16106.516804495885;16234.26945787466;16515.33938642489;16719.33122675128;12844.165129266568;13753.38109785042;13771.724565508433;14189.858101419266;14429.278536073365;13074.411651475517;13449.193048417126;13779.724405511633;13863.79204311916;13909.513167039106;13546.661333466742;13872;14325.64185895361;14515.85484145145;14843.21881374242;8455.281301089477;8898.73303800887;8901.910980890108;9162.404443711137;9194.402363846328;9425.622975081194;12516.374181291081;13488.93255533716;13700.109492882932;13844.792328114885 08:33:15 INFO - 2015-12-14 08:33:15,567 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1491.753860612999;1656.0312217352855;1659.286506802075;1668.1158985737557;1729.3255630304184;5942.049272116462;6143.047827586731;6509.8372540686505;6628.9005664915;6697.196336439628;6644;6871.278515755848;6887.27683593223;6924.446044316443;6930.861382772341;1987.0064967516241;2007.0968064371018;2022.1405902491383;2022.4741567192561;2029.5839352932614;2031.7765045844944;2035.3690355989615;2056.362527616436;2058.269314393391;2058.7750288578272;2028.5537181819975;2047.406252186864;2055.2601063617085;2081.6253074446595;2083.0418007716466;2028.9492762680977;2041.7549894012739;2043.6832290994919;2044.0597325230412;2047.6314263432575;2009.4775358406919;2014.9496262593407;2070.3064473401428;2079.9896000520052;2083.3958152136015;7026.789196324067;7131.286871312879;7140.821479463003;7141.3215744504705;7149.428045756327;4127.360259159835;4183.602557757008;4202.873913782591;4217.304144816102;4224.091820258659;2641.168032069892;2667.759901608845;2703.162019773876;2712.2948033511234;2714.5113879501682;873.6287077991892;881.8104107616894;884.5842454046652;902.8149229408021;929.3355250995571;9497.335186536946;9497.762555936157;9520.238380929579;9544.284178686557;9561.904380956172;3770.6040865709256;3773.24535092977;3824.388097904322;3832.7508711933633;3838.4242363645117;8133.10535841057;8189.058258300252;8207.425480216327;8208.794780130545;8209.220124088202;4137.834486620562;4142.689298302579;4151.8546850860075;4155.8961025974595;4167.770772607536;3670.1742108025483;3725.590185079639;3756.6431189037;3765.4163604641326;3781.6596506314013;3225.3871764364694;3243.5783348164587;3248.0742988248235;3248.8700451982127;3281.507773833944;974.8391515399879;975.4927437732481;977.8777652793401;979.7550612346913;982.4596471940404;828.5525816059381;830.543201239316;1050.1913526584487;1089.9891001089889;1113.4043286841502;6405.167328247298;6423.807285781434;6447.742090316428;6462.32145624712;6477.4170324671;416.2819136988731;418.9664826813848;429.1288683971543;429.225248426593;431.2108840821289;4826.7827947742435;4829.589484893753;4829.782659780319;4865.367502224759;4866.732329721899;8069.556174410463;8225;8250.422470427133;8335.916330876948;8369.539675317794;8174.550399728072;8207.425480216447;8219.794505137419;8220.424570280024;8221.630026648816;6628.900566491507;6664.266930637626;6687.498437617198;6732.966335168391;6767.627780472121;6692;6739.191297044386;6760.290169532325;6761.0534525167495;6773.05177275172;7159.212486626363;7367.410607151308;7393.223711510429;7477;7549.7357592483995;7488.438367122597;7490.288422599844;7725.884111738216;7744.651490683045;7798.25916537928;5417.377001644703;5528.668279903219;6081.787137450345;6158.230221222348;6159.476444502267;6525.64108974011;6670.799876003728;6694.196696396269;6706.66466676674;6713.328667133248;6069.9089513656445;6233.594816336924;6238.845813524513;6400.55196136266;6488.805335839932;6184.536159788124;6264.2796078451565;6275.309715931336;6314.905276420949;6372.330905254881;6244.625322480666;6260.467860231931;6263;6284.528660350401;6341.936580634135;5734.254546908875;5818.127280907897;5819.0689489681445;5827.59206855516;5862.794802181903;5615.045442274904;5625.831225063254;5656.0667489865355;5670.347909990239;5672.262605861211 08:33:15 INFO - 2015-12-14 08:33:15,570 DEBUG : BROWSER_OUTPUT: |4;prototype.html;293.1484038867091;300.4276852595806;303.0710871179834;304.9573059771631;307.1798298542891;5560.388357280701;5563.972180139099;5579.804706835256;5586.692731899754;5740.081586946089;5548.056830338842;5592;5616.045272303708;5622.072358060915;5627.549796016319;4107.014316564018;4241.766702831343;4244.639205667522;4247.214265360903;4248.766317852517;4191.266528357541;4200.663946884257;4200.915981680365;4203.85286514972;4204.306289462235;4137.1725654869;4156.937645935313;4194.895127621803;4203.222403855297;4213.389058586503;4186.225548273549;4189.392538081992;4196.7062305638465;4200.97899510502;4206.305959516676;3633.709303255733;3636.8727094551564;3641.998450426154;3652.0687224757517;3662.102784817737;5158.458361872024;5172.069027575035;5260.316158899357;5282.550983166436;5315.973420132875;4809.350737650408;4819.95180048202;4825.541573550507;4829.323894654751;4834.685745426536;5840.328362238354;5858.589898707092;5875.706214689249;5877.059670452707;5887;3874.9225015499533;3925.6270654287796;3951.8616848410165;3965.325894597925;3972.602739726033;6074.42292982166;6168.75324987;6174.845628859314;6178.042403427431;6178.042403427476;4057.8173982170283;4057.857974970862;4060.167665628598;4060.2285565742413;4063.91872162561;4092;4108.958910410917;4119.443875076886;4124.670026397881;4133.379993001014;4780.784864681098;4785.736784476887;4786.976065119722;4791.161546729309;4792.329073929653;5647.0964645656495;5855.297364316224;5859.94140058594;5869.383714709894;5878.059510478303;1462.8464011278875;1479.8372179060295;1485.732568137724;1486.0637798187072;1489.471237710597;975.1175186456269;975.3708857786829;982.5185659027026;1000.9199264058858;1004.7237009822211;5100.515451032146;5114.616403769732;5121.487851214849;5123.154679477844;5130.589552835764;6082.148499210114;6082.726277317532;6095.268567771807;6095.451409373178;6116.816495505142;5078.390593128848;5097.515736005073;5106;5106.693598384109;5107.157319042316;3196.2329041029984;3258.120307516957;3281.9015429536676;3285.178705323669;3285.5400243965864;5756.856078598069;5761.942380576224;5771.826845194651;5772.451617096453;5776.566757493205;6128.295246046672;6333.96833015832;6344.016677415008;6352.36476352361;6356.523260755462;5727.0550359190265;5743.827685169452;5746.0519014363;5746.224259724967;5779.971100144472;6121.112438696453;6134.110553969738;6141.692915354125;6144.10910417978;6144.477719393902;5854.209681692917;5964.165016897725;5996.490298324691;6003.939960600513;6026.638401695912;5765.164051212634;5770.105633626795;5774.2782152230975;5775.104858746901;5782.971085144547;3996.060925682404;4041.1109555897656;4055.310597198424;4064.7154699170774;4065.776382299002;5985.371535988658;6120.44915957566;6123.479504242189;6126.050462178369;6132.478739307209;5860.853478663067;5863.589548731718;5876.324222714443;5876.3536011039605;5877.23595932526;5824.796132135355;5826.329972053268;5837.912431313449;5838.591298609056;5855.03391940325;5538.723063846872;5697.829065128053;5741.5119714824705;5746.166805813217;5750.079987202028;5915.816836632776;5929.525637948867;5930.377310382348;5949.0481522956115;5949.3455719871645;5788.27646544182;5790.681512516852;5791.53667706574;5795;5799.217105690846 08:33:15 INFO - 2015-12-14 08:33:15,570 DEBUG : BROWSER_OUTPUT: |5;yui.html;738.634375983888;739.8335374540728;751.4548284442506;751.8270797716525;766.9846603067939;11640.301581905092;11908.464119114638;11920.701982450442;11951.880481195196;11988.340641264738;11574.131940104484;11759.588414405498;11807.114466415032;11833.349165795878;11839.112066595018;618.6628287583278;795.2365728900248;809.1746418652971;809.5142914251461;809.76516810125;616.9969150154243;799.1289494451047;814.9592520373988;815.0993152566388;816.1878930464196;835.8704400817883;839.9286060684849;850.7490290364358;852.4672079950032;853.5860107847689;840.2143995364354;842.9325653947669;844.8901642786399;845.3406343052399;845.8477474054667;623.6382897919196;624.9250089989185;625.3215261441342;625.4964753373532;627.3193584960324;11434.942825285903;11484.196106272564;11496;11996.340201288926;12090.032797376276;11003.724906877313;11217.547134963022;11312.095032397388;11465.254758440758;11949.880501194964;9611.903880961241;9788.314817962746;9882.258830587663;9897.90102098977;10181.440020798853;3252.837358132084;3273.0508152635944;3297.653746356646;3307.933841323184;3393.3552625001416;42250.78874605638;42307.36538951918;42646.57353426457;42719.786401067795;42760.78619606913;9137.451752894847;9152.679656212134;9182.494962777111;9284.767880803034;9378.5310734463;16058.116803575915;16108.275127619285;16142.273597688132;16161;16220.837791622169;6469.385408386196;6483.805485835433;6516.022596610546;6532.41208291256;6703.865922681616;3683.336999340091;3726.6459686329754;3755;3809.066778639251;3873.1285460771664;2593.4424098818845;2614.9084782032537;2624.475104979012;2627.4482358704886;2628.1852625686097;470.3650072402298;473.68026582056973;475.7407213068886;476.3521610609568;476.41401076675885;527.2513031495286;570.4580648384052;591.588845752198;594.2156353613276;619.851235703428;7505.924940750522;7613.505122167041;7623.618819059025;7661.540307581563;7802.180771019075;430.8082903108149;549.4478049560166;608.2003204177253;613.8342647485154;619.9721012554446;3334.6498617645284;3453.689167974894;3560.839762210707;3561.3055454186183;3651.1602331463914;51502.22746658803;51526;51731;51920.480795191565;51940;43121.35317970233;45919.31121033187;45941.310880336154;46505.76747116243;46996.29505557419;41488;42747.7862610685;42752.3587146193;42806.57193428088;42909.356359654004;7952.801179970547;8143.918560814316;8152.163142353254;8287.792805179919;8411.957940210259;30018.24954376158;30968.53547196839;30980.0705978821;33183.83408082944;33210.50184247286;37669;40362.798186008884;40951.7952410236;41031;41187.588124119575;10058.949705251427;10283.640072597424;10545.578176873147;10650.627228046982;10674.73313167177;10861.891381086089;11156.21906466572;11484.770304593694;12040.698982525508;12431.254124752544;10921.126309895348;11116.666500005012;11163.609273675707;11527.308361498337;11634.243774154653;10427;10838.241323107306;10972.341659500455;11248.887511124783;11625.534978600761;9646.372985755903;9759.853602195832;10898.564057437614;11217.102631789601;11320.320780753182;9451.385659932082;9657.420554766737;9736.41581505112;9827.213822894295;10080.143187829117;9160.496172710298;9515.096065873731;9551.522423878918;9568.330216884751;9672.75818104553 08:33:15 INFO - 2015-12-14 08:33:15,571 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:33:15 INFO - 2015-12-14 08:33:15,571 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:33:15 INFO - 2015-12-14 08:33:15,571 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,328 08:33:15 INFO - 2015-12-14 08:33:15,571 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:33:15 INFO - 2015-12-14 08:33:15,571 DEBUG : BROWSER_OUTPUT: __startTimestamp1450110795558__endTimestamp 08:33:15 INFO - 2015-12-14 08:33:15,571 DEBUG : BROWSER_OUTPUT: 08:33:15 INFO - 2015-12-14 08:33:15,571 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:33:15 INFO - 2015-12-14 08:33:15,572 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:33:15 INFO - 2015-12-14 08:33:15,572 DEBUG : BROWSER_OUTPUT: 08:33:15 INFO - 2015-12-14 08:33:15,572 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4674.42 Median:4831.18 stddev:601.50 (12.5%) stddev-sans-first:581.83 08:33:15 INFO - 2015-12-14 08:33:15,572 DEBUG : BROWSER_OUTPUT: Values: 2642.2 2698.1 2728.1 2744.0 2745.3 4649.4 4802.8 4829.0 4839.6 4867.4 4719.5 4747.2 4775.9 4855.5 4906.4 4309.6 4440.2 4493.9 4504.8 4538.4 129.0 4341.8 4467.9 4485.3 4507.1 4382.9 4442.8 4482.9 4489.0 4494.6 4472.5 4473.5 4481.2 4523.4 4564.2 4195.8 4268.4 4290.9 4420.0 4471.9 4669.1 4669.4 4678.2 4722.3 4753.2 5057.8 5065.0 5075.6 5123.6 5156.4 4850.1 4900.2 4995.4 5088.2 5139.8 4694.6 4700.4 4704.8 4709.7 4766.6 5226.6 5241.2 5246.4 5261.8 5290.7 4831.2 4889.7 4958.2 4968.6 4997.5 5112.5 5183.7 5193.7 5198.7 5234.9 4736.2 5062.0 5074.3 5074.9 5117.8 4945.5 4969.9 4998.7 4999.2 5008.1 4155.8 4200.1 4203.2 4230.0 4240.1 3707.1 3712.6 3723.3 3753.8 3754.3 4382.1 4384.4 4389.4 4390.8 4422.7 4822.6 4935.4 5020.3 5090.4 5123.6 4373.3 4403.2 4407.1 4428.7 4461.3 4343.6 4513.8 4527.1 4530.0 4549.2 4738.2 4770.3 4822.2 4823.6 4857.2 5111.4 5150.3 5157.1 5158.5 5205.6 4690.1 4813.8 4852.5 4864.9 4902.1 4905.2 4964.8 4992.7 4993.8 5030.2 5115.3 5136.6 5137.3 5151.6 5196.8 4789.8 4821.6 4893.8 4950.9 4952.9 4936.1 4959.6 4979.4 4984.2 5030.7 4836.4 4863.0 4874.0 4892.0 4945.0 4788.6 4886.3 4909.6 5031.9 5084.3 4893.2 4902.9 4907.0 4914.9 4964.0 08:33:15 INFO - 2015-12-14 08:33:15,572 DEBUG : BROWSER_OUTPUT: 08:33:15 INFO - 2015-12-14 08:33:15,572 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38504.99 Median:18836.48 stddev:59159.94 (314.1%) stddev-sans-first:59257.19 08:33:15 INFO - 2015-12-14 08:33:15,573 DEBUG : BROWSER_OUTPUT: Values: 532.0 583.1 583.3 590.3 600.9 36134.6 36836.3 37039.1 37156.3 37180.4 40981.4 41288.4 41458.4 41701.6 41723.6 7962.6 8060.8 8095.9 8113.0 8115.3 7809.5 7937.4 7958.3 8001.8 8027.6 7968.1 8065.7 8069.8 8075.0 8078.3 7897.5 8000.2 8009.7 8017.4 8073.6 7858.8 7939.6 7967.7 7982.2 7995.0 37156.8 37183.6 37486.8 37667.0 37679.2 2901.7 2930.4 2941.0 2941.4 2955.8 27847.4 28239.7 28520.9 28728.0 28858.3 3441.6 3493.6 3514.3 3601.0 3612.5 222493.0 223217.0 223879.9 224229.0 224627.0 53082.5 53377.5 53442.0 53516.0 53533.0 49310.8 50309.7 63980.0 64866.0 65010.7 13421.5 13493.0 13517.2 13555.1 13609.1 9591.0 9607.8 9646.6 9664.2 9796.9 18500.2 18677.5 18694.8 18720.0 18742.1 7550.2 7885.6 7904.3 7927.4 7995.0 811.6 833.7 878.7 990.8 1013.8 25597.2 26396.3 26518.5 26650.0 26656.5 927.1 986.0 1014.4 1027.0 1149.2 14306.2 14382.3 14403.1 14838.0 14870.0 266455.0 271980.0 272796.0 273613.0 275199.0 45908.0 45971.8 46021.3 46035.3 46049.5 1202.2 1202.3 1233.8 1244.1 1355.3 25886.4 26671.3 27053.9 27177.2 27297.6 37274.4 37322.6 37685.8 37714.8 37765.0 174427.0 174582.0 174901.0 174923.1 175258.0 26697.0 29378.0 29500.3 29633.4 29925.7 34154.7 34231.3 34472.2 34497.8 34976.7 28958.9 29253.4 29544.3 29724.6 29871.1 29440.4 29460.6 29532.0 29753.7 29809.7 31832.2 32259.0 32275.7 32294.5 32356.8 27520.9 28705.0 29885.3 30170.7 30423.5 23187.4 23795.9 24091.2 24120.4 25162.5 08:33:15 INFO - 2015-12-14 08:33:15,574 DEBUG : BROWSER_OUTPUT: 08:33:15 INFO - 2015-12-14 08:33:15,574 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26669.85 Median:4208.99 stddev:77349.26 (1837.7%) stddev-sans-first:77540.95 08:33:15 INFO - 2015-12-14 08:33:15,574 DEBUG : BROWSER_OUTPUT: Values: 326.8 329.0 329.5 331.2 331.5 10439.1 10724.0 15014.9 15591.0 15706.0 15557.7 15680.5 15804.3 15916.5 15946.0 5430.3 5466.9 5536.6 5582.2 5591.1 5453.0 5513.6 5514.9 5515.1 5522.1 5524.8 5631.5 6176.4 6337.9 6412.9 6326.7 6343.5 6380.9 6507.6 6723.0 6412.1 6449.9 6452.1 6453.2 6471.5 20196.5 21326.3 21384.1 21669.7 22412.0 1887.7 1897.8 1990.8 2001.3 2003.5 13724.5 13868.4 13928.0 14120.0 14120.9 1771.5 1778.5 1853.9 1854.9 1860.9 60974.4 63586.7 65282.7 65936.7 66363.3 9332.2 9478.6 9550.9 9579.0 9619.2 12468.8 12540.4 12542.2 12555.8 12654.2 7028.5 7050.2 7096.6 7145.6 7198.7 6676.2 6746.1 6757.4 6771.9 6806.7 4169.0 4249.0 4257.9 4269.0 4277.3 1651.2 1696.3 1711.4 1765.2 1771.2 363.4 782.3 813.6 844.7 963.2 9481.8 9675.9 9723.6 9786.7 9943.9 381.1 389.9 391.9 403.9 405.1 8807.6 9061.0 9243.0 9327.4 9484.9 455347.0 459937.0 465447.0 489109.0 491035.0 73310.3 74148.6 77219.0 77498.6 77547.2 1104.1 1106.0 1114.2 1127.4 1129.7 14407.9 14748.6 14880.9 15015.2 15140.2 34781.4 35072.6 35226.1 35480.6 35794.0 45242.3 46631.3 47560.8 47731.5 49520.0 8600.4 8820.7 9217.9 9222.6 9225.0 15496.3 16106.5 16234.3 16515.3 16719.3 12844.2 13753.4 13771.7 14189.9 14429.3 13074.4 13449.2 13779.7 13863.8 13909.5 13546.7 13872.0 14325.6 14515.9 14843.2 8455.3 8898.7 8901.9 9162.4 9194.4 9425.6 12516.4 13488.9 13700.1 13844.8 08:33:15 INFO - 2015-12-14 08:33:15,574 DEBUG : BROWSER_OUTPUT: 08:33:15 INFO - 2015-12-14 08:33:15,574 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4835.96 Median:6172.01 stddev:2528.51 (41.0%) stddev-sans-first:2523.11 08:33:15 INFO - 2015-12-14 08:33:15,574 DEBUG : BROWSER_OUTPUT: Values: 1491.8 1656.0 1659.3 1668.1 1729.3 5942.0 6143.0 6509.8 6628.9 6697.2 6644.0 6871.3 6887.3 6924.4 6930.9 1987.0 2007.1 2022.1 2022.5 2029.6 2031.8 2035.4 2056.4 2058.3 2058.8 2028.6 2047.4 2055.3 2081.6 2083.0 2028.9 2041.8 2043.7 2044.1 2047.6 2009.5 2014.9 2070.3 2080.0 2083.4 7026.8 7131.3 7140.8 7141.3 7149.4 4127.4 4183.6 4202.9 4217.3 4224.1 2641.2 2667.8 2703.2 2712.3 2714.5 873.6 881.8 884.6 902.8 929.3 9497.3 9497.8 9520.2 9544.3 9561.9 3770.6 3773.2 3824.4 3832.8 3838.4 8133.1 8189.1 8207.4 8208.8 8209.2 4137.8 4142.7 4151.9 4155.9 4167.8 3670.2 3725.6 3756.6 3765.4 3781.7 3225.4 3243.6 3248.1 3248.9 3281.5 974.8 975.5 977.9 979.8 982.5 828.6 830.5 1050.2 1090.0 1113.4 6405.2 6423.8 6447.7 6462.3 6477.4 416.3 419.0 429.1 429.2 431.2 4826.8 4829.6 4829.8 4865.4 4866.7 8069.6 8225.0 8250.4 8335.9 8369.5 8174.6 8207.4 8219.8 8220.4 8221.6 6628.9 6664.3 6687.5 6733.0 6767.6 6692.0 6739.2 6760.3 6761.1 6773.1 7159.2 7367.4 7393.2 7477.0 7549.7 7488.4 7490.3 7725.9 7744.7 7798.3 5417.4 5528.7 6081.8 6158.2 6159.5 6525.6 6670.8 6694.2 6706.7 6713.3 6069.9 6233.6 6238.8 6400.6 6488.8 6184.5 6264.3 6275.3 6314.9 6372.3 6244.6 6260.5 6263.0 6284.5 6341.9 5734.3 5818.1 5819.1 5827.6 5862.8 5615.0 5625.8 5656.1 5670.3 5672.3 08:33:15 INFO - 2015-12-14 08:33:15,574 DEBUG : BROWSER_OUTPUT: 08:33:15 INFO - 2015-12-14 08:33:15,574 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4826.94 Median:5571.89 stddev:1455.41 (26.1%) stddev-sans-first:1419.15 08:33:15 INFO - 2015-12-14 08:33:15,576 DEBUG : BROWSER_OUTPUT: Values: 293.1 300.4 303.1 305.0 307.2 5560.4 5564.0 5579.8 5586.7 5740.1 5548.1 5592.0 5616.0 5622.1 5627.5 4107.0 4241.8 4244.6 4247.2 4248.8 4191.3 4200.7 4200.9 4203.9 4204.3 4137.2 4156.9 4194.9 4203.2 4213.4 4186.2 4189.4 4196.7 4201.0 4206.3 3633.7 3636.9 3642.0 3652.1 3662.1 5158.5 5172.1 5260.3 5282.6 5316.0 4809.4 4820.0 4825.5 4829.3 4834.7 5840.3 5858.6 5875.7 5877.1 5887.0 3874.9 3925.6 3951.9 3965.3 3972.6 6074.4 6168.8 6174.8 6178.0 6178.0 4057.8 4057.9 4060.2 4060.2 4063.9 4092.0 4109.0 4119.4 4124.7 4133.4 4780.8 4785.7 4787.0 4791.2 4792.3 5647.1 5855.3 5859.9 5869.4 5878.1 1462.8 1479.8 1485.7 1486.1 1489.5 975.1 975.4 982.5 1000.9 1004.7 5100.5 5114.6 5121.5 5123.2 5130.6 6082.1 6082.7 6095.3 6095.5 6116.8 5078.4 5097.5 5106.0 5106.7 5107.2 3196.2 3258.1 3281.9 3285.2 3285.5 5756.9 5761.9 5771.8 5772.5 5776.6 6128.3 6334.0 6344.0 6352.4 6356.5 5727.1 5743.8 5746.1 5746.2 5780.0 6121.1 6134.1 6141.7 6144.1 6144.5 5854.2 5964.2 5996.5 6003.9 6026.6 5765.2 5770.1 5774.3 5775.1 5783.0 3996.1 4041.1 4055.3 4064.7 4065.8 5985.4 6120.4 6123.5 6126.1 6132.5 5860.9 5863.6 5876.3 5876.4 5877.2 5824.8 5826.3 5837.9 5838.6 5855.0 5538.7 5697.8 5741.5 5746.2 5750.1 5915.8 5929.5 5930.4 5949.0 5949.3 5788.3 5790.7 5791.5 5795.0 5799.2 08:33:15 INFO - 2015-12-14 08:33:15,576 DEBUG : BROWSER_OUTPUT: 08:33:15 INFO - 2015-12-14 08:33:15,576 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12564.76 Median:21776.08 stddev:14303.15 (65.7%) stddev-sans-first:14315.70 08:33:15 INFO - 2015-12-14 08:33:15,576 DEBUG : BROWSER_OUTPUT: Values: 738.6 739.8 751.5 751.8 767.0 11640.3 11908.5 11920.7 11951.9 11988.3 11574.1 11759.6 11807.1 11833.3 11839.1 618.7 795.2 809.2 809.5 809.8 617.0 799.1 815.0 815.1 816.2 835.9 839.9 850.7 852.5 853.6 840.2 842.9 844.9 845.3 845.8 623.6 624.9 625.3 625.5 627.3 11434.9 11484.2 11496.0 11996.3 12090.0 11003.7 11217.5 11312.1 11465.3 11949.9 9611.9 9788.3 9882.3 9897.9 10181.4 3252.8 3273.1 3297.7 3307.9 3393.4 42250.8 42307.4 42646.6 42719.8 42760.8 9137.5 9152.7 9182.5 9284.8 9378.5 16058.1 16108.3 16142.3 16161.0 16220.8 6469.4 6483.8 6516.0 6532.4 6703.9 3683.3 3726.6 3755.0 3809.1 3873.1 2593.4 2614.9 2624.5 2627.4 2628.2 470.4 473.7 475.7 476.4 476.4 527.3 570.5 591.6 594.2 619.9 7505.9 7613.5 7623.6 7661.5 7802.2 430.8 549.4 608.2 613.8 620.0 3334.6 3453.7 3560.8 3561.3 3651.2 51502.2 51526.0 51731.0 51920.5 51940.0 43121.4 45919.3 45941.3 46505.8 46996.3 41488.0 42747.8 42752.4 42806.6 42909.4 7952.8 8143.9 8152.2 8287.8 8412.0 30018.2 30968.5 30980.1 33183.8 33210.5 37669.0 40362.8 40951.8 41031.0 41187.6 10058.9 10283.6 10545.6 10650.6 10674.7 10861.9 11156.2 11484.8 12040.7 12431.3 10921.1 11116.7 11163.6 11527.3 11634.2 10427.0 10838.2 10972.3 11248.9 11625.5 9646.4 9759.9 10898.6 11217.1 11320.3 9451.4 9657.4 9736.4 9827.2 10080.1 9160.5 9515.1 9551.5 9568.3 9672.8 08:33:15 INFO - 2015-12-14 08:33:15,576 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:33:15 INFO - 2015-12-14 08:33:15,576 DEBUG : BROWSER_OUTPUT: 08:33:16 INFO - 2015-12-14 08:33:16,322 INFO : Browser exited with error code: 0 08:33:16 INFO - 2015-12-14 08:33:16,345 INFO : Completed test dromaeo_css (00:18:37) 08:33:16 INFO - 2015-12-14 08:33:16,345 INFO : Starting test kraken 08:33:16 INFO - 2015-12-14 08:33:16,346 DEBUG : operating with platform_type : linux_ 08:33:16 INFO - 2015-12-14 08:33:16,346 INFO : Initialising browser for kraken test... 08:33:16 INFO - 2015-12-14 08:33:16,352 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUYpoq7/profile http://localhost:48310/getInfo.html 08:33:21 INFO - 2015-12-14 08:33:21,276 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:33:21 INFO - 2015-12-14 08:33:21,276 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:33:21 INFO - 2015-12-14 08:33:21,276 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:33:21 INFO - 2015-12-14 08:33:21,276 DEBUG : BROWSER_OUTPUT: __metrics 08:33:21 INFO - 2015-12-14 08:33:21,384 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:33:22 INFO - 2015-12-14 08:33:22,334 INFO : Browser initialized. 08:33:22 INFO - 2015-12-14 08:33:22,334 INFO : Running cycle 1/1 for kraken test... 08:33:22 INFO - 2015-12-14 08:33:22,334 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUYpoq7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:33:34 INFO - 2015-12-14 08:33:34,356 DEBUG : BROWSER_OUTPUT: RSS: Main: 143421440 08:33:34 INFO - 2015-12-14 08:33:34,356 DEBUG : BROWSER_OUTPUT: 08:33:37 INFO - 2015-12-14 08:33:37,019 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48310/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48310/tests/kraken/driver.html?testName=audio-beat-detection) 08:33:37 INFO - 2015-12-14 08:33:37,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 142598144 08:33:37 INFO - 2015-12-14 08:33:37,641 DEBUG : BROWSER_OUTPUT: 08:33:40 INFO - 2015-12-14 08:33:40,372 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48310/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48310/tests/kraken/driver.html?testName=audio-dft) 08:33:40 INFO - 2015-12-14 08:33:40,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 143044608 08:33:40 INFO - 2015-12-14 08:33:40,965 DEBUG : BROWSER_OUTPUT: 08:33:43 INFO - 2015-12-14 08:33:43,864 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48310/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48310/tests/kraken/driver.html?testName=audio-fft) 08:33:44 INFO - 2015-12-14 08:33:44,445 DEBUG : BROWSER_OUTPUT: RSS: Main: 138334208 08:33:44 INFO - 2015-12-14 08:33:44,445 DEBUG : BROWSER_OUTPUT: 08:33:46 INFO - 2015-12-14 08:33:46,483 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48310/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48310/tests/kraken/driver.html?testName=audio-oscillator) 08:33:47 INFO - 2015-12-14 08:33:47,072 DEBUG : BROWSER_OUTPUT: RSS: Main: 139300864 08:33:47 INFO - 2015-12-14 08:33:47,073 DEBUG : BROWSER_OUTPUT: 08:33:49 INFO - 2015-12-14 08:33:49,327 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48310/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48310/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:33:49 INFO - 2015-12-14 08:33:49,916 DEBUG : BROWSER_OUTPUT: RSS: Main: 140783616 08:33:49 INFO - 2015-12-14 08:33:49,916 DEBUG : BROWSER_OUTPUT: 08:33:52 INFO - 2015-12-14 08:33:52,960 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48310/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48310/tests/kraken/driver.html?testName=imaging-darkroom) 08:33:53 INFO - 2015-12-14 08:33:53,567 DEBUG : BROWSER_OUTPUT: RSS: Main: 141819904 08:33:53 INFO - 2015-12-14 08:33:53,567 DEBUG : BROWSER_OUTPUT: 08:33:57 INFO - 2015-12-14 08:33:57,099 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48310/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48310/tests/kraken/driver.html?testName=imaging-desaturate) 08:33:57 INFO - 2015-12-14 08:33:57,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 139173888 08:33:57 INFO - 2015-12-14 08:33:57,701 DEBUG : BROWSER_OUTPUT: 08:34:00 INFO - 2015-12-14 08:34:00,544 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48310/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48310/tests/kraken/driver.html?testName=json-parse-financial) 08:34:01 INFO - 2015-12-14 08:34:01,133 DEBUG : BROWSER_OUTPUT: RSS: Main: 138182656 08:34:01 INFO - 2015-12-14 08:34:01,133 DEBUG : BROWSER_OUTPUT: 08:34:02 INFO - 2015-12-14 08:34:02,907 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48310/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48310/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:34:03 INFO - 2015-12-14 08:34:03,489 DEBUG : BROWSER_OUTPUT: RSS: Main: 141312000 08:34:03 INFO - 2015-12-14 08:34:03,489 DEBUG : BROWSER_OUTPUT: 08:34:05 INFO - 2015-12-14 08:34:05,405 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48310/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48310/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:34:06 INFO - 2015-12-14 08:34:06,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 140722176 08:34:06 INFO - 2015-12-14 08:34:06,019 DEBUG : BROWSER_OUTPUT: 08:34:08 INFO - 2015-12-14 08:34:08,192 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48310/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48310/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:34:08 INFO - 2015-12-14 08:34:08,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 140324864 08:34:08 INFO - 2015-12-14 08:34:08,794 DEBUG : BROWSER_OUTPUT: 08:34:11 INFO - 2015-12-14 08:34:11,414 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48310/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48310/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:34:12 INFO - 2015-12-14 08:34:12,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 140918784 08:34:12 INFO - 2015-12-14 08:34:12,016 DEBUG : BROWSER_OUTPUT: 08:34:14 INFO - 2015-12-14 08:34:14,650 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48310/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48310/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:34:15 INFO - 2015-12-14 08:34:15,244 DEBUG : BROWSER_OUTPUT: RSS: Main: 140361728 08:34:15 INFO - 2015-12-14 08:34:15,244 DEBUG : BROWSER_OUTPUT: 08:34:17 INFO - 2015-12-14 08:34:17,027 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48310/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48310/tests/kraken/driver.html?testName=ai-astar) 08:34:17 INFO - 2015-12-14 08:34:17,276 DEBUG : BROWSER_OUTPUT: RSS: Main: 141381632 08:34:17 INFO - 2015-12-14 08:34:17,276 DEBUG : BROWSER_OUTPUT: 08:34:17 INFO - 2015-12-14 08:34:17,278 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:34:17 INFO - 2015-12-14 08:34:17,278 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:34:17 INFO - 2015-12-14 08:34:17,278 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:34:17 INFO - 2015-12-14 08:34:17,278 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:34:17 INFO - 2015-12-14 08:34:17,278 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;109;114;113;115;124;112;114;116;114 08:34:17 INFO - 2015-12-14 08:34:17,278 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;141;157;164;131;156;158;135;169;131 08:34:17 INFO - 2015-12-14 08:34:17,279 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;163;163;163;164;163;164;162;166;164 08:34:17 INFO - 2015-12-14 08:34:17,279 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;72;73;72;72;132;72;78;74;73 08:34:17 INFO - 2015-12-14 08:34:17,279 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;131;93;93;94;131;95;95;134 08:34:17 INFO - 2015-12-14 08:34:17,279 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;110;110;111;110;109;110;110;111 08:34:17 INFO - 2015-12-14 08:34:17,279 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;148;146;147;148;147;152;147;147;147 08:34:17 INFO - 2015-12-14 08:34:17,279 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;96;96;96;96;96 08:34:17 INFO - 2015-12-14 08:34:17,279 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;74;75;73;74;73;74;72;74;74 08:34:17 INFO - 2015-12-14 08:34:17,279 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;67;69;69;68;69;69;69;70 08:34:17 INFO - 2015-12-14 08:34:17,279 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;85;84;89;86;83;88;84;94;89 08:34:17 INFO - 2015-12-14 08:34:17,279 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;132;137;127;129;120;123;131;123;126;130 08:34:17 INFO - 2015-12-14 08:34:17,279 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;153;144;165;153;141;164;152;144;141 08:34:17 INFO - 2015-12-14 08:34:17,280 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;72;70;71;75;70;71;73;70;73 08:34:17 INFO - 2015-12-14 08:34:17,280 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:34:17 INFO - 2015-12-14 08:34:17,280 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:34:17 INFO - 2015-12-14 08:34:17,280 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,796 08:34:17 INFO - 2015-12-14 08:34:17,280 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:34:17 INFO - 2015-12-14 08:34:17,280 DEBUG : BROWSER_OUTPUT: __startTimestamp1450110857277__endTimestamp 08:34:17 INFO - 2015-12-14 08:34:17,280 DEBUG : BROWSER_OUTPUT: 08:34:17 INFO - 2015-12-14 08:34:17,288 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:34:17 INFO - 2015-12-14 08:34:17,288 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:34:17 INFO - 2015-12-14 08:34:17,288 DEBUG : BROWSER_OUTPUT: 08:34:17 INFO - 2015-12-14 08:34:17,288 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.60 Median:114.50 stddev:3.84 (3.3%) stddev-sans-first:4.07 08:34:17 INFO - 2015-12-14 08:34:17,288 DEBUG : BROWSER_OUTPUT: Values: 115.0 109.0 114.0 113.0 115.0 124.0 112.0 114.0 116.0 114.0 08:34:17 INFO - 2015-12-14 08:34:17,289 DEBUG : BROWSER_OUTPUT: 08:34:17 INFO - 2015-12-14 08:34:17,289 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.50 Median:156.50 stddev:13.91 (8.9%) stddev-sans-first:14.69 08:34:17 INFO - 2015-12-14 08:34:17,289 DEBUG : BROWSER_OUTPUT: Values: 153.0 141.0 157.0 164.0 131.0 156.0 158.0 135.0 169.0 131.0 08:34:17 INFO - 2015-12-14 08:34:17,289 DEBUG : BROWSER_OUTPUT: 08:34:17 INFO - 2015-12-14 08:34:17,289 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.50 Median:163.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 08:34:17 INFO - 2015-12-14 08:34:17,289 DEBUG : BROWSER_OUTPUT: Values: 163.0 163.0 163.0 163.0 164.0 163.0 164.0 162.0 166.0 164.0 08:34:17 INFO - 2015-12-14 08:34:17,289 DEBUG : BROWSER_OUTPUT: 08:34:17 INFO - 2015-12-14 08:34:17,289 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.20 Median:73.00 stddev:18.64 (25.5%) stddev-sans-first:19.68 08:34:17 INFO - 2015-12-14 08:34:17,289 DEBUG : BROWSER_OUTPUT: Values: 74.0 72.0 73.0 72.0 72.0 132.0 72.0 78.0 74.0 73.0 08:34:17 INFO - 2015-12-14 08:34:17,289 DEBUG : BROWSER_OUTPUT: 08:34:17 INFO - 2015-12-14 08:34:17,289 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.60 Median:94.50 stddev:18.25 (19.3%) stddev-sans-first:18.95 08:34:17 INFO - 2015-12-14 08:34:17,289 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 131.0 93.0 93.0 94.0 131.0 95.0 95.0 134.0 08:34:17 INFO - 2015-12-14 08:34:17,289 DEBUG : BROWSER_OUTPUT: 08:34:17 INFO - 2015-12-14 08:34:17,289 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 08:34:17 INFO - 2015-12-14 08:34:17,290 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 110.0 110.0 111.0 110.0 109.0 110.0 110.0 111.0 08:34:17 INFO - 2015-12-14 08:34:17,290 DEBUG : BROWSER_OUTPUT: 08:34:17 INFO - 2015-12-14 08:34:17,290 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.80 Median:147.50 stddev:1.69 (1.1%) stddev-sans-first:1.73 08:34:17 INFO - 2015-12-14 08:34:17,290 DEBUG : BROWSER_OUTPUT: Values: 149.0 148.0 146.0 147.0 148.0 147.0 152.0 147.0 147.0 147.0 08:34:17 INFO - 2015-12-14 08:34:17,290 DEBUG : BROWSER_OUTPUT: 08:34:17 INFO - 2015-12-14 08:34:17,290 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 08:34:17 INFO - 2015-12-14 08:34:17,290 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 08:34:17 INFO - 2015-12-14 08:34:17,290 DEBUG : BROWSER_OUTPUT: 08:34:17 INFO - 2015-12-14 08:34:17,290 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.70 Median:74.00 stddev:0.82 (1.1%) stddev-sans-first:0.87 08:34:17 INFO - 2015-12-14 08:34:17,291 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 75.0 73.0 74.0 73.0 74.0 72.0 74.0 74.0 08:34:17 INFO - 2015-12-14 08:34:17,291 DEBUG : BROWSER_OUTPUT: 08:34:17 INFO - 2015-12-14 08:34:17,291 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.84 (1.2%) stddev-sans-first:0.87 08:34:17 INFO - 2015-12-14 08:34:17,291 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 67.0 69.0 69.0 68.0 69.0 69.0 69.0 70.0 08:34:17 INFO - 2015-12-14 08:34:17,291 DEBUG : BROWSER_OUTPUT: 08:34:17 INFO - 2015-12-14 08:34:17,291 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:87.00 stddev:3.33 (3.8%) stddev-sans-first:3.48 08:34:17 INFO - 2015-12-14 08:34:17,291 DEBUG : BROWSER_OUTPUT: Values: 85.0 85.0 84.0 89.0 86.0 83.0 88.0 84.0 94.0 89.0 08:34:17 INFO - 2015-12-14 08:34:17,291 DEBUG : BROWSER_OUTPUT: 08:34:17 INFO - 2015-12-14 08:34:17,291 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:129.50 stddev:5.05 (3.9%) stddev-sans-first:5.12 08:34:17 INFO - 2015-12-14 08:34:17,291 DEBUG : BROWSER_OUTPUT: Values: 132.0 137.0 127.0 129.0 120.0 123.0 131.0 123.0 126.0 130.0 08:34:17 INFO - 2015-12-14 08:34:17,291 DEBUG : BROWSER_OUTPUT: 08:34:17 INFO - 2015-12-14 08:34:17,291 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.20 Median:152.50 stddev:8.83 (5.8%) stddev-sans-first:9.16 08:34:17 INFO - 2015-12-14 08:34:17,291 DEBUG : BROWSER_OUTPUT: Values: 145.0 153.0 144.0 165.0 153.0 141.0 164.0 152.0 144.0 141.0 08:34:17 INFO - 2015-12-14 08:34:17,291 DEBUG : BROWSER_OUTPUT: 08:34:17 INFO - 2015-12-14 08:34:17,291 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:71.50 stddev:1.72 (2.4%) stddev-sans-first:1.73 08:34:17 INFO - 2015-12-14 08:34:17,292 DEBUG : BROWSER_OUTPUT: Values: 70.0 72.0 70.0 71.0 75.0 70.0 71.0 73.0 70.0 73.0 08:34:17 INFO - 2015-12-14 08:34:17,292 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:34:17 INFO - 2015-12-14 08:34:17,292 DEBUG : BROWSER_OUTPUT: 08:34:18 INFO - 2015-12-14 08:34:18,218 INFO : Browser exited with error code: 0 08:34:18 INFO - 2015-12-14 08:34:18,271 INFO : Completed test kraken (00:01:01) 08:34:18 INFO - 2015-12-14 08:34:18,271 INFO : Starting test v8_7 08:34:18 INFO - 2015-12-14 08:34:18,271 DEBUG : operating with platform_type : linux_ 08:34:18 INFO - 2015-12-14 08:34:18,271 INFO : Initialising browser for v8_7 test... 08:34:18 INFO - 2015-12-14 08:34:18,277 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2cOm7J/profile http://localhost:48310/getInfo.html 08:34:23 INFO - 2015-12-14 08:34:23,228 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:34:23 INFO - 2015-12-14 08:34:23,229 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:34:23 INFO - 2015-12-14 08:34:23,229 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:34:23 INFO - 2015-12-14 08:34:23,229 DEBUG : BROWSER_OUTPUT: __metrics 08:34:23 INFO - 2015-12-14 08:34:23,366 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:34:24 INFO - 2015-12-14 08:34:24,306 INFO : Browser initialized. 08:34:24 INFO - 2015-12-14 08:34:24,306 INFO : Running cycle 1/1 for v8_7 test... 08:34:24 INFO - 2015-12-14 08:34:24,306 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2cOm7J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:34:36 INFO - 2015-12-14 08:34:36,329 DEBUG : BROWSER_OUTPUT: RSS: Main: 143007744 08:34:36 INFO - 2015-12-14 08:34:36,330 DEBUG : BROWSER_OUTPUT: 08:34:57 INFO - 2015-12-14 08:34:57,806 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48310/tests/v8_7/run.html (next: http://localhost:48310/tests/v8_7/run.html) 08:34:58 INFO - 2015-12-14 08:34:58,056 DEBUG : BROWSER_OUTPUT: RSS: Main: 137629696 08:34:58 INFO - 2015-12-14 08:34:58,057 DEBUG : BROWSER_OUTPUT: 08:34:58 INFO - 2015-12-14 08:34:58,057 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:34:58 INFO - 2015-12-14 08:34:58,057 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:34:58 INFO - 2015-12-14 08:34:58,057 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:34:58 INFO - 2015-12-14 08:34:58,057 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:34:58 INFO - 2015-12-14 08:34:58,058 DEBUG : BROWSER_OUTPUT: |0;Richards;166.91704223001167 08:34:58 INFO - 2015-12-14 08:34:58,058 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.15040953090096 08:34:58 INFO - 2015-12-14 08:34:58,058 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.214848143982 08:34:58 INFO - 2015-12-14 08:34:58,058 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5170.103092783505 08:34:58 INFO - 2015-12-14 08:34:58,058 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1070.6638115631692 08:34:58 INFO - 2015-12-14 08:34:58,058 DEBUG : BROWSER_OUTPUT: |5;Earley;693.000693000693 08:34:58 INFO - 2015-12-14 08:34:58,058 DEBUG : BROWSER_OUTPUT: |6;Boyer;11988.095238095239 08:34:58 INFO - 2015-12-14 08:34:58,059 DEBUG : BROWSER_OUTPUT: |7;RegExp;26842.105263157893 08:34:58 INFO - 2015-12-14 08:34:58,059 DEBUG : BROWSER_OUTPUT: |8;Splay;603.5003017501509 08:34:58 INFO - 2015-12-14 08:34:58,059 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 08:34:58 INFO - 2015-12-14 08:34:58,059 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:34:58 INFO - 2015-12-14 08:34:58,059 DEBUG : BROWSER_OUTPUT: __startTimestamp1450110898056__endTimestamp 08:34:58 INFO - 2015-12-14 08:34:58,059 DEBUG : BROWSER_OUTPUT: 08:34:58 INFO - 2015-12-14 08:34:58,059 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:34:58 INFO - 2015-12-14 08:34:58,059 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:34:58 INFO - 2015-12-14 08:34:58,059 DEBUG : BROWSER_OUTPUT: 08:34:58 INFO - 2015-12-14 08:34:58,060 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.92 Median:166.92 stddev:0.00 (0.0%) 08:34:58 INFO - 2015-12-14 08:34:58,060 DEBUG : BROWSER_OUTPUT: Values: 166.9 08:34:58 INFO - 2015-12-14 08:34:58,060 DEBUG : BROWSER_OUTPUT: 08:34:58 INFO - 2015-12-14 08:34:58,060 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.15 Median:186.15 stddev:0.00 (0.0%) 08:34:58 INFO - 2015-12-14 08:34:58,060 DEBUG : BROWSER_OUTPUT: Values: 186.2 08:34:58 INFO - 2015-12-14 08:34:58,060 DEBUG : BROWSER_OUTPUT: 08:34:58 INFO - 2015-12-14 08:34:58,060 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.21 Median:281.21 stddev:0.00 (0.0%) 08:34:58 INFO - 2015-12-14 08:34:58,060 DEBUG : BROWSER_OUTPUT: Values: 281.2 08:34:58 INFO - 2015-12-14 08:34:58,060 DEBUG : BROWSER_OUTPUT: 08:34:58 INFO - 2015-12-14 08:34:58,061 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 08:34:58 INFO - 2015-12-14 08:34:58,061 DEBUG : BROWSER_OUTPUT: Values: 5170.1 08:34:58 INFO - 2015-12-14 08:34:58,061 DEBUG : BROWSER_OUTPUT: 08:34:58 INFO - 2015-12-14 08:34:58,061 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1070.66 Median:1070.66 stddev:0.00 (0.0%) 08:34:58 INFO - 2015-12-14 08:34:58,061 DEBUG : BROWSER_OUTPUT: Values: 1070.7 08:34:58 INFO - 2015-12-14 08:34:58,061 DEBUG : BROWSER_OUTPUT: 08:34:58 INFO - 2015-12-14 08:34:58,061 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:693.00 Median:693.00 stddev:0.00 (0.0%) 08:34:58 INFO - 2015-12-14 08:34:58,061 DEBUG : BROWSER_OUTPUT: Values: 693.0 08:34:58 INFO - 2015-12-14 08:34:58,061 DEBUG : BROWSER_OUTPUT: 08:34:58 INFO - 2015-12-14 08:34:58,062 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11988.10 Median:11988.10 stddev:0.00 (0.0%) 08:34:58 INFO - 2015-12-14 08:34:58,062 DEBUG : BROWSER_OUTPUT: Values: 11988.1 08:34:58 INFO - 2015-12-14 08:34:58,062 DEBUG : BROWSER_OUTPUT: 08:34:58 INFO - 2015-12-14 08:34:58,062 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26842.11 Median:26842.11 stddev:0.00 (0.0%) 08:34:58 INFO - 2015-12-14 08:34:58,062 DEBUG : BROWSER_OUTPUT: Values: 26842.1 08:34:58 INFO - 2015-12-14 08:34:58,062 DEBUG : BROWSER_OUTPUT: 08:34:58 INFO - 2015-12-14 08:34:58,063 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:603.50 Median:603.50 stddev:0.00 (0.0%) 08:34:58 INFO - 2015-12-14 08:34:58,063 DEBUG : BROWSER_OUTPUT: Values: 603.5 08:34:58 INFO - 2015-12-14 08:34:58,063 DEBUG : BROWSER_OUTPUT: 08:34:58 INFO - 2015-12-14 08:34:58,063 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 08:34:58 INFO - 2015-12-14 08:34:58,064 DEBUG : BROWSER_OUTPUT: Values: 4835.7 08:34:58 INFO - 2015-12-14 08:34:58,064 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:34:58 INFO - 2015-12-14 08:34:58,064 DEBUG : BROWSER_OUTPUT: 08:34:59 INFO - 2015-12-14 08:34:59,014 INFO : Browser exited with error code: 0 08:34:59 INFO - 2015-12-14 08:34:59,026 INFO : Completed test v8_7 (00:00:40) 08:34:59 INFO - 2015-12-14 08:34:59,037 INFO : Completed test suite (00:20:19) 08:34:59 INFO - 2015-12-14 08:34:59,037 DEBUG : Working with test: dromaeo_css 08:34:59 INFO - 2015-12-14 08:34:59,037 DEBUG : Generating results file: dromaeo_css 08:34:59 INFO - 2015-12-14 08:34:59,038 DEBUG : Working with test: kraken 08:34:59 INFO - 2015-12-14 08:34:59,038 DEBUG : Generating results file: kraken 08:34:59 INFO - 2015-12-14 08:34:59,038 INFO : javascript benchmark 08:34:59 INFO - 2015-12-14 08:34:59,039 DEBUG : Working with test: v8_7 08:34:59 INFO - 2015-12-14 08:34:59,039 DEBUG : Generating results file: v8_7 08:34:59 INFO - 2015-12-14 08:34:59,039 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:34:59 INFO - 2015-12-14 08:34:59,105 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 08:34:59 INFO - 2015-12-14 08:34:59,105 DEBUG : process_Request line: dromaeo_css 6320.55 graph.html#tests=[[72,132,43]] 08:34:59 INFO - 2015-12-14 08:34:59,105 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:34:59 INFO - 2015-12-14 08:34:59,135 DEBUG : process_Request line: kraken 1544.90 graph.html#tests=[[232,132,43]] 08:34:59 INFO - 2015-12-14 08:34:59,135 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:34:59 INFO - 2015-12-14 08:34:59,183 DEBUG : process_Request line: v8_7 21365.66 graph.html#tests=[[230,132,43]] 08:34:59 INFO - 2015-12-14 08:34:59,184 INFO : javascript benchmark 08:34:59 INFO - 2015-12-14 08:34:59,188 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2642.1677171690917, 2698.1096238241385, 2728.0724553651753, 2743.958840617391, 2745.2999485131295, 4649.442066951962, 4802.831900883465, 4828.975855120724, 4839.588634966032, 4867.440244371894, 4719.504452032538, 4747.240441529356, 4775.90448191036, 4855.490173531782, 4906.435759887614, 4309.590588894058, 4440.178566965122, 4493.932591011121, 4504.8198072077075, 4538.364628951949, 128.96948455313307, 4341.804618792146, 4467.932981005288, 4485.34962430449, 4507.098580283956, 4382.9342559861625, 4442.800073996646, 4482.932756008662, 4488.955110448903, 4494.595486406239, 4472.508024117345, 4473.530279320657, 4481.170983368054, 4523.411956445641, 4564.178447879381, 4195.811188496495, 4268.402423660659, 4290.935635965463, 4419.977900110511, 4471.932921006188, 4669.089527542131, 4669.41632295963, 4678.228092364756, 4722.3152642866935, 4753.168195565762, 5057.848264552069, 5065.0, 5075.6447048706605, 5123.641345105844, 5156.381234251876, 4850.102730994742, 4900.191468407708, 4995.350604421402, 5088.236764485357, 5139.7687104080405, 4694.554017368345, 4700.4359476862655, 4704.788284527204, 4709.7174169549935, 4766.594839438617, 5226.63413561047, 5241.24002019705, 5246.396664383645, 5261.842144735664, 5290.68255904647, 4831.178699621002, 4889.657723959289, 4958.181899986534, 4968.627352948471, 4997.475265097185, 5112.539871411516, 5183.740812959337, 5193.714345710947, 5198.6880787152895, 5234.869128271824, 4736.218523943579, 5062.0, 5074.264231686385, 5074.934263804568, 5117.795288188505, 4945.530174633404, 4969.90060198794, 4998.650094493423, 4999.200127979506, 5008.098542262355, 4155.792210389468, 4200.138971510833, 4203.180379825966, 4230.048239146167, 4240.067185219247, 3707.073231692077, 3712.6101759315425, 3723.3298006359114, 3753.8123093845197, 3754.267917756066, 4382.145481631115, 4384.4300240969105, 4389.407429996973, 4390.8024138913825, 4422.71252368595, 4822.638302127354, 4935.383077115361, 5020.2720605511995, 5090.440051594322, 5123.615728820353, 4373.256546387058, 4403.185410699031, 4407.096545208225, 4428.689991700615, 4461.308497182942, 4343.587359200871, 4513.796879140446, 4527.09458108373, 4529.9547004530195, 4549.158405694957, 4738.218193998021, 4770.284457331428, 4822.156122678447, 4823.589994850477, 4857.2228443449585, 5111.386633603991, 5150.278960945546, 5157.07172708916, 5158.484151584811, 5205.6356055075785, 4690.061987602425, 4813.807447702193, 4852.490488498657, 4864.902701945871, 4902.117618828503, 4905.23968784839, 4964.776585053609, 4992.700437973734, 4993.750312484434, 5030.195168772979, 5115.335006449138, 5136.563392111712, 5137.280780690781, 5151.562117220078, 5196.766145523385, 4789.760511974457, 4821.566059054702, 4893.828715994923, 4950.851474455772, 4952.851414457572, 4936.136176169228, 4959.603231741524, 4979.427365852828, 4984.22744474607, 5030.698158110525, 4836.443808961873, 4863.0, 4874.0, 4892.0, 4945.035718034948, 4788.592969597623, 4886.340344053508, 4909.631777616764, 5031.94329190874, 5084.288199651977, 4893.217085266483, 4902.8774280643265, 4907.0431265904235, 4914.8771280718265, 4963.950360496493], "unit": "ms", "name": "dojo.html", "value": 4640.100978407565}, {"lowerIsBetter": false, "replicates": [531.9761859035913, 583.067092651757, 583.2854752927664, 590.2621722846442, 600.9429104235099, 36134.63865361346, 36836.26327473449, 37039.074023149435, 37156.25687486252, 37180.442293365624, 40981.38527922076, 41288.38067428984, 41458.37812432808, 41701.58298417015, 41723.58276417235, 7962.601869906496, 8060.838783224332, 8095.919040809605, 8112.959435202816, 8115.310198633094, 7809.531428114303, 7937.3650107991225, 7958.283754462097, 8001.799955001114, 8027.638756255982, 7968.083670377894, 8065.6773729051065, 8069.838603227932, 8074.9596252018655, 8078.313343365821, 7897.486663366892, 8000.199980002011, 8009.719659811908, 8017.358611311081, 8073.596320183968, 7858.764237072897, 7939.603019848984, 7967.721129760488, 7982.161873003309, 7995.040595128622, 37156.814215929015, 37183.62816371856, 37486.81256593727, 37667.0, 37679.24641507182, 2901.6518017837993, 2930.3846192299643, 2940.985295073532, 2941.3676059647278, 2955.8374289414073, 27847.443051139067, 28239.717602823916, 28520.857395713098, 28728.0, 28858.278543036384, 3441.638627944055, 3493.6366259689303, 3514.297140571896, 3600.981995090008, 3612.4581312803025, 222493.0, 223217.0, 223879.8806005976, 224228.99999999837, 224627.0, 53082.46917530775, 53377.46622533802, 53442.0, 53516.0, 53533.0, 49310.75344623254, 50309.74845125751, 63980.0, 64866.0, 65010.67494662497, 13421.530246441327, 13492.988025897901, 13517.188968661912, 13555.118917270345, 13609.11540749848, 9591.040895910493, 9607.807843843084, 9646.565904534313, 9664.178544823628, 9796.902030979742, 18500.16749246287, 18677.533061673566, 18694.81305186958, 18720.0, 18742.062896855103, 7550.244975502405, 7885.645145968445, 7904.288614024766, 7927.3658107351275, 7995.0, 811.6225954930985, 833.7290380626321, 878.6573236437795, 990.8216521026285, 1013.7769690668041, 25597.23208303754, 26396.340091497867, 26518.46963060728, 26650.0, 26656.46687066248, 927.1470247372433, 985.9753506162403, 1014.4116412480744, 1027.0038063078803, 1149.2070471374725, 14306.213158276187, 14382.28088595566, 14403.135811851322, 14838.0, 14870.0, 266455.0, 271980.0, 272796.0, 273613.0, 275199.0, 45908.0, 45971.77014114975, 46021.30968035415, 46035.30947035797, 46049.53950460452, 1202.2305724336431, 1202.2546021466571, 1233.802591585342, 1244.116677159209, 1355.2681551962028, 25886.35284117912, 26671.33321666974, 27053.86473067622, 27177.1846844595, 27297.590536141575, 37274.44088338732, 37322.626773731914, 37685.81157094197, 37714.81142594379, 37765.0, 174427.0, 174582.0, 174901.0, 174923.12538437225, 175258.0, 26697.0, 29378.0, 29500.262493437836, 29633.40733185281, 29925.700742993162, 34154.65845341515, 34231.31537369289, 34472.20552362125, 34497.827510862284, 34976.65023349734, 28958.855205723838, 29253.41493170167, 29544.261393465335, 29724.554131688474, 29871.103866884027, 29440.411191775616, 29460.558091628212, 29532.0, 29753.702462975092, 29809.701902980694, 31832.204194894388, 32259.0, 32275.677243228205, 32294.515582265816, 32356.83821580877, 27520.862395687895, 28705.0, 29885.252868678457, 30170.69829301679, 30423.54364684487, 23187.420314492272, 23795.881020594785, 24091.156809511584, 24120.396990075387, 25162.496750065264], "unit": "ms", "name": "ext.html", "value": 16597.467857371805}, {"lowerIsBetter": false, "replicates": [326.80555069733515, 328.998355008225, 329.49422636253354, 331.16050811193617, 331.53916056681203, 10439.060484556388, 10724.0, 15014.924925375371, 15591.0, 15706.0, 15557.688846223096, 15680.451184208527, 15804.288807003684, 15916.52250432486, 15946.0, 5430.294061771964, 5466.9179962300595, 5536.584756143286, 5582.246396736449, 5591.133374326986, 5452.972735136319, 5513.558915286768, 5514.944850551483, 5515.062439385294, 5522.088855338884, 5524.806631767869, 5631.549476041927, 6176.444120029197, 6337.904931426009, 6412.903806442907, 6326.65203413812, 6343.524235682319, 6380.936190638104, 6507.609543427409, 6723.0, 6412.102305677209, 6449.871002579969, 6452.064450654629, 6453.16108905844, 6471.482281417475, 20196.49508762278, 21326.253581124587, 21384.144634214612, 21669.67495487569, 22412.0, 1887.669657809878, 1897.791242963273, 1990.7511561054869, 2001.3395579458743, 2003.4790954351975, 13724.519641812489, 13868.361488765313, 13928.0, 14120.0, 14120.870330373647, 1771.4951238896851, 1778.510909499885, 1853.9258429662932, 1854.9072546372763, 1860.8697391182623, 60974.390256097315, 63586.6820665903, 65282.673586632234, 65936.67031664858, 66363.3363666362, 9332.160105590394, 9478.57346419399, 9550.904490955141, 9578.952105239428, 9619.18236949853, 12468.75062498745, 12540.372981350896, 12542.24746515212, 12555.811662825065, 12654.240745555297, 7028.543144695681, 7050.189228238715, 7096.609686467191, 7145.606991615407, 7198.676059577227, 6676.232233293136, 6746.055552222692, 6757.425618822455, 6771.93228067713, 6806.659667016728, 4168.979155104205, 4249.0, 4257.87226383209, 4268.9786551067045, 4277.272863613193, 1651.157909466157, 1696.253648394727, 1711.3753479979719, 1765.2497688482345, 1771.1941066814568, 363.39494741256044, 782.2881178127876, 813.5728742410164, 844.7254642241296, 963.1957315641378, 9481.762955926157, 9675.90324096764, 9723.562439690231, 9786.657466988763, 9943.850842237372, 381.1025036040086, 389.8713424569885, 391.9157381163064, 403.93537034074404, 405.1208876737428, 8807.559622018873, 9060.95469522648, 9242.953785231166, 9327.440353578808, 9484.90515094854, 455347.0, 459937.0, 465447.0, 489109.0, 491035.0, 73310.26689733141, 74148.62925685337, 77219.0, 77498.6125069371, 77547.224527754, 1104.127739086129, 1106.043272569222, 1114.225613198819, 1127.4475507001673, 1129.7119234595125, 14407.927960360132, 14748.63128421755, 14880.851191487947, 15015.249237538297, 15140.167290799112, 34781.39139564594, 35072.64927350694, 35226.11934701653, 35480.645193548764, 35794.0, 45242.32136518021, 46631.30053049275, 47560.7621961888, 47731.5226847741, 49520.0, 8600.440971336842, 8820.691275805317, 9217.907820921704, 9222.631094756403, 9224.953875230582, 15496.302666380265, 16106.516804495885, 16234.26945787466, 16515.33938642489, 16719.33122675128, 12844.165129266568, 13753.38109785042, 13771.724565508433, 14189.858101419266, 14429.278536073365, 13074.411651475517, 13449.193048417126, 13779.724405511633, 13863.79204311916, 13909.513167039106, 13546.661333466742, 13872.0, 14325.64185895361, 14515.85484145145, 14843.21881374242, 8455.281301089477, 8898.73303800887, 8901.910980890108, 9162.404443711137, 9194.402363846328, 9425.622975081194, 12516.374181291081, 13488.93255533716, 13700.109492882932, 13844.792328114885], "unit": "ms", "name": "jquery.html", "value": 8387.80333464045}, {"lowerIsBetter": false, "replicates": [1491.753860612999, 1656.0312217352855, 1659.286506802075, 1668.1158985737557, 1729.3255630304184, 5942.049272116462, 6143.047827586731, 6509.8372540686505, 6628.9005664915, 6697.196336439628, 6644.0, 6871.278515755848, 6887.27683593223, 6924.446044316443, 6930.861382772341, 1987.0064967516241, 2007.0968064371018, 2022.1405902491383, 2022.4741567192561, 2029.5839352932614, 2031.7765045844944, 2035.3690355989615, 2056.362527616436, 2058.269314393391, 2058.7750288578272, 2028.5537181819975, 2047.406252186864, 2055.2601063617085, 2081.6253074446595, 2083.0418007716466, 2028.9492762680977, 2041.7549894012739, 2043.6832290994919, 2044.0597325230412, 2047.6314263432575, 2009.4775358406919, 2014.9496262593407, 2070.3064473401428, 2079.9896000520052, 2083.3958152136015, 7026.789196324067, 7131.286871312879, 7140.821479463003, 7141.3215744504705, 7149.428045756327, 4127.360259159835, 4183.602557757008, 4202.873913782591, 4217.304144816102, 4224.091820258659, 2641.168032069892, 2667.759901608845, 2703.162019773876, 2712.2948033511234, 2714.5113879501682, 873.6287077991892, 881.8104107616894, 884.5842454046652, 902.8149229408021, 929.3355250995571, 9497.335186536946, 9497.762555936157, 9520.238380929579, 9544.284178686557, 9561.904380956172, 3770.6040865709256, 3773.24535092977, 3824.388097904322, 3832.7508711933633, 3838.4242363645117, 8133.10535841057, 8189.058258300252, 8207.425480216327, 8208.794780130545, 8209.220124088202, 4137.834486620562, 4142.689298302579, 4151.8546850860075, 4155.8961025974595, 4167.770772607536, 3670.1742108025483, 3725.590185079639, 3756.6431189037, 3765.4163604641326, 3781.6596506314013, 3225.3871764364694, 3243.5783348164587, 3248.0742988248235, 3248.8700451982127, 3281.507773833944, 974.8391515399879, 975.4927437732481, 977.8777652793401, 979.7550612346913, 982.4596471940404, 828.5525816059381, 830.543201239316, 1050.1913526584487, 1089.9891001089889, 1113.4043286841502, 6405.167328247298, 6423.807285781434, 6447.742090316428, 6462.32145624712, 6477.4170324671, 416.2819136988731, 418.9664826813848, 429.1288683971543, 429.225248426593, 431.2108840821289, 4826.7827947742435, 4829.589484893753, 4829.782659780319, 4865.367502224759, 4866.732329721899, 8069.556174410463, 8225.0, 8250.422470427133, 8335.916330876948, 8369.539675317794, 8174.550399728072, 8207.425480216447, 8219.794505137419, 8220.424570280024, 8221.630026648816, 6628.900566491507, 6664.266930637626, 6687.498437617198, 6732.966335168391, 6767.627780472121, 6692.0, 6739.191297044386, 6760.290169532325, 6761.0534525167495, 6773.05177275172, 7159.212486626363, 7367.410607151308, 7393.223711510429, 7477.0, 7549.7357592483995, 7488.438367122597, 7490.288422599844, 7725.884111738216, 7744.651490683045, 7798.25916537928, 5417.377001644703, 5528.668279903219, 6081.787137450345, 6158.230221222348, 6159.476444502267, 6525.64108974011, 6670.799876003728, 6694.196696396269, 6706.66466676674, 6713.328667133248, 6069.9089513656445, 6233.594816336924, 6238.845813524513, 6400.55196136266, 6488.805335839932, 6184.536159788124, 6264.2796078451565, 6275.309715931336, 6314.905276420949, 6372.330905254881, 6244.625322480666, 6260.467860231931, 6263.0, 6284.528660350401, 6341.936580634135, 5734.254546908875, 5818.127280907897, 5819.0689489681445, 5827.59206855516, 5862.794802181903, 5615.045442274904, 5625.831225063254, 5656.0667489865355, 5670.347909990239, 5672.262605861211], "unit": "ms", "name": "mootools.html", "value": 3901.9051755484606}, {"lowerIsBetter": false, "replicates": [293.1484038867091, 300.4276852595806, 303.0710871179834, 304.9573059771631, 307.1798298542891, 5560.388357280701, 5563.972180139099, 5579.804706835256, 5586.692731899754, 5740.081586946089, 5548.056830338842, 5592.0, 5616.045272303708, 5622.072358060915, 5627.549796016319, 4107.014316564018, 4241.766702831343, 4244.639205667522, 4247.214265360903, 4248.766317852517, 4191.266528357541, 4200.663946884257, 4200.915981680365, 4203.85286514972, 4204.306289462235, 4137.1725654869, 4156.937645935313, 4194.895127621803, 4203.222403855297, 4213.389058586503, 4186.225548273549, 4189.392538081992, 4196.7062305638465, 4200.97899510502, 4206.305959516676, 3633.709303255733, 3636.8727094551564, 3641.998450426154, 3652.0687224757517, 3662.102784817737, 5158.458361872024, 5172.069027575035, 5260.316158899357, 5282.550983166436, 5315.973420132875, 4809.350737650408, 4819.95180048202, 4825.541573550507, 4829.323894654751, 4834.685745426536, 5840.328362238354, 5858.589898707092, 5875.706214689249, 5877.059670452707, 5887.0, 3874.9225015499533, 3925.6270654287796, 3951.8616848410165, 3965.325894597925, 3972.602739726033, 6074.42292982166, 6168.75324987, 6174.845628859314, 6178.042403427431, 6178.042403427476, 4057.8173982170283, 4057.857974970862, 4060.167665628598, 4060.2285565742413, 4063.91872162561, 4092.0, 4108.958910410917, 4119.443875076886, 4124.670026397881, 4133.379993001014, 4780.784864681098, 4785.736784476887, 4786.976065119722, 4791.161546729309, 4792.329073929653, 5647.0964645656495, 5855.297364316224, 5859.94140058594, 5869.383714709894, 5878.059510478303, 1462.8464011278875, 1479.8372179060295, 1485.732568137724, 1486.0637798187072, 1489.471237710597, 975.1175186456269, 975.3708857786829, 982.5185659027026, 1000.9199264058858, 1004.7237009822211, 5100.515451032146, 5114.616403769732, 5121.487851214849, 5123.154679477844, 5130.589552835764, 6082.148499210114, 6082.726277317532, 6095.268567771807, 6095.451409373178, 6116.816495505142, 5078.390593128848, 5097.515736005073, 5106.0, 5106.693598384109, 5107.157319042316, 3196.2329041029984, 3258.120307516957, 3281.9015429536676, 3285.178705323669, 3285.5400243965864, 5756.856078598069, 5761.942380576224, 5771.826845194651, 5772.451617096453, 5776.566757493205, 6128.295246046672, 6333.96833015832, 6344.016677415008, 6352.36476352361, 6356.523260755462, 5727.0550359190265, 5743.827685169452, 5746.0519014363, 5746.224259724967, 5779.971100144472, 6121.112438696453, 6134.110553969738, 6141.692915354125, 6144.10910417978, 6144.477719393902, 5854.209681692917, 5964.165016897725, 5996.490298324691, 6003.939960600513, 6026.638401695912, 5765.164051212634, 5770.105633626795, 5774.2782152230975, 5775.104858746901, 5782.971085144547, 3996.060925682404, 4041.1109555897656, 4055.310597198424, 4064.7154699170774, 4065.776382299002, 5985.371535988658, 6120.44915957566, 6123.479504242189, 6126.050462178369, 6132.478739307209, 5860.853478663067, 5863.589548731718, 5876.324222714443, 5876.3536011039605, 5877.23595932526, 5824.796132135355, 5826.329972053268, 5837.912431313449, 5838.591298609056, 5855.03391940325, 5538.723063846872, 5697.829065128053, 5741.5119714824705, 5746.166805813217, 5750.079987202028, 5915.816836632776, 5929.525637948867, 5930.377310382348, 5949.0481522956115, 5949.3455719871645, 5788.27646544182, 5790.681512516852, 5791.53667706574, 5795.0, 5799.217105690846], "unit": "ms", "name": "prototype.html", "value": 4354.035712554281}, {"lowerIsBetter": false, "replicates": [738.634375983888, 739.8335374540728, 751.4548284442506, 751.8270797716525, 766.9846603067939, 11640.301581905092, 11908.464119114638, 11920.701982450442, 11951.880481195196, 11988.340641264738, 11574.131940104484, 11759.588414405498, 11807.114466415032, 11833.349165795878, 11839.112066595018, 618.6628287583278, 795.2365728900248, 809.1746418652971, 809.5142914251461, 809.76516810125, 616.9969150154243, 799.1289494451047, 814.9592520373988, 815.0993152566388, 816.1878930464196, 835.8704400817883, 839.9286060684849, 850.7490290364358, 852.4672079950032, 853.5860107847689, 840.2143995364354, 842.9325653947669, 844.8901642786399, 845.3406343052399, 845.8477474054667, 623.6382897919196, 624.9250089989185, 625.3215261441342, 625.4964753373532, 627.3193584960324, 11434.942825285903, 11484.196106272564, 11496.0, 11996.340201288926, 12090.032797376276, 11003.724906877313, 11217.547134963022, 11312.095032397388, 11465.254758440758, 11949.880501194964, 9611.903880961241, 9788.314817962746, 9882.258830587663, 9897.90102098977, 10181.440020798853, 3252.837358132084, 3273.0508152635944, 3297.653746356646, 3307.933841323184, 3393.3552625001416, 42250.78874605638, 42307.36538951918, 42646.57353426457, 42719.786401067795, 42760.78619606913, 9137.451752894847, 9152.679656212134, 9182.494962777111, 9284.767880803034, 9378.5310734463, 16058.116803575915, 16108.275127619285, 16142.273597688132, 16161.0, 16220.837791622169, 6469.385408386196, 6483.805485835433, 6516.022596610546, 6532.41208291256, 6703.865922681616, 3683.336999340091, 3726.6459686329754, 3755.0, 3809.066778639251, 3873.1285460771664, 2593.4424098818845, 2614.9084782032537, 2624.475104979012, 2627.4482358704886, 2628.1852625686097, 470.3650072402298, 473.68026582056973, 475.7407213068886, 476.3521610609568, 476.41401076675885, 527.2513031495286, 570.4580648384052, 591.588845752198, 594.2156353613276, 619.851235703428, 7505.924940750522, 7613.505122167041, 7623.618819059025, 7661.540307581563, 7802.180771019075, 430.8082903108149, 549.4478049560166, 608.2003204177253, 613.8342647485154, 619.9721012554446, 3334.6498617645284, 3453.689167974894, 3560.839762210707, 3561.3055454186183, 3651.1602331463914, 51502.22746658803, 51526.0, 51731.0, 51920.480795191565, 51940.0, 43121.35317970233, 45919.31121033187, 45941.310880336154, 46505.76747116243, 46996.29505557419, 41488.0, 42747.7862610685, 42752.3587146193, 42806.57193428088, 42909.356359654004, 7952.801179970547, 8143.918560814316, 8152.163142353254, 8287.792805179919, 8411.957940210259, 30018.24954376158, 30968.53547196839, 30980.0705978821, 33183.83408082944, 33210.50184247286, 37669.0, 40362.798186008884, 40951.7952410236, 41031.0, 41187.588124119575, 10058.949705251427, 10283.640072597424, 10545.578176873147, 10650.627228046982, 10674.73313167177, 10861.891381086089, 11156.21906466572, 11484.770304593694, 12040.698982525508, 12431.254124752544, 10921.126309895348, 11116.666500005012, 11163.609273675707, 11527.308361498337, 11634.243774154653, 10427.0, 10838.241323107306, 10972.341659500455, 11248.887511124783, 11625.534978600761, 9646.372985755903, 9759.853602195832, 10898.564057437614, 11217.102631789601, 11320.320780753182, 9451.385659932082, 9657.420554766737, 9736.41581505112, 9827.213822894295, 10080.143187829117, 9160.496172710298, 9515.096065873731, 9551.522423878918, 9568.330216884751, 9672.75818104553], "unit": "ms", "name": "yui.html", "value": 5808.974765186473}], "name": "dromaeo_css", "value": 6320.553724311595}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 114.0, 113.0, 115.0, 124.0, 112.0, 114.0, 116.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 114.6}, {"lowerIsBetter": true, "replicates": [153.0, 141.0, 157.0, 164.0, 131.0, 156.0, 158.0, 135.0, 169.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.5}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 163.0, 163.0, 164.0, 163.0, 164.0, 162.0, 166.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 73.0, 72.0, 72.0, 132.0, 72.0, 78.0, 74.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 79.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 131.0, 93.0, 93.0, 94.0, 131.0, 95.0, 95.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 105.6}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 110.0, 111.0, 110.0, 109.0, 110.0, 110.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [149.0, 148.0, 146.0, 147.0, 148.0, 147.0, 152.0, 147.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 75.0, 73.0, 74.0, 73.0, 74.0, 72.0, 74.0, 74.0], "unit": "ms", "name": "json-parse-financial", "value": 73.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 69.0, 69.0, 68.0, 69.0, 69.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 84.0, 89.0, 86.0, 83.0, 88.0, 84.0, 94.0, 89.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.7}, {"lowerIsBetter": true, "replicates": [132.0, 137.0, 127.0, 129.0, 120.0, 123.0, 131.0, 123.0, 126.0, 130.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.8}, {"lowerIsBetter": true, "replicates": [145.0, 153.0, 144.0, 165.0, 153.0, 141.0, 164.0, 152.0, 144.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 150.2}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 70.0, 71.0, 75.0, 70.0, 71.0, 73.0, 70.0, 73.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.5}], "name": "kraken", "value": 1544.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.91704223001167], "unit": "score", "name": "Richards", "value": 211.49428200000003}, {"lowerIsBetter": false, "replicates": [186.15040953090096], "unit": "score", "name": "DeltaBlue", "value": 355.1858960000002}, {"lowerIsBetter": false, "replicates": [281.214848143982], "unit": "score", "name": "Encrypt", "value": 946.5396360000002}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1070.6638115631692], "unit": "score", "name": "RayTrace", "value": 691.1497260000002}, {"lowerIsBetter": false, "replicates": [693.000693000693], "unit": "score", "name": "Earley", "value": 961.7061090000003}, {"lowerIsBetter": false, "replicates": [11988.095238095239], "unit": "score", "name": "Boyer", "value": 55.59373584905661}, {"lowerIsBetter": false, "replicates": [26842.105263157893], "unit": "score", "name": "RegExp", "value": 33.93865686274513}, {"lowerIsBetter": false, "replicates": [603.5003017501509], "unit": "score", "name": "Splay", "value": 135.030587}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21365.656318776026}]} 08:34:59 INFO - RETURN: dromaeo_css: 6320.55 08:34:59 INFO - RETURN: kraken: 1544.90 08:34:59 INFO - RETURN: v8_7: 21365.66 08:34:59 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21365.66"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1544.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6320.55"}}} 08:34:59 INFO - Return code: 0 08:34:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:34:59 INFO - # TBPL SUCCESS # 08:34:59 INFO - Running post-action listener: _resource_record_post_action 08:34:59 INFO - Running post-run listener: _resource_record_post_run 08:35:00 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 10452992; Write bytes: 280170496; Read time: 2268; Write time: 190624 08:35:00 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 11595776; Read time: 0; Write time: 3432 08:35:00 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 8691712; Write bytes: 268574720; Read time: 2212; Write time: 187192 08:35:00 INFO - Running post-run listener: _upload_blobber_files 08:35:00 INFO - Blob upload gear active. 08:35:00 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:35:00 INFO - Copying logs to upload dir... 08:35:00 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1284.168574 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-12-14 08:35:00.451244) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-14 08:35:00.454760) ========= 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=f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/r0RmFnevTy6wwdkjDI82rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009922 build_url: 'https://queue.taskcluster.net/v1/task/r0RmFnevTy6wwdkjDI82rQ/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-14 08:35:00.506827) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 08:35:00.507187) ========= 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=f5f5a079460e1a9be8676904000001c1-1450108640.221720-1370719119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 08:35:00.557795) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-14 08:35:00.558169) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-14 08:35:00.558565) ========= ========= Total master_lag: 1.81 =========