builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-038 starttime: 1447686759.9 results: success (0) buildid: 20151116063637 builduid: b4a46ce8894948c1bc8130d5400bb282 revision: 37ee16bb31cf4b78973b71af1362542dfc6b64bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 07:12:39.903946) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 07:12:39.904381) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 07:12:39.904663) ========= 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=e8c3f5a4c0a512351e80f2ca000001d7-1447686406.172897-1280556760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006647 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 07:12:39.925964) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 07:12:39.926278) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 07:12:39.939652) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 07:12:39.940070) ========= 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=e8c3f5a4c0a512351e80f2ca000001d7-1447686406.172897-1280556760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004617 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 07:12:39.990757) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 07:12:39.991240) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 07:12:39.995310) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 07:12:39.995813) ========= 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=e8c3f5a4c0a512351e80f2ca000001d7-1447686406.172897-1280556760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-16 07:12:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2015-11-16 07:12:40 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124536 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 07:12:40.133488) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 07:12:40.133792) ========= 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=e8c3f5a4c0a512351e80f2ca000001d7-1447686406.172897-1280556760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022087 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 07:12:40.183122) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 07:12:40.183435) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 37ee16bb31cf4b78973b71af1362542dfc6b64bc --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 37ee16bb31cf4b78973b71af1362542dfc6b64bc --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=e8c3f5a4c0a512351e80f2ca000001d7-1447686406.172897-1280556760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-16 07:12:40,770 truncating revision to first 12 chars 2015-11-16 07:12:40,770 Setting DEBUG logging. 2015-11-16 07:12:40,770 attempt 1/10 2015-11-16 07:12:40,770 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/37ee16bb31cf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 07:12:41,022 unpacking tar archive at: fx-team-37ee16bb31cf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.518257 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 07:12:40.734718) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 07:12:40.735075) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 07:12:40.747760) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 07:12:40.748168) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 07:12:40.748673) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-16 07:12:40.748974) ========= /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=e8c3f5a4c0a512351e80f2ca000001d7-1447686406.172897-1280556760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:12:41 INFO - MultiFileLogger online at 20151116 07:12:41 in /builds/slave/test 07:12:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:12:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:12:41 INFO - {'append_to_log': False, 07:12:41 INFO - 'base_work_dir': '/builds/slave/test', 07:12:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:12:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:12:41 INFO - 'branch': 'Fx-Team-Non-PGO', 07:12:41 INFO - 'buildbot_json_path': 'buildprops.json', 07:12:41 INFO - 'config_files': ('talos/linux_config.py',), 07:12:41 INFO - 'default_actions': ('clobber', 07:12:41 INFO - 'read-buildbot-config', 07:12:41 INFO - 'download-and-extract', 07:12:41 INFO - 'populate-webroot', 07:12:41 INFO - 'create-virtualenv', 07:12:41 INFO - 'install', 07:12:41 INFO - 'run-tests'), 07:12:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:12:41 INFO - 'download_minidump_stackwalk': True, 07:12:41 INFO - 'download_symbols': 'ondemand', 07:12:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:12:41 INFO - 'tooltool.py': '/tools/tooltool.py', 07:12:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:12:41 INFO - '/tools/misc-python/virtualenv.py')}, 07:12:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:12:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:12:41 INFO - 'installer_path': 'installer.exe', 07:12:41 INFO - 'log_level': 'info', 07:12:41 INFO - 'log_name': 'talos', 07:12:41 INFO - 'log_to_console': True, 07:12:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:12:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:12:41 INFO - 'opt_config_files': (), 07:12:41 INFO - 'pip_index': False, 07:12:41 INFO - 'sps_profile': False, 07:12:41 INFO - 'sps_profile_interval': 0, 07:12:41 INFO - 'suite': 'dromaeojs-e10s', 07:12:41 INFO - 'system_bits': '64', 07:12:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:12:41 INFO - 'title': 'talos-linux64-ix-038', 07:12:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:12:41 INFO - 'use_talos_json': True, 07:12:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:12:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:12:41 INFO - 'work_dir': 'build'} 07:12:41 INFO - ##### 07:12:41 INFO - ##### Running clobber step. 07:12:41 INFO - ##### 07:12:41 INFO - Running pre-action listener: _resource_record_pre_action 07:12:41 INFO - Running main action method: clobber 07:12:41 INFO - rmtree: /builds/slave/test/build 07:12:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:12:41 INFO - Running post-action listener: _resource_record_post_action 07:12:41 INFO - ##### 07:12:41 INFO - ##### Running read-buildbot-config step. 07:12:41 INFO - ##### 07:12:41 INFO - Running pre-action listener: _resource_record_pre_action 07:12:41 INFO - Running main action method: read_buildbot_config 07:12:41 INFO - Using buildbot properties: 07:12:41 INFO - { 07:12:41 INFO - "properties": { 07:12:41 INFO - "buildnumber": 683, 07:12:41 INFO - "product": "firefox", 07:12:41 INFO - "script_repo_revision": "production", 07:12:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:12:41 INFO - "repository": "", 07:12:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 07:12:41 INFO - "buildid": "20151116063637", 07:12:41 INFO - "slavename": "talos-linux64-ix-038", 07:12:41 INFO - "pgo_build": "False", 07:12:41 INFO - "basedir": "/builds/slave/test", 07:12:41 INFO - "project": "", 07:12:41 INFO - "platform": "ubuntu64_hw", 07:12:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:12:41 INFO - "slavebuilddir": "test", 07:12:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:12:41 INFO - "branch": "fx-team", 07:12:41 INFO - "repo_path": "integration/fx-team", 07:12:41 INFO - "stage_platform": "linux64", 07:12:41 INFO - "builduid": "b4a46ce8894948c1bc8130d5400bb282", 07:12:41 INFO - "revision": "37ee16bb31cf4b78973b71af1362542dfc6b64bc" 07:12:41 INFO - }, 07:12:41 INFO - "sourcestamp": { 07:12:41 INFO - "repository": "", 07:12:41 INFO - "hasPatch": false, 07:12:41 INFO - "project": "", 07:12:41 INFO - "branch": "fx-team-linux64-talos", 07:12:41 INFO - "changes": [ 07:12:41 INFO - { 07:12:41 INFO - "category": null, 07:12:41 INFO - "files": [ 07:12:41 INFO - { 07:12:41 INFO - "url": null, 07:12:41 INFO - "name": "https://queue.taskcluster.net/v1/task/Z2XtXOEHRpKtWWUGC648Gg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 07:12:41 INFO - } 07:12:41 INFO - ], 07:12:41 INFO - "repository": "", 07:12:41 INFO - "rev": "37ee16bb31cf4b78973b71af1362542dfc6b64bc", 07:12:41 INFO - "who": "mleibovic@mozilla.com", 07:12:41 INFO - "when": 1447686697, 07:12:41 INFO - "number": 6666078, 07:12:41 INFO - "comments": "Bug 1224197 - Update 'Change' button in about:telemetry to open privacy settings. r=gfritzsche", 07:12:41 INFO - "project": "", 07:12:41 INFO - "at": "Mon 16 Nov 2015 07:11:37", 07:12:41 INFO - "branch": "fx-team-linux64-talos", 07:12:41 INFO - "revlink": "", 07:12:41 INFO - "properties": [ 07:12:41 INFO - [ 07:12:41 INFO - "buildid", 07:12:41 INFO - "20151116063637", 07:12:41 INFO - "Change" 07:12:41 INFO - ], 07:12:41 INFO - [ 07:12:41 INFO - "builduid", 07:12:41 INFO - "b4a46ce8894948c1bc8130d5400bb282", 07:12:41 INFO - "Change" 07:12:41 INFO - ], 07:12:41 INFO - [ 07:12:41 INFO - "pgo_build", 07:12:41 INFO - "False", 07:12:41 INFO - "Change" 07:12:41 INFO - ] 07:12:41 INFO - ], 07:12:41 INFO - "revision": "37ee16bb31cf4b78973b71af1362542dfc6b64bc" 07:12:41 INFO - } 07:12:41 INFO - ], 07:12:41 INFO - "revision": "37ee16bb31cf4b78973b71af1362542dfc6b64bc" 07:12:41 INFO - } 07:12:41 INFO - } 07:12:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z2XtXOEHRpKtWWUGC648Gg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 07:12:41 INFO - Running post-action listener: _resource_record_post_action 07:12:41 INFO - ##### 07:12:41 INFO - ##### Running download-and-extract step. 07:12:41 INFO - ##### 07:12:41 INFO - Running pre-action listener: _resource_record_pre_action 07:12:41 INFO - Running main action method: download_and_extract 07:12:41 INFO - mkdir: /builds/slave/test/build/tests 07:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:41 INFO - https://queue.taskcluster.net/v1/task/Z2XtXOEHRpKtWWUGC648Gg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:12:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2XtXOEHRpKtWWUGC648Gg/artifacts/public/build/test_packages.json 07:12:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2XtXOEHRpKtWWUGC648Gg/artifacts/public/build/test_packages.json 07:12:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2XtXOEHRpKtWWUGC648Gg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:12:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2XtXOEHRpKtWWUGC648Gg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:12:42 INFO - Downloaded 1302 bytes. 07:12:42 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:12:42 INFO - Using the following test package requirements: 07:12:42 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:12:42 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:12:42 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:42 INFO - u'jsshell-linux-x86_64.zip'], 07:12:42 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:12:42 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:12:42 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:12:42 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:12:42 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:12:42 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:12:42 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:12:42 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:42 INFO - https://queue.taskcluster.net/v1/task/Z2XtXOEHRpKtWWUGC648Gg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:12:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2XtXOEHRpKtWWUGC648Gg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:12:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2XtXOEHRpKtWWUGC648Gg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:12:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2XtXOEHRpKtWWUGC648Gg/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 07:12:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2XtXOEHRpKtWWUGC648Gg/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 07:12:43 INFO - Downloaded 21278251 bytes. 07:12:43 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 07:12:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:12:43 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 07:12:44 INFO - Return code: 0 07:12:44 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 07:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:44 INFO - https://queue.taskcluster.net/v1/task/Z2XtXOEHRpKtWWUGC648Gg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:12:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2XtXOEHRpKtWWUGC648Gg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:12:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2XtXOEHRpKtWWUGC648Gg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:12:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2XtXOEHRpKtWWUGC648Gg/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 07:12:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2XtXOEHRpKtWWUGC648Gg/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 07:12:45 INFO - Downloaded 21278251 bytes. 07:12:45 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 07:12:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:12:45 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 07:12:46 INFO - Return code: 0 07:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:46 INFO - https://queue.taskcluster.net/v1/task/Z2XtXOEHRpKtWWUGC648Gg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:12:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2XtXOEHRpKtWWUGC648Gg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:12:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2XtXOEHRpKtWWUGC648Gg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:12:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2XtXOEHRpKtWWUGC648Gg/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 07:12:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2XtXOEHRpKtWWUGC648Gg/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 07:12:48 INFO - Downloaded 11131693 bytes. 07:12:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 07:12:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:12:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 07:12:48 INFO - Return code: 0 07:12: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')]} 07:12:48 INFO - https://queue.taskcluster.net/v1/task/Z2XtXOEHRpKtWWUGC648Gg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:12:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2XtXOEHRpKtWWUGC648Gg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:12:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2XtXOEHRpKtWWUGC648Gg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:12:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2XtXOEHRpKtWWUGC648Gg/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 07:12:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2XtXOEHRpKtWWUGC648Gg/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 07:12:50 INFO - Downloaded 55600854 bytes. 07:12:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z2XtXOEHRpKtWWUGC648Gg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:12:50 INFO - mkdir: /builds/slave/test/properties 07:12:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:12:50 INFO - Writing to file /builds/slave/test/properties/build_url 07:12:50 INFO - Contents: 07:12:50 INFO - build_url:https://queue.taskcluster.net/v1/task/Z2XtXOEHRpKtWWUGC648Gg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:12:50 INFO - Running post-action listener: _resource_record_post_action 07:12:50 INFO - Running post-action listener: set_extra_try_arguments 07:12:50 INFO - ##### 07:12:50 INFO - ##### Running populate-webroot step. 07:12:50 INFO - ##### 07:12:50 INFO - Running pre-action listener: _resource_record_pre_action 07:12:50 INFO - Running main action method: populate_webroot 07:12:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:12:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:12:50 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 07:12:50 INFO - '../fennec_ids.txt'], 07:12:50 INFO - 'tests': ['tcheck2']}, 07:12:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:12:50 INFO - '--tppagecycles', 07:12:50 INFO - '7'], 07:12:50 INFO - 'tests': ['tsvgm']}}, 07:12:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:12:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:12:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:12:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:12:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:12:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:12:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:12:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:50 INFO - 'talos_options': ['--e10s'], 07:12:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:12:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:50 INFO - 'tests': ['damp', 'tps']}, 07:12:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:50 INFO - 'talos_options': ['--e10s'], 07:12:50 INFO - 'tests': ['damp', 'tps']}, 07:12:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:12:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:12:50 INFO - 'other': {'tests': ['a11yr', 07:12:50 INFO - 'ts_paint', 07:12:50 INFO - 'tpaint', 07:12:50 INFO - 'sessionrestore', 07:12:50 INFO - 'sessionrestore_no_auto_restore']}, 07:12:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:12:50 INFO - 'tests': ['a11yr', 07:12:50 INFO - 'ts_paint', 07:12:50 INFO - 'tpaint', 07:12:50 INFO - 'sessionrestore', 07:12:50 INFO - 'sessionrestore_no_auto_restore']}, 07:12:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:12:50 INFO - 'tests': ['a11yr', 07:12:50 INFO - 'ts_paint', 07:12:50 INFO - 'tpaint', 07:12:50 INFO - 'sessionrestore', 07:12:50 INFO - 'sessionrestore_no_auto_restore']}, 07:12:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:12:50 INFO - 'tests': ['a11yr', 07:12:50 INFO - 'ts_paint', 07:12:50 INFO - 'tpaint', 07:12:50 INFO - 'sessionrestore', 07:12:50 INFO - 'sessionrestore_no_auto_restore']}, 07:12:50 INFO - 'other_l64': {'tests': ['a11yr', 07:12:50 INFO - 'ts_paint', 07:12:50 INFO - 'tpaint', 07:12:50 INFO - 'sessionrestore', 07:12:50 INFO - 'sessionrestore_no_auto_restore']}, 07:12:50 INFO - 'other_nol64': {'tests': ['a11yr', 07:12:50 INFO - 'ts_paint', 07:12:50 INFO - 'tpaint', 07:12:50 INFO - 'sessionrestore', 07:12:50 INFO - 'sessionrestore_no_auto_restore']}, 07:12:50 INFO - 'svgr': {'tests': ['tsvgx', 07:12:50 INFO - 'tsvgr_opacity', 07:12:50 INFO - 'tart', 07:12:50 INFO - 'tscrollx', 07:12:50 INFO - 'cart']}, 07:12:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:12:50 INFO - 'tests': ['tsvgx', 07:12:50 INFO - 'tsvgr_opacity', 07:12:50 INFO - 'tart', 07:12:50 INFO - 'tscrollx', 07:12:50 INFO - 'cart']}, 07:12:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:50 INFO - 'tests': ['tp5o']}, 07:12:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:50 INFO - 'talos_options': ['--e10s'], 07:12:50 INFO - 'tests': ['tp5o']}, 07:12:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:50 INFO - 'talos_options': ['--xperf_path', 07:12:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:12:50 INFO - 'tests': ['tp5n']}, 07:12:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:50 INFO - 'talos_options': ['--e10s', 07:12:50 INFO - '--xperf_path', 07:12:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:12:50 INFO - 'tests': ['tp5n']}}, 07:12:50 INFO - 'talos.zip': {'path': '', 07:12:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:12:50 INFO - Running post-action listener: _resource_record_post_action 07:12:50 INFO - ##### 07:12:50 INFO - ##### Running create-virtualenv step. 07:12:50 INFO - ##### 07:12:50 INFO - Running pre-action listener: _resource_record_pre_action 07:12:50 INFO - Running main action method: create_virtualenv 07:12:50 INFO - Creating virtualenv /builds/slave/test/build/venv 07:12:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:12:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:12:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:12:50 INFO - Using real prefix '/usr' 07:12:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:12:51 INFO - Installing distribute.............................................................................................................................................................................................done. 07:12:53 INFO - Installing pip.................done. 07:12:53 INFO - Return code: 0 07:12:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd07e38c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f086c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2048ac0>, '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 0x20499a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2049e50>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1447686406.172897-1280556760', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:12:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:12:53 INFO - Using env: {'DISPLAY': ':0', 07:12:53 INFO - 'HOME': '/home/cltbld', 07:12:53 INFO - 'LANG': 'en_US.UTF-8', 07:12:53 INFO - 'LANGUAGE': 'en_US:en', 07:12:53 INFO - 'LOGNAME': 'cltbld', 07:12:53 INFO - 'MAIL': '/var/mail/cltbld', 07:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:53 INFO - 'MOZ_NO_REMOTE': '1', 07:12:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:53 INFO - 'NO_EM_RESTART': '1', 07:12:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:53 INFO - 'PWD': '/builds/slave/test', 07:12:53 INFO - 'SHELL': '/bin/bash', 07:12:53 INFO - 'SHLVL': '1', 07:12:53 INFO - 'TERM': 'linux', 07:12:53 INFO - 'TMOUT': '86400', 07:12:53 INFO - 'USER': 'cltbld', 07:12:53 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1447686406.172897-1280556760', 07:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:53 INFO - '_': '/tools/buildbot/bin/python'} 07:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:12:53 INFO - Cleaning up... 07:12:53 INFO - Return code: 0 07:12:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd07e38c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f086c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2048ac0>, '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 0x20499a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2049e50>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1447686406.172897-1280556760', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:12:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:12:53 INFO - Using env: {'DISPLAY': ':0', 07:12:53 INFO - 'HOME': '/home/cltbld', 07:12:53 INFO - 'LANG': 'en_US.UTF-8', 07:12:53 INFO - 'LANGUAGE': 'en_US:en', 07:12:53 INFO - 'LOGNAME': 'cltbld', 07:12:53 INFO - 'MAIL': '/var/mail/cltbld', 07:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:53 INFO - 'MOZ_NO_REMOTE': '1', 07:12:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:53 INFO - 'NO_EM_RESTART': '1', 07:12:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:53 INFO - 'PWD': '/builds/slave/test', 07:12:53 INFO - 'SHELL': '/bin/bash', 07:12:53 INFO - 'SHLVL': '1', 07:12:53 INFO - 'TERM': 'linux', 07:12:53 INFO - 'TMOUT': '86400', 07:12:53 INFO - 'USER': 'cltbld', 07:12:53 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1447686406.172897-1280556760', 07:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:53 INFO - '_': '/tools/buildbot/bin/python'} 07:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:53 INFO - Downloading/unpacking psutil>=0.7.1 07:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:55 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:12:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:12:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:12:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:12:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:12:55 INFO - Installing collected packages: psutil 07:12:55 INFO - Running setup.py install for psutil 07:12:55 INFO - building 'psutil._psutil_linux' extension 07:12:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:12:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:12:55 INFO - building 'psutil._psutil_posix' extension 07:12:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:12:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:12:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:12:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:12:55 INFO - Successfully installed psutil 07:12:55 INFO - Cleaning up... 07:12:55 INFO - Return code: 0 07:12:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:12: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')]} 07:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12: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')]} 07:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd07e38c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f086c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2048ac0>, '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 0x20499a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2049e50>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1447686406.172897-1280556760', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:12:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:12:55 INFO - Using env: {'DISPLAY': ':0', 07:12:55 INFO - 'HOME': '/home/cltbld', 07:12:55 INFO - 'LANG': 'en_US.UTF-8', 07:12:55 INFO - 'LANGUAGE': 'en_US:en', 07:12:55 INFO - 'LOGNAME': 'cltbld', 07:12:55 INFO - 'MAIL': '/var/mail/cltbld', 07:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:55 INFO - 'MOZ_NO_REMOTE': '1', 07:12:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:55 INFO - 'NO_EM_RESTART': '1', 07:12:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:55 INFO - 'PWD': '/builds/slave/test', 07:12:55 INFO - 'SHELL': '/bin/bash', 07:12:55 INFO - 'SHLVL': '1', 07:12:55 INFO - 'TERM': 'linux', 07:12:55 INFO - 'TMOUT': '86400', 07:12:55 INFO - 'USER': 'cltbld', 07:12:55 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1447686406.172897-1280556760', 07:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:55 INFO - '_': '/tools/buildbot/bin/python'} 07:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:12:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:12:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:12:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:12:57 INFO - Installing collected packages: mozsystemmonitor 07:12:57 INFO - Running setup.py install for mozsystemmonitor 07:12:57 INFO - Successfully installed mozsystemmonitor 07:12:57 INFO - Cleaning up... 07:12:57 INFO - Return code: 0 07:12:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:12:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd07e38c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f086c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2048ac0>, '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 0x20499a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2049e50>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1447686406.172897-1280556760', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:12:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:12:57 INFO - Using env: {'DISPLAY': ':0', 07:12:57 INFO - 'HOME': '/home/cltbld', 07:12:57 INFO - 'LANG': 'en_US.UTF-8', 07:12:57 INFO - 'LANGUAGE': 'en_US:en', 07:12:57 INFO - 'LOGNAME': 'cltbld', 07:12:57 INFO - 'MAIL': '/var/mail/cltbld', 07:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:57 INFO - 'MOZ_NO_REMOTE': '1', 07:12:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:57 INFO - 'NO_EM_RESTART': '1', 07:12:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:57 INFO - 'PWD': '/builds/slave/test', 07:12:57 INFO - 'SHELL': '/bin/bash', 07:12:57 INFO - 'SHLVL': '1', 07:12:57 INFO - 'TERM': 'linux', 07:12:57 INFO - 'TMOUT': '86400', 07:12:57 INFO - 'USER': 'cltbld', 07:12:57 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1447686406.172897-1280556760', 07:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:57 INFO - '_': '/tools/buildbot/bin/python'} 07:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:58 INFO - Downloading/unpacking blobuploader==1.2.4 07:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:59 INFO - Downloading blobuploader-1.2.4.tar.gz 07:12:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:12:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:12:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:13:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:13:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:00 INFO - Downloading docopt-0.6.1.tar.gz 07:13:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:13:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:13:00 INFO - Installing collected packages: blobuploader, requests, docopt 07:13:00 INFO - Running setup.py install for blobuploader 07:13:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:13:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:13:00 INFO - Running setup.py install for requests 07:13:01 INFO - Running setup.py install for docopt 07:13:01 INFO - Successfully installed blobuploader requests docopt 07:13:01 INFO - Cleaning up... 07:13:01 INFO - Return code: 0 07:13:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:13: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')]} 07:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13: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')]} 07:13:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:01 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 0x7fdd07e38c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f086c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2048ac0>, '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 0x20499a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2049e50>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1447686406.172897-1280556760', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:13:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:13:01 INFO - Using env: {'DISPLAY': ':0', 07:13:01 INFO - 'HOME': '/home/cltbld', 07:13:01 INFO - 'LANG': 'en_US.UTF-8', 07:13:01 INFO - 'LANGUAGE': 'en_US:en', 07:13:01 INFO - 'LOGNAME': 'cltbld', 07:13:01 INFO - 'MAIL': '/var/mail/cltbld', 07:13:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:01 INFO - 'MOZ_NO_REMOTE': '1', 07:13:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:01 INFO - 'NO_EM_RESTART': '1', 07:13:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:01 INFO - 'PWD': '/builds/slave/test', 07:13:01 INFO - 'SHELL': '/bin/bash', 07:13:01 INFO - 'SHLVL': '1', 07:13:01 INFO - 'TERM': 'linux', 07:13:01 INFO - 'TMOUT': '86400', 07:13:01 INFO - 'USER': 'cltbld', 07:13:01 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1447686406.172897-1280556760', 07:13:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:01 INFO - '_': '/tools/buildbot/bin/python'} 07:13:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:13:01 INFO - Running setup.py (path:/tmp/pip-iw77DM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:13:01 INFO - Running setup.py (path:/tmp/pip-atBhZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:13:01 INFO - Running setup.py (path:/tmp/pip-L4K7gc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:13:01 INFO - Running setup.py (path:/tmp/pip-YY69mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:13:01 INFO - Running setup.py (path:/tmp/pip-NFQ0tJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:13:01 INFO - Running setup.py (path:/tmp/pip-NtgUuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:13:01 INFO - Running setup.py (path:/tmp/pip-NW1Xkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:13:01 INFO - Running setup.py (path:/tmp/pip-xPL3aW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:13:01 INFO - Running setup.py (path:/tmp/pip-4poKlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:13:02 INFO - Running setup.py (path:/tmp/pip-iBaogd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:13:02 INFO - Running setup.py (path:/tmp/pip-waj_az-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:13:02 INFO - Running setup.py (path:/tmp/pip-hnw8PT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:13:02 INFO - Running setup.py (path:/tmp/pip-aip82b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:13:02 INFO - Running setup.py (path:/tmp/pip-jxD99v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:13:02 INFO - Running setup.py (path:/tmp/pip-MC6PkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:13:02 INFO - Running setup.py (path:/tmp/pip-2D4wqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:13:02 INFO - Running setup.py (path:/tmp/pip-uws8U9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:13:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:13:02 INFO - Running setup.py install for manifestparser 07:13:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:13:02 INFO - Running setup.py install for mozcrash 07:13:02 INFO - Running setup.py install for mozdebug 07:13:02 INFO - Running setup.py install for mozdevice 07:13:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:13:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:13:03 INFO - Running setup.py install for mozfile 07:13:03 INFO - Running setup.py install for mozhttpd 07:13:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:13:03 INFO - Running setup.py install for mozinfo 07:13:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:13:03 INFO - Running setup.py install for mozInstall 07:13:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:13:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:13:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:13:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:13:03 INFO - Running setup.py install for mozleak 07:13:03 INFO - Running setup.py install for mozlog 07:13:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:13:03 INFO - Running setup.py install for moznetwork 07:13:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:13:03 INFO - Running setup.py install for mozprocess 07:13:03 INFO - Running setup.py install for mozprofile 07:13:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:13:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:13:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:13:03 INFO - Running setup.py install for mozrunner 07:13:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:13:04 INFO - Running setup.py install for mozscreenshot 07:13:04 INFO - Running setup.py install for moztest 07:13:04 INFO - Running setup.py install for mozversion 07:13:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:13:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:13:04 INFO - Cleaning up... 07:13:04 INFO - Return code: 0 07:13:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd07e38c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f086c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2048ac0>, '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 0x20499a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2049e50>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1447686406.172897-1280556760', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:13:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:13:04 INFO - Using env: {'DISPLAY': ':0', 07:13:04 INFO - 'HOME': '/home/cltbld', 07:13:04 INFO - 'LANG': 'en_US.UTF-8', 07:13:04 INFO - 'LANGUAGE': 'en_US:en', 07:13:04 INFO - 'LOGNAME': 'cltbld', 07:13:04 INFO - 'MAIL': '/var/mail/cltbld', 07:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:04 INFO - 'MOZ_NO_REMOTE': '1', 07:13:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:04 INFO - 'NO_EM_RESTART': '1', 07:13:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:04 INFO - 'PWD': '/builds/slave/test', 07:13:04 INFO - 'SHELL': '/bin/bash', 07:13:04 INFO - 'SHLVL': '1', 07:13:04 INFO - 'TERM': 'linux', 07:13:04 INFO - 'TMOUT': '86400', 07:13:04 INFO - 'USER': 'cltbld', 07:13:04 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1447686406.172897-1280556760', 07:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:04 INFO - '_': '/tools/buildbot/bin/python'} 07:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:13:04 INFO - Running setup.py (path:/tmp/pip-fK51Kx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:13:04 INFO - Running setup.py (path:/tmp/pip-obofnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:13:04 INFO - Running setup.py (path:/tmp/pip-f6PEiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:13:04 INFO - Running setup.py (path:/tmp/pip-QbX6U4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:13:04 INFO - Running setup.py (path:/tmp/pip-JMGEQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:13:04 INFO - Running setup.py (path:/tmp/pip-8vW5Pb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:13:05 INFO - Running setup.py (path:/tmp/pip-wJe_O3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:13:05 INFO - Running setup.py (path:/tmp/pip-wTQgVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:13:05 INFO - Running setup.py (path:/tmp/pip-2EdDYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:13:05 INFO - Running setup.py (path:/tmp/pip-wws1q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:13:05 INFO - Running setup.py (path:/tmp/pip-x9X7Zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:13:05 INFO - Running setup.py (path:/tmp/pip-v9Ms1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:13:05 INFO - Running setup.py (path:/tmp/pip-foi6hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:13:05 INFO - Running setup.py (path:/tmp/pip-VZBYj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:13:05 INFO - Running setup.py (path:/tmp/pip-6IUPP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:13:05 INFO - Running setup.py (path:/tmp/pip-dTz1R0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:13:05 INFO - Running setup.py (path:/tmp/pip-yZ75wa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:13:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:13: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 07:13: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 07:13: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 07:13: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 07:13: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 07:13: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 07:13:07 INFO - Downloading blessings-1.5.1.tar.gz 07:13:07 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 07:13:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:13:07 INFO - Installing collected packages: blessings 07:13:07 INFO - Running setup.py install for blessings 07:13:07 INFO - Successfully installed blessings 07:13:07 INFO - Cleaning up... 07:13:07 INFO - Return code: 0 07:13:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:13:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:13:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:13:07 INFO - Reading from file tmpfile_stdout 07:13:07 INFO - Current package versions: 07:13:07 INFO - argparse == 1.2.1 07:13:07 INFO - blessings == 1.5.1 07:13:07 INFO - blobuploader == 1.2.4 07:13:07 INFO - docopt == 0.6.1 07:13:07 INFO - manifestparser == 1.1 07:13:07 INFO - mozInstall == 1.12 07:13:07 INFO - mozcrash == 0.16 07:13:07 INFO - mozdebug == 0.1 07:13:07 INFO - mozdevice == 0.47 07:13:07 INFO - mozfile == 1.2 07:13:07 INFO - mozhttpd == 0.7 07:13:07 INFO - mozinfo == 0.9 07:13:07 INFO - mozleak == 0.1 07:13:07 INFO - mozlog == 3.0 07:13:07 INFO - moznetwork == 0.27 07:13:07 INFO - mozprocess == 0.22 07:13:07 INFO - mozprofile == 0.27 07:13:07 INFO - mozrunner == 6.11 07:13:07 INFO - mozscreenshot == 0.1 07:13:07 INFO - mozsystemmonitor == 0.0 07:13:07 INFO - moztest == 0.7 07:13:07 INFO - mozversion == 1.4 07:13:07 INFO - psutil == 3.1.1 07:13:07 INFO - requests == 1.2.3 07:13:07 INFO - wsgiref == 0.1.2 07:13:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:13: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')]} 07:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13: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')]} 07:13:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd07e38c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f086c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2048ac0>, '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 0x20499a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2049e50>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1447686406.172897-1280556760', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:13:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:13:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:13:07 INFO - Using env: {'DISPLAY': ':0', 07:13:07 INFO - 'HOME': '/home/cltbld', 07:13:07 INFO - 'LANG': 'en_US.UTF-8', 07:13:07 INFO - 'LANGUAGE': 'en_US:en', 07:13:07 INFO - 'LOGNAME': 'cltbld', 07:13:07 INFO - 'MAIL': '/var/mail/cltbld', 07:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:07 INFO - 'MOZ_NO_REMOTE': '1', 07:13:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:07 INFO - 'NO_EM_RESTART': '1', 07:13:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:07 INFO - 'PWD': '/builds/slave/test', 07:13:07 INFO - 'SHELL': '/bin/bash', 07:13:07 INFO - 'SHLVL': '1', 07:13:07 INFO - 'TERM': 'linux', 07:13:07 INFO - 'TMOUT': '86400', 07:13:07 INFO - 'USER': 'cltbld', 07:13:07 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1447686406.172897-1280556760', 07:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:07 INFO - '_': '/tools/buildbot/bin/python'} 07:13:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:13:08 INFO - Cleaning up... 07:13:08 INFO - Return code: 0 07:13:08 INFO - Running post-action listener: _resource_record_post_action 07:13:08 INFO - Running post-action listener: _start_resource_monitoring 07:13:08 INFO - Starting resource monitoring. 07:13:08 INFO - ##### 07:13:08 INFO - ##### Running install step. 07:13:08 INFO - ##### 07:13:08 INFO - Running pre-action listener: _resource_record_pre_action 07:13:08 INFO - Running main action method: install 07:13:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:13:08 INFO - Reading from file tmpfile_stdout 07:13:08 INFO - Detecting whether we're running mozinstall >=1.0... 07:13:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:13:08 INFO - Reading from file tmpfile_stdout 07:13:08 INFO - Output received: 07:13:08 INFO - Usage: mozinstall [options] installer 07:13:08 INFO - Options: 07:13:08 INFO - -h, --help show this help message and exit 07:13:08 INFO - -d DEST, --destination=DEST 07:13:08 INFO - Directory to install application into. [default: 07:13:08 INFO - "/builds/slave/test"] 07:13:08 INFO - --app=APP Application being installed. [default: firefox] 07:13:08 INFO - mkdir: /builds/slave/test/build/application 07:13:08 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'] 07:13:08 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 07:13:22 INFO - Reading from file tmpfile_stdout 07:13:22 INFO - Output received: 07:13:22 INFO - /builds/slave/test/build/application/firefox/firefox 07:13:22 INFO - Running post-action listener: _resource_record_post_action 07:13:22 INFO - ##### 07:13:22 INFO - ##### Running run-tests step. 07:13:22 INFO - ##### 07:13:22 INFO - Running pre-action listener: _resource_record_pre_action 07:13:22 INFO - Running main action method: run_tests 07:13:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:13:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:13:22 INFO - Python 2.7.3 07:13:22 INFO - Return code: 0 07:13:22 INFO - grabbing minidump binary from tooltool 07:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:22 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 0x2048ac0>, '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 0x20499a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2049e50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:13:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:13:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:13:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:13:22 INFO - Return code: 0 07:13:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:13:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:13:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:13:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:13:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:13:22 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/Z2XtXOEHRpKtWWUGC648Gg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost'] in /builds/slave/test/build 07:13:22 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/Z2XtXOEHRpKtWWUGC648Gg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost 07:13:22 INFO - Using env: {'DISPLAY': ':0', 07:13:22 INFO - 'HOME': '/home/cltbld', 07:13:22 INFO - 'LANG': 'en_US.UTF-8', 07:13:22 INFO - 'LANGUAGE': 'en_US:en', 07:13:22 INFO - 'LOGNAME': 'cltbld', 07:13:22 INFO - 'MAIL': '/var/mail/cltbld', 07:13:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:13:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:22 INFO - 'MOZ_NO_REMOTE': '1', 07:13:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:22 INFO - 'NO_EM_RESTART': '1', 07:13:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:22 INFO - 'PWD': '/builds/slave/test', 07:13:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:13:22 INFO - 'SHELL': '/bin/bash', 07:13:22 INFO - 'SHLVL': '1', 07:13:22 INFO - 'TERM': 'linux', 07:13:22 INFO - 'TMOUT': '86400', 07:13:22 INFO - 'USER': 'cltbld', 07:13:22 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1447686406.172897-1280556760', 07:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:22 INFO - '_': '/tools/buildbot/bin/python'} 07:13:22 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/Z2XtXOEHRpKtWWUGC648Gg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost'] with output_timeout 3600 07:13:22 INFO - mozversion INFO | application_buildid: 20151116063637 07:13:22 INFO - mozversion INFO | application_changeset: 37ee16bb31cf4b78973b71af1362542dfc6b64bc 07:13:22 INFO - mozversion INFO | application_display_name: Nightly 07:13:22 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:13:22 INFO - mozversion INFO | application_name: Firefox 07:13:22 INFO - mozversion INFO | application_remotingname: firefox 07:13:22 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 07:13:22 INFO - mozversion INFO | application_vendor: Mozilla 07:13:22 INFO - mozversion INFO | application_version: 45.0a1 07:13:22 INFO - mozversion INFO | platform_buildid: 20151116063637 07:13:22 INFO - mozversion INFO | platform_changeset: 37ee16bb31cf4b78973b71af1362542dfc6b64bc 07:13:22 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 07:13:22 INFO - mozversion INFO | platform_version: 45.0a1 07:13:22 INFO - 2015-11-16 07:13:22,733 DEBUG : using testdate: 1447686802 07:13:22 INFO - 2015-11-16 07:13:22,733 DEBUG : actual date: 1447686802 07:13:22 INFO - 2015-11-16 07:13:22,784 INFO : starting webserver on 'localhost:38028' 07:13:22 INFO - 2015-11-16 07:13:22,785 INFO : Starting test suite talos-linux64-ix-038.e 07:13:22 INFO - 2015-11-16 07:13:22,785 INFO : Starting test dromaeo_css 07:13:22 INFO - 2015-11-16 07:13:22,785 DEBUG : operating with platform_type : linux_ 07:13:22 INFO - 2015-11-16 07:13:22,786 INFO : Initialising browser for dromaeo_css test... 07:13:22 INFO - 2015-11-16 07:13:22,792 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4QvnUd/profile http://localhost:38028/getInfo.html 07:13:32 INFO - 2015-11-16 07:13:32,425 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:13:32 INFO - 2015-11-16 07:13:32,426 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:13:32 INFO - 2015-11-16 07:13:32,426 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:13:32 INFO - 2015-11-16 07:13:32,426 DEBUG : BROWSER_OUTPUT: __metrics 07:13:33 INFO - 2015-11-16 07:13:33,589 INFO : Browser initialized. 07:13:33 INFO - 2015-11-16 07:13:33,589 INFO : Running cycle 1/1 for dromaeo_css test... 07:13:33 INFO - 2015-11-16 07:13:33,590 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4QvnUd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:13:45 INFO - 2015-11-16 07:13:45,534 DEBUG : BROWSER_OUTPUT: RSS: Main: 141307904 07:13:45 INFO - 2015-11-16 07:13:45,534 DEBUG : BROWSER_OUTPUT: 07:14:35 INFO - 2015-11-16 07:14:35,184 DEBUG : BROWSER_OUTPUT: 1447686875182 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:16:48 INFO - 2015-11-16 07:16:48,000 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38028/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38028/tests/dromaeo/cssquery-ext.html) 07:16:49 INFO - 2015-11-16 07:16:49,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 144162816 07:16:49 INFO - 2015-11-16 07:16:49,110 DEBUG : BROWSER_OUTPUT: 07:19:51 INFO - 2015-11-16 07:19:51,052 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38028/tests/dromaeo/cssquery-ext.html (next: http://localhost:38028/tests/dromaeo/cssquery-jquery.html) 07:19:51 INFO - 2015-11-16 07:19:51,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 141717504 07:19:51 INFO - 2015-11-16 07:19:51,639 DEBUG : BROWSER_OUTPUT: 07:22:53 INFO - 2015-11-16 07:22:53,397 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38028/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38028/tests/dromaeo/cssquery-mootools.html) 07:22:53 INFO - 2015-11-16 07:22:53,986 DEBUG : BROWSER_OUTPUT: RSS: Main: 141336576 07:22:53 INFO - 2015-11-16 07:22:53,986 DEBUG : BROWSER_OUTPUT: 07:25:55 INFO - 2015-11-16 07:25:55,745 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38028/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38028/tests/dromaeo/cssquery-prototype.html) 07:25:56 INFO - 2015-11-16 07:25:56,347 DEBUG : BROWSER_OUTPUT: RSS: Main: 140681216 07:25:56 INFO - 2015-11-16 07:25:56,348 DEBUG : BROWSER_OUTPUT: 07:28:58 INFO - 2015-11-16 07:28:58,957 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38028/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38028/tests/dromaeo/cssquery-yui.html) 07:28:59 INFO - 2015-11-16 07:28:59,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 141328384 07:28:59 INFO - 2015-11-16 07:28:59,578 DEBUG : BROWSER_OUTPUT: 07:32:01 INFO - 2015-11-16 07:32:01,705 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38028/tests/dromaeo/cssquery-yui.html (next: http://localhost:38028/tests/dromaeo/cssquery-dojo.html) 07:32:01 INFO - 2015-11-16 07:32:01,963 DEBUG : BROWSER_OUTPUT: RSS: Main: 143593472 07:32:01 INFO - 2015-11-16 07:32:01,964 DEBUG : BROWSER_OUTPUT: 07:32:01 INFO - 2015-11-16 07:32:01,964 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:32:01 INFO - 2015-11-16 07:32:01,964 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:32:01 INFO - 2015-11-16 07:32:01,964 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:32:01 INFO - 2015-11-16 07:32:01,964 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:32:01 INFO - 2015-11-16 07:32:01,964 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2702.5405681034226;2745.3822889849775;2768.5016696994544;2788.8466134362616;2794.329360953371;4711.411073615798;4896.8530944071645;4942.110420124376;4960.156773348531;5002.599792016639;4826.49321821209;4838.177509823329;4838.298446725232;4920.557149856512;4949.579285760706;4470.016596348806;4478.23869942109;4537.069900670354;4544.431946006749;4571.817127314904;4484.282514797633;4534.34252033455;4583.1062942726185;4589.105124500724;4637.605803506706;4335.739855608674;4444.20004399208;4448.955510444886;4535.4103966484145;4563.018950925567;4580.587747102777;4598.057398233354;4606.861794146181;4614.353990441341;4636.768161591941;4547.431571053618;4557.726536407826;4578.931316030262;4590.74750888701;4591.931121033187;4711.505291944331;4719.056188762262;4838.564529192389;4847.3698419205275;4853.272009198613;5257.684538927677;5293.338332708411;5295.338082739658;5300.072487314743;5339.866503337409;5163.406208286057;5315.760790764425;5320.467953204688;5325.627206095575;5337.626366154371;4820.34925285082;4859.1010663027455;4867.172580661296;4907.9263811042865;4924.852254432372;5386.649867758583;5441.401445840955;5446.564274858002;5454.3454785426;5483.396826349099;4914.140025495524;5009.474005229471;5207.114790485626;5209.947900521022;5214.765335559909;5238.476152384807;5344.6258761887075;5354.063038968165;5385.542228910586;5398.838034858961;5198.2722418861385;5236.188390799432;5244.239585260116;5250.238715386247;5283.867903302448;5049.444561098277;5078.7460626968505;5200.843974680765;5210.713410762369;5243.764030618631;4004.979975100106;4008.939865902014;4014.437978682987;4029.9194016119513;4058.370952502367;3531.29374125176;3574.7318951078773;3580.1765593913547;3602.009447401933;3612.476190952297;4355.934660980088;4449.3993310902615;4456.309272062836;4552.203364411214;4575.336576196433;5280.20796880471;5288.2596436498925;5299.761510732026;5303.946960530422;5304.38999515053;4548.044910568751;4552.203364411214;4572.702774319659;4579.17574836526;4586.518415566385;4489.7979590918485;4584.88537786558;4639.907201855944;4653.627709783277;4656.580907718321;5026.070177017264;5027.899442011066;5030.195168772979;5033.119204139188;5059.418166910705;5298;5316.867078323073;5327.174287985368;5334.439883812299;5364.678119312854;4829.13075646387;4916.459189489082;4925.679830810986;4928.802847886044;5046.57104146137;5145.588352931682;5255.080360936744;5255.264263003259;5257.5005374489365;5280.603954703336;5292.629515933848;5298.046351656739;5301.787928482971;5304.734763261744;5367.302250707539;4874.902501950012;4982.277569752293;5090.898182036412;5107.489251075011;5113.8977220454635;5101.56636685871;5131.974340128276;5153.175491921274;5156.432792392909;5176.094183517945;4984.026830943175;4990.775415106256;5000.399952005782;5027.7234752087525;5070.6957582545165;5041.420236672683;5042.445331013512;5167.483251674803;5179.171332586919;5194.065068287593;4983.103041452573;4998.725070121178;5017.874553136201;5022.146235139962;5045.949540504695 07:32:01 INFO - 2015-11-16 07:32:01,964 DEBUG : BROWSER_OUTPUT: |1;ext.html;535.1998761851032;558.5392051557466;560.5095541401274;561.0574235284721;580.3645008715455;34845.65154348456;35299.64700352996;35457.46813797795;35485.822570887176;35488.64511354889;38820.80589597055;39340.606593934055;39550.80224598873;39622.8018859906;39699.603003969954;7948.284654381119;8116.310113640318;8151.592420378957;8173.305269052138;8185.8362832743305;7905.881411778828;7952.204779522031;7966.760997170065;7980.840383192332;8011.078725946503;7897.210278972086;8013.47912385696;8035.316998055172;8035.758927232163;8064.475809072421;7922.722704705337;7966.083900351447;7999.240072193133;8057.758267251992;8068.596570171527;7808.492447990862;8009.67961281548;8017.438779285452;8017.5189488630285;8023.398245131581;36683.26633467316;36815.07962300937;36926.44610330847;37055.81472092649;37081;2872.569114632801;2984.358362951954;3014.969850301513;3439.793612383265;3573.10672331917;27434.862825685945;27500.862495687594;27703.307417314525;27902.581461278096;27993.440131197465;2891.7252860978174;2994.4909365407934;2998.7750918681186;3035.3474003089223;3052.9847350763325;219054;220080;220356;220415;220438;49268.50731492639;50096.74951625219;50654;58062;59118.70440647855;53068.20397694038;53115.734421328416;53401.1989820153;53405.732971334895;53451.73274133605;13093.148945318715;13119.42566891979;13266.800997985038;13284.468621255235;13323;10521.473926303654;10522.631707890187;10554.10290125348;10630.946845265724;10717.410542420243;17171;17481.125943702766;17506.56233594145;17513.649727005388;17525.211365488583;7470.220874319086;7607.467477276648;7666.233376662289;7676.309132178131;7683.5774032427635;863.5293764898146;923.7459698582809;958.520739630185;1011.231464087299;1014.3761586624173;25221.9206950366;25262;25608.615870761954;25837.741622583533;25936.351591210372;947.7772723409993;952.885653721544;962.4802606592361;979.2068424576116;1071.1002757683427;13241.73516529664;13348.73302533944;13482.730345393038;13509.2569908654;13539.66150846217;268879;272201;274053;274858;274873;44245.55754442479;44497.110057798665;44610.55389446129;44775.77612111918;44869.775651121534;1169.7543515861764;1183.680406290314;1190.4761904761876;1193.7552801675636;1200.099925056208;24254.636180456953;24771.256862293438;24984.500309993335;25035.624465632667;25079.373015674024;39204.803975979936;39309.606903930595;39404.2119157621;39411.40882886702;39575.2084958305;254948;256045;257283;257468;257514;28390.574141387482;28607.713922860505;28758.85620571884;28861;29381.559276610442;35817.283654327286;36396;36433.45349819702;37019;37113.814430927676;30926.536101958038;31379.05862824119;31514.212144696565;31817.204569885937;31977.840110799298;31601.367972639957;31913.521297180097;31951.201219969687;32015.83992080025;32087.197820054684;32080;32164.35671286608;32318.83840580782;32752;32956.67043329632;26743.331416714736;26837;28727;29071.41857162887;29260.707392926648;21601.135954561643;22827.9182310386;23020.654690179996;23342.416439589146;23432.414189644714 07:32:01 INFO - 2015-11-16 07:32:01,964 DEBUG : BROWSER_OUTPUT: |2;jquery.html;310.6350038704522;331.90140634499824;337.3657523855152;345.55250950019723;347.2932582195233;11182.161337899659;11230.438478076105;11634.360110193937;15030.473933412333;15711.764323535142;10999.780004399907;11004.174686898474;11197.104231661468;11240.156988225875;11249.775004499905;4242.9151416971645;4379.671524635649;4379.912401751963;4381.78091095444;4383.057642606839;4252.914941701164;4332.371806088116;4332.588404101605;4334.393184954109;4341.50072741634;4327.5239723630375;4341;4645.581897629213;4839.225723884179;4844.176489996691;4778.737169455679;4783.115123702126;4784.617230621577;4792.065547218293;4819.0602832447685;3890.260850438436;3894.5910679378826;4020.0954785173394;4113.568075352075;4129.421880936671;11073.557057717682;11203.719907002309;11258.493367798386;11261.155413344031;12306;1709.4615196213279;1724.844763971236;1747.2312182639726;1747.5718448979953;1771.3623095685543;9459.858102128474;9506.764908222567;9645.565949532287;9708.126268635857;9758.853617195748;1570.8429157084315;1600.1279302779897;1615.9030458172547;1617.4662361420703;1679.521336419127;53120.73439632816;55390;56458.15312770312;56558;56784.148237776055;6646.26891041985;6796.592204467649;6797.762078327235;6828.624425656637;6841.076454678555;7847;7875.645595948196;7923.128455869965;7937.444378893538;7944.483608565425;5128.974355128201;5147.0735267651435;5187.703074231442;5280.313559237275;5282.339707536558;5333.759980800795;5376.301080859464;5398.190271459234;5413.215083812904;5413.7834486620095;3040.893568725084;3071.6006919100373;3105.4720697481484;3117.6258848938273;3123.2660324823646;1096.5613754498106;1096.923215374916;1097.5829184909842;1098.3355070182583;1120.971975700614;379.508536445304;389.8615991323096;403.519811424404;430.5393229244678;449.0883506481847;9483.668071617598;10038;10166.593336266615;10332.896671033344;10416.635417760343;395.5629029921895;409.6763556790162;415.38730372700024;417.66586730615387;424.5351340282386;5519.69641669704;5691.288588926384;5935.169076329317;6334.176557047646;6355.841103972438;505731;505737;512944;524842;525790.3394347264;36738.63261367405;36837.26325473529;40853.97865053338;59210.70394647999;70458.64770676114;442.5883927946976;447.7313611832939;451.58454222115734;456.54801746270954;456.68032377336;9825.803483930138;9906.405615663083;9944.801103978025;10065.094141527297;10071.446070466194;32664.183395415304;33254.33491330208;34041.65958340484;34246.65753342534;34366.656333436345;43507;44600.55399445964;46125.769371154274;46346;46542;5649.604527683023;5792.073268277056;5806.622569532967;5817.301923769175;5850.034744267148;10281.84577231357;10639.680809575726;10652.733681658021;10659.8934010662;10699.518521666389;9228.307876909124;9349.065093490868;9492.382995105296;9523.476208808583;9603.231741460526;9387.85918211241;9517.619295228113;9759;9831.803363932539;10101.595936162765;9974.60101595957;10505.68482945513;10641.14870810318;10778.676639700821;10804.729881753019;6354.968225158845;6417.935820641734;6421.004744264646;6459.418652321314;6462;9706.417614943126;9887.703368898945;10117.038881306264;10261.538230779484;10321.225908057077 07:32:01 INFO - 2015-11-16 07:32:01,965 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1470.801441805356;1591.9920400397996;1634.795650543682;1652.1821698259364;1668.783058202434;6808.659567021654;6896.448284137269;6925.961105834127;7064.293570642933;7080.539764915284;7386.963065184666;7395.704171833134;7427.665755041023;7435.702571897131;7476.738314159005;2066.72099266599;2104.947376315589;2107.1360742095744;2107.9683804742863;2112.091800525773;2117.7564580073335;2122.596706625744;2135.6155891939443;2140.743110826703;2145.7639659637507;2050.7539095308584;2094.4030951178916;2097.339338108491;2108.156737305075;2139.80741733244;2012.456636708088;2095.423758466419;2095.5913596848623;2098.223657246821;2100.7584127825266;2004.0681083296192;2042.6425375559218;2050.63088644044;2051.3333166720877;2052.6818343156683;7218.4586156037985;7251.891221631679;7258.854822903565;7306.561606303639;7312.597807120606;4280.272353699878;4313.61177494027;4329.9567004329865;4349.173657005159;4359.651227901792;2914.2714321419644;2931.662858771247;2962.3927094945484;2985.596944412498;2996.4007198560157;858.5406807358096;869.3002133282705;918.8759517465123;935.4808081514757;973.4062222044547;9796.412215267106;9909.058639429242;9930.90069099307;9940;9950.651727189586;3738.7569807962395;3854.325493038707;3870.748401353903;3877.5734669186368;3879.4956655634587;7484.887726684104;7538.434617403716;7560.9621951889885;7564.940908272846;7567.697292108254;4239.173361194537;4242.4272723181975;4243.087736136746;4278.272693642089;4278.315469524861;3915.7258991870294;3917.353636649978;3936.7441116327345;3951.427043078795;3959.40608908666;3087.9536806947913;3128;3138.10563989262;3145.9213519661735;3147.35479226758;947.9004704506066;974.7222041718077;976.1312431935582;977.5307852230969;978.2320878110648;774.6823802241054;803.1045384396356;909.6997990663066;917.6421195733669;978.3787295067541;6672.065910772496;6761.594304341756;6783.287754785775;6795.422389096982;6801.489888258301;1023.8054769593754;1029.0481304793036;1030.9329893557044;1048.308116643012;1060.3531845574194;5198.9740051299505;5282.260483532308;5283.07546179417;5284.154535274414;5288.338957630296;8445.704400345958;8448.155184481502;8636.395452318404;8662.566871656392;8706.869396959051;8628.956855215683;8719.346049046348;8744.038155802857;8770;8847.336449766293;6716.5634233774645;6848.287928017996;6851;6864.0047193156715;6871.793846184622;6595.637239951849;6611.504137189634;6623.701933412912;6625.635590042594;6656.068150458843;7601.467897247139;7745.690172393041;7749.263819937097;7814.53112813233;7829.177936316605;7730.613469326398;7924.881126783218;7974.082980457089;7998.400119990907;8024.358051355995;6057.454829065406;6100.8779824404155;6133.141360209664;6135.171751813448;6152.169457123231;6615.305392933865;6774.491913106438;6789.72841086351;6813.182418109858;6850.520463567503;6413.35866413355;6429.421352078149;6517.967410162919;6632.204135503771;6763.7632682855865;5418.078926582411;6208.875822483616;6243.282022567463;6253.405926436982;6264.373562643699;6435.163428754232;6492.091107245084;6496.220453545605;6496.577722448026;6504.772332968323;5925.851853703692;5936.28764548257;5998.190244316961;6023.1266466363;6042.335343112166;6055.848603784941;6094.542909281733;6113.480354169767;6113.816585502442;6142.570020098729 07:32:01 INFO - 2015-11-16 07:32:01,965 DEBUG : BROWSER_OUTPUT: |4;prototype.html;307.5279446050313;316.2504863473568;316.5915968400763;319.29595242490313;321.1281371077524;5598.412166722492;5679.744411501482;5799.710014499279;5862;5875.559333050017;5678.772849086042;5711.7715291388395;5727.828165155052;5733.799317023905;5735.684537350444;4188.497380314367;4285.164392943378;4326.913461730764;4360.6293465055505;4376.846810361638;4277.422547956033;4312.762798046107;4318.417013703157;4322.04914918719;4326.0266440051055;4263.616274535291;4271.551487093857;4275.080857615612;4277.657787377002;4280.871573852789;4264.658827293809;4269.6370808481315;4271.636910862565;4285.785710714452;4296.8281268749215;3598.226381328001;3683.521142251517;3684.889453316405;3685.060309621056;3692.5015122958325;5300;5443.129099344086;5451.509364157205;5485.149801780691;5489;4929.433115191763;4930.063287975309;4935.90128197434;4936.531029552187;4957.876053098701;5922.733476993502;5947.702614869282;5958.880822383571;5963;5984.281886173687;3872.7289089763726;4007.338789099824;4012.3580227163807;4017.357222844331;4056.9594304056877;6165;6245.656488893109;6264.718087686065;6266.467350275278;6277.811665650038;4126.803227064178;4144.958550414457;4162.41726158338;4165.437665915063;4170.145120250341;4188.4555007848785;4215;4219.936700949488;4223.450951376363;4226.197022565702;4704.9059018819435;4742.620590352763;4829.323894654751;4880.292357608127;4915.066137433948;5954.46409823118;5970.104484327298;5979.880402391927;5984.042553191555;5987.072003839412;1455.6724736934104;1460.9634759130895;1476.217604669527;1480.592836969842;1484.2578710644677;950.8431108867098;953.5137080089204;957.1194501059042;957.6736220334748;968.1093394077466;5194.454582268883;5201.335572616802;5217.478252174752;5220.216967454836;5238.7904483820985;6163;6167.321594624587;6168.167297414881;6179.918514259986;6186.783462578788;5181.740912954338;5189.169732842803;5194.883100133489;5199.194124910645;5206.323177986837;3251.64231934487;3308.4210263203845;3356.9160770980434;3378.391889459921;3387.3733359328603;5870.911936320958;5874.236349274567;5877.735501902424;5879.823605291848;5891.7054147292465;6371.39471750183;6392.328805475451;6400.855713336085;6412.775552855721;6432.903506447407;5679.091345384636;5851.824445266649;5855.853603659943;5871.823845284648;5874;6181.783637572664;6224.190855188796;6230.657313847601;6248.562600617913;6252.030935205051;6089.391060893875;6101.572889897665;6103.969480152571;6111.541634377529;6123.601965872204;5723.599348045597;5825.126231065374;5865.824025279248;5872.442117998783;5882.823515294548;4148.958510414978;4190.224808410454;4194.182134483746;4200.516940551754;4206.390073439396;6056.6971651418135;6158.261008678987;6214.8135555933395;6223.502119830312;6227.782027629011;5926.436988486087;5945.970270148621;5960.493358064613;5971.193888825127;5971.716081042597;5950.702464876826;5950.880982380241;5958.821235362946;5962.105684147239;5964.105384192406;5703.600747947604;5826.446487583673;5838.1826544282985;5839;5857.355690874086;6001.699915004319;6013.609115407485;6030.487408570145;6037.0642550404755;6042.335343112166;5799.594028417971;5860.824175274749;5869.706514674163;5870.823875283749;5873.119032145041 07:32:01 INFO - 2015-11-16 07:32:01,966 DEBUG : BROWSER_OUTPUT: |5;yui.html;738.5716284554959;746.3394895517465;747.178104085506;748.0723902361073;768.9769306920795;10497.895021049788;11622.651320460389;11626.302421854694;11699.883001169996;11717.589884354049;11407.600733974312;11420.600278990238;11485.483153258103;11518;11540.769184616303;740.6481921087494;756.0473803008222;761.7181642792175;769.3729610367533;770.4221833624781;746.8468963862422;755.3994574313407;760.2131793593632;765.0857225615392;765.2882818978347;776.6194564663331;783.9372850172001;785.2540086917422;789.3172405868911;792.18405042806;772.9574873381962;777.3780975219802;779.4271210660161;779.5751315532991;780.4341852157197;571.6427232979388;572.2617823008314;573.2690819205546;575.8243735660621;576.700115939709;10810.567577296899;10882.183836212316;10894.128469722404;10908.836367454494;10973.725656858562;8637.093105223987;8966.103389661046;9189.77025574366;9418.246540276761;9487.573059212284;8907.510086945216;8938.955305223431;9087.091290870927;9169.862452063224;9285.442873427548;2721.306066952934;2826.364068084685;2879.1074766822353;2901.5937768712397;2927.7657787376957;38059.61940380588;38098.428523572446;38249.617503824884;38363.23273534542;38957.22085558273;6581.86836263272;6589.0116482528;6603.70283337251;6626.304238055031;6662.733490660319;10236.897631023594;10248.128909042814;10274.897251027394;10307.484625768682;10309.020643038899;5294.285271488377;5426.186072089218;5504.91742623861;5551.833444996657;5634.04221282383;3198.6001749781276;3223;3245.5618491503815;3306.9338613228083;3381.985404378677;2355.0579768092557;2386.97613023871;2387.594109001474;2393.210240620591;2395.8322917395617;380.56425392924945;387.68791123145576;391.8843941037401;393.62408899500906;394.40051122293954;539.4982666120467;581.1312088427743;592.6977241606811;602.6896148483535;613.9631622102688;7454.962725186339;7731.149573546905;7847.6468558914985;7871.0948240951875;7897.644605992744;491.8549028036738;492.82504710827857;500.47200203785354;504.46778648525424;578.9128751017828;3641.9635803642154;3700.703943684499;3764.642358975893;3778.5654649715634;3781.357169281229;49589.50410495849;50051.49948500541;50349.49650503521;50989.49010509848;51210.743946280774;46103.30845037327;46183.53816461859;46470.5352946473;46582;46686.29970550445;39009.80495097563;39310.80344598259;40107.59892401097;40498.190036199114;40867.38698919518;7722.227777222233;7730.188330225245;8005.3995950305125;8064.55644939534;8575.95712021436;31394.843025784725;32486.35027299488;32713.34573308568;33300;33342.333153337284;39285;39631.20737585174;39661.80169099251;39707;40640.59359406368;6475.190601174853;6638.734450621921;7081.787546373617;7177.856442871009;7331.3768329692575;10526.526306316387;10625.468726563795;10664.306820056672;10856.728581785519;10867.891321086689;9393.201577865684;9541.761455963657;9594.472304023067;9652.27607929394;9689.27330450205;10373.948130259603;10684.09185219265;10748.301360411548;10842.349459032483;10877.292975956538;10720.35677859331;10723.463826808784;10744.46277686097;10767.6231331903;10917.508712107816;9355.111264429868;9387.249020078241;9563.569639366384;9698.9030109698;9718.562664679965;8970.820583588162;9771.755706107404;9804.607815687292;9813.26400519978;9856.605735770489 07:32:01 INFO - 2015-11-16 07:32:01,966 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:32:01 INFO - 2015-11-16 07:32:01,966 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:32:01 INFO - 2015-11-16 07:32:01,966 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,302 07:32:01 INFO - 2015-11-16 07:32:01,966 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:32:01 INFO - 2015-11-16 07:32:01,966 DEBUG : BROWSER_OUTPUT: __startTimestamp1447687921957__endTimestamp 07:32:01 INFO - 2015-11-16 07:32:01,967 DEBUG : BROWSER_OUTPUT: 07:32:01 INFO - 2015-11-16 07:32:01,967 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:32:01 INFO - 2015-11-16 07:32:01,967 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:32:01 INFO - 2015-11-16 07:32:01,967 DEBUG : BROWSER_OUTPUT: 07:32:01 INFO - 2015-11-16 07:32:01,967 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4834.88 Median:4984.03 stddev:549.48 (11.0%) stddev-sans-first:525.09 07:32:01 INFO - 2015-11-16 07:32:01,968 DEBUG : BROWSER_OUTPUT: Values: 2702.5 2745.4 2768.5 2788.8 2794.3 4711.4 4896.9 4942.1 4960.2 5002.6 4826.5 4838.2 4838.3 4920.6 4949.6 4470.0 4478.2 4537.1 4544.4 4571.8 4484.3 4534.3 4583.1 4589.1 4637.6 4335.7 4444.2 4449.0 4535.4 4563.0 4580.6 4598.1 4606.9 4614.4 4636.8 4547.4 4557.7 4578.9 4590.7 4591.9 4711.5 4719.1 4838.6 4847.4 4853.3 5257.7 5293.3 5295.3 5300.1 5339.9 5163.4 5315.8 5320.5 5325.6 5337.6 4820.3 4859.1 4867.2 4907.9 4924.9 5386.6 5441.4 5446.6 5454.3 5483.4 4914.1 5009.5 5207.1 5209.9 5214.8 5238.5 5344.6 5354.1 5385.5 5398.8 5198.3 5236.2 5244.2 5250.2 5283.9 5049.4 5078.7 5200.8 5210.7 5243.8 4005.0 4008.9 4014.4 4029.9 4058.4 3531.3 3574.7 3580.2 3602.0 3612.5 4355.9 4449.4 4456.3 4552.2 4575.3 5280.2 5288.3 5299.8 5303.9 5304.4 4548.0 4552.2 4572.7 4579.2 4586.5 4489.8 4584.9 4639.9 4653.6 4656.6 5026.1 5027.9 5030.2 5033.1 5059.4 5298.0 5316.9 5327.2 5334.4 5364.7 4829.1 4916.5 4925.7 4928.8 5046.6 5145.6 5255.1 5255.3 5257.5 5280.6 5292.6 5298.0 5301.8 5304.7 5367.3 4874.9 4982.3 5090.9 5107.5 5113.9 5101.6 5132.0 5153.2 5156.4 5176.1 4984.0 4990.8 5000.4 5027.7 5070.7 5041.4 5042.4 5167.5 5179.2 5194.1 4983.1 4998.7 5017.9 5022.1 5045.9 07:32:01 INFO - 2015-11-16 07:32:01,968 DEBUG : BROWSER_OUTPUT: 07:32:01 INFO - 2015-11-16 07:32:01,968 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40404.85 Median:32083.60 stddev:65421.54 (203.9%) stddev-sans-first:65536.58 07:32:01 INFO - 2015-11-16 07:32:01,969 DEBUG : BROWSER_OUTPUT: Values: 535.2 558.5 560.5 561.1 580.4 34845.7 35299.6 35457.5 35485.8 35488.6 38820.8 39340.6 39550.8 39622.8 39699.6 7948.3 8116.3 8151.6 8173.3 8185.8 7905.9 7952.2 7966.8 7980.8 8011.1 7897.2 8013.5 8035.3 8035.8 8064.5 7922.7 7966.1 7999.2 8057.8 8068.6 7808.5 8009.7 8017.4 8017.5 8023.4 36683.3 36815.1 36926.4 37055.8 37081.0 2872.6 2984.4 3015.0 3439.8 3573.1 27434.9 27500.9 27703.3 27902.6 27993.4 2891.7 2994.5 2998.8 3035.3 3053.0 219054.0 220080.0 220356.0 220415.0 220438.0 49268.5 50096.7 50654.0 58062.0 59118.7 53068.2 53115.7 53401.2 53405.7 53451.7 13093.1 13119.4 13266.8 13284.5 13323.0 10521.5 10522.6 10554.1 10630.9 10717.4 17171.0 17481.1 17506.6 17513.6 17525.2 7470.2 7607.5 7666.2 7676.3 7683.6 863.5 923.7 958.5 1011.2 1014.4 25221.9 25262.0 25608.6 25837.7 25936.4 947.8 952.9 962.5 979.2 1071.1 13241.7 13348.7 13482.7 13509.3 13539.7 268879.0 272201.0 274053.0 274858.0 274873.0 44245.6 44497.1 44610.6 44775.8 44869.8 1169.8 1183.7 1190.5 1193.8 1200.1 24254.6 24771.3 24984.5 25035.6 25079.4 39204.8 39309.6 39404.2 39411.4 39575.2 254948.0 256045.0 257283.0 257468.0 257514.0 28390.6 28607.7 28758.9 28861.0 29381.6 35817.3 36396.0 36433.5 37019.0 37113.8 30926.5 31379.1 31514.2 31817.2 31977.8 31601.4 31913.5 31951.2 32015.8 32087.2 32080.0 32164.4 32318.8 32752.0 32956.7 26743.3 26837.0 28727.0 29071.4 29260.7 21601.1 22827.9 23020.7 23342.4 23432.4 07:32:01 INFO - 2015-11-16 07:32:01,969 DEBUG : BROWSER_OUTPUT: 07:32:01 INFO - 2015-11-16 07:32:01,969 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24690.10 Median:4379.79 stddev:84207.76 (1922.6%) stddev-sans-first:84424.08 07:32:01 INFO - 2015-11-16 07:32:01,969 DEBUG : BROWSER_OUTPUT: Values: 310.6 331.9 337.4 345.6 347.3 11182.2 11230.4 11634.4 15030.5 15711.8 10999.8 11004.2 11197.1 11240.2 11249.8 4242.9 4379.7 4379.9 4381.8 4383.1 4252.9 4332.4 4332.6 4334.4 4341.5 4327.5 4341.0 4645.6 4839.2 4844.2 4778.7 4783.1 4784.6 4792.1 4819.1 3890.3 3894.6 4020.1 4113.6 4129.4 11073.6 11203.7 11258.5 11261.2 12306.0 1709.5 1724.8 1747.2 1747.6 1771.4 9459.9 9506.8 9645.6 9708.1 9758.9 1570.8 1600.1 1615.9 1617.5 1679.5 53120.7 55390.0 56458.2 56558.0 56784.1 6646.3 6796.6 6797.8 6828.6 6841.1 7847.0 7875.6 7923.1 7937.4 7944.5 5129.0 5147.1 5187.7 5280.3 5282.3 5333.8 5376.3 5398.2 5413.2 5413.8 3040.9 3071.6 3105.5 3117.6 3123.3 1096.6 1096.9 1097.6 1098.3 1121.0 379.5 389.9 403.5 430.5 449.1 9483.7 10038.0 10166.6 10332.9 10416.6 395.6 409.7 415.4 417.7 424.5 5519.7 5691.3 5935.2 6334.2 6355.8 505731.0 505737.0 512944.0 524842.0 525790.3 36738.6 36837.3 40854.0 59210.7 70458.6 442.6 447.7 451.6 456.5 456.7 9825.8 9906.4 9944.8 10065.1 10071.4 32664.2 33254.3 34041.7 34246.7 34366.7 43507.0 44600.6 46125.8 46346.0 46542.0 5649.6 5792.1 5806.6 5817.3 5850.0 10281.8 10639.7 10652.7 10659.9 10699.5 9228.3 9349.1 9492.4 9523.5 9603.2 9387.9 9517.6 9759.0 9831.8 10101.6 9974.6 10505.7 10641.1 10778.7 10804.7 6355.0 6417.9 6421.0 6459.4 6462.0 9706.4 9887.7 10117.0 10261.5 10321.2 07:32:01 INFO - 2015-11-16 07:32:01,969 DEBUG : BROWSER_OUTPUT: 07:32:01 INFO - 2015-11-16 07:32:01,969 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4999.22 Median:6421.39 stddev:2593.08 (40.4%) stddev-sans-first:2586.79 07:32:01 INFO - 2015-11-16 07:32:01,970 DEBUG : BROWSER_OUTPUT: Values: 1470.8 1592.0 1634.8 1652.2 1668.8 6808.7 6896.4 6926.0 7064.3 7080.5 7387.0 7395.7 7427.7 7435.7 7476.7 2066.7 2104.9 2107.1 2108.0 2112.1 2117.8 2122.6 2135.6 2140.7 2145.8 2050.8 2094.4 2097.3 2108.2 2139.8 2012.5 2095.4 2095.6 2098.2 2100.8 2004.1 2042.6 2050.6 2051.3 2052.7 7218.5 7251.9 7258.9 7306.6 7312.6 4280.3 4313.6 4330.0 4349.2 4359.7 2914.3 2931.7 2962.4 2985.6 2996.4 858.5 869.3 918.9 935.5 973.4 9796.4 9909.1 9930.9 9940.0 9950.7 3738.8 3854.3 3870.7 3877.6 3879.5 7484.9 7538.4 7561.0 7564.9 7567.7 4239.2 4242.4 4243.1 4278.3 4278.3 3915.7 3917.4 3936.7 3951.4 3959.4 3088.0 3128.0 3138.1 3145.9 3147.4 947.9 974.7 976.1 977.5 978.2 774.7 803.1 909.7 917.6 978.4 6672.1 6761.6 6783.3 6795.4 6801.5 1023.8 1029.0 1030.9 1048.3 1060.4 5199.0 5282.3 5283.1 5284.2 5288.3 8445.7 8448.2 8636.4 8662.6 8706.9 8629.0 8719.3 8744.0 8770.0 8847.3 6716.6 6848.3 6851.0 6864.0 6871.8 6595.6 6611.5 6623.7 6625.6 6656.1 7601.5 7745.7 7749.3 7814.5 7829.2 7730.6 7924.9 7974.1 7998.4 8024.4 6057.5 6100.9 6133.1 6135.2 6152.2 6615.3 6774.5 6789.7 6813.2 6850.5 6413.4 6429.4 6518.0 6632.2 6763.8 5418.1 6208.9 6243.3 6253.4 6264.4 6435.2 6492.1 6496.2 6496.6 6504.8 5925.9 5936.3 5998.2 6023.1 6042.3 6055.8 6094.5 6113.5 6113.8 6142.6 07:32:01 INFO - 2015-11-16 07:32:01,970 DEBUG : BROWSER_OUTPUT: 07:32:01 INFO - 2015-11-16 07:32:01,970 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4915.28 Median:5717.69 stddev:1483.36 (25.9%) stddev-sans-first:1446.65 07:32:01 INFO - 2015-11-16 07:32:01,970 DEBUG : BROWSER_OUTPUT: Values: 307.5 316.3 316.6 319.3 321.1 5598.4 5679.7 5799.7 5862.0 5875.6 5678.8 5711.8 5727.8 5733.8 5735.7 4188.5 4285.2 4326.9 4360.6 4376.8 4277.4 4312.8 4318.4 4322.0 4326.0 4263.6 4271.6 4275.1 4277.7 4280.9 4264.7 4269.6 4271.6 4285.8 4296.8 3598.2 3683.5 3684.9 3685.1 3692.5 5300.0 5443.1 5451.5 5485.1 5489.0 4929.4 4930.1 4935.9 4936.5 4957.9 5922.7 5947.7 5958.9 5963.0 5984.3 3872.7 4007.3 4012.4 4017.4 4057.0 6165.0 6245.7 6264.7 6266.5 6277.8 4126.8 4145.0 4162.4 4165.4 4170.1 4188.5 4215.0 4219.9 4223.5 4226.2 4704.9 4742.6 4829.3 4880.3 4915.1 5954.5 5970.1 5979.9 5984.0 5987.1 1455.7 1461.0 1476.2 1480.6 1484.3 950.8 953.5 957.1 957.7 968.1 5194.5 5201.3 5217.5 5220.2 5238.8 6163.0 6167.3 6168.2 6179.9 6186.8 5181.7 5189.2 5194.9 5199.2 5206.3 3251.6 3308.4 3356.9 3378.4 3387.4 5870.9 5874.2 5877.7 5879.8 5891.7 6371.4 6392.3 6400.9 6412.8 6432.9 5679.1 5851.8 5855.9 5871.8 5874.0 6181.8 6224.2 6230.7 6248.6 6252.0 6089.4 6101.6 6104.0 6111.5 6123.6 5723.6 5825.1 5865.8 5872.4 5882.8 4149.0 4190.2 4194.2 4200.5 4206.4 6056.7 6158.3 6214.8 6223.5 6227.8 5926.4 5946.0 5960.5 5971.2 5971.7 5950.7 5950.9 5958.8 5962.1 5964.1 5703.6 5826.4 5838.2 5839.0 5857.4 6001.7 6013.6 6030.5 6037.1 6042.3 5799.6 5860.8 5869.7 5870.8 5873.1 07:32:01 INFO - 2015-11-16 07:32:01,971 DEBUG : BROWSER_OUTPUT: 07:32:01 INFO - 2015-11-16 07:32:01,971 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11771.53 Median:25426.98 stddev:13973.19 (55.0%) stddev-sans-first:13987.82 07:32:01 INFO - 2015-11-16 07:32:01,971 DEBUG : BROWSER_OUTPUT: Values: 738.6 746.3 747.2 748.1 769.0 10497.9 11622.7 11626.3 11699.9 11717.6 11407.6 11420.6 11485.5 11518.0 11540.8 740.6 756.0 761.7 769.4 770.4 746.8 755.4 760.2 765.1 765.3 776.6 783.9 785.3 789.3 792.2 773.0 777.4 779.4 779.6 780.4 571.6 572.3 573.3 575.8 576.7 10810.6 10882.2 10894.1 10908.8 10973.7 8637.1 8966.1 9189.8 9418.2 9487.6 8907.5 8939.0 9087.1 9169.9 9285.4 2721.3 2826.4 2879.1 2901.6 2927.8 38059.6 38098.4 38249.6 38363.2 38957.2 6581.9 6589.0 6603.7 6626.3 6662.7 10236.9 10248.1 10274.9 10307.5 10309.0 5294.3 5426.2 5504.9 5551.8 5634.0 3198.6 3223.0 3245.6 3306.9 3382.0 2355.1 2387.0 2387.6 2393.2 2395.8 380.6 387.7 391.9 393.6 394.4 539.5 581.1 592.7 602.7 614.0 7455.0 7731.1 7847.6 7871.1 7897.6 491.9 492.8 500.5 504.5 578.9 3642.0 3700.7 3764.6 3778.6 3781.4 49589.5 50051.5 50349.5 50989.5 51210.7 46103.3 46183.5 46470.5 46582.0 46686.3 39009.8 39310.8 40107.6 40498.2 40867.4 7722.2 7730.2 8005.4 8064.6 8576.0 31394.8 32486.4 32713.3 33300.0 33342.3 39285.0 39631.2 39661.8 39707.0 40640.6 6475.2 6638.7 7081.8 7177.9 7331.4 10526.5 10625.5 10664.3 10856.7 10867.9 9393.2 9541.8 9594.5 9652.3 9689.3 10373.9 10684.1 10748.3 10842.3 10877.3 10720.4 10723.5 10744.5 10767.6 10917.5 9355.1 9387.2 9563.6 9698.9 9718.6 8970.8 9771.8 9804.6 9813.3 9856.6 07:32:01 INFO - 2015-11-16 07:32:01,971 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:32:01 INFO - 2015-11-16 07:32:01,971 DEBUG : BROWSER_OUTPUT: 07:32:02 INFO - 2015-11-16 07:32:02,737 INFO : Browser exited with error code: 0 07:32:02 INFO - 2015-11-16 07:32:02,758 INFO : Completed test dromaeo_css (00:18:39) 07:32:02 INFO - 2015-11-16 07:32:02,758 INFO : Starting test kraken 07:32:02 INFO - 2015-11-16 07:32:02,758 DEBUG : operating with platform_type : linux_ 07:32:02 INFO - 2015-11-16 07:32:02,759 INFO : Initialising browser for kraken test... 07:32:02 INFO - 2015-11-16 07:32:02,765 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7VemVj/profile http://localhost:38028/getInfo.html 07:32:08 INFO - 2015-11-16 07:32:08,095 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:32:08 INFO - 2015-11-16 07:32:08,095 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:32:08 INFO - 2015-11-16 07:32:08,095 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:32:08 INFO - 2015-11-16 07:32:08,095 DEBUG : BROWSER_OUTPUT: __metrics 07:32:09 INFO - 2015-11-16 07:32:09,246 INFO : Browser initialized. 07:32:09 INFO - 2015-11-16 07:32:09,247 INFO : Running cycle 1/1 for kraken test... 07:32:09 INFO - 2015-11-16 07:32:09,247 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7VemVj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:32:21 INFO - 2015-11-16 07:32:21,157 DEBUG : BROWSER_OUTPUT: RSS: Main: 140988416 07:32:21 INFO - 2015-11-16 07:32:21,158 DEBUG : BROWSER_OUTPUT: 07:32:23 INFO - 2015-11-16 07:32:23,719 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38028/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38028/tests/kraken/driver.html?testName=audio-beat-detection) 07:32:24 INFO - 2015-11-16 07:32:24,329 DEBUG : BROWSER_OUTPUT: RSS: Main: 141926400 07:32:24 INFO - 2015-11-16 07:32:24,329 DEBUG : BROWSER_OUTPUT: 07:32:27 INFO - 2015-11-16 07:32:27,127 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38028/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38028/tests/kraken/driver.html?testName=audio-dft) 07:32:27 INFO - 2015-11-16 07:32:27,728 DEBUG : BROWSER_OUTPUT: RSS: Main: 142262272 07:32:27 INFO - 2015-11-16 07:32:27,728 DEBUG : BROWSER_OUTPUT: 07:32:30 INFO - 2015-11-16 07:32:30,668 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38028/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38028/tests/kraken/driver.html?testName=audio-fft) 07:32:31 INFO - 2015-11-16 07:32:31,249 DEBUG : BROWSER_OUTPUT: RSS: Main: 135970816 07:32:31 INFO - 2015-11-16 07:32:31,250 DEBUG : BROWSER_OUTPUT: 07:32:33 INFO - 2015-11-16 07:32:33,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38028/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38028/tests/kraken/driver.html?testName=audio-oscillator) 07:32:33 INFO - 2015-11-16 07:32:33,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 136941568 07:32:33 INFO - 2015-11-16 07:32:33,863 DEBUG : BROWSER_OUTPUT: 07:32:36 INFO - 2015-11-16 07:32:36,098 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38028/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38028/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:32:36 INFO - 2015-11-16 07:32:36,684 DEBUG : BROWSER_OUTPUT: RSS: Main: 138735616 07:32:36 INFO - 2015-11-16 07:32:36,684 DEBUG : BROWSER_OUTPUT: 07:32:39 INFO - 2015-11-16 07:32:39,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38028/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38028/tests/kraken/driver.html?testName=imaging-darkroom) 07:32:40 INFO - 2015-11-16 07:32:40,382 DEBUG : BROWSER_OUTPUT: RSS: Main: 138633216 07:32:40 INFO - 2015-11-16 07:32:40,382 DEBUG : BROWSER_OUTPUT: 07:32:43 INFO - 2015-11-16 07:32:43,858 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38028/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38028/tests/kraken/driver.html?testName=imaging-desaturate) 07:32:44 INFO - 2015-11-16 07:32:44,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 136196096 07:32:44 INFO - 2015-11-16 07:32:44,459 DEBUG : BROWSER_OUTPUT: 07:32:47 INFO - 2015-11-16 07:32:47,406 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38028/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38028/tests/kraken/driver.html?testName=json-parse-financial) 07:32:48 INFO - 2015-11-16 07:32:48,007 DEBUG : BROWSER_OUTPUT: RSS: Main: 137252864 07:32:48 INFO - 2015-11-16 07:32:48,008 DEBUG : BROWSER_OUTPUT: 07:32:49 INFO - 2015-11-16 07:32:49,757 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38028/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38028/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:32:50 INFO - 2015-11-16 07:32:50,348 DEBUG : BROWSER_OUTPUT: RSS: Main: 138690560 07:32:50 INFO - 2015-11-16 07:32:50,348 DEBUG : BROWSER_OUTPUT: 07:32:52 INFO - 2015-11-16 07:32:52,260 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38028/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38028/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:32:52 INFO - 2015-11-16 07:32:52,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 138227712 07:32:52 INFO - 2015-11-16 07:32:52,875 DEBUG : BROWSER_OUTPUT: 07:32:55 INFO - 2015-11-16 07:32:55,012 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38028/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38028/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:32:55 INFO - 2015-11-16 07:32:55,614 DEBUG : BROWSER_OUTPUT: RSS: Main: 138887168 07:32:55 INFO - 2015-11-16 07:32:55,614 DEBUG : BROWSER_OUTPUT: 07:32:58 INFO - 2015-11-16 07:32:58,177 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38028/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38028/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:32:58 INFO - 2015-11-16 07:32:58,778 DEBUG : BROWSER_OUTPUT: RSS: Main: 138768384 07:32:58 INFO - 2015-11-16 07:32:58,778 DEBUG : BROWSER_OUTPUT: 07:33:01 INFO - 2015-11-16 07:33:01,454 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38028/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38028/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:33:02 INFO - 2015-11-16 07:33:02,043 DEBUG : BROWSER_OUTPUT: RSS: Main: 138227712 07:33:02 INFO - 2015-11-16 07:33:02,043 DEBUG : BROWSER_OUTPUT: 07:33:03 INFO - 2015-11-16 07:33:03,803 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38028/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38028/tests/kraken/driver.html?testName=ai-astar) 07:33:04 INFO - 2015-11-16 07:33:04,054 DEBUG : BROWSER_OUTPUT: RSS: Main: 138436608 07:33:04 INFO - 2015-11-16 07:33:04,054 DEBUG : BROWSER_OUTPUT: 07:33:04 INFO - 2015-11-16 07:33:04,054 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:33:04 INFO - 2015-11-16 07:33:04,054 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:33:04 INFO - 2015-11-16 07:33:04,054 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:33:04 INFO - 2015-11-16 07:33:04,055 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:33:04 INFO - 2015-11-16 07:33:04,055 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;107;113;112;113;124;112;114;111;111 07:33:04 INFO - 2015-11-16 07:33:04,055 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;136;169;166;141;163;157;133;176;141 07:33:04 INFO - 2015-11-16 07:33:04,055 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;165;165;165;164;166;170;164;165;164 07:33:04 INFO - 2015-11-16 07:33:04,055 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;74;74;74;142;73;72;73;74 07:33:04 INFO - 2015-11-16 07:33:04,056 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;92;130;92;92;92;126;92;91;134 07:33:04 INFO - 2015-11-16 07:33:04,056 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;111;110;110;111;110;111;110;110 07:33:04 INFO - 2015-11-16 07:33:04,056 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;149;149;151;150;149;148;149;149;150 07:33:04 INFO - 2015-11-16 07:33:04,056 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;97;96;96;97;96;97;97;95 07:33:04 INFO - 2015-11-16 07:33:04,056 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;72;72;73;72;72;73;71;70;71 07:33:04 INFO - 2015-11-16 07:33:04,056 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;69;69;79;69;69;68;69 07:33:04 INFO - 2015-11-16 07:33:04,056 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;82;83;85;86;84;84;94;85;87 07:33:04 INFO - 2015-11-16 07:33:04,056 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;122;139;124;124;122;130;129;131;130 07:33:04 INFO - 2015-11-16 07:33:04,057 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;149;150;149;151;164;153;161;142;165 07:33:04 INFO - 2015-11-16 07:33:04,057 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;71;72;73;70;69;71;70;71;69 07:33:04 INFO - 2015-11-16 07:33:04,057 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:33:04 INFO - 2015-11-16 07:33:04,057 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:33:04 INFO - 2015-11-16 07:33:04,057 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,774 07:33:04 INFO - 2015-11-16 07:33:04,057 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:33:04 INFO - 2015-11-16 07:33:04,057 DEBUG : BROWSER_OUTPUT: __startTimestamp1447687984052__endTimestamp 07:33:04 INFO - 2015-11-16 07:33:04,058 DEBUG : BROWSER_OUTPUT: 07:33:04 INFO - 2015-11-16 07:33:04,061 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:33:04 INFO - 2015-11-16 07:33:04,061 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:33:04 INFO - 2015-11-16 07:33:04,061 DEBUG : BROWSER_OUTPUT: 07:33:04 INFO - 2015-11-16 07:33:04,061 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:4.32 (3.8%) stddev-sans-first:4.58 07:33:04 INFO - 2015-11-16 07:33:04,061 DEBUG : BROWSER_OUTPUT: Values: 113.0 107.0 113.0 112.0 113.0 124.0 112.0 114.0 111.0 111.0 07:33:04 INFO - 2015-11-16 07:33:04,061 DEBUG : BROWSER_OUTPUT: 07:33:04 INFO - 2015-11-16 07:33:04,062 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:154.00 Median:160.50 stddev:15.14 (9.4%) stddev-sans-first:15.99 07:33:04 INFO - 2015-11-16 07:33:04,062 DEBUG : BROWSER_OUTPUT: Values: 158.0 136.0 169.0 166.0 141.0 163.0 157.0 133.0 176.0 141.0 07:33:04 INFO - 2015-11-16 07:33:04,062 DEBUG : BROWSER_OUTPUT: 07:33:04 INFO - 2015-11-16 07:33:04,062 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:165.20 Median:165.00 stddev:1.81 (1.1%) stddev-sans-first:1.87 07:33:04 INFO - 2015-11-16 07:33:04,062 DEBUG : BROWSER_OUTPUT: Values: 164.0 165.0 165.0 165.0 164.0 166.0 170.0 164.0 165.0 164.0 07:33:04 INFO - 2015-11-16 07:33:04,062 DEBUG : BROWSER_OUTPUT: 07:33:04 INFO - 2015-11-16 07:33:04,063 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.20 Median:73.50 stddev:21.72 (29.6%) stddev-sans-first:22.89 07:33:04 INFO - 2015-11-16 07:33:04,063 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 74.0 74.0 74.0 142.0 73.0 72.0 73.0 74.0 07:33:04 INFO - 2015-11-16 07:33:04,064 DEBUG : BROWSER_OUTPUT: 07:33:04 INFO - 2015-11-16 07:33:04,064 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.20 Median:92.00 stddev:18.59 (20.2%) stddev-sans-first:19.19 07:33:04 INFO - 2015-11-16 07:33:04,064 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 130.0 92.0 92.0 92.0 126.0 92.0 91.0 134.0 07:33:04 INFO - 2015-11-16 07:33:04,064 DEBUG : BROWSER_OUTPUT: 07:33:04 INFO - 2015-11-16 07:33:04,064 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:110.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:33:04 INFO - 2015-11-16 07:33:04,064 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 111.0 110.0 110.0 111.0 110.0 111.0 110.0 110.0 07:33:04 INFO - 2015-11-16 07:33:04,064 DEBUG : BROWSER_OUTPUT: 07:33:04 INFO - 2015-11-16 07:33:04,064 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:149.30 Median:149.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 07:33:04 INFO - 2015-11-16 07:33:04,064 DEBUG : BROWSER_OUTPUT: Values: 149.0 149.0 149.0 151.0 150.0 149.0 148.0 149.0 149.0 150.0 07:33:04 INFO - 2015-11-16 07:33:04,064 DEBUG : BROWSER_OUTPUT: 07:33:04 INFO - 2015-11-16 07:33:04,064 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 07:33:04 INFO - 2015-11-16 07:33:04,064 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 97.0 96.0 96.0 97.0 96.0 97.0 97.0 95.0 07:33:04 INFO - 2015-11-16 07:33:04,064 DEBUG : BROWSER_OUTPUT: 07:33:04 INFO - 2015-11-16 07:33:04,064 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.00 Median:72.00 stddev:1.15 (1.6%) stddev-sans-first:0.97 07:33:04 INFO - 2015-11-16 07:33:04,064 DEBUG : BROWSER_OUTPUT: Values: 74.0 72.0 72.0 73.0 72.0 72.0 73.0 71.0 70.0 71.0 07:33:04 INFO - 2015-11-16 07:33:04,065 DEBUG : BROWSER_OUTPUT: 07:33:04 INFO - 2015-11-16 07:33:04,065 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:69.00 stddev:3.30 (4.8%) stddev-sans-first:3.44 07:33:04 INFO - 2015-11-16 07:33:04,065 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 69.0 69.0 79.0 69.0 69.0 68.0 69.0 07:33:04 INFO - 2015-11-16 07:33:04,065 DEBUG : BROWSER_OUTPUT: 07:33:04 INFO - 2015-11-16 07:33:04,065 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.00 stddev:3.34 (3.9%) stddev-sans-first:3.50 07:33:04 INFO - 2015-11-16 07:33:04,065 DEBUG : BROWSER_OUTPUT: Values: 84.0 82.0 83.0 85.0 86.0 84.0 84.0 94.0 85.0 87.0 07:33:04 INFO - 2015-11-16 07:33:04,065 DEBUG : BROWSER_OUTPUT: 07:33:04 INFO - 2015-11-16 07:33:04,066 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:130.00 stddev:5.24 (4.0%) stddev-sans-first:5.51 07:33:04 INFO - 2015-11-16 07:33:04,066 DEBUG : BROWSER_OUTPUT: Values: 130.0 122.0 139.0 124.0 124.0 122.0 130.0 129.0 131.0 130.0 07:33:04 INFO - 2015-11-16 07:33:04,066 DEBUG : BROWSER_OUTPUT: 07:33:04 INFO - 2015-11-16 07:33:04,066 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.00 Median:152.00 stddev:7.77 (5.1%) stddev-sans-first:7.82 07:33:04 INFO - 2015-11-16 07:33:04,066 DEBUG : BROWSER_OUTPUT: Values: 146.0 149.0 150.0 149.0 151.0 164.0 153.0 161.0 142.0 165.0 07:33:04 INFO - 2015-11-16 07:33:04,066 DEBUG : BROWSER_OUTPUT: 07:33:04 INFO - 2015-11-16 07:33:04,066 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:71.00 stddev:1.26 (1.8%) stddev-sans-first:1.32 07:33:04 INFO - 2015-11-16 07:33:04,067 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 72.0 73.0 70.0 69.0 71.0 70.0 71.0 69.0 07:33:04 INFO - 2015-11-16 07:33:04,067 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:33:04 INFO - 2015-11-16 07:33:04,067 DEBUG : BROWSER_OUTPUT: 07:33:05 INFO - 2015-11-16 07:33:05,021 INFO : Browser exited with error code: 0 07:33:05 INFO - 2015-11-16 07:33:05,072 INFO : Completed test kraken (00:01:02) 07:33:05 INFO - 2015-11-16 07:33:05,072 INFO : Starting test v8_7 07:33:05 INFO - 2015-11-16 07:33:05,072 DEBUG : operating with platform_type : linux_ 07:33:05 INFO - 2015-11-16 07:33:05,073 INFO : Initialising browser for v8_7 test... 07:33:05 INFO - 2015-11-16 07:33:05,079 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK8skZf/profile http://localhost:38028/getInfo.html 07:33:10 INFO - 2015-11-16 07:33:10,538 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:33:10 INFO - 2015-11-16 07:33:10,539 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:33:10 INFO - 2015-11-16 07:33:10,539 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:33:10 INFO - 2015-11-16 07:33:10,539 DEBUG : BROWSER_OUTPUT: __metrics 07:33:11 INFO - 2015-11-16 07:33:11,717 INFO : Browser initialized. 07:33:11 INFO - 2015-11-16 07:33:11,718 INFO : Running cycle 1/1 for v8_7 test... 07:33:11 INFO - 2015-11-16 07:33:11,718 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK8skZf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:33:23 INFO - 2015-11-16 07:33:23,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 141119488 07:33:23 INFO - 2015-11-16 07:33:23,672 DEBUG : BROWSER_OUTPUT: 07:33:45 INFO - 2015-11-16 07:33:45,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38028/tests/v8_7/run.html (next: http://localhost:38028/tests/v8_7/run.html) 07:33:45 INFO - 2015-11-16 07:33:45,449 DEBUG : BROWSER_OUTPUT: RSS: Main: 138010624 07:33:45 INFO - 2015-11-16 07:33:45,449 DEBUG : BROWSER_OUTPUT: 07:33:45 INFO - 2015-11-16 07:33:45,449 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:33:45 INFO - 2015-11-16 07:33:45,449 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:33:45 INFO - 2015-11-16 07:33:45,449 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:33:45 INFO - 2015-11-16 07:33:45,449 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:33:45 INFO - 2015-11-16 07:33:45,449 DEBUG : BROWSER_OUTPUT: |0;Richards;164.93485073396008 07:33:45 INFO - 2015-11-16 07:33:45,450 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.43991620643686 07:33:45 INFO - 2015-11-16 07:33:45,450 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.4076557697681 07:33:45 INFO - 2015-11-16 07:33:45,450 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.50505050505 07:33:45 INFO - 2015-11-16 07:33:45,450 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1069.51871657754 07:33:45 INFO - 2015-11-16 07:33:45,450 DEBUG : BROWSER_OUTPUT: |5;Earley;734.2143906020558 07:33:45 INFO - 2015-11-16 07:33:45,450 DEBUG : BROWSER_OUTPUT: |6;Boyer;12156.626506024097 07:33:45 INFO - 2015-11-16 07:33:45,451 DEBUG : BROWSER_OUTPUT: |7;RegExp;25871.79487179487 07:33:45 INFO - 2015-11-16 07:33:45,451 DEBUG : BROWSER_OUTPUT: |8;Splay;609.6224116930573 07:33:45 INFO - 2015-11-16 07:33:45,451 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4817.307692307692 07:33:45 INFO - 2015-11-16 07:33:45,451 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:33:45 INFO - 2015-11-16 07:33:45,451 DEBUG : BROWSER_OUTPUT: __startTimestamp1447688025447__endTimestamp 07:33:45 INFO - 2015-11-16 07:33:45,452 DEBUG : BROWSER_OUTPUT: 07:33:45 INFO - 2015-11-16 07:33:45,452 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:33:45 INFO - 2015-11-16 07:33:45,452 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:33:45 INFO - 2015-11-16 07:33:45,452 DEBUG : BROWSER_OUTPUT: 07:33:45 INFO - 2015-11-16 07:33:45,452 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.93 Median:164.93 stddev:0.00 (0.0%) 07:33:45 INFO - 2015-11-16 07:33:45,453 DEBUG : BROWSER_OUTPUT: Values: 164.9 07:33:45 INFO - 2015-11-16 07:33:45,453 DEBUG : BROWSER_OUTPUT: 07:33:45 INFO - 2015-11-16 07:33:45,453 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.44 Median:190.44 stddev:0.00 (0.0%) 07:33:45 INFO - 2015-11-16 07:33:45,453 DEBUG : BROWSER_OUTPUT: Values: 190.4 07:33:45 INFO - 2015-11-16 07:33:45,453 DEBUG : BROWSER_OUTPUT: 07:33:45 INFO - 2015-11-16 07:33:45,454 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 07:33:45 INFO - 2015-11-16 07:33:45,454 DEBUG : BROWSER_OUTPUT: Values: 279.4 07:33:45 INFO - 2015-11-16 07:33:45,454 DEBUG : BROWSER_OUTPUT: 07:33:45 INFO - 2015-11-16 07:33:45,454 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.51 Median:5050.51 stddev:0.00 (0.0%) 07:33:45 INFO - 2015-11-16 07:33:45,455 DEBUG : BROWSER_OUTPUT: Values: 5050.5 07:33:45 INFO - 2015-11-16 07:33:45,456 DEBUG : BROWSER_OUTPUT: 07:33:45 INFO - 2015-11-16 07:33:45,456 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1069.52 Median:1069.52 stddev:0.00 (0.0%) 07:33:45 INFO - 2015-11-16 07:33:45,456 DEBUG : BROWSER_OUTPUT: Values: 1069.5 07:33:45 INFO - 2015-11-16 07:33:45,456 DEBUG : BROWSER_OUTPUT: 07:33:45 INFO - 2015-11-16 07:33:45,456 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:734.21 Median:734.21 stddev:0.00 (0.0%) 07:33:45 INFO - 2015-11-16 07:33:45,456 DEBUG : BROWSER_OUTPUT: Values: 734.2 07:33:45 INFO - 2015-11-16 07:33:45,457 DEBUG : BROWSER_OUTPUT: 07:33:45 INFO - 2015-11-16 07:33:45,457 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12156.63 Median:12156.63 stddev:0.00 (0.0%) 07:33:45 INFO - 2015-11-16 07:33:45,457 DEBUG : BROWSER_OUTPUT: Values: 12156.6 07:33:45 INFO - 2015-11-16 07:33:45,457 DEBUG : BROWSER_OUTPUT: 07:33:45 INFO - 2015-11-16 07:33:45,457 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25871.79 Median:25871.79 stddev:0.00 (0.0%) 07:33:45 INFO - 2015-11-16 07:33:45,457 DEBUG : BROWSER_OUTPUT: Values: 25871.8 07:33:45 INFO - 2015-11-16 07:33:45,457 DEBUG : BROWSER_OUTPUT: 07:33:45 INFO - 2015-11-16 07:33:45,458 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:609.62 Median:609.62 stddev:0.00 (0.0%) 07:33:45 INFO - 2015-11-16 07:33:45,458 DEBUG : BROWSER_OUTPUT: Values: 609.6 07:33:45 INFO - 2015-11-16 07:33:45,458 DEBUG : BROWSER_OUTPUT: 07:33:45 INFO - 2015-11-16 07:33:45,458 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 07:33:45 INFO - 2015-11-16 07:33:45,458 DEBUG : BROWSER_OUTPUT: Values: 4817.3 07:33:45 INFO - 2015-11-16 07:33:45,458 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:33:45 INFO - 2015-11-16 07:33:45,458 DEBUG : BROWSER_OUTPUT: 07:33:46 INFO - 2015-11-16 07:33:46,437 INFO : Browser exited with error code: 0 07:33:46 INFO - 2015-11-16 07:33:46,456 INFO : Completed test v8_7 (00:00:41) 07:33:46 INFO - 2015-11-16 07:33:46,925 INFO : Completed test suite (00:20:24) 07:33:46 INFO - 2015-11-16 07:33:46,926 DEBUG : Working with test: dromaeo_css 07:33:46 INFO - 2015-11-16 07:33:46,926 DEBUG : Generating results file: dromaeo_css 07:33:46 INFO - 2015-11-16 07:33:46,927 DEBUG : Working with test: kraken 07:33:46 INFO - 2015-11-16 07:33:46,927 DEBUG : Generating results file: kraken 07:33:46 INFO - 2015-11-16 07:33:46,927 INFO : javascript benchmark 07:33:46 INFO - 2015-11-16 07:33:46,927 DEBUG : Working with test: v8_7 07:33:46 INFO - 2015-11-16 07:33:46,927 DEBUG : Generating results file: v8_7 07:33:46 INFO - 2015-11-16 07:33:46,928 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:33:46 INFO - 2015-11-16 07:33:46,978 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 07:33:46 INFO - 2015-11-16 07:33:46,978 DEBUG : process_Request line: dromaeo_css 6029.95 graph.html#tests=[[72,132,43]] 07:33:46 INFO - 2015-11-16 07:33:46,978 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:33:47 INFO - 2015-11-16 07:33:47,017 DEBUG : process_Request line: kraken 1550.40 graph.html#tests=[[232,132,43]] 07:33:47 INFO - 2015-11-16 07:33:47,018 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:33:47 INFO - 2015-11-16 07:33:47,048 DEBUG : process_Request line: v8_7 21318.05 graph.html#tests=[[230,132,43]] 07:33:47 INFO - 2015-11-16 07:33:47,050 INFO : javascript benchmark 07:33:47 INFO - 2015-11-16 07:33:47,054 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [310.6350038704522, 331.90140634499824, 337.3657523855152, 345.55250950019723, 347.2932582195233, 11182.161337899659, 11230.438478076105, 11634.360110193937, 15030.473933412333, 15711.764323535142, 10999.780004399907, 11004.174686898474, 11197.104231661468, 11240.156988225875, 11249.775004499905, 4242.9151416971645, 4379.671524635649, 4379.912401751963, 4381.78091095444, 4383.057642606839, 4252.914941701164, 4332.371806088116, 4332.588404101605, 4334.393184954109, 4341.50072741634, 4327.5239723630375, 4341.0, 4645.581897629213, 4839.225723884179, 4844.176489996691, 4778.737169455679, 4783.115123702126, 4784.617230621577, 4792.065547218293, 4819.0602832447685, 3890.260850438436, 3894.5910679378826, 4020.0954785173394, 4113.568075352075, 4129.421880936671, 11073.557057717682, 11203.719907002309, 11258.493367798386, 11261.155413344031, 12306.0, 1709.4615196213279, 1724.844763971236, 1747.2312182639726, 1747.5718448979953, 1771.3623095685543, 9459.858102128474, 9506.764908222567, 9645.565949532287, 9708.126268635857, 9758.853617195748, 1570.8429157084315, 1600.1279302779897, 1615.9030458172547, 1617.4662361420703, 1679.521336419127, 53120.73439632816, 55390.0, 56458.15312770312, 56558.0, 56784.148237776055, 6646.26891041985, 6796.592204467649, 6797.762078327235, 6828.624425656637, 6841.076454678555, 7847.0, 7875.645595948196, 7923.128455869965, 7937.444378893538, 7944.483608565425, 5128.974355128201, 5147.0735267651435, 5187.703074231442, 5280.313559237275, 5282.339707536558, 5333.759980800795, 5376.301080859464, 5398.190271459234, 5413.215083812904, 5413.7834486620095, 3040.893568725084, 3071.6006919100373, 3105.4720697481484, 3117.6258848938273, 3123.2660324823646, 1096.5613754498106, 1096.923215374916, 1097.5829184909842, 1098.3355070182583, 1120.971975700614, 379.508536445304, 389.8615991323096, 403.519811424404, 430.5393229244678, 449.0883506481847, 9483.668071617598, 10038.0, 10166.593336266615, 10332.896671033344, 10416.635417760343, 395.5629029921895, 409.6763556790162, 415.38730372700024, 417.66586730615387, 424.5351340282386, 5519.69641669704, 5691.288588926384, 5935.169076329317, 6334.176557047646, 6355.841103972438, 505731.0, 505737.0, 512944.0, 524842.0, 525790.3394347264, 36738.63261367405, 36837.26325473529, 40853.97865053338, 59210.70394647999, 70458.64770676114, 442.5883927946976, 447.7313611832939, 451.58454222115734, 456.54801746270954, 456.68032377336, 9825.803483930138, 9906.405615663083, 9944.801103978025, 10065.094141527297, 10071.446070466194, 32664.183395415304, 33254.33491330208, 34041.65958340484, 34246.65753342534, 34366.656333436345, 43507.0, 44600.55399445964, 46125.769371154274, 46346.0, 46542.0, 5649.604527683023, 5792.073268277056, 5806.622569532967, 5817.301923769175, 5850.034744267148, 10281.84577231357, 10639.680809575726, 10652.733681658021, 10659.8934010662, 10699.518521666389, 9228.307876909124, 9349.065093490868, 9492.382995105296, 9523.476208808583, 9603.231741460526, 9387.85918211241, 9517.619295228113, 9759.0, 9831.803363932539, 10101.595936162765, 9974.60101595957, 10505.68482945513, 10641.14870810318, 10778.676639700821, 10804.729881753019, 6354.968225158845, 6417.935820641734, 6421.004744264646, 6459.418652321314, 6462.0, 9706.417614943126, 9887.703368898945, 10117.038881306264, 10261.538230779484, 10321.225908057077], "dojo.html": [2702.5405681034226, 2745.3822889849775, 2768.5016696994544, 2788.8466134362616, 2794.329360953371, 4711.411073615798, 4896.8530944071645, 4942.110420124376, 4960.156773348531, 5002.599792016639, 4826.49321821209, 4838.177509823329, 4838.298446725232, 4920.557149856512, 4949.579285760706, 4470.016596348806, 4478.23869942109, 4537.069900670354, 4544.431946006749, 4571.817127314904, 4484.282514797633, 4534.34252033455, 4583.1062942726185, 4589.105124500724, 4637.605803506706, 4335.739855608674, 4444.20004399208, 4448.955510444886, 4535.4103966484145, 4563.018950925567, 4580.587747102777, 4598.057398233354, 4606.861794146181, 4614.353990441341, 4636.768161591941, 4547.431571053618, 4557.726536407826, 4578.931316030262, 4590.74750888701, 4591.931121033187, 4711.505291944331, 4719.056188762262, 4838.564529192389, 4847.3698419205275, 4853.272009198613, 5257.684538927677, 5293.338332708411, 5295.338082739658, 5300.072487314743, 5339.866503337409, 5163.406208286057, 5315.760790764425, 5320.467953204688, 5325.627206095575, 5337.626366154371, 4820.34925285082, 4859.1010663027455, 4867.172580661296, 4907.9263811042865, 4924.852254432372, 5386.649867758583, 5441.401445840955, 5446.564274858002, 5454.3454785426, 5483.396826349099, 4914.140025495524, 5009.474005229471, 5207.114790485626, 5209.947900521022, 5214.765335559909, 5238.476152384807, 5344.6258761887075, 5354.063038968165, 5385.542228910586, 5398.838034858961, 5198.2722418861385, 5236.188390799432, 5244.239585260116, 5250.238715386247, 5283.867903302448, 5049.444561098277, 5078.7460626968505, 5200.843974680765, 5210.713410762369, 5243.764030618631, 4004.979975100106, 4008.939865902014, 4014.437978682987, 4029.9194016119513, 4058.370952502367, 3531.29374125176, 3574.7318951078773, 3580.1765593913547, 3602.009447401933, 3612.476190952297, 4355.934660980088, 4449.3993310902615, 4456.309272062836, 4552.203364411214, 4575.336576196433, 5280.20796880471, 5288.2596436498925, 5299.761510732026, 5303.946960530422, 5304.38999515053, 4548.044910568751, 4552.203364411214, 4572.702774319659, 4579.17574836526, 4586.518415566385, 4489.7979590918485, 4584.88537786558, 4639.907201855944, 4653.627709783277, 4656.580907718321, 5026.070177017264, 5027.899442011066, 5030.195168772979, 5033.119204139188, 5059.418166910705, 5298.0, 5316.867078323073, 5327.174287985368, 5334.439883812299, 5364.678119312854, 4829.13075646387, 4916.459189489082, 4925.679830810986, 4928.802847886044, 5046.57104146137, 5145.588352931682, 5255.080360936744, 5255.264263003259, 5257.5005374489365, 5280.603954703336, 5292.629515933848, 5298.046351656739, 5301.787928482971, 5304.734763261744, 5367.302250707539, 4874.902501950012, 4982.277569752293, 5090.898182036412, 5107.489251075011, 5113.8977220454635, 5101.56636685871, 5131.974340128276, 5153.175491921274, 5156.432792392909, 5176.094183517945, 4984.026830943175, 4990.775415106256, 5000.399952005782, 5027.7234752087525, 5070.6957582545165, 5041.420236672683, 5042.445331013512, 5167.483251674803, 5179.171332586919, 5194.065068287593, 4983.103041452573, 4998.725070121178, 5017.874553136201, 5022.146235139962, 5045.949540504695], "mootools.html": [1470.801441805356, 1591.9920400397996, 1634.795650543682, 1652.1821698259364, 1668.783058202434, 6808.659567021654, 6896.448284137269, 6925.961105834127, 7064.293570642933, 7080.539764915284, 7386.963065184666, 7395.704171833134, 7427.665755041023, 7435.702571897131, 7476.738314159005, 2066.72099266599, 2104.947376315589, 2107.1360742095744, 2107.9683804742863, 2112.091800525773, 2117.7564580073335, 2122.596706625744, 2135.6155891939443, 2140.743110826703, 2145.7639659637507, 2050.7539095308584, 2094.4030951178916, 2097.339338108491, 2108.156737305075, 2139.80741733244, 2012.456636708088, 2095.423758466419, 2095.5913596848623, 2098.223657246821, 2100.7584127825266, 2004.0681083296192, 2042.6425375559218, 2050.63088644044, 2051.3333166720877, 2052.6818343156683, 7218.4586156037985, 7251.891221631679, 7258.854822903565, 7306.561606303639, 7312.597807120606, 4280.272353699878, 4313.61177494027, 4329.9567004329865, 4349.173657005159, 4359.651227901792, 2914.2714321419644, 2931.662858771247, 2962.3927094945484, 2985.596944412498, 2996.4007198560157, 858.5406807358096, 869.3002133282705, 918.8759517465123, 935.4808081514757, 973.4062222044547, 9796.412215267106, 9909.058639429242, 9930.90069099307, 9940.0, 9950.651727189586, 3738.7569807962395, 3854.325493038707, 3870.748401353903, 3877.5734669186368, 3879.4956655634587, 7484.887726684104, 7538.434617403716, 7560.9621951889885, 7564.940908272846, 7567.697292108254, 4239.173361194537, 4242.4272723181975, 4243.087736136746, 4278.272693642089, 4278.315469524861, 3915.7258991870294, 3917.353636649978, 3936.7441116327345, 3951.427043078795, 3959.40608908666, 3087.9536806947913, 3128.0, 3138.10563989262, 3145.9213519661735, 3147.35479226758, 947.9004704506066, 974.7222041718077, 976.1312431935582, 977.5307852230969, 978.2320878110648, 774.6823802241054, 803.1045384396356, 909.6997990663066, 917.6421195733669, 978.3787295067541, 6672.065910772496, 6761.594304341756, 6783.287754785775, 6795.422389096982, 6801.489888258301, 1023.8054769593754, 1029.0481304793036, 1030.9329893557044, 1048.308116643012, 1060.3531845574194, 5198.9740051299505, 5282.260483532308, 5283.07546179417, 5284.154535274414, 5288.338957630296, 8445.704400345958, 8448.155184481502, 8636.395452318404, 8662.566871656392, 8706.869396959051, 8628.956855215683, 8719.346049046348, 8744.038155802857, 8770.0, 8847.336449766293, 6716.5634233774645, 6848.287928017996, 6851.0, 6864.0047193156715, 6871.793846184622, 6595.637239951849, 6611.504137189634, 6623.701933412912, 6625.635590042594, 6656.068150458843, 7601.467897247139, 7745.690172393041, 7749.263819937097, 7814.53112813233, 7829.177936316605, 7730.613469326398, 7924.881126783218, 7974.082980457089, 7998.400119990907, 8024.358051355995, 6057.454829065406, 6100.8779824404155, 6133.141360209664, 6135.171751813448, 6152.169457123231, 6615.305392933865, 6774.491913106438, 6789.72841086351, 6813.182418109858, 6850.520463567503, 6413.35866413355, 6429.421352078149, 6517.967410162919, 6632.204135503771, 6763.7632682855865, 5418.078926582411, 6208.875822483616, 6243.282022567463, 6253.405926436982, 6264.373562643699, 6435.163428754232, 6492.091107245084, 6496.220453545605, 6496.577722448026, 6504.772332968323, 5925.851853703692, 5936.28764548257, 5998.190244316961, 6023.1266466363, 6042.335343112166, 6055.848603784941, 6094.542909281733, 6113.480354169767, 6113.816585502442, 6142.570020098729], "ext.html": [535.1998761851032, 558.5392051557466, 560.5095541401274, 561.0574235284721, 580.3645008715455, 34845.65154348456, 35299.64700352996, 35457.46813797795, 35485.822570887176, 35488.64511354889, 38820.80589597055, 39340.606593934055, 39550.80224598873, 39622.8018859906, 39699.603003969954, 7948.284654381119, 8116.310113640318, 8151.592420378957, 8173.305269052138, 8185.8362832743305, 7905.881411778828, 7952.204779522031, 7966.760997170065, 7980.840383192332, 8011.078725946503, 7897.210278972086, 8013.47912385696, 8035.316998055172, 8035.758927232163, 8064.475809072421, 7922.722704705337, 7966.083900351447, 7999.240072193133, 8057.758267251992, 8068.596570171527, 7808.492447990862, 8009.67961281548, 8017.438779285452, 8017.5189488630285, 8023.398245131581, 36683.26633467316, 36815.07962300937, 36926.44610330847, 37055.81472092649, 37081.0, 2872.569114632801, 2984.358362951954, 3014.969850301513, 3439.793612383265, 3573.10672331917, 27434.862825685945, 27500.862495687594, 27703.307417314525, 27902.581461278096, 27993.440131197465, 2891.7252860978174, 2994.4909365407934, 2998.7750918681186, 3035.3474003089223, 3052.9847350763325, 219054.0, 220080.0, 220356.0, 220415.0, 220438.0, 49268.50731492639, 50096.74951625219, 50654.0, 58062.0, 59118.70440647855, 53068.20397694038, 53115.734421328416, 53401.1989820153, 53405.732971334895, 53451.73274133605, 13093.148945318715, 13119.42566891979, 13266.800997985038, 13284.468621255235, 13323.0, 10521.473926303654, 10522.631707890187, 10554.10290125348, 10630.946845265724, 10717.410542420243, 17171.0, 17481.125943702766, 17506.56233594145, 17513.649727005388, 17525.211365488583, 7470.220874319086, 7607.467477276648, 7666.233376662289, 7676.309132178131, 7683.5774032427635, 863.5293764898146, 923.7459698582809, 958.520739630185, 1011.231464087299, 1014.3761586624173, 25221.9206950366, 25262.0, 25608.615870761954, 25837.741622583533, 25936.351591210372, 947.7772723409993, 952.885653721544, 962.4802606592361, 979.2068424576116, 1071.1002757683427, 13241.73516529664, 13348.73302533944, 13482.730345393038, 13509.2569908654, 13539.66150846217, 268879.0, 272201.0, 274053.0, 274858.0, 274873.0, 44245.55754442479, 44497.110057798665, 44610.55389446129, 44775.77612111918, 44869.775651121534, 1169.7543515861764, 1183.680406290314, 1190.4761904761876, 1193.7552801675636, 1200.099925056208, 24254.636180456953, 24771.256862293438, 24984.500309993335, 25035.624465632667, 25079.373015674024, 39204.803975979936, 39309.606903930595, 39404.2119157621, 39411.40882886702, 39575.2084958305, 254948.0, 256045.0, 257283.0, 257468.0, 257514.0, 28390.574141387482, 28607.713922860505, 28758.85620571884, 28861.0, 29381.559276610442, 35817.283654327286, 36396.0, 36433.45349819702, 37019.0, 37113.814430927676, 30926.536101958038, 31379.05862824119, 31514.212144696565, 31817.204569885937, 31977.840110799298, 31601.367972639957, 31913.521297180097, 31951.201219969687, 32015.83992080025, 32087.197820054684, 32080.0, 32164.35671286608, 32318.83840580782, 32752.0, 32956.67043329632, 26743.331416714736, 26837.0, 28727.0, 29071.41857162887, 29260.707392926648, 21601.135954561643, 22827.9182310386, 23020.654690179996, 23342.416439589146, 23432.414189644714], "prototype.html": [307.5279446050313, 316.2504863473568, 316.5915968400763, 319.29595242490313, 321.1281371077524, 5598.412166722492, 5679.744411501482, 5799.710014499279, 5862.0, 5875.559333050017, 5678.772849086042, 5711.7715291388395, 5727.828165155052, 5733.799317023905, 5735.684537350444, 4188.497380314367, 4285.164392943378, 4326.913461730764, 4360.6293465055505, 4376.846810361638, 4277.422547956033, 4312.762798046107, 4318.417013703157, 4322.04914918719, 4326.0266440051055, 4263.616274535291, 4271.551487093857, 4275.080857615612, 4277.657787377002, 4280.871573852789, 4264.658827293809, 4269.6370808481315, 4271.636910862565, 4285.785710714452, 4296.8281268749215, 3598.226381328001, 3683.521142251517, 3684.889453316405, 3685.060309621056, 3692.5015122958325, 5300.0, 5443.129099344086, 5451.509364157205, 5485.149801780691, 5489.0, 4929.433115191763, 4930.063287975309, 4935.90128197434, 4936.531029552187, 4957.876053098701, 5922.733476993502, 5947.702614869282, 5958.880822383571, 5963.0, 5984.281886173687, 3872.7289089763726, 4007.338789099824, 4012.3580227163807, 4017.357222844331, 4056.9594304056877, 6165.0, 6245.656488893109, 6264.718087686065, 6266.467350275278, 6277.811665650038, 4126.803227064178, 4144.958550414457, 4162.41726158338, 4165.437665915063, 4170.145120250341, 4188.4555007848785, 4215.0, 4219.936700949488, 4223.450951376363, 4226.197022565702, 4704.9059018819435, 4742.620590352763, 4829.323894654751, 4880.292357608127, 4915.066137433948, 5954.46409823118, 5970.104484327298, 5979.880402391927, 5984.042553191555, 5987.072003839412, 1455.6724736934104, 1460.9634759130895, 1476.217604669527, 1480.592836969842, 1484.2578710644677, 950.8431108867098, 953.5137080089204, 957.1194501059042, 957.6736220334748, 968.1093394077466, 5194.454582268883, 5201.335572616802, 5217.478252174752, 5220.216967454836, 5238.7904483820985, 6163.0, 6167.321594624587, 6168.167297414881, 6179.918514259986, 6186.783462578788, 5181.740912954338, 5189.169732842803, 5194.883100133489, 5199.194124910645, 5206.323177986837, 3251.64231934487, 3308.4210263203845, 3356.9160770980434, 3378.391889459921, 3387.3733359328603, 5870.911936320958, 5874.236349274567, 5877.735501902424, 5879.823605291848, 5891.7054147292465, 6371.39471750183, 6392.328805475451, 6400.855713336085, 6412.775552855721, 6432.903506447407, 5679.091345384636, 5851.824445266649, 5855.853603659943, 5871.823845284648, 5874.0, 6181.783637572664, 6224.190855188796, 6230.657313847601, 6248.562600617913, 6252.030935205051, 6089.391060893875, 6101.572889897665, 6103.969480152571, 6111.541634377529, 6123.601965872204, 5723.599348045597, 5825.126231065374, 5865.824025279248, 5872.442117998783, 5882.823515294548, 4148.958510414978, 4190.224808410454, 4194.182134483746, 4200.516940551754, 4206.390073439396, 6056.6971651418135, 6158.261008678987, 6214.8135555933395, 6223.502119830312, 6227.782027629011, 5926.436988486087, 5945.970270148621, 5960.493358064613, 5971.193888825127, 5971.716081042597, 5950.702464876826, 5950.880982380241, 5958.821235362946, 5962.105684147239, 5964.105384192406, 5703.600747947604, 5826.446487583673, 5838.1826544282985, 5839.0, 5857.355690874086, 6001.699915004319, 6013.609115407485, 6030.487408570145, 6037.0642550404755, 6042.335343112166, 5799.594028417971, 5860.824175274749, 5869.706514674163, 5870.823875283749, 5873.119032145041], "yui.html": [738.5716284554959, 746.3394895517465, 747.178104085506, 748.0723902361073, 768.9769306920795, 10497.895021049788, 11622.651320460389, 11626.302421854694, 11699.883001169996, 11717.589884354049, 11407.600733974312, 11420.600278990238, 11485.483153258103, 11518.0, 11540.769184616303, 740.6481921087494, 756.0473803008222, 761.7181642792175, 769.3729610367533, 770.4221833624781, 746.8468963862422, 755.3994574313407, 760.2131793593632, 765.0857225615392, 765.2882818978347, 776.6194564663331, 783.9372850172001, 785.2540086917422, 789.3172405868911, 792.18405042806, 772.9574873381962, 777.3780975219802, 779.4271210660161, 779.5751315532991, 780.4341852157197, 571.6427232979388, 572.2617823008314, 573.2690819205546, 575.8243735660621, 576.700115939709, 10810.567577296899, 10882.183836212316, 10894.128469722404, 10908.836367454494, 10973.725656858562, 8637.093105223987, 8966.103389661046, 9189.77025574366, 9418.246540276761, 9487.573059212284, 8907.510086945216, 8938.955305223431, 9087.091290870927, 9169.862452063224, 9285.442873427548, 2721.306066952934, 2826.364068084685, 2879.1074766822353, 2901.5937768712397, 2927.7657787376957, 38059.61940380588, 38098.428523572446, 38249.617503824884, 38363.23273534542, 38957.22085558273, 6581.86836263272, 6589.0116482528, 6603.70283337251, 6626.304238055031, 6662.733490660319, 10236.897631023594, 10248.128909042814, 10274.897251027394, 10307.484625768682, 10309.020643038899, 5294.285271488377, 5426.186072089218, 5504.91742623861, 5551.833444996657, 5634.04221282383, 3198.6001749781276, 3223.0, 3245.5618491503815, 3306.9338613228083, 3381.985404378677, 2355.0579768092557, 2386.97613023871, 2387.594109001474, 2393.210240620591, 2395.8322917395617, 380.56425392924945, 387.68791123145576, 391.8843941037401, 393.62408899500906, 394.40051122293954, 539.4982666120467, 581.1312088427743, 592.6977241606811, 602.6896148483535, 613.9631622102688, 7454.962725186339, 7731.149573546905, 7847.6468558914985, 7871.0948240951875, 7897.644605992744, 491.8549028036738, 492.82504710827857, 500.47200203785354, 504.46778648525424, 578.9128751017828, 3641.9635803642154, 3700.703943684499, 3764.642358975893, 3778.5654649715634, 3781.357169281229, 49589.50410495849, 50051.49948500541, 50349.49650503521, 50989.49010509848, 51210.743946280774, 46103.30845037327, 46183.53816461859, 46470.5352946473, 46582.0, 46686.29970550445, 39009.80495097563, 39310.80344598259, 40107.59892401097, 40498.190036199114, 40867.38698919518, 7722.227777222233, 7730.188330225245, 8005.3995950305125, 8064.55644939534, 8575.95712021436, 31394.843025784725, 32486.35027299488, 32713.34573308568, 33300.0, 33342.333153337284, 39285.0, 39631.20737585174, 39661.80169099251, 39707.0, 40640.59359406368, 6475.190601174853, 6638.734450621921, 7081.787546373617, 7177.856442871009, 7331.3768329692575, 10526.526306316387, 10625.468726563795, 10664.306820056672, 10856.728581785519, 10867.891321086689, 9393.201577865684, 9541.761455963657, 9594.472304023067, 9652.27607929394, 9689.27330450205, 10373.948130259603, 10684.09185219265, 10748.301360411548, 10842.349459032483, 10877.292975956538, 10720.35677859331, 10723.463826808784, 10744.46277686097, 10767.6231331903, 10917.508712107816, 9355.111264429868, 9387.249020078241, 9563.569639366384, 9698.9030109698, 9718.562664679965, 8970.820583588162, 9771.755706107404, 9804.607815687292, 9813.26400519978, 9856.605735770489]}, "summary": {"lowerIsBetter": false, "suite": 6029.949127375051, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6262.4562925207265, "unit": "ms", "value": 6262.4562925207265}, "dojo.html": {"lowerIsBetter": false, "filtered": 4797.572203676619, "unit": "ms", "value": 4797.572203676619}, "mootools.html": {"lowerIsBetter": false, "filtered": 4093.3901393431665, "unit": "ms", "value": 4093.3901393431665}, "ext.html": {"lowerIsBetter": false, "filtered": 16551.74109550756, "unit": "ms", "value": 16551.74109550756}, "prototype.html": {"lowerIsBetter": false, "filtered": 4430.99449668667, "unit": "ms", "value": 4430.99449668667}, "yui.html": {"lowerIsBetter": false, "filtered": 5329.028707495265, "unit": "ms", "value": 5329.028707495265}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-038.e"}, "testrun": {"date": 1447686802, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116063637", "branch": "Fx-Team-Non-PGO", "revision": "37ee16bb31cf4b78973b71af1362542dfc6b64bc"}}, {"talos_counters": {}, "results": {"audio-dft": [164.0, 165.0, 165.0, 165.0, 164.0, 166.0, 170.0, 164.0, 165.0, 164.0], "ai-astar": [113.0, 107.0, 113.0, 112.0, 113.0, 124.0, 112.0, 114.0, 111.0, 111.0], "imaging-gaussian-blur": [110.0, 111.0, 111.0, 110.0, 110.0, 111.0, 110.0, 111.0, 110.0, 110.0], "audio-beat-detection": [158.0, 136.0, 169.0, 166.0, 141.0, 163.0, 157.0, 133.0, 176.0, 141.0], "json-stringify-tinderbox": [68.0, 69.0, 68.0, 69.0, 69.0, 79.0, 69.0, 69.0, 68.0, 69.0], "stanford-crypto-pbkdf2": [146.0, 149.0, 150.0, 149.0, 151.0, 164.0, 153.0, 161.0, 142.0, 165.0], "json-parse-financial": [74.0, 72.0, 72.0, 73.0, 72.0, 72.0, 73.0, 71.0, 70.0, 71.0], "stanford-crypto-sha256-iterative": [70.0, 71.0, 72.0, 73.0, 70.0, 69.0, 71.0, 70.0, 71.0, 69.0], "audio-fft": [73.0, 73.0, 74.0, 74.0, 74.0, 142.0, 73.0, 72.0, 73.0, 74.0], "imaging-darkroom": [149.0, 149.0, 149.0, 151.0, 150.0, 149.0, 148.0, 149.0, 149.0, 150.0], "stanford-crypto-ccm": [130.0, 122.0, 139.0, 124.0, 124.0, 122.0, 130.0, 129.0, 131.0, 130.0], "audio-oscillator": [91.0, 92.0, 130.0, 92.0, 92.0, 92.0, 126.0, 92.0, 91.0, 134.0], "stanford-crypto-aes": [84.0, 82.0, 83.0, 85.0, 86.0, 84.0, 84.0, 94.0, 85.0, 87.0], "imaging-desaturate": [96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 97.0, 97.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1550.3999999999999, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.2, "unit": "ms", "value": 80.2}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 153.0, "unit": "ms", "value": 153.0}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 154.0, "unit": "ms", "value": 154.0}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 128.1, "unit": "ms", "value": 128.1}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 149.3, "unit": "ms", "value": 149.3}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 72.0, "unit": "ms", "value": 72.0}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.2, "unit": "ms", "value": 103.2}, "ai-astar": {"lowerIsBetter": true, "filtered": 113.0, "unit": "ms", "value": 113.0}, "audio-dft": {"lowerIsBetter": true, "filtered": 165.2, "unit": "ms", "value": 165.2}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 70.6, "unit": "ms", "value": 70.6}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.7, "unit": "ms", "value": 69.7}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 110.4, "unit": "ms", "value": 110.4}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.4, "unit": "ms", "value": 85.4}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.3, "unit": "ms", "value": 96.3}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-038.e"}, "testrun": {"date": 1447686802, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116063637", "branch": "Fx-Team-Non-PGO", "revision": "37ee16bb31cf4b78973b71af1362542dfc6b64bc"}}, {"talos_counters": {}, "results": {"DeltaBlue": [190.43991620643686], "Encrypt": [279.4076557697681], "NavierStokes": [4817.307692307692], "Decrypt": [5050.50505050505], "Splay": [609.6224116930573], "Richards": [164.93485073396008], "RegExp": [25871.79487179487], "Earley": [734.2143906020558], "Boyer": [12156.626506024097], "RayTrace": [1069.51871657754]}, "summary": {"lowerIsBetter": false, "suite": 21318.052323932592, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 347.1856180000001, "unit": "score", "value": 347.1856180000001}, "Encrypt": {"lowerIsBetter": false, "filtered": 952.6617989999997, "unit": "score", "value": 952.6617989999997}, "NavierStokes": {"lowerIsBetter": false, "filtered": 308.055888223553, "unit": "score", "value": 308.055888223553}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.70383799999996, "unit": "score", "value": 52.70383799999996}, "Splay": {"lowerIsBetter": false, "filtered": 133.67454745254742, "unit": "score", "value": 133.67454745254742}, "RegExp": {"lowerIsBetter": false, "filtered": 35.21151139742318, "unit": "score", "value": 35.21151139742318}, "Richards": {"lowerIsBetter": false, "filtered": 214.03602599999994, "unit": "score", "value": 214.03602599999994}, "Earley": {"lowerIsBetter": false, "filtered": 907.7226059999997, "unit": "score", "value": 907.7226059999997}, "Boyer": {"lowerIsBetter": false, "filtered": 54.82302180376615, "unit": "score", "value": 54.82302180376615}, "RayTrace": {"lowerIsBetter": false, "filtered": 691.889715, "unit": "score", "value": 691.889715}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-038.e"}, "testrun": {"date": 1447686802, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116063637", "branch": "Fx-Team-Non-PGO", "revision": "37ee16bb31cf4b78973b71af1362542dfc6b64bc"}}] 07:33:47 INFO - RETURN: dromaeo_css: 6029.95 07:33:47 INFO - RETURN: kraken: 1550.40 07:33:47 INFO - RETURN: v8_7: 21318.05 07:33:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21318.05"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1550.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6029.95"}}} 07:33:47 INFO - Return code: 0 07:33:47 INFO - # TBPL SUCCESS # 07:33:47 INFO - Running post-action listener: _resource_record_post_action 07:33:47 INFO - Running post-run listener: _resource_record_post_run 07:33:48 INFO - Total resource usage - Wall time: 1238s; CPU: 13.0%; Read bytes: 12288; Write bytes: 504385536; Read time: 424; Write time: 1082792 07:33:48 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 125194240; Read time: 0; Write time: 160296 07:33:48 INFO - run-tests - Wall time: 1225s; CPU: 13.0%; Read bytes: 8192; Write bytes: 344182784; Read time: 264; Write time: 773104 07:33:48 INFO - Running post-run listener: _upload_blobber_files 07:33:48 INFO - Blob upload gear active. 07:33:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:33:48 INFO - Copying logs to upload dir... 07:33:48 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1266.956093 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-16 07:33:47.733642) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 07:33:47.737300) ========= 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=e8c3f5a4c0a512351e80f2ca000001d7-1447686406.172897-1280556760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Z2XtXOEHRpKtWWUGC648Gg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010038 build_url: 'https://queue.taskcluster.net/v1/task/Z2XtXOEHRpKtWWUGC648Gg/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-11-16 07:33:47.788135) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 07:33:47.788477) ========= 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=e8c3f5a4c0a512351e80f2ca000001d7-1447686406.172897-1280556760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004567 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 07:33:47.837739) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 07:33:47.838052) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 07:33:47.838341) ========= ========= Total master_lag: 0.25 =========