builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-057 starttime: 1445639321.19 results: success (0) buildid: 20151023150531 builduid: 0462a002367d4871a41d7833a6a9cbfb revision: 599cddea4a027034f05a3b99c8050c592a7241c8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-23 15:28:41.186011) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-23 15:28:41.186432) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-23 15:28:41.186717) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1445638716.984502-36503012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006384 basedir: '/builds/slave/test' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-23 15:28:41.272576) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-23 15:28:41.273047) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-23 15:28:41.297987) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 15:28:41.298539) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1445638716.984502-36503012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 15:28:41.350843) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-23 15:28:41.351323) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-23 15:28:41.351873) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 15:28:41.352315) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1445638716.984502-36503012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-10-23 15:28:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2015-10-23 15:28:41 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.311542 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 15:28:41.676197) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 15:28:41.676616) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1445638716.984502-36503012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014069 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 15:28:41.762004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-23 15:28:41.762354) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 599cddea4a027034f05a3b99c8050c592a7241c8 --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 599cddea4a027034f05a3b99c8050c592a7241c8 --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=6b42339bb4b96cfc3b1ae7e5000001a3-1445638716.984502-36503012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-10-23 15:28:41,847 truncating revision to first 12 chars 2015-10-23 15:28:41,847 Setting DEBUG logging. 2015-10-23 15:28:41,847 attempt 1/10 2015-10-23 15:28:41,847 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/599cddea4a02?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-23 15:28:42,819 unpacking tar archive at: fx-team-599cddea4a02/testing/mozharness/ program finished with exit code 0 elapsedTime=1.388038 ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-23 15:28:43.161977) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-23 15:28:43.162287) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-23 15:28:43.170854) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-23 15:28:43.171141) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-23 15:28:43.171551) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-10-23 15:28:43.171848) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=6b42339bb4b96cfc3b1ae7e5000001a3-1445638716.984502-36503012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:28:43 INFO - MultiFileLogger online at 20151023 15:28:43 in /builds/slave/test 15:28:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 15:28:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:28:43 INFO - {'append_to_log': False, 15:28:43 INFO - 'base_work_dir': '/builds/slave/test', 15:28:43 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:28:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:28:43 INFO - 'branch': 'Fx-Team-Non-PGO', 15:28:43 INFO - 'buildbot_json_path': 'buildprops.json', 15:28:43 INFO - 'config_files': ('talos/linux_config.py',), 15:28:43 INFO - 'default_actions': ('clobber', 15:28:43 INFO - 'read-buildbot-config', 15:28:43 INFO - 'download-and-extract', 15:28:43 INFO - 'populate-webroot', 15:28:43 INFO - 'create-virtualenv', 15:28:43 INFO - 'install', 15:28:43 INFO - 'run-tests'), 15:28:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:28:43 INFO - 'download_minidump_stackwalk': True, 15:28:43 INFO - 'download_symbols': 'ondemand', 15:28:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:28:43 INFO - 'tooltool.py': '/tools/tooltool.py', 15:28:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:28:43 INFO - '/tools/misc-python/virtualenv.py')}, 15:28:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:28:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:28:43 INFO - 'installer_path': 'installer.exe', 15:28:43 INFO - 'log_level': 'info', 15:28:43 INFO - 'log_name': 'talos', 15:28:43 INFO - 'log_to_console': True, 15:28:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:28:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:28:43 INFO - 'opt_config_files': (), 15:28:43 INFO - 'pip_index': False, 15:28:43 INFO - 'sps_profile': False, 15:28:43 INFO - 'sps_profile_interval': 0, 15:28:43 INFO - 'suite': 'dromaeojs', 15:28:43 INFO - 'system_bits': '64', 15:28:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:28:43 INFO - 'title': 'talos-linux64-ix-057', 15:28:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:28:43 INFO - 'use_talos_json': True, 15:28:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:28:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:28:43 INFO - 'work_dir': 'build'} 15:28:43 INFO - ##### 15:28:43 INFO - ##### Running clobber step. 15:28:43 INFO - ##### 15:28:43 INFO - Running pre-action listener: _resource_record_pre_action 15:28:43 INFO - Running main action method: clobber 15:28:43 INFO - rmtree: /builds/slave/test/build 15:28:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:28:43 INFO - Running post-action listener: _resource_record_post_action 15:28:43 INFO - ##### 15:28:43 INFO - ##### Running read-buildbot-config step. 15:28:43 INFO - ##### 15:28:43 INFO - Running pre-action listener: _resource_record_pre_action 15:28:43 INFO - Running main action method: read_buildbot_config 15:28:43 INFO - Using buildbot properties: 15:28:43 INFO - { 15:28:43 INFO - "properties": { 15:28:43 INFO - "buildnumber": 1026, 15:28:43 INFO - "product": "firefox", 15:28:43 INFO - "script_repo_revision": "production", 15:28:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:28:43 INFO - "repository": "", 15:28:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:28:43 INFO - "buildid": "20151023150531", 15:28:43 INFO - "slavename": "talos-linux64-ix-057", 15:28:43 INFO - "pgo_build": "False", 15:28:43 INFO - "basedir": "/builds/slave/test", 15:28:43 INFO - "project": "", 15:28:43 INFO - "platform": "ubuntu64_hw", 15:28:43 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:28:43 INFO - "slavebuilddir": "test", 15:28:43 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:28:43 INFO - "branch": "fx-team", 15:28:43 INFO - "repo_path": "integration/fx-team", 15:28:43 INFO - "stage_platform": "linux64", 15:28:43 INFO - "builduid": "0462a002367d4871a41d7833a6a9cbfb", 15:28:43 INFO - "revision": "599cddea4a027034f05a3b99c8050c592a7241c8" 15:28:43 INFO - }, 15:28:43 INFO - "sourcestamp": { 15:28:43 INFO - "repository": "", 15:28:43 INFO - "hasPatch": false, 15:28:43 INFO - "project": "", 15:28:43 INFO - "branch": "fx-team-linux64-talos", 15:28:43 INFO - "changes": [ 15:28:43 INFO - { 15:28:43 INFO - "category": null, 15:28:43 INFO - "files": [ 15:28:43 INFO - { 15:28:43 INFO - "url": null, 15:28:43 INFO - "name": "https://queue.taskcluster.net/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2" 15:28:43 INFO - } 15:28:43 INFO - ], 15:28:43 INFO - "repository": "", 15:28:43 INFO - "rev": "599cddea4a027034f05a3b99c8050c592a7241c8", 15:28:43 INFO - "who": "nalexander@mozilla.com", 15:28:43 INFO - "when": 1445639244, 15:28:43 INFO - "number": 6568418, 15:28:43 INFO - "comments": "Bug 1192064 - Determine |mach artifact| job from mozconfig. r=me", 15:28:43 INFO - "project": "", 15:28:43 INFO - "at": "Fri 23 Oct 2015 15:27:24", 15:28:43 INFO - "branch": "fx-team-linux64-talos", 15:28:43 INFO - "revlink": "", 15:28:43 INFO - "properties": [ 15:28:43 INFO - [ 15:28:43 INFO - "buildid", 15:28:43 INFO - "20151023150531", 15:28:43 INFO - "Change" 15:28:43 INFO - ], 15:28:43 INFO - [ 15:28:43 INFO - "builduid", 15:28:43 INFO - "0462a002367d4871a41d7833a6a9cbfb", 15:28:43 INFO - "Change" 15:28:43 INFO - ], 15:28:43 INFO - [ 15:28:43 INFO - "pgo_build", 15:28:43 INFO - "False", 15:28:43 INFO - "Change" 15:28:43 INFO - ] 15:28:43 INFO - ], 15:28:43 INFO - "revision": "599cddea4a027034f05a3b99c8050c592a7241c8" 15:28:43 INFO - } 15:28:43 INFO - ], 15:28:43 INFO - "revision": "599cddea4a027034f05a3b99c8050c592a7241c8" 15:28:43 INFO - } 15:28:43 INFO - } 15:28:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2. 15:28:43 INFO - Running post-action listener: _resource_record_post_action 15:28:43 INFO - ##### 15:28:43 INFO - ##### Running download-and-extract step. 15:28:43 INFO - ##### 15:28:43 INFO - Running pre-action listener: _resource_record_pre_action 15:28:43 INFO - Running main action method: download_and_extract 15:28:43 INFO - mkdir: /builds/slave/test/build/tests 15:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:43 INFO - https://queue.taskcluster.net/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:28:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/test_packages.json 15:28:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/test_packages.json 15:28:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:28:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:28:45 INFO - Downloaded 1302 bytes. 15:28:45 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:28:45 INFO - Using the following test package requirements: 15:28:45 INFO - {u'common': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'], 15:28:45 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:45 INFO - u'firefox-44.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:28:45 INFO - u'jittest': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:45 INFO - u'jsshell-linux-x86_64.zip'], 15:28:45 INFO - u'mochitest': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:45 INFO - u'firefox-44.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:28:45 INFO - u'mozbase': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'], 15:28:45 INFO - u'reftest': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:45 INFO - u'firefox-44.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:28:45 INFO - u'talos': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:45 INFO - u'firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:28:45 INFO - u'web-platform': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:45 INFO - u'firefox-44.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:28:45 INFO - u'webapprt': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'], 15:28:45 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:45 INFO - u'firefox-44.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:28:45 INFO - Downloading packages: [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:45 INFO - https://queue.taskcluster.net/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:28:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 15:28:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 15:28:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 15:28:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:28:50 INFO - Downloaded 22678773 bytes. 15:28:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 15:28:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 15:28:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:28:52 INFO - Return code: 0 15:28:52 INFO - Downloading packages: [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:52 INFO - https://queue.taskcluster.net/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:28:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 15:28:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 15:28:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 15:28:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:29:01 INFO - Downloaded 22678773 bytes. 15:29:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 15:29:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 15:29:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:29:02 INFO - Return code: 0 15:29:02 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')]} 15:29:02 INFO - https://queue.taskcluster.net/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:29:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip 15:29:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip 15:29:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip 15:29:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:29:04 INFO - Downloaded 11131307 bytes. 15:29:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 15:29:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip 15:29:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 15:29:04 INFO - Return code: 0 15:29: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')]} 15:29:04 INFO - https://queue.taskcluster.net/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:29:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 15:29:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 15:29:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 15:29:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:29:06 INFO - Downloaded 55663530 bytes. 15:29:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 15:29:06 INFO - mkdir: /builds/slave/test/properties 15:29:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:29:06 INFO - Writing to file /builds/slave/test/properties/build_url 15:29:06 INFO - Contents: 15:29:06 INFO - build_url:https://queue.taskcluster.net/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 15:29:06 INFO - Running post-action listener: _resource_record_post_action 15:29:06 INFO - Running post-action listener: set_extra_try_arguments 15:29:06 INFO - ##### 15:29:06 INFO - ##### Running populate-webroot step. 15:29:06 INFO - ##### 15:29:06 INFO - Running pre-action listener: _resource_record_pre_action 15:29:06 INFO - Running main action method: populate_webroot 15:29:06 INFO - Guessing talos json url... 15:29:06 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')]} 15:29:06 INFO - https://queue.taskcluster.net/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.txt matches https://queue.taskcluster.net 15:29:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.txt 15:29:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.txt 15:29:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.txt to /builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.txt 15:29:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.txt', 'file_name': '/builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.txt'}, attempt #1 15:29:08 INFO - Downloaded 103 bytes. 15:29:08 INFO - Reading from file /builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.txt 15:29:08 INFO - Contents: 15:29:08 INFO - 20151023150531 15:29:08 INFO - https://hg.mozilla.org/integration/fx-team/rev/599cddea4a027034f05a3b99c8050c592a7241c8 15:29:08 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')]} 15:29:08 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/599cddea4a/testing/talos/talos.json 15:29:08 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/599cddea4a/testing/talos/talos.json to /builds/slave/test/build/talos.json 15:29:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/599cddea4a/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 15:29:09 INFO - Downloaded 4264 bytes. 15:29:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:29:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:29:09 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:29:09 INFO - '../fennec_ids.txt'], 15:29:09 INFO - 'tests': ['tcheck2']}, 15:29:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:29:09 INFO - '--tppagecycles', 15:29:09 INFO - '7'], 15:29:09 INFO - 'tests': ['tsvgm']}}, 15:29:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:29:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:29:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:29:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:29:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:29:09 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:29:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:29:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:29:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:29:09 INFO - 'talos_options': ['--e10s'], 15:29:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:29:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:29:09 INFO - 'tests': ['damp', 'tps']}, 15:29:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:29:09 INFO - 'talos_options': ['--e10s'], 15:29:09 INFO - 'tests': ['damp', 'tps']}, 15:29:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:29:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:29:09 INFO - 'other': {'tests': ['a11yr', 15:29:09 INFO - 'ts_paint', 15:29:09 INFO - 'tpaint', 15:29:09 INFO - 'sessionrestore', 15:29:09 INFO - 'sessionrestore_no_auto_restore']}, 15:29:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:29:09 INFO - 'tests': ['a11yr', 15:29:09 INFO - 'ts_paint', 15:29:09 INFO - 'tpaint', 15:29:09 INFO - 'sessionrestore', 15:29:09 INFO - 'sessionrestore_no_auto_restore']}, 15:29:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:29:09 INFO - 'tests': ['a11yr', 15:29:09 INFO - 'ts_paint', 15:29:09 INFO - 'tpaint', 15:29:09 INFO - 'sessionrestore', 15:29:09 INFO - 'sessionrestore_no_auto_restore']}, 15:29:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:29:09 INFO - 'tests': ['a11yr', 15:29:09 INFO - 'ts_paint', 15:29:09 INFO - 'tpaint', 15:29:09 INFO - 'sessionrestore', 15:29:09 INFO - 'sessionrestore_no_auto_restore']}, 15:29:09 INFO - 'other_l64': {'tests': ['a11yr', 15:29:09 INFO - 'ts_paint', 15:29:09 INFO - 'tpaint', 15:29:09 INFO - 'sessionrestore', 15:29:09 INFO - 'sessionrestore_no_auto_restore']}, 15:29:09 INFO - 'other_nol64': {'tests': ['a11yr', 15:29:09 INFO - 'ts_paint', 15:29:09 INFO - 'tpaint', 15:29:09 INFO - 'sessionrestore', 15:29:09 INFO - 'sessionrestore_no_auto_restore']}, 15:29:09 INFO - 'svgr': {'tests': ['tsvgx', 15:29:09 INFO - 'tsvgr_opacity', 15:29:09 INFO - 'tart', 15:29:09 INFO - 'tscrollx', 15:29:09 INFO - 'cart']}, 15:29:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:29:09 INFO - 'tests': ['tsvgx', 15:29:09 INFO - 'tsvgr_opacity', 15:29:09 INFO - 'tart', 15:29:09 INFO - 'tscrollx', 15:29:09 INFO - 'cart']}, 15:29:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:29:09 INFO - 'tests': ['tp5o']}, 15:29:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:29:09 INFO - 'talos_options': ['--e10s'], 15:29:09 INFO - 'tests': ['tp5o']}, 15:29:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:29:09 INFO - 'talos_options': ['--xperf_path', 15:29:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:29:09 INFO - 'tests': ['tp5n']}, 15:29:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:29:09 INFO - 'talos_options': ['--e10s', 15:29:09 INFO - '--xperf_path', 15:29:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 15:29:09 INFO - 'C:/slave/talos-data/talos/xperf.config'], 15:29:09 INFO - 'tests': ['tp5n']}}, 15:29:09 INFO - 'talos.zip': {'path': '', 15:29:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:29:09 INFO - Running post-action listener: _resource_record_post_action 15:29:09 INFO - ##### 15:29:09 INFO - ##### Running create-virtualenv step. 15:29:09 INFO - ##### 15:29:09 INFO - Running pre-action listener: _resource_record_pre_action 15:29:09 INFO - Running main action method: create_virtualenv 15:29:09 INFO - Creating virtualenv /builds/slave/test/build/venv 15:29:09 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 15:29:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:29:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:29:09 INFO - Using real prefix '/usr' 15:29:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:29:10 INFO - Installing distribute.............................................................................................................................................................................................done. 15:29:11 INFO - Installing pip.................done. 15:29:12 INFO - Return code: 0 15:29:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:29:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:12 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 0x7ff2ffc18c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27517b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2823ae0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8a30>, '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 0x28220b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2822540>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1445638716.984502-36503012', '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 15:29:12 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 15:29:12 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 15:29:12 INFO - Using env: {'DISPLAY': ':0', 15:29:12 INFO - 'HOME': '/home/cltbld', 15:29:12 INFO - 'LANG': 'en_US.UTF-8', 15:29:12 INFO - 'LANGUAGE': 'en_US:en', 15:29:12 INFO - 'LOGNAME': 'cltbld', 15:29:12 INFO - 'MAIL': '/var/mail/cltbld', 15:29:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:12 INFO - 'MOZ_NO_REMOTE': '1', 15:29:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:12 INFO - 'NO_EM_RESTART': '1', 15:29:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:12 INFO - 'PWD': '/builds/slave/test', 15:29:12 INFO - 'SHELL': '/bin/bash', 15:29:12 INFO - 'SHLVL': '1', 15:29:12 INFO - 'TERM': 'linux', 15:29:12 INFO - 'TMOUT': '86400', 15:29:12 INFO - 'USER': 'cltbld', 15:29:12 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1445638716.984502-36503012', 15:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:12 INFO - '_': '/tools/buildbot/bin/python'} 15:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:12 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 15:29:12 INFO - Cleaning up... 15:29:12 INFO - Return code: 0 15:29:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:29:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:12 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 0x7ff2ffc18c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27517b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2823ae0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8a30>, '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 0x28220b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2822540>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1445638716.984502-36503012', '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 15:29:12 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 15:29:12 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 15:29:12 INFO - Using env: {'DISPLAY': ':0', 15:29:12 INFO - 'HOME': '/home/cltbld', 15:29:12 INFO - 'LANG': 'en_US.UTF-8', 15:29:12 INFO - 'LANGUAGE': 'en_US:en', 15:29:12 INFO - 'LOGNAME': 'cltbld', 15:29:12 INFO - 'MAIL': '/var/mail/cltbld', 15:29:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:12 INFO - 'MOZ_NO_REMOTE': '1', 15:29:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:12 INFO - 'NO_EM_RESTART': '1', 15:29:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:12 INFO - 'PWD': '/builds/slave/test', 15:29:12 INFO - 'SHELL': '/bin/bash', 15:29:12 INFO - 'SHLVL': '1', 15:29:12 INFO - 'TERM': 'linux', 15:29:12 INFO - 'TMOUT': '86400', 15:29:12 INFO - 'USER': 'cltbld', 15:29:12 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1445638716.984502-36503012', 15:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:12 INFO - '_': '/tools/buildbot/bin/python'} 15:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:12 INFO - Downloading/unpacking psutil>=0.7.1 15:29:12 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 15:29:12 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 15:29:12 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 15:29:12 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 15:29:12 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 15:29:12 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 15:29:14 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:29:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:29:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:29:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:29:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:29:14 INFO - Installing collected packages: psutil 15:29:14 INFO - Running setup.py install for psutil 15:29:14 INFO - building 'psutil._psutil_linux' extension 15:29:14 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 15:29:15 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 15:29:15 INFO - building 'psutil._psutil_posix' extension 15:29:15 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 15:29:15 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 15:29:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:29:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:29:16 INFO - Successfully installed psutil 15:29:16 INFO - Cleaning up... 15:29:16 INFO - Return code: 0 15:29:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:29:16 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')]} 15:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:16 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')]} 15:29:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:16 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 0x7ff2ffc18c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27517b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2823ae0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8a30>, '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 0x28220b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2822540>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1445638716.984502-36503012', '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 15:29:16 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 15:29:16 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 15:29:16 INFO - Using env: {'DISPLAY': ':0', 15:29:16 INFO - 'HOME': '/home/cltbld', 15:29:16 INFO - 'LANG': 'en_US.UTF-8', 15:29:16 INFO - 'LANGUAGE': 'en_US:en', 15:29:16 INFO - 'LOGNAME': 'cltbld', 15:29:16 INFO - 'MAIL': '/var/mail/cltbld', 15:29:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:16 INFO - 'MOZ_NO_REMOTE': '1', 15:29:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:16 INFO - 'NO_EM_RESTART': '1', 15:29:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:16 INFO - 'PWD': '/builds/slave/test', 15:29:16 INFO - 'SHELL': '/bin/bash', 15:29:16 INFO - 'SHLVL': '1', 15:29:16 INFO - 'TERM': 'linux', 15:29:16 INFO - 'TMOUT': '86400', 15:29:16 INFO - 'USER': 'cltbld', 15:29:16 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1445638716.984502-36503012', 15:29:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:16 INFO - '_': '/tools/buildbot/bin/python'} 15:29:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:29:16 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 15:29:16 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 15:29:16 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 15:29:16 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 15:29:16 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 15:29:16 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 15:29:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:29:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:29:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:29:18 INFO - Installing collected packages: mozsystemmonitor 15:29:18 INFO - Running setup.py install for mozsystemmonitor 15:29:18 INFO - Successfully installed mozsystemmonitor 15:29:18 INFO - Cleaning up... 15:29:18 INFO - Return code: 0 15:29:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:29:18 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')]} 15:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:18 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')]} 15:29:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:18 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 0x7ff2ffc18c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27517b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2823ae0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8a30>, '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 0x28220b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2822540>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1445638716.984502-36503012', '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 15:29:18 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 15:29:18 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 15:29:18 INFO - Using env: {'DISPLAY': ':0', 15:29:18 INFO - 'HOME': '/home/cltbld', 15:29:18 INFO - 'LANG': 'en_US.UTF-8', 15:29:18 INFO - 'LANGUAGE': 'en_US:en', 15:29:18 INFO - 'LOGNAME': 'cltbld', 15:29:18 INFO - 'MAIL': '/var/mail/cltbld', 15:29:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:18 INFO - 'MOZ_NO_REMOTE': '1', 15:29:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:18 INFO - 'NO_EM_RESTART': '1', 15:29:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:18 INFO - 'PWD': '/builds/slave/test', 15:29:18 INFO - 'SHELL': '/bin/bash', 15:29:18 INFO - 'SHLVL': '1', 15:29:18 INFO - 'TERM': 'linux', 15:29:18 INFO - 'TMOUT': '86400', 15:29:18 INFO - 'USER': 'cltbld', 15:29:18 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1445638716.984502-36503012', 15:29:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:18 INFO - '_': '/tools/buildbot/bin/python'} 15:29:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:18 INFO - Downloading/unpacking blobuploader==1.2.4 15:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:21 INFO - Downloading blobuploader-1.2.4.tar.gz 15:29:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:29:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:29:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:29:21 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 15:29:21 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 15:29:21 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 15:29:21 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 15:29:21 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 15:29:21 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 15:29:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:29:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:29:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:29:21 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 15:29:21 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 15:29:21 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 15:29:21 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 15:29:21 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 15:29:21 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 15:29:22 INFO - Downloading docopt-0.6.1.tar.gz 15:29:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:29:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:29:22 INFO - Installing collected packages: blobuploader, requests, docopt 15:29:22 INFO - Running setup.py install for blobuploader 15:29:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:29:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:29:22 INFO - Running setup.py install for requests 15:29:22 INFO - Running setup.py install for docopt 15:29:22 INFO - Successfully installed blobuploader requests docopt 15:29:22 INFO - Cleaning up... 15:29:22 INFO - Return code: 0 15:29:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:29: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')]} 15:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29: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')]} 15:29:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:22 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 0x7ff2ffc18c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27517b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2823ae0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8a30>, '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 0x28220b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2822540>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1445638716.984502-36503012', '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 15:29:22 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 15:29:22 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 15:29:22 INFO - Using env: {'DISPLAY': ':0', 15:29:22 INFO - 'HOME': '/home/cltbld', 15:29:22 INFO - 'LANG': 'en_US.UTF-8', 15:29:22 INFO - 'LANGUAGE': 'en_US:en', 15:29:22 INFO - 'LOGNAME': 'cltbld', 15:29:22 INFO - 'MAIL': '/var/mail/cltbld', 15:29:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:22 INFO - 'MOZ_NO_REMOTE': '1', 15:29:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:22 INFO - 'NO_EM_RESTART': '1', 15:29:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:22 INFO - 'PWD': '/builds/slave/test', 15:29:22 INFO - 'SHELL': '/bin/bash', 15:29:22 INFO - 'SHLVL': '1', 15:29:22 INFO - 'TERM': 'linux', 15:29:22 INFO - 'TMOUT': '86400', 15:29:22 INFO - 'USER': 'cltbld', 15:29:22 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1445638716.984502-36503012', 15:29:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:22 INFO - '_': '/tools/buildbot/bin/python'} 15:29:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:29:22 INFO - Running setup.py (path:/tmp/pip-sokVgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:29:23 INFO - Running setup.py (path:/tmp/pip-aVppQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:29:23 INFO - Running setup.py (path:/tmp/pip-83VCDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:29:23 INFO - Running setup.py (path:/tmp/pip-xMlAic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:29:23 INFO - Running setup.py (path:/tmp/pip-Mrnz7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:29:23 INFO - Running setup.py (path:/tmp/pip-kVZvHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:29:23 INFO - Running setup.py (path:/tmp/pip-LDtgFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:29:23 INFO - Running setup.py (path:/tmp/pip-oRFrzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:29:23 INFO - Running setup.py (path:/tmp/pip-rYD8FV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:29:23 INFO - Running setup.py (path:/tmp/pip-yp3oEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:29:23 INFO - Running setup.py (path:/tmp/pip-TS0PCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:29:23 INFO - Running setup.py (path:/tmp/pip-hGvWF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:29:23 INFO - Running setup.py (path:/tmp/pip-PnL0FI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:29:23 INFO - Running setup.py (path:/tmp/pip-0zLdvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:29:23 INFO - Running setup.py (path:/tmp/pip-LMuVJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:29:24 INFO - Running setup.py (path:/tmp/pip-DeTdeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:29:24 INFO - Running setup.py (path:/tmp/pip-7jflnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:29:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:29:24 INFO - Running setup.py install for manifestparser 15:29:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:29:24 INFO - Running setup.py install for mozcrash 15:29:24 INFO - Running setup.py install for mozdebug 15:29:24 INFO - Running setup.py install for mozdevice 15:29:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:29:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:29:24 INFO - Running setup.py install for mozfile 15:29:24 INFO - Running setup.py install for mozhttpd 15:29:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:29:24 INFO - Running setup.py install for mozinfo 15:29:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:29:24 INFO - Running setup.py install for mozInstall 15:29:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:29:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:29:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:29:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:29:24 INFO - Running setup.py install for mozleak 15:29:25 INFO - Running setup.py install for mozlog 15:29:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:29:25 INFO - Running setup.py install for moznetwork 15:29:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:29:25 INFO - Running setup.py install for mozprocess 15:29:25 INFO - Running setup.py install for mozprofile 15:29:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:29:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:29:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:29:25 INFO - Running setup.py install for mozrunner 15:29:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:29:25 INFO - Running setup.py install for mozscreenshot 15:29:25 INFO - Running setup.py install for moztest 15:29:25 INFO - Running setup.py install for mozversion 15:29:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:29:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:29:25 INFO - Cleaning up... 15:29:25 INFO - Return code: 0 15:29:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:29:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:29:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:29:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:25 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 0x7ff2ffc18c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27517b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2823ae0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8a30>, '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 0x28220b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2822540>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1445638716.984502-36503012', '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 15:29:25 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 15:29:25 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 15:29:25 INFO - Using env: {'DISPLAY': ':0', 15:29:25 INFO - 'HOME': '/home/cltbld', 15:29:25 INFO - 'LANG': 'en_US.UTF-8', 15:29:25 INFO - 'LANGUAGE': 'en_US:en', 15:29:25 INFO - 'LOGNAME': 'cltbld', 15:29:25 INFO - 'MAIL': '/var/mail/cltbld', 15:29:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:25 INFO - 'MOZ_NO_REMOTE': '1', 15:29:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:25 INFO - 'NO_EM_RESTART': '1', 15:29:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:25 INFO - 'PWD': '/builds/slave/test', 15:29:25 INFO - 'SHELL': '/bin/bash', 15:29:25 INFO - 'SHLVL': '1', 15:29:25 INFO - 'TERM': 'linux', 15:29:25 INFO - 'TMOUT': '86400', 15:29:25 INFO - 'USER': 'cltbld', 15:29:25 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1445638716.984502-36503012', 15:29:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:25 INFO - '_': '/tools/buildbot/bin/python'} 15:29:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:29:26 INFO - Running setup.py (path:/tmp/pip-MlgAHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:29:26 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)) 15:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:29:26 INFO - Running setup.py (path:/tmp/pip-uuwTEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:29:26 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)) 15:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:29:26 INFO - Running setup.py (path:/tmp/pip-OxSc_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:29:26 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)) 15:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:29:26 INFO - Running setup.py (path:/tmp/pip-ZtRW3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 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)) 15:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:29:26 INFO - Running setup.py (path:/tmp/pip-ce6GWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:29:26 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)) 15:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:29:26 INFO - Running setup.py (path:/tmp/pip-XjE_Zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:29:26 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)) 15:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:29:26 INFO - Running setup.py (path:/tmp/pip-s5Wr2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 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)) 15:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:29:26 INFO - Running setup.py (path:/tmp/pip-WMiTnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:29:26 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)) 15:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:29:26 INFO - Running setup.py (path:/tmp/pip-vz0mGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:29:26 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)) 15:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:29:26 INFO - Running setup.py (path:/tmp/pip-mIPTmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:29:26 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)) 15:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:29:26 INFO - Running setup.py (path:/tmp/pip-wOcs3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:29:26 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)) 15:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:29:26 INFO - Running setup.py (path:/tmp/pip-eTiCJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:29:27 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)) 15:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:29:27 INFO - Running setup.py (path:/tmp/pip-4CvOEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:29:27 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)) 15:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:29:27 INFO - Running setup.py (path:/tmp/pip-ZYX_AH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.10 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)) 15:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:29:27 INFO - Running setup.py (path:/tmp/pip-AE5EBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:29:27 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)) 15:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:29:27 INFO - Running setup.py (path:/tmp/pip-BznYIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:29:27 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)) 15:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:29:27 INFO - Running setup.py (path:/tmp/pip-lz8nm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:29:27 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)) 15:29:27 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)) 15:29:27 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)) 15:29:27 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)) 15:29:27 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.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:29:27 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.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:29:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:29:27 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 15:29:27 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 15:29:27 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 15:29:27 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 15:29:27 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 15:29:27 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 15:29:29 INFO - Downloading blessings-1.5.1.tar.gz 15:29:29 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 15:29:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:29:29 INFO - Installing collected packages: blessings 15:29:29 INFO - Running setup.py install for blessings 15:29:29 INFO - Successfully installed blessings 15:29:29 INFO - Cleaning up... 15:29:29 INFO - Return code: 0 15:29:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:29:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:29:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:29:30 INFO - Reading from file tmpfile_stdout 15:29:30 INFO - Current package versions: 15:29:30 INFO - argparse == 1.2.1 15:29:30 INFO - blessings == 1.5.1 15:29:30 INFO - blobuploader == 1.2.4 15:29:30 INFO - docopt == 0.6.1 15:29:30 INFO - manifestparser == 1.1 15:29:30 INFO - mozInstall == 1.12 15:29:30 INFO - mozcrash == 0.16 15:29:30 INFO - mozdebug == 0.1 15:29:30 INFO - mozdevice == 0.46 15:29:30 INFO - mozfile == 1.2 15:29:30 INFO - mozhttpd == 0.7 15:29:30 INFO - mozinfo == 0.8 15:29:30 INFO - mozleak == 0.1 15:29:30 INFO - mozlog == 3.0 15:29:30 INFO - moznetwork == 0.27 15:29:30 INFO - mozprocess == 0.22 15:29:30 INFO - mozprofile == 0.27 15:29:30 INFO - mozrunner == 6.10 15:29:30 INFO - mozscreenshot == 0.1 15:29:30 INFO - mozsystemmonitor == 0.0 15:29:30 INFO - moztest == 0.7 15:29:30 INFO - mozversion == 1.4 15:29:30 INFO - psutil == 3.1.1 15:29:30 INFO - requests == 1.2.3 15:29:30 INFO - wsgiref == 0.1.2 15:29:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:29:30 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')]} 15:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:30 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')]} 15:29:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:30 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 0x7ff2ffc18c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27517b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2823ae0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8a30>, '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 0x28220b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2822540>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1445638716.984502-36503012', '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 15:29:30 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 15:29:30 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 15:29:30 INFO - Using env: {'DISPLAY': ':0', 15:29:30 INFO - 'HOME': '/home/cltbld', 15:29:30 INFO - 'LANG': 'en_US.UTF-8', 15:29:30 INFO - 'LANGUAGE': 'en_US:en', 15:29:30 INFO - 'LOGNAME': 'cltbld', 15:29:30 INFO - 'MAIL': '/var/mail/cltbld', 15:29:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:30 INFO - 'MOZ_NO_REMOTE': '1', 15:29:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:30 INFO - 'NO_EM_RESTART': '1', 15:29:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:30 INFO - 'PWD': '/builds/slave/test', 15:29:30 INFO - 'SHELL': '/bin/bash', 15:29:30 INFO - 'SHLVL': '1', 15:29:30 INFO - 'TERM': 'linux', 15:29:30 INFO - 'TMOUT': '86400', 15:29:30 INFO - 'USER': 'cltbld', 15:29:30 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1445638716.984502-36503012', 15:29:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:30 INFO - '_': '/tools/buildbot/bin/python'} 15:29:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:30 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)) 15:29:30 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)) 15:29:30 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)) 15:29:30 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)) 15:29:30 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)) 15:29:30 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)) 15:29:30 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)) 15:29:30 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)) 15:29:30 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)) 15:29:30 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)) 15:29:30 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)) 15:29:30 INFO - Cleaning up... 15:29:30 INFO - Return code: 0 15:29:30 INFO - Running post-action listener: _resource_record_post_action 15:29:30 INFO - Running post-action listener: _start_resource_monitoring 15:29:30 INFO - Starting resource monitoring. 15:29:30 INFO - ##### 15:29:30 INFO - ##### Running install step. 15:29:30 INFO - ##### 15:29:30 INFO - Running pre-action listener: _resource_record_pre_action 15:29:30 INFO - Running main action method: install 15:29:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:29:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:29:30 INFO - Reading from file tmpfile_stdout 15:29:30 INFO - Detecting whether we're running mozinstall >=1.0... 15:29:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:29:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:29:30 INFO - Reading from file tmpfile_stdout 15:29:30 INFO - Output received: 15:29:30 INFO - Usage: mozinstall [options] installer 15:29:30 INFO - Options: 15:29:30 INFO - -h, --help show this help message and exit 15:29:30 INFO - -d DEST, --destination=DEST 15:29:30 INFO - Directory to install application into. [default: 15:29:30 INFO - "/builds/slave/test"] 15:29:30 INFO - --app=APP Application being installed. [default: firefox] 15:29:30 INFO - mkdir: /builds/slave/test/build/application 15:29:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:29:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:29:44 INFO - Reading from file tmpfile_stdout 15:29:44 INFO - Output received: 15:29:44 INFO - /builds/slave/test/build/application/firefox/firefox 15:29:44 INFO - Running post-action listener: _resource_record_post_action 15:29:44 INFO - ##### 15:29:44 INFO - ##### Running run-tests step. 15:29:44 INFO - ##### 15:29:44 INFO - Running pre-action listener: _resource_record_pre_action 15:29:44 INFO - Running main action method: run_tests 15:29:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:29:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:29:44 INFO - Python 2.7.3 15:29:44 INFO - Return code: 0 15:29:44 INFO - grabbing minidump binary from tooltool 15:29: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')]} 15:29:44 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 0x28b8a30>, '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 0x28220b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2822540>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:29:44 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 15:29:44 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 15:29:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:29:44 INFO - Return code: 0 15:29:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:29:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:29:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:29:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:29:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:29:44 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost'] in /builds/slave/test/build 15:29:44 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost 15:29:44 INFO - Using env: {'DISPLAY': ':0', 15:29:44 INFO - 'HOME': '/home/cltbld', 15:29:44 INFO - 'LANG': 'en_US.UTF-8', 15:29:44 INFO - 'LANGUAGE': 'en_US:en', 15:29:44 INFO - 'LOGNAME': 'cltbld', 15:29:44 INFO - 'MAIL': '/var/mail/cltbld', 15:29:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:29:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:44 INFO - 'MOZ_NO_REMOTE': '1', 15:29:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:29:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:44 INFO - 'NO_EM_RESTART': '1', 15:29:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:44 INFO - 'PWD': '/builds/slave/test', 15:29:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:29:44 INFO - 'SHELL': '/bin/bash', 15:29:44 INFO - 'SHLVL': '1', 15:29:44 INFO - 'TERM': 'linux', 15:29:44 INFO - 'TMOUT': '86400', 15:29:44 INFO - 'USER': 'cltbld', 15:29:44 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1445638716.984502-36503012', 15:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:44 INFO - '_': '/tools/buildbot/bin/python'} 15:29:44 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost'] with output_timeout 3600 15:29:45 INFO - mozversion INFO | application_buildid: 20151023150531 15:29:45 INFO - mozversion INFO | application_changeset: 599cddea4a027034f05a3b99c8050c592a7241c8 15:29:45 INFO - mozversion INFO | application_display_name: Nightly 15:29:45 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:29:45 INFO - mozversion INFO | application_name: Firefox 15:29:45 INFO - mozversion INFO | application_remotingname: firefox 15:29:45 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 15:29:45 INFO - mozversion INFO | application_vendor: Mozilla 15:29:45 INFO - mozversion INFO | application_version: 44.0a1 15:29:45 INFO - mozversion INFO | platform_buildid: 20151023150531 15:29:45 INFO - mozversion INFO | platform_changeset: 599cddea4a027034f05a3b99c8050c592a7241c8 15:29:45 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 15:29:45 INFO - mozversion INFO | platform_version: 44.0a1 15:29:45 INFO - 2015-10-23 15:29:45,099 DEBUG : using testdate: 1445639385 15:29:45 INFO - 2015-10-23 15:29:45,100 DEBUG : actual date: 1445639385 15:29:45 INFO - 2015-10-23 15:29:45,147 INFO : starting webserver on 'localhost:48185' 15:29:45 INFO - 2015-10-23 15:29:45,148 INFO : Starting test suite talos-linux64-ix-057 15:29:45 INFO - 2015-10-23 15:29:45,148 INFO : Starting test dromaeo_css 15:29:45 INFO - 2015-10-23 15:29:45,148 DEBUG : operating with platform_type : linux_ 15:29:45 INFO - 2015-10-23 15:29:45,149 INFO : Initialising browser for dromaeo_css test... 15:29:45 INFO - 2015-10-23 15:29:45,163 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2Zb6c0/profile http://localhost:48185/getInfo.html 15:29:51 INFO - 2015-10-23 15:29:51,382 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:29:51 INFO - 2015-10-23 15:29:51,382 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:29:51 INFO - 2015-10-23 15:29:51,382 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:29:51 INFO - 2015-10-23 15:29:51,382 DEBUG : BROWSER_OUTPUT: __metrics 15:29:51 INFO - 2015-10-23 15:29:51,498 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:29:52 INFO - 2015-10-23 15:29:52,634 INFO : Browser initialized. 15:29:52 INFO - 2015-10-23 15:29:52,634 INFO : Running cycle 1/1 for dromaeo_css test... 15:29:52 INFO - 2015-10-23 15:29:52,634 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2Zb6c0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:30:04 INFO - 2015-10-23 15:30:04,592 DEBUG : BROWSER_OUTPUT: RSS: Main: 141684736 15:30:04 INFO - 2015-10-23 15:30:04,592 DEBUG : BROWSER_OUTPUT: 15:30:56 INFO - 2015-10-23 15:30:56,044 DEBUG : BROWSER_OUTPUT: 1445639456041 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] 15:33:08 INFO - 2015-10-23 15:33:08,138 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48185/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48185/tests/dromaeo/cssquery-ext.html) 15:33:09 INFO - 2015-10-23 15:33:09,214 DEBUG : BROWSER_OUTPUT: RSS: Main: 252198912 15:33:09 INFO - 2015-10-23 15:33:09,214 DEBUG : BROWSER_OUTPUT: 15:36:11 INFO - 2015-10-23 15:36:11,740 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48185/tests/dromaeo/cssquery-ext.html (next: http://localhost:48185/tests/dromaeo/cssquery-jquery.html) 15:36:12 INFO - 2015-10-23 15:36:12,321 DEBUG : BROWSER_OUTPUT: RSS: Main: 220332032 15:36:12 INFO - 2015-10-23 15:36:12,321 DEBUG : BROWSER_OUTPUT: 15:39:14 INFO - 2015-10-23 15:39:14,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48185/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48185/tests/dromaeo/cssquery-mootools.html) 15:39:15 INFO - 2015-10-23 15:39:15,039 DEBUG : BROWSER_OUTPUT: RSS: Main: 220712960 15:39:15 INFO - 2015-10-23 15:39:15,039 DEBUG : BROWSER_OUTPUT: 15:42:16 INFO - 2015-10-23 15:42:16,970 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48185/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48185/tests/dromaeo/cssquery-prototype.html) 15:42:17 INFO - 2015-10-23 15:42:17,544 DEBUG : BROWSER_OUTPUT: RSS: Main: 206053376 15:42:17 INFO - 2015-10-23 15:42:17,544 DEBUG : BROWSER_OUTPUT: 15:45:20 INFO - 2015-10-23 15:45:20,286 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48185/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48185/tests/dromaeo/cssquery-yui.html) 15:45:20 INFO - 2015-10-23 15:45:20,892 DEBUG : BROWSER_OUTPUT: RSS: Main: 208723968 15:45:20 INFO - 2015-10-23 15:45:20,892 DEBUG : BROWSER_OUTPUT: 15:48:23 INFO - 2015-10-23 15:48:23,503 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48185/tests/dromaeo/cssquery-yui.html (next: http://localhost:48185/tests/dromaeo/cssquery-dojo.html) 15:48:23 INFO - 2015-10-23 15:48:23,753 DEBUG : BROWSER_OUTPUT: RSS: Main: 254853120 15:48:23 INFO - 2015-10-23 15:48:23,753 DEBUG : BROWSER_OUTPUT: 15:48:23 INFO - 2015-10-23 15:48:23,757 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:48:23 INFO - 2015-10-23 15:48:23,757 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:48:23 INFO - 2015-10-23 15:48:23,757 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:48:23 INFO - 2015-10-23 15:48:23,758 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:48:23 INFO - 2015-10-23 15:48:23,758 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2628.697699764527;2722.2649884531165;2739.6301499297615;2746.46443943431;2758.2828464599197;4756.405449318835;4880.951190488103;4981.701097934127;4998.100341938454;5015.799368025275;4832.395950506187;4857.902841943159;4919.77860996256;4921.335619691341;4922.704637721739;4507.188706032913;4541.137183935059;4556.0660064686745;4566.155261276658;4612.561806628365;4338.392625032498;4567.200739870526;4568.862934111982;4573.405457290548;4609.9308510372375;4473.530279320657;4498.662600304974;4523.095380923795;4603.125406172817;4612.377329060601;4558.361829343895;4566.132434837404;4568;4576.8626941191815;4611.239145540982;4542.364069030338;4554.544545545419;4557.567031132037;4563.429571303587;4605.30920361945;4564.109998550284;4672.57946784791;4684.32077348786;4685.625149987993;4688.929666055012;5231.764570594332;5232.555232805216;5250.369955605352;5254.343207099113;5257.395399529027;5260.710660913648;5265.210218467222;5270.367555893317;5281.313429254211;5329.493698098674;4658.138244424792;4772.451168115642;4775.21209000518;4891.510848915151;4897.020595880838;5220.686758794484;5306.7611957462;5307.336582927134;5312.415634280226;5345.679259244458;5102.69383836971;5107.923381149286;5108.259302401131;5110.131277682803;5119.795208191631;5001.89996200074;5132.974335128375;5147.7683504242395;5255.868603284948;5256.6320357574605;5115.053715062725;5206.921896171561;5217.843464696065;5221.6344855859725;5262.105442074857;5151.0470562945975;5153.510416510426;5165.560927321219;5169.095408303532;5215.348081489814;4126.607972242632;4235.30117530604;4237.851675191415;4286;4293.549177336335;3691.501647277637;3705.7035437164964;3732.9440058399146;3739.7382183247455;3765.039914821703;4511.661625378109;4534.433195850519;4537;4545.2954792007295;4562.270036794097;4970.080535101018;5092.624991252341;5107.514786095315;5199.0641684496395;5255.737213139328;4419.292913133883;4469.195544801902;4475.865724028285;4528.592426681615;4532.864014079583;4586.197415452282;4609.6542759292515;4615.515370886009;4624.05206932578;4670.089332580114;4740.502247263988;4847.515248475124;4854.8786280341865;4976.2286845539;4986.426560945538;5097.566706829813;5172.120739474373;5181.481851814789;5193.792248310026;5226.9215961761365;4935.728534930613;4944.085344211332;4944.777485013111;4956.330895329084;4993.500649934977;4868.342773725643;4996.750162491788;5000.699958002531;5117.590592752496;5119.180931051014;5094.617903657167;5185.637005409585;5189.377274727057;5194.428612852507;5210.5831533477985;5022.196448568212;5039.924401134059;5048.343715316985;5051.191809310492;5087.974560127176;4814.470408255019;4931.2849636803185;4940.555350018516;5031.6729412588065;5036.445990941067;4810.5670489656095;4896.730679812645;4897.632677549269;4908.263760435821;4932.8766780830765;5067.037262920034;5082.517160869859;5093.592512599057;5095.796168153232;5140.12617854973;4727.290906364073;4843.297721830385;4853.757312134449;4954.430240522386;5006.799728010838 15:48:23 INFO - 2015-10-23 15:48:23,761 DEBUG : BROWSER_OUTPUT: |1;ext.html;558.8546977785776;562.5274769193876;565.9264295641568;566.798786430817;569.441946892046;28896.422071558583;29597.704022959762;37911.24177516448;38334.4249836252;38347.80826095873;41288.174236515326;41608.79195604025;41848.16303673925;41941.370879436836;41964;7196;8086.47437916535;8272.669093236293;8273.255407013368;8275.54484503352;7279.381252593509;10402.271840971134;10661.893381066206;10662.093722033636;10663.093637040862;10335.896641033607;10430.791384172311;10450.843237351446;10454.529546170403;10455.73860653486;7401.962990185015;7591.202923693043;10356.948215258913;10478.476076196197;10524.894751052469;10251.743706407326;10408.531616077295;10424.94787526065;10425;10433.16534677224;38693.613063869285;38863;38885.80557097225;38891;38900.61099389027;2689.367998520346;2761.552827114872;2828.1939647200447;3415.3852306584804;3624.5288112545463;28664.644610288575;28713.56929646057;28811.85594072016;29095;29744.55383169254;2486.527559763639;2519.433127546306;2547.541442540342;2632.565626671597;2633.986830065857;244310;244482;244617;244997;245548;57058.14412783812;57350.426495735344;57571;57573.42426575765;57599.71200143972;61279.6936015326;61303.08045379323;61339;61459.69270153621;61617.691911540154;13747.450101995808;14293.714125717635;14329.78505322421;14338.211398373189;14339.928300358431;10911.23621346514;10977.506012229469;11048.613298534674;11059.889401106047;11061.281016733887;18210.45368638943;18353.082345882918;18355.81644183568;18387.816121838878;18473.1687074082;8008.719694810654;8145.918540814635;8245.340372770164;8270.172982701803;8295.377846661524;861.5433820075244;871.7820544863785;881.3830318776882;927.9860802087974;971.6162115964155;27141;27357.726422735916;27488.725112748616;27552.586711199347;27567.586486202723;868.405142477405;942.4151502938292;984.2077127911956;1076.381080878498;1095.1074873977682;13262.137961032502;13606.523771667944;14130.788038179435;14163.221022843842;14355.78466323006;287107;290737;290841;290967.5451622728;292297;38507.2298554033;39571.40642890359;44244.778776105915;45771.542284577394;45846;1149.8620165580016;1220.3776074202221;1226.6013545597716;1236.7897457432077;1237.4369661803858;24107.27678169658;24415.633765493178;24952.625710614717;27481.17556473309;29904.551431728105;44004;44372.77813610911;44425.33533978886;44448.33327500155;44497.332540012576;229641;231618;232814.8359258193;232819;233007;28582.714172858006;28989;29024.419511609227;29774.702252977193;30447.543286850272;35416.93749187529;36285.27429451343;36360.09099772527;38824;40200.597994020856;32994.835025824716;33298.833505832314;34121.317573648885;34397.31205375829;34541;31546.842265788524;33358.66641333556;35108.64891351054;36132.63867361293;37185.814070929475;33698.326033478705;34162.31675366528;34381.828090860385;34414.655853441145;34450.48324275088;30201.546976794925;30209;30560.235994100327;30803.691963080084;30853;23413.41466463352;23436.648450273602;23459.88270058639;23756.287311380685;23806.64290035616 15:48:23 INFO - 2015-10-23 15:48:23,762 DEBUG : BROWSER_OUTPUT: |2;jquery.html;358.11902719310496;359.62778524227423;359.6852753840389;366.03184576794365;366.3881318198608;12847.80728289074;13173.34133293334;15383.230838458074;16397.344106235752;17414.82585174146;14916.477923272687;14959.102453852776;16253.756193657075;16280.83719162808;16313.347466101342;4712.0575884823;4840.854774356775;4845.3216549683075;4847.951520484803;5009.023240468101;3169.2393825481836;3247.0421225738346;4656.650751193657;4768.64235182361;4789.90420191596;4687.789049492781;4708.929366059512;4714.387129673138;4719.174144524694;4730.314104454852;4555.612772914306;4649.628029757611;4651.79066941985;4655.930161047587;4699.530046995307;4006;4015.8393664253394;4019.9598004019876;4020.296448121567;4024.8993775155564;12763.5532756354;12921.095523313372;13211.405486753023;13229.073964822466;13248.801267980987;624;1701.0899168944554;1741.947741567755;1780.64387122576;1809.3513007822628;9340.906590934072;9384.20234280087;9459.66891158813;9608.615655373776;9660.855087173699;1599.8800089993297;1604.7592861070932;1614.73356896112;1643.5808868738516;1669.8330166983326;54283.72858135724;55903.16145257824;56013.879722405734;56558.151627725616;56647;6471.482281417475;6539.673016349164;6547.050677651714;6594;6632.734690612418;7683.462157648911;7716.691332346643;7742.651580678883;7744.883826742604;7762.961185194038;5288.338957630296;5301.416844147141;5310.415854256029;5329.760160792774;5353.0899747043095;5260.579153667697;5270.973645131749;5357.758900849393;5478.616496845182;5480.725963701799;3042.3154790172475;3085.5988721466065;3094.8297843618816;3113.579666745006;3116.1897906544464;1049.223574554824;1088.50473034769;1089.096050278267;1137.8748337682848;1139.5214010115772;411.9320312148522;423.54468945882684;432.67765514691126;445.98662040138845;451.5552181101612;11105.500252488657;11584.304941703356;11600.94199528997;11613.210212487553;11703.765924681458;386.1735885205662;392.86249812565376;397.66794726403776;397.92240513099665;398.38847369288004;5450.591205659592;6122.54080943931;6148.197993152126;6386.936130638727;6431.5819471734185;528438;529637;532384;535698;539080;67768;73014.63492682608;73402.63298683579;73497.26502734904;73846;469.15786163836;493.45719708321275;496.08967544555424;497.8431793984883;498.1581127893848;10133.746656333651;10372.27394082407;10478.79042419132;10535.367877927349;10551.788964220827;29376.55935161017;29426.705732943254;30044.3991120172;30456.39087218199;31328;38261.617383825804;39270.803645981585;39468;45350.54649453463;45403.77298113488;6171.876562468636;6328.367163283635;6374.1394911688185;6375.713092910923;6376.3623637635865;11236.719082023015;11257.493412796608;11575.594854180063;11644.88355116438;11655.650330490098;8271.379646526415;8374.748757537283;9746.26902982265;9812.313138080266;10225.539850706587;9575.707279517175;9883.209343252667;9939.602415903282;9978.351407158512;10241.79801342715;9578.994205608311;9928.156106731009;10040.598376065167;10203.642872499428;10252.333598316085;6141.3551577085545;6252.124702541739;6410.038494225903;6453.419192272718;6461.353864613689;10102.949485252526;10222.080012798884;10325.32885362449;10365.326253793479;10492.317999330018 15:48:23 INFO - 2015-10-23 15:48:23,766 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1230.8215308780232;1478.8669019788217;1607.116086152616;1712.246611490944;1877.906104694765;7419.814504637387;8545.359098067647;8824.426412283197;8838.469691818495;8838.734837954855;8452.154784521545;8477.872831907527;8493.405461617689;8496.32029437645;8602.354823388256;2208.745994210662;2228.465168359598;2245.5059886824874;2246.4945387287894;2246.5506898620342;2225.610518159324;2243.8204943604474;2315.3748487908256;2318.6174281243575;2321.0483701682315;2244.8316376271764;2268.7050683411135;2282.8744419056943;2285.1430713482446;2297.1041293895396;2234.19568955176;2269.4212975691175;2270.5345404192185;2276.4195130241765;2277.3054218463362;2101.443117573844;2115.4076858479652;2115.672070829024;2115.756687980871;2118.5445129297277;7098.432125429953;7200.711971521133;8438.409311348209;8474.83050338996;8480.872786908201;4579.67942244043;4705.482396936334;4714.175019371596;4716.764161791897;4720.103180395714;2904.9273768155754;3008.7893847430687;3039.528873024685;3084.552739852709;3088.042706760911;715.3383120613412;871.1941454154882;881.5107615273521;893.660409044559;894.6287290774321;13078.215307081511;13226;13250.86749132506;13252.536161234408;13255.86744132556;4659.044895796354;4689.788959496831;4721.952780472151;4823.517648235148;4830.396200474941;10956.945215273872;11038.11695064393;11042.116630669527;11052.115830733523;11054.170937179744;4995.17579599362;4996.375453068366;4996.425411077773;5000.449950505442;5004.699718016858;4249.745015299092;4413.786208792543;4415.205263052617;4418.9337159942625;4421.867343979686;3861.2084522672785;3865.903352416212;3874.6512813846325;3889.7082718796205;3899.53205615328;1183.627157445402;1183.7040739815047;1194.5042807235075;1197.4551579031695;1218.2690385768467;1174.7356844710043;1184.1296646964474;1203.6990752311922;1210.4552951172009;1224.455117472734;8167.550784706779;8251.628676709563;8263.628136733862;8310.958445207736;8362.331013518904;447.917135329965;449.4965638484918;454.56816024776595;454.7680682851769;463.46006901959515;6253.1245625612455;6283.842903927439;6293.685315734195;6309.3690630936535;6309.968450157719;9875.950620246853;10716;11217.887821121847;11231.269967452254;11233.94383028096;9946.950265248772;10943.890561094287;11144.721381965353;11175.776484470265;11183.83224251637;8045.517268963881;8111.634976426075;8141.592920353959;8177.4684645497855;8193.672253110048;8157.8776318354085;8187.672493100209;8199.385046121446;8236.588170591567;8238.50568965864;8952.507612081397;9044.276457883221;9251.35240533183;9257.490838003974;9258.305627077862;9261.861072084059;9598.760030999281;9611.375260608038;9613.51932403363;9629.32594718363;7356;7425.257474252531;7429.591372474566;7453;7456;8246.216609422096;8362.540060296498;8485.660573576988;8575.95712021436;8640.179182977607;7764.689412423666;7890.9605451972375;7920.168382319774;7936;7962.522248665098;7647.541147531166;7671.501352412075;7862.764117076496;7884.763457096296;7950.443468957117;7760.961195193988;7766.534007959541;7772.805679858049;7775.416843736629;7789.61051947389;7216.9639151806;7249.456290778318;7304.452166087458;7337.633118343954;7344.449166312655;6981;7117.395021423237;7119.6084215368655;7143.964280178566;7281.162666293232 15:48:23 INFO - 2015-10-23 15:48:23,766 DEBUG : BROWSER_OUTPUT: |4;prototype.html;304.29555578835;315.71585572984316;317.5078628126405;329.61032514271534;330.86765293882456;5108.642395032344;5156.303898973638;5159.251908473274;5159.871003224921;5165.664231824938;5078.4413714491375;5081.339425874631;5081.898362032757;5084.135696931521;5095.566876815476;3907.081835768592;3965.504311961005;4021.6380525752675;4111.54772974974;4112.7326723762935;4041.4341992121126;4068.2677118118727;4070.837166513336;4073.5315438724483;4074.979625101885;4034.4150098235737;4035.455213546163;4036.031352475414;4037.818298176589;4041.898952526181;3864.439656249856;3924.803759811998;3950.683945284399;3991.1419044905483;4014.197160567898;3553.200529880782;3561.198730285691;3564.9643503565153;3568.660977207187;3571.4464258040043;4829.637777166691;4887.902241955141;4890.24201248807;4895.143349913787;4899.657024008321;4508.977455112704;4510.391097201868;4515.887102822456;4517.028838799673;4523.705959112647;5161.767720452589;5222.529972302511;5232.6860388376435;5264.473552644743;5271.077561426735;3788.0340513168967;3790.2987947229576;3791;3791.203847192093;3792.924141517154;5425.810096646638;5458.6724796512335;5499.285092937893;5501.202325662756;5511.779528818883;3903.5706072332023;3909.5308562972054;3911.5501717302873;3917.3536366499206;3919.6864250859862;3902.1610353774076;3955.960440395617;3962.445257663929;3962.484876965976;3964.147708242742;4472.418585583853;4475.530069342737;4475.6419486441655;4477.037436951006;4478.037221997221;5255.369355677343;5256.6320357574605;5259.658122222043;5264.2630031794815;5268.15709486488;1411.1392050848974;1412.3856122586708;1413.1662319231702;1413.2439145057344;1414.886809055273;978.4611474680696;981.9803603927882;998.495759641391;1004.4977511244377;1005.9899401006043;4792.976035119872;4798.184308667535;4798.47216806151;4798.664093513421;4805.038992201504;5510.448955104538;5519.641223320552;5521.033819081645;5527.336719593674;5530.253415788817;4789.4971028042255;4791.880202994953;4796.736179510161;4798.376211092535;4798.976005119952;2864.069177517315;2909.767218622505;3000.3099287164073;3010.1270631516613;3036.362363903561;5197.272381866542;5217.399999000164;5220.034293655686;5238.057149713089;5239.47605239473;5593.664380137205;5596.776128954878;5602.663840169603;5608.523275521627;5614.887702246014;5220;5220.738963051908;5221.008008478377;5222.738863056832;5233;5397.568194544506;5564.304461942257;5566.693831839126;5568.081266590967;5573.972130139324;5448.591355648263;5453.291072160594;5455.099908515051;5456.154296084113;5456.290682211287;5292.603054770831;5295;5295.099833028471;5296.602754793329;5301.231321458444;3864.053306939818;3942.3889297158985;3967.6032396760093;3973.463582416337;3973.7417067890497;5430.918536222039;5433.212184233185;5433.646812957145;5433.994710978482;5436.673799572039;5239.764210610608;5240.764165612481;5241.60687948413;5245.737713114406;5251.501107394792;5229.529342359206;5235.554977826928;5235.973820131027;5239.47605239473;5240.868978275574;5009.899802004013;5141.126008578625;5223.425423203521;5226.425093239664;5234.816781412632;5363.597730170175;5364.892702146013;5370.275012873212;5371.731413429235;5372.704501252312;5187.610929180402;5212.635115542027;5215.452377500308;5220.686758794484;5221.269022336952 15:48:23 INFO - 2015-10-23 15:48:23,767 DEBUG : BROWSER_OUTPUT: |5;yui.html;691.5815931361523;719.9892001619974;732.7362149626134;732.8314487667836;736.797380720302;10463.47682615869;10590.41752703601;10605.204609654269;10617.946910265438;10623.309484883486;10929.56281748731;11024.779504409908;11035.282706624064;11039.613613523528;11046.116310695144;622.6544267931297;631.5452873930763;801.9919800802005;804.3484777330367;818.5375262976399;749.6776386153952;795.1094773853292;808.0142226483681;815.2988429950268;815.9143289954559;839.0434904209206;840.3109450250797;848.6011574559977;849.9915000850006;850.4259624753298;657.1522735671002;665.7070888808933;845.1084106267884;857.8198578298565;858.8883445152153;633.2527617411453;633.7053270229319;633.71482832725;635.2155088465787;636.4144986612328;10963.232573719843;11105.500252488577;11108.61119860809;11115.72210694731;11121.05471034963;10212.540435680412;10412.79174416515;10558.577656893714;10703.197260205437;10795.676129716121;8270.83458330836;8354.775538534046;8524.8721269181;8601;8803.471791692518;2768.6123942648046;2793.106206014056;2794.9720502794917;2797.846118463484;2839.2050225936564;32597.185070372958;32909.17727056819;33037.66962330394;33086.17284567881;33183.502247466065;5945.316288626863;6069.393060693984;6097.512199024068;6202.038684003986;6284.685765711696;9575.425474471554;9591.760205994906;9592.472414017157;15415.922920385327;15587;6002.789902353396;6020.127081573148;6080.209572755602;6186.659733714599;6199.16311297969;3232.1596384939617;3285.490748933919;3371.780834245766;3492.5634295713035;3565.3760591896316;2654.7876169906363;2683.2889284339667;2690.3139699376534;2690.9192724218306;2694.6901106372625;418.4142200918738;419.0299456757596;428.14584903118475;428.7213311347649;428.9056407590325;390.83389559437126;399.2215180398235;399.39890464850214;411.88497067557705;414.50880706363057;6953.687084081229;7014.859702805916;7664.310212080828;7702.629767722806;7720.575368354795;439.4155772822203;448.7868262575316;469.4413647759156;480.0518975024299;502.4347608939943;3233.288676491168;3280.507923811447;3366.915827104293;3376.3584918865336;3416.9487457688156;39430.211395772494;39792.40311395331;39793.40309895354;39809;43237.56762432399;33318.333633327195;33462;33481.162970925434;33485.16287092842;33498.330033399194;32319.676803232138;32329.51505727416;32710;32743.181420464203;32789;6823.454123669995;6866.313368663294;7279.854402911807;7437.442191835526;7443.739469118772;23123.653145202497;23411.76588234096;23856.926438310664;23889.402764931016;23907.40231494157;30872.69127308788;31080.844595776878;31211.531827023067;33915.15212119717;33915.3216935655;9215.44707317563;9398.812023759623;9417;9521.333506654744;9638.036196380306;9490.715278541655;9526.618935242514;9589.376690515093;9604.567794449127;10039.69880903574;9052.728418147466;9126.45241285525;9229.723108306762;9336.906630933603;9535.38020028696;9125.087491250822;9162.221211197122;9170.44977301364;9225.815483690154;9389.154976051916;8982.09819991566;9004.32467564922;9013.022448220265;9198.908010919806;9272.728181595552;7647;7740.26467485588;7839.686412543434;7887.290143887078;7937.6031198438695;7428.861991266165;7456.96271518639;7665.731699390494;7688.423368247292;7733.458657894119 15:48:23 INFO - 2015-10-23 15:48:23,767 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:48:23 INFO - 2015-10-23 15:48:23,767 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:48:23 INFO - 2015-10-23 15:48:23,768 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,888 15:48:23 INFO - 2015-10-23 15:48:23,768 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:48:23 INFO - 2015-10-23 15:48:23,768 DEBUG : BROWSER_OUTPUT: __startTimestamp1445640503754__endTimestamp 15:48:23 INFO - 2015-10-23 15:48:23,768 DEBUG : BROWSER_OUTPUT: 15:48:23 INFO - 2015-10-23 15:48:23,768 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:48:23 INFO - 2015-10-23 15:48:23,768 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:48:23 INFO - 2015-10-23 15:48:23,768 DEBUG : BROWSER_OUTPUT: 15:48:23 INFO - 2015-10-23 15:48:23,768 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4788.98 Median:4921.34 stddev:503.30 (10.2%) stddev-sans-first:475.45 15:48:23 INFO - 2015-10-23 15:48:23,768 DEBUG : BROWSER_OUTPUT: Values: 2628.7 2722.3 2739.6 2746.5 2758.3 4756.4 4881.0 4981.7 4998.1 5015.8 4832.4 4857.9 4919.8 4921.3 4922.7 4507.2 4541.1 4556.1 4566.2 4612.6 4338.4 4567.2 4568.9 4573.4 4609.9 4473.5 4498.7 4523.1 4603.1 4612.4 4558.4 4566.1 4568.0 4576.9 4611.2 4542.4 4554.5 4557.6 4563.4 4605.3 4564.1 4672.6 4684.3 4685.6 4688.9 5231.8 5232.6 5250.4 5254.3 5257.4 5260.7 5265.2 5270.4 5281.3 5329.5 4658.1 4772.5 4775.2 4891.5 4897.0 5220.7 5306.8 5307.3 5312.4 5345.7 5102.7 5107.9 5108.3 5110.1 5119.8 5001.9 5133.0 5147.8 5255.9 5256.6 5115.1 5206.9 5217.8 5221.6 5262.1 5151.0 5153.5 5165.6 5169.1 5215.3 4126.6 4235.3 4237.9 4286.0 4293.5 3691.5 3705.7 3732.9 3739.7 3765.0 4511.7 4534.4 4537.0 4545.3 4562.3 4970.1 5092.6 5107.5 5199.1 5255.7 4419.3 4469.2 4475.9 4528.6 4532.9 4586.2 4609.7 4615.5 4624.1 4670.1 4740.5 4847.5 4854.9 4976.2 4986.4 5097.6 5172.1 5181.5 5193.8 5226.9 4935.7 4944.1 4944.8 4956.3 4993.5 4868.3 4996.8 5000.7 5117.6 5119.2 5094.6 5185.6 5189.4 5194.4 5210.6 5022.2 5039.9 5048.3 5051.2 5088.0 4814.5 4931.3 4940.6 5031.7 5036.4 4810.6 4896.7 4897.6 4908.3 4932.9 5067.0 5082.5 5093.6 5095.8 5140.1 4727.3 4843.3 4853.8 4954.4 5006.8 15:48:23 INFO - 2015-10-23 15:48:23,768 DEBUG : BROWSER_OUTPUT: 15:48:23 INFO - 2015-10-23 15:48:23,769 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42154.99 Median:29759.63 stddev:66938.35 (224.9%) stddev-sans-first:67053.26 15:48:23 INFO - 2015-10-23 15:48:23,769 DEBUG : BROWSER_OUTPUT: Values: 558.9 562.5 565.9 566.8 569.4 28896.4 29597.7 37911.2 38334.4 38347.8 41288.2 41608.8 41848.2 41941.4 41964.0 7196.0 8086.5 8272.7 8273.3 8275.5 7279.4 10402.3 10661.9 10662.1 10663.1 10335.9 10430.8 10450.8 10454.5 10455.7 7402.0 7591.2 10356.9 10478.5 10524.9 10251.7 10408.5 10424.9 10425.0 10433.2 38693.6 38863.0 38885.8 38891.0 38900.6 2689.4 2761.6 2828.2 3415.4 3624.5 28664.6 28713.6 28811.9 29095.0 29744.6 2486.5 2519.4 2547.5 2632.6 2634.0 244310.0 244482.0 244617.0 244997.0 245548.0 57058.1 57350.4 57571.0 57573.4 57599.7 61279.7 61303.1 61339.0 61459.7 61617.7 13747.5 14293.7 14329.8 14338.2 14339.9 10911.2 10977.5 11048.6 11059.9 11061.3 18210.5 18353.1 18355.8 18387.8 18473.2 8008.7 8145.9 8245.3 8270.2 8295.4 861.5 871.8 881.4 928.0 971.6 27141.0 27357.7 27488.7 27552.6 27567.6 868.4 942.4 984.2 1076.4 1095.1 13262.1 13606.5 14130.8 14163.2 14355.8 287107.0 290737.0 290841.0 290967.5 292297.0 38507.2 39571.4 44244.8 45771.5 45846.0 1149.9 1220.4 1226.6 1236.8 1237.4 24107.3 24415.6 24952.6 27481.2 29904.6 44004.0 44372.8 44425.3 44448.3 44497.3 229641.0 231618.0 232814.8 232819.0 233007.0 28582.7 28989.0 29024.4 29774.7 30447.5 35416.9 36285.3 36360.1 38824.0 40200.6 32994.8 33298.8 34121.3 34397.3 34541.0 31546.8 33358.7 35108.6 36132.6 37185.8 33698.3 34162.3 34381.8 34414.7 34450.5 30201.5 30209.0 30560.2 30803.7 30853.0 23413.4 23436.6 23459.9 23756.3 23806.6 15:48:23 INFO - 2015-10-23 15:48:23,769 DEBUG : BROWSER_OUTPUT: 15:48:23 INFO - 2015-10-23 15:48:23,769 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25953.25 Median:24979.69 stddev:87294.27 (349.5%) stddev-sans-first:87517.99 15:48:23 INFO - 2015-10-23 15:48:23,769 DEBUG : BROWSER_OUTPUT: Values: 358.1 359.6 359.7 366.0 366.4 12847.8 13173.3 15383.2 16397.3 17414.8 14916.5 14959.1 16253.8 16280.8 16313.3 4712.1 4840.9 4845.3 4848.0 5009.0 3169.2 3247.0 4656.7 4768.6 4789.9 4687.8 4708.9 4714.4 4719.2 4730.3 4555.6 4649.6 4651.8 4655.9 4699.5 4006.0 4015.8 4020.0 4020.3 4024.9 12763.6 12921.1 13211.4 13229.1 13248.8 624.0 1701.1 1741.9 1780.6 1809.4 9340.9 9384.2 9459.7 9608.6 9660.9 1599.9 1604.8 1614.7 1643.6 1669.8 54283.7 55903.2 56013.9 56558.2 56647.0 6471.5 6539.7 6547.1 6594.0 6632.7 7683.5 7716.7 7742.7 7744.9 7763.0 5288.3 5301.4 5310.4 5329.8 5353.1 5260.6 5271.0 5357.8 5478.6 5480.7 3042.3 3085.6 3094.8 3113.6 3116.2 1049.2 1088.5 1089.1 1137.9 1139.5 411.9 423.5 432.7 446.0 451.6 11105.5 11584.3 11600.9 11613.2 11703.8 386.2 392.9 397.7 397.9 398.4 5450.6 6122.5 6148.2 6386.9 6431.6 528438.0 529637.0 532384.0 535698.0 539080.0 67768.0 73014.6 73402.6 73497.3 73846.0 469.2 493.5 496.1 497.8 498.2 10133.7 10372.3 10478.8 10535.4 10551.8 29376.6 29426.7 30044.4 30456.4 31328.0 38261.6 39270.8 39468.0 45350.5 45403.8 6171.9 6328.4 6374.1 6375.7 6376.4 11236.7 11257.5 11575.6 11644.9 11655.7 8271.4 8374.7 9746.3 9812.3 10225.5 9575.7 9883.2 9939.6 9978.4 10241.8 9579.0 9928.2 10040.6 10203.6 10252.3 6141.4 6252.1 6410.0 6453.4 6461.4 10102.9 10222.1 10325.3 10365.3 10492.3 15:48:23 INFO - 2015-10-23 15:48:23,769 DEBUG : BROWSER_OUTPUT: 15:48:23 INFO - 2015-10-23 15:48:23,769 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:6012.72 Median:4998.44 stddev:3402.97 (68.1%) stddev-sans-first:3393.54 15:48:23 INFO - 2015-10-23 15:48:23,770 DEBUG : BROWSER_OUTPUT: Values: 1230.8 1478.9 1607.1 1712.2 1877.9 7419.8 8545.4 8824.4 8838.5 8838.7 8452.2 8477.9 8493.4 8496.3 8602.4 2208.7 2228.5 2245.5 2246.5 2246.6 2225.6 2243.8 2315.4 2318.6 2321.0 2244.8 2268.7 2282.9 2285.1 2297.1 2234.2 2269.4 2270.5 2276.4 2277.3 2101.4 2115.4 2115.7 2115.8 2118.5 7098.4 7200.7 8438.4 8474.8 8480.9 4579.7 4705.5 4714.2 4716.8 4720.1 2904.9 3008.8 3039.5 3084.6 3088.0 715.3 871.2 881.5 893.7 894.6 13078.2 13226.0 13250.9 13252.5 13255.9 4659.0 4689.8 4722.0 4823.5 4830.4 10956.9 11038.1 11042.1 11052.1 11054.2 4995.2 4996.4 4996.4 5000.4 5004.7 4249.7 4413.8 4415.2 4418.9 4421.9 3861.2 3865.9 3874.7 3889.7 3899.5 1183.6 1183.7 1194.5 1197.5 1218.3 1174.7 1184.1 1203.7 1210.5 1224.5 8167.6 8251.6 8263.6 8311.0 8362.3 447.9 449.5 454.6 454.8 463.5 6253.1 6283.8 6293.7 6309.4 6310.0 9876.0 10716.0 11217.9 11231.3 11233.9 9947.0 10943.9 11144.7 11175.8 11183.8 8045.5 8111.6 8141.6 8177.5 8193.7 8157.9 8187.7 8199.4 8236.6 8238.5 8952.5 9044.3 9251.4 9257.5 9258.3 9261.9 9598.8 9611.4 9613.5 9629.3 7356.0 7425.3 7429.6 7453.0 7456.0 8246.2 8362.5 8485.7 8576.0 8640.2 7764.7 7891.0 7920.2 7936.0 7962.5 7647.5 7671.5 7862.8 7884.8 7950.4 7761.0 7766.5 7772.8 7775.4 7789.6 7217.0 7249.5 7304.5 7337.6 7344.4 6981.0 7117.4 7119.6 7144.0 7281.2 15:48:23 INFO - 2015-10-23 15:48:23,770 DEBUG : BROWSER_OUTPUT: 15:48:23 INFO - 2015-10-23 15:48:23,771 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4447.59 Median:5083.02 stddev:1268.56 (25.0%) stddev-sans-first:1233.41 15:48:23 INFO - 2015-10-23 15:48:23,771 DEBUG : BROWSER_OUTPUT: Values: 304.3 315.7 317.5 329.6 330.9 5108.6 5156.3 5159.3 5159.9 5165.7 5078.4 5081.3 5081.9 5084.1 5095.6 3907.1 3965.5 4021.6 4111.5 4112.7 4041.4 4068.3 4070.8 4073.5 4075.0 4034.4 4035.5 4036.0 4037.8 4041.9 3864.4 3924.8 3950.7 3991.1 4014.2 3553.2 3561.2 3565.0 3568.7 3571.4 4829.6 4887.9 4890.2 4895.1 4899.7 4509.0 4510.4 4515.9 4517.0 4523.7 5161.8 5222.5 5232.7 5264.5 5271.1 3788.0 3790.3 3791.0 3791.2 3792.9 5425.8 5458.7 5499.3 5501.2 5511.8 3903.6 3909.5 3911.6 3917.4 3919.7 3902.2 3956.0 3962.4 3962.5 3964.1 4472.4 4475.5 4475.6 4477.0 4478.0 5255.4 5256.6 5259.7 5264.3 5268.2 1411.1 1412.4 1413.2 1413.2 1414.9 978.5 982.0 998.5 1004.5 1006.0 4793.0 4798.2 4798.5 4798.7 4805.0 5510.4 5519.6 5521.0 5527.3 5530.3 4789.5 4791.9 4796.7 4798.4 4799.0 2864.1 2909.8 3000.3 3010.1 3036.4 5197.3 5217.4 5220.0 5238.1 5239.5 5593.7 5596.8 5602.7 5608.5 5614.9 5220.0 5220.7 5221.0 5222.7 5233.0 5397.6 5564.3 5566.7 5568.1 5574.0 5448.6 5453.3 5455.1 5456.2 5456.3 5292.6 5295.0 5295.1 5296.6 5301.2 3864.1 3942.4 3967.6 3973.5 3973.7 5430.9 5433.2 5433.6 5434.0 5436.7 5239.8 5240.8 5241.6 5245.7 5251.5 5229.5 5235.6 5236.0 5239.5 5240.9 5009.9 5141.1 5223.4 5226.4 5234.8 5363.6 5364.9 5370.3 5371.7 5372.7 5187.6 5212.6 5215.5 5220.7 5221.3 15:48:23 INFO - 2015-10-23 15:48:23,771 DEBUG : BROWSER_OUTPUT: 15:48:23 INFO - 2015-10-23 15:48:23,771 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10160.80 Median:6044.76 stddev:10896.88 (180.3%) stddev-sans-first:10904.24 15:48:23 INFO - 2015-10-23 15:48:23,772 DEBUG : BROWSER_OUTPUT: Values: 691.6 720.0 732.7 732.8 736.8 10463.5 10590.4 10605.2 10617.9 10623.3 10929.6 11024.8 11035.3 11039.6 11046.1 622.7 631.5 802.0 804.3 818.5 749.7 795.1 808.0 815.3 815.9 839.0 840.3 848.6 850.0 850.4 657.2 665.7 845.1 857.8 858.9 633.3 633.7 633.7 635.2 636.4 10963.2 11105.5 11108.6 11115.7 11121.1 10212.5 10412.8 10558.6 10703.2 10795.7 8270.8 8354.8 8524.9 8601.0 8803.5 2768.6 2793.1 2795.0 2797.8 2839.2 32597.2 32909.2 33037.7 33086.2 33183.5 5945.3 6069.4 6097.5 6202.0 6284.7 9575.4 9591.8 9592.5 15415.9 15587.0 6002.8 6020.1 6080.2 6186.7 6199.2 3232.2 3285.5 3371.8 3492.6 3565.4 2654.8 2683.3 2690.3 2690.9 2694.7 418.4 419.0 428.1 428.7 428.9 390.8 399.2 399.4 411.9 414.5 6953.7 7014.9 7664.3 7702.6 7720.6 439.4 448.8 469.4 480.1 502.4 3233.3 3280.5 3366.9 3376.4 3416.9 39430.2 39792.4 39793.4 39809.0 43237.6 33318.3 33462.0 33481.2 33485.2 33498.3 32319.7 32329.5 32710.0 32743.2 32789.0 6823.5 6866.3 7279.9 7437.4 7443.7 23123.7 23411.8 23856.9 23889.4 23907.4 30872.7 31080.8 31211.5 33915.2 33915.3 9215.4 9398.8 9417.0 9521.3 9638.0 9490.7 9526.6 9589.4 9604.6 10039.7 9052.7 9126.5 9229.7 9336.9 9535.4 9125.1 9162.2 9170.4 9225.8 9389.2 8982.1 9004.3 9013.0 9198.9 9272.7 7647.0 7740.3 7839.7 7887.3 7937.6 7428.9 7457.0 7665.7 7688.4 7733.5 15:48:23 INFO - 2015-10-23 15:48:23,772 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:48:23 INFO - 2015-10-23 15:48:23,772 DEBUG : BROWSER_OUTPUT: 15:48:24 INFO - 2015-10-23 15:48:24,410 INFO : Browser exited with error code: 0 15:48:24 INFO - 2015-10-23 15:48:24,426 INFO : Completed test dromaeo_css (00:18:39) 15:48:24 INFO - 2015-10-23 15:48:24,426 INFO : Starting test kraken 15:48:24 INFO - 2015-10-23 15:48:24,426 DEBUG : operating with platform_type : linux_ 15:48:24 INFO - 2015-10-23 15:48:24,426 INFO : Initialising browser for kraken test... 15:48:24 INFO - 2015-10-23 15:48:24,432 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnj5YnK/profile http://localhost:48185/getInfo.html 15:48:28 INFO - 2015-10-23 15:48:28,361 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:48:28 INFO - 2015-10-23 15:48:28,361 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:48:28 INFO - 2015-10-23 15:48:28,361 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:48:28 INFO - 2015-10-23 15:48:28,361 DEBUG : BROWSER_OUTPUT: __metrics 15:48:28 INFO - 2015-10-23 15:48:28,503 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:48:29 INFO - 2015-10-23 15:48:29,145 DEBUG : BROWSER_OUTPUT: console.error: 15:48:29 INFO - 2015-10-23 15:48:29,145 DEBUG : BROWSER_OUTPUT: Message: [Exception... "Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [mozIStorageAsyncStatement.executeAsync]" nsresult: "0x80040111 (NS_ERROR_NOT_AVAILABLE)" location: "JS frame :: resource://gre/modules/Sqlite.jsm :: ConnectionData.prototype<._executeStatement :: line 758" data: no] 15:48:29 INFO - 2015-10-23 15:48:29,145 DEBUG : BROWSER_OUTPUT: Stack: 15:48:29 INFO - 2015-10-23 15:48:29,145 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 15:48:29 INFO - 2015-10-23 15:48:29,146 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 15:48:29 INFO - 2015-10-23 15:48:29,146 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 15:48:29 INFO - 2015-10-23 15:48:29,146 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 15:48:29 INFO - 2015-10-23 15:48:29,146 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 15:48:29 INFO - 2015-10-23 15:48:29,146 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 15:48:29 INFO - 2015-10-23 15:48:29,146 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 15:48:29 INFO - 2015-10-23 15:48:29,146 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:798:13 15:48:29 INFO - 2015-10-23 15:48:29,146 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 15:48:29 INFO - 2015-10-23 15:48:29,147 DEBUG : BROWSER_OUTPUT: Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23 15:48:29 INFO - 2015-10-23 15:48:29,147 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 15:48:29 INFO - 2015-10-23 15:48:29,147 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 15:48:29 INFO - 2015-10-23 15:48:29,147 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 15:48:29 INFO - 2015-10-23 15:48:29,147 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 15:48:29 INFO - 2015-10-23 15:48:29,147 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 15:48:29 INFO - 2015-10-23 15:48:29,147 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 15:48:29 INFO - 2015-10-23 15:48:29,148 DEBUG : BROWSER_OUTPUT: 15:48:29 INFO - 2015-10-23 15:48:29,651 INFO : Browser initialized. 15:48:29 INFO - 2015-10-23 15:48:29,651 INFO : Running cycle 1/1 for kraken test... 15:48:29 INFO - 2015-10-23 15:48:29,651 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnj5YnK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:48:41 INFO - 2015-10-23 15:48:41,629 DEBUG : BROWSER_OUTPUT: RSS: Main: 142860288 15:48:41 INFO - 2015-10-23 15:48:41,629 DEBUG : BROWSER_OUTPUT: 15:48:44 INFO - 2015-10-23 15:48:44,272 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48185/tests/kraken/driver.html?testName=audio-beat-detection) 15:48:44 INFO - 2015-10-23 15:48:44,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 176369664 15:48:44 INFO - 2015-10-23 15:48:44,859 DEBUG : BROWSER_OUTPUT: 15:48:47 INFO - 2015-10-23 15:48:47,455 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48185/tests/kraken/driver.html?testName=audio-dft) 15:48:48 INFO - 2015-10-23 15:48:48,025 DEBUG : BROWSER_OUTPUT: RSS: Main: 170037248 15:48:48 INFO - 2015-10-23 15:48:48,025 DEBUG : BROWSER_OUTPUT: 15:48:51 INFO - 2015-10-23 15:48:51,030 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48185/tests/kraken/driver.html?testName=audio-fft) 15:48:51 INFO - 2015-10-23 15:48:51,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 151871488 15:48:51 INFO - 2015-10-23 15:48:51,598 DEBUG : BROWSER_OUTPUT: 15:48:53 INFO - 2015-10-23 15:48:53,529 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48185/tests/kraken/driver.html?testName=audio-oscillator) 15:48:54 INFO - 2015-10-23 15:48:54,103 DEBUG : BROWSER_OUTPUT: RSS: Main: 153157632 15:48:54 INFO - 2015-10-23 15:48:54,103 DEBUG : BROWSER_OUTPUT: 15:48:56 INFO - 2015-10-23 15:48:56,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48185/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:48:56 INFO - 2015-10-23 15:48:56,919 DEBUG : BROWSER_OUTPUT: RSS: Main: 160157696 15:48:56 INFO - 2015-10-23 15:48:56,919 DEBUG : BROWSER_OUTPUT: 15:48:59 INFO - 2015-10-23 15:48:59,886 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48185/tests/kraken/driver.html?testName=imaging-darkroom) 15:49:00 INFO - 2015-10-23 15:49:00,469 DEBUG : BROWSER_OUTPUT: RSS: Main: 154722304 15:49:00 INFO - 2015-10-23 15:49:00,471 DEBUG : BROWSER_OUTPUT: 15:49:03 INFO - 2015-10-23 15:49:03,893 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48185/tests/kraken/driver.html?testName=imaging-desaturate) 15:49:04 INFO - 2015-10-23 15:49:04,456 DEBUG : BROWSER_OUTPUT: RSS: Main: 152420352 15:49:04 INFO - 2015-10-23 15:49:04,456 DEBUG : BROWSER_OUTPUT: 15:49:07 INFO - 2015-10-23 15:49:07,275 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48185/tests/kraken/driver.html?testName=json-parse-financial) 15:49:07 INFO - 2015-10-23 15:49:07,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 158605312 15:49:07 INFO - 2015-10-23 15:49:07,840 DEBUG : BROWSER_OUTPUT: 15:49:09 INFO - 2015-10-23 15:49:09,601 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48185/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:49:10 INFO - 2015-10-23 15:49:10,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 161759232 15:49:10 INFO - 2015-10-23 15:49:10,167 DEBUG : BROWSER_OUTPUT: 15:49:12 INFO - 2015-10-23 15:49:12,051 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48185/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:49:12 INFO - 2015-10-23 15:49:12,624 DEBUG : BROWSER_OUTPUT: RSS: Main: 165642240 15:49:12 INFO - 2015-10-23 15:49:12,624 DEBUG : BROWSER_OUTPUT: 15:49:14 INFO - 2015-10-23 15:49:14,762 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48185/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:49:15 INFO - 2015-10-23 15:49:15,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 175144960 15:49:15 INFO - 2015-10-23 15:49:15,335 DEBUG : BROWSER_OUTPUT: 15:49:17 INFO - 2015-10-23 15:49:17,882 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48185/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:49:18 INFO - 2015-10-23 15:49:18,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 181039104 15:49:18 INFO - 2015-10-23 15:49:18,464 DEBUG : BROWSER_OUTPUT: 15:49:20 INFO - 2015-10-23 15:49:20,965 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48185/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:49:21 INFO - 2015-10-23 15:49:21,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 179142656 15:49:21 INFO - 2015-10-23 15:49:21,538 DEBUG : BROWSER_OUTPUT: 15:49:23 INFO - 2015-10-23 15:49:23,320 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48185/tests/kraken/driver.html?testName=ai-astar) 15:49:23 INFO - 2015-10-23 15:49:23,569 DEBUG : BROWSER_OUTPUT: RSS: Main: 231530496 15:49:23 INFO - 2015-10-23 15:49:23,570 DEBUG : BROWSER_OUTPUT: 15:49:23 INFO - 2015-10-23 15:49:23,571 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:49:23 INFO - 2015-10-23 15:49:23,571 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:49:23 INFO - 2015-10-23 15:49:23,571 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:49:23 INFO - 2015-10-23 15:49:23,572 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:49:23 INFO - 2015-10-23 15:49:23,572 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;114;107;112;113;113;102;111;103;111 15:49:23 INFO - 2015-10-23 15:49:23,572 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;132;130;142;155;129;130;131;129;157;128 15:49:23 INFO - 2015-10-23 15:49:23,572 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;159;159;159;160;160;157;160;160;161 15:49:23 INFO - 2015-10-23 15:49:23,573 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;71;74;84;70;71;73;75;80;70 15:49:23 INFO - 2015-10-23 15:49:23,573 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;131;95;93;95;135;95;94;134 15:49:23 INFO - 2015-10-23 15:49:23,573 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;111;110;110;110;110;110;110;110 15:49:23 INFO - 2015-10-23 15:49:23,573 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;147;148;149;147;148;148;147;148 15:49:23 INFO - 2015-10-23 15:49:23,573 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;96;95;96;96;95;96;95 15:49:23 INFO - 2015-10-23 15:49:23,573 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;68;70;69;68;68;69;76;68;66 15:49:23 INFO - 2015-10-23 15:49:23,574 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;70;68;69;69;68;68;68;68 15:49:23 INFO - 2015-10-23 15:49:23,574 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;82;83;83;83;92;83;83;93;82 15:49:23 INFO - 2015-10-23 15:49:23,574 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;118;123;116;126;131;119;133;132;124 15:49:23 INFO - 2015-10-23 15:49:23,574 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;128;139;136;139;141;127;140;137;133;130 15:49:23 INFO - 2015-10-23 15:49:23,574 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;72;73;70;71;70;71;69;71;70 15:49:23 INFO - 2015-10-23 15:49:23,574 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:49:23 INFO - 2015-10-23 15:49:23,574 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:49:23 INFO - 2015-10-23 15:49:23,574 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,903 15:49:23 INFO - 2015-10-23 15:49:23,574 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:49:23 INFO - 2015-10-23 15:49:23,575 DEBUG : BROWSER_OUTPUT: __startTimestamp1445640563570__endTimestamp 15:49:23 INFO - 2015-10-23 15:49:23,575 DEBUG : BROWSER_OUTPUT: 15:49:23 INFO - 2015-10-23 15:49:23,576 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:49:23 INFO - 2015-10-23 15:49:23,576 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:49:23 INFO - 2015-10-23 15:49:23,576 DEBUG : BROWSER_OUTPUT: 15:49:23 INFO - 2015-10-23 15:49:23,576 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.60 Median:111.50 stddev:4.22 (3.8%) stddev-sans-first:4.48 15:49:23 INFO - 2015-10-23 15:49:23,576 DEBUG : BROWSER_OUTPUT: Values: 110.0 114.0 107.0 112.0 113.0 113.0 102.0 111.0 103.0 111.0 15:49:23 INFO - 2015-10-23 15:49:23,577 DEBUG : BROWSER_OUTPUT: 15:49:23 INFO - 2015-10-23 15:49:23,577 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:136.30 Median:131.50 stddev:11.12 (8.5%) stddev-sans-first:11.68 15:49:23 INFO - 2015-10-23 15:49:23,577 DEBUG : BROWSER_OUTPUT: Values: 132.0 130.0 142.0 155.0 129.0 130.0 131.0 129.0 157.0 128.0 15:49:23 INFO - 2015-10-23 15:49:23,577 DEBUG : BROWSER_OUTPUT: 15:49:23 INFO - 2015-10-23 15:49:23,577 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.50 Median:160.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 15:49:23 INFO - 2015-10-23 15:49:23,577 DEBUG : BROWSER_OUTPUT: Values: 160.0 159.0 159.0 159.0 160.0 160.0 157.0 160.0 160.0 161.0 15:49:23 INFO - 2015-10-23 15:49:23,577 DEBUG : BROWSER_OUTPUT: 15:49:23 INFO - 2015-10-23 15:49:23,577 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:74.10 Median:73.50 stddev:4.58 (6.2%) stddev-sans-first:4.84 15:49:23 INFO - 2015-10-23 15:49:23,578 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 74.0 84.0 70.0 71.0 73.0 75.0 80.0 70.0 15:49:23 INFO - 2015-10-23 15:49:23,578 DEBUG : BROWSER_OUTPUT: 15:49:23 INFO - 2015-10-23 15:49:23,578 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.20 Median:95.00 stddev:18.76 (19.7%) stddev-sans-first:19.46 15:49:23 INFO - 2015-10-23 15:49:23,578 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 131.0 95.0 93.0 95.0 135.0 95.0 94.0 134.0 15:49:23 INFO - 2015-10-23 15:49:23,578 DEBUG : BROWSER_OUTPUT: 15:49:23 INFO - 2015-10-23 15:49:23,578 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 15:49:23 INFO - 2015-10-23 15:49:23,578 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 111.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 15:49:23 INFO - 2015-10-23 15:49:23,578 DEBUG : BROWSER_OUTPUT: 15:49:23 INFO - 2015-10-23 15:49:23,579 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 15:49:23 INFO - 2015-10-23 15:49:23,579 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 147.0 148.0 149.0 147.0 148.0 148.0 147.0 148.0 15:49:23 INFO - 2015-10-23 15:49:23,579 DEBUG : BROWSER_OUTPUT: 15:49:23 INFO - 2015-10-23 15:49:23,579 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 15:49:23 INFO - 2015-10-23 15:49:23,579 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 96.0 95.0 96.0 96.0 95.0 96.0 95.0 15:49:23 INFO - 2015-10-23 15:49:23,579 DEBUG : BROWSER_OUTPUT: 15:49:23 INFO - 2015-10-23 15:49:23,580 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:69.10 Median:69.00 stddev:2.64 (3.8%) stddev-sans-first:2.80 15:49:23 INFO - 2015-10-23 15:49:23,581 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 70.0 69.0 68.0 68.0 69.0 76.0 68.0 66.0 15:49:23 INFO - 2015-10-23 15:49:23,581 DEBUG : BROWSER_OUTPUT: 15:49:23 INFO - 2015-10-23 15:49:23,581 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 15:49:23 INFO - 2015-10-23 15:49:23,581 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 70.0 68.0 69.0 69.0 68.0 68.0 68.0 68.0 15:49:23 INFO - 2015-10-23 15:49:23,582 DEBUG : BROWSER_OUTPUT: 15:49:23 INFO - 2015-10-23 15:49:23,582 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:83.00 stddev:4.28 (5.2%) stddev-sans-first:4.34 15:49:23 INFO - 2015-10-23 15:49:23,582 DEBUG : BROWSER_OUTPUT: Values: 81.0 82.0 83.0 83.0 83.0 92.0 83.0 83.0 93.0 82.0 15:49:23 INFO - 2015-10-23 15:49:23,582 DEBUG : BROWSER_OUTPUT: 15:49:23 INFO - 2015-10-23 15:49:23,582 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:127.00 stddev:6.06 (4.8%) stddev-sans-first:6.32 15:49:23 INFO - 2015-10-23 15:49:23,583 DEBUG : BROWSER_OUTPUT: Values: 128.0 118.0 123.0 116.0 126.0 131.0 119.0 133.0 132.0 124.0 15:49:23 INFO - 2015-10-23 15:49:23,583 DEBUG : BROWSER_OUTPUT: 15:49:23 INFO - 2015-10-23 15:49:23,583 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.00 Median:138.00 stddev:5.16 (3.7%) stddev-sans-first:4.82 15:49:23 INFO - 2015-10-23 15:49:23,583 DEBUG : BROWSER_OUTPUT: Values: 128.0 139.0 136.0 139.0 141.0 127.0 140.0 137.0 133.0 130.0 15:49:23 INFO - 2015-10-23 15:49:23,584 DEBUG : BROWSER_OUTPUT: 15:49:23 INFO - 2015-10-23 15:49:23,584 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:1.14 (1.6%) stddev-sans-first:1.20 15:49:23 INFO - 2015-10-23 15:49:23,584 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 73.0 70.0 71.0 70.0 71.0 69.0 71.0 70.0 15:49:23 INFO - 2015-10-23 15:49:23,584 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:49:23 INFO - 2015-10-23 15:49:23,585 DEBUG : BROWSER_OUTPUT: 15:49:24 INFO - 2015-10-23 15:49:24,445 INFO : Browser exited with error code: 0 15:49:24 INFO - 2015-10-23 15:49:24,496 INFO : Completed test kraken (00:01:00) 15:49:24 INFO - 2015-10-23 15:49:24,497 INFO : Starting test v8_7 15:49:24 INFO - 2015-10-23 15:49:24,497 DEBUG : operating with platform_type : linux_ 15:49:24 INFO - 2015-10-23 15:49:24,497 INFO : Initialising browser for v8_7 test... 15:49:24 INFO - 2015-10-23 15:49:24,503 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpppw2XL/profile http://localhost:48185/getInfo.html 15:49:28 INFO - 2015-10-23 15:49:28,394 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:49:28 INFO - 2015-10-23 15:49:28,394 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:49:28 INFO - 2015-10-23 15:49:28,394 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:49:28 INFO - 2015-10-23 15:49:28,394 DEBUG : BROWSER_OUTPUT: __metrics 15:49:28 INFO - 2015-10-23 15:49:28,551 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:49:29 INFO - 2015-10-23 15:49:29,173 DEBUG : BROWSER_OUTPUT: console.error: 15:49:29 INFO - 2015-10-23 15:49:29,174 DEBUG : BROWSER_OUTPUT: Message: [Exception... "Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [mozIStorageAsyncStatement.executeAsync]" nsresult: "0x80040111 (NS_ERROR_NOT_AVAILABLE)" location: "JS frame :: resource://gre/modules/Sqlite.jsm :: ConnectionData.prototype<._executeStatement :: line 758" data: no] 15:49:29 INFO - 2015-10-23 15:49:29,174 DEBUG : BROWSER_OUTPUT: Stack: 15:49:29 INFO - 2015-10-23 15:49:29,174 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 15:49:29 INFO - 2015-10-23 15:49:29,174 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 15:49:29 INFO - 2015-10-23 15:49:29,174 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 15:49:29 INFO - 2015-10-23 15:49:29,174 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 15:49:29 INFO - 2015-10-23 15:49:29,174 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 15:49:29 INFO - 2015-10-23 15:49:29,174 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 15:49:29 INFO - 2015-10-23 15:49:29,175 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 15:49:29 INFO - 2015-10-23 15:49:29,175 DEBUG : BROWSER_OUTPUT: setAncestorsLastModified<@resource://gre/modules/Bookmarks.jsm:1347:9 15:49:29 INFO - 2015-10-23 15:49:29,175 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 15:49:29 INFO - 2015-10-23 15:49:29,175 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 15:49:29 INFO - 2015-10-23 15:49:29,175 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 15:49:29 INFO - 2015-10-23 15:49:29,175 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:808:13 15:49:29 INFO - 2015-10-23 15:49:29,175 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 15:49:29 INFO - 2015-10-23 15:49:29,175 DEBUG : BROWSER_OUTPUT: Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23 15:49:29 INFO - 2015-10-23 15:49:29,176 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 15:49:29 INFO - 2015-10-23 15:49:29,176 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 15:49:29 INFO - 2015-10-23 15:49:29,176 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 15:49:29 INFO - 2015-10-23 15:49:29,176 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 15:49:29 INFO - 2015-10-23 15:49:29,176 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 15:49:29 INFO - 2015-10-23 15:49:29,176 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 15:49:29 INFO - 2015-10-23 15:49:29,176 DEBUG : BROWSER_OUTPUT: 15:49:29 INFO - 2015-10-23 15:49:29,722 INFO : Browser initialized. 15:49:29 INFO - 2015-10-23 15:49:29,722 INFO : Running cycle 1/1 for v8_7 test... 15:49:29 INFO - 2015-10-23 15:49:29,723 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpppw2XL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:49:41 INFO - 2015-10-23 15:49:41,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 141574144 15:49:41 INFO - 2015-10-23 15:49:41,640 DEBUG : BROWSER_OUTPUT: 15:50:03 INFO - 2015-10-23 15:50:03,101 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48185/tests/v8_7/run.html (next: http://localhost:48185/tests/v8_7/run.html) 15:50:03 INFO - 2015-10-23 15:50:03,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 438636544 15:50:03 INFO - 2015-10-23 15:50:03,351 DEBUG : BROWSER_OUTPUT: 15:50:03 INFO - 2015-10-23 15:50:03,351 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:50:03 INFO - 2015-10-23 15:50:03,351 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:50:03 INFO - 2015-10-23 15:50:03,352 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:50:03 INFO - 2015-10-23 15:50:03,352 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:50:03 INFO - 2015-10-23 15:50:03,352 DEBUG : BROWSER_OUTPUT: |0;Richards;165.0982334489021 15:50:03 INFO - 2015-10-23 15:50:03,352 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.11662347278786 15:50:03 INFO - 2015-10-23 15:50:03,352 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.135788585887 15:50:03 INFO - 2015-10-23 15:50:03,353 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5020 15:50:03 INFO - 2015-10-23 15:50:03,353 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2010.0401606425703 15:50:03 INFO - 2015-10-23 15:50:03,353 DEBUG : BROWSER_OUTPUT: |5;Earley;789.2659826361484 15:50:03 INFO - 2015-10-23 15:50:03,353 DEBUG : BROWSER_OUTPUT: |6;Boyer;11823.529411764706 15:50:03 INFO - 2015-10-23 15:50:03,353 DEBUG : BROWSER_OUTPUT: |7;RegExp;27189.18918918919 15:50:03 INFO - 2015-10-23 15:50:03,353 DEBUG : BROWSER_OUTPUT: |8;Splay;607.3582629674306 15:50:03 INFO - 2015-10-23 15:50:03,354 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 15:50:03 INFO - 2015-10-23 15:50:03,354 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:50:03 INFO - 2015-10-23 15:50:03,354 DEBUG : BROWSER_OUTPUT: __startTimestamp1445640603349__endTimestamp 15:50:03 INFO - 2015-10-23 15:50:03,354 DEBUG : BROWSER_OUTPUT: 15:50:03 INFO - 2015-10-23 15:50:03,354 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:50:03 INFO - 2015-10-23 15:50:03,354 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:50:03 INFO - 2015-10-23 15:50:03,354 DEBUG : BROWSER_OUTPUT: 15:50:03 INFO - 2015-10-23 15:50:03,354 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.10 Median:165.10 stddev:0.00 (0.0%) 15:50:03 INFO - 2015-10-23 15:50:03,354 DEBUG : BROWSER_OUTPUT: Values: 165.1 15:50:03 INFO - 2015-10-23 15:50:03,355 DEBUG : BROWSER_OUTPUT: 15:50:03 INFO - 2015-10-23 15:50:03,355 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.12 Median:185.12 stddev:0.00 (0.0%) 15:50:03 INFO - 2015-10-23 15:50:03,355 DEBUG : BROWSER_OUTPUT: Values: 185.1 15:50:03 INFO - 2015-10-23 15:50:03,355 DEBUG : BROWSER_OUTPUT: 15:50:03 INFO - 2015-10-23 15:50:03,355 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.14 Median:281.14 stddev:0.00 (0.0%) 15:50:03 INFO - 2015-10-23 15:50:03,355 DEBUG : BROWSER_OUTPUT: Values: 281.1 15:50:03 INFO - 2015-10-23 15:50:03,355 DEBUG : BROWSER_OUTPUT: 15:50:03 INFO - 2015-10-23 15:50:03,355 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5020.00 Median:5020.00 stddev:0.00 (0.0%) 15:50:03 INFO - 2015-10-23 15:50:03,355 DEBUG : BROWSER_OUTPUT: Values: 5020.0 15:50:03 INFO - 2015-10-23 15:50:03,356 DEBUG : BROWSER_OUTPUT: 15:50:03 INFO - 2015-10-23 15:50:03,356 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2010.04 Median:2010.04 stddev:0.00 (0.0%) 15:50:03 INFO - 2015-10-23 15:50:03,356 DEBUG : BROWSER_OUTPUT: Values: 2010.0 15:50:03 INFO - 2015-10-23 15:50:03,356 DEBUG : BROWSER_OUTPUT: 15:50:03 INFO - 2015-10-23 15:50:03,356 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:789.27 Median:789.27 stddev:0.00 (0.0%) 15:50:03 INFO - 2015-10-23 15:50:03,356 DEBUG : BROWSER_OUTPUT: Values: 789.3 15:50:03 INFO - 2015-10-23 15:50:03,356 DEBUG : BROWSER_OUTPUT: 15:50:03 INFO - 2015-10-23 15:50:03,356 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11823.53 Median:11823.53 stddev:0.00 (0.0%) 15:50:03 INFO - 2015-10-23 15:50:03,356 DEBUG : BROWSER_OUTPUT: Values: 11823.5 15:50:03 INFO - 2015-10-23 15:50:03,356 DEBUG : BROWSER_OUTPUT: 15:50:03 INFO - 2015-10-23 15:50:03,356 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27189.19 Median:27189.19 stddev:0.00 (0.0%) 15:50:03 INFO - 2015-10-23 15:50:03,356 DEBUG : BROWSER_OUTPUT: Values: 27189.2 15:50:03 INFO - 2015-10-23 15:50:03,356 DEBUG : BROWSER_OUTPUT: 15:50:03 INFO - 2015-10-23 15:50:03,356 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:607.36 Median:607.36 stddev:0.00 (0.0%) 15:50:03 INFO - 2015-10-23 15:50:03,357 DEBUG : BROWSER_OUTPUT: Values: 607.4 15:50:03 INFO - 2015-10-23 15:50:03,357 DEBUG : BROWSER_OUTPUT: 15:50:03 INFO - 2015-10-23 15:50:03,357 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 15:50:03 INFO - 2015-10-23 15:50:03,357 DEBUG : BROWSER_OUTPUT: Values: 4840.6 15:50:03 INFO - 2015-10-23 15:50:03,357 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:50:03 INFO - 2015-10-23 15:50:03,357 DEBUG : BROWSER_OUTPUT: 15:50:04 INFO - 2015-10-23 15:50:04,181 INFO : Browser exited with error code: 0 15:50:04 INFO - 2015-10-23 15:50:04,198 INFO : Completed test v8_7 (00:00:39) 15:50:04 INFO - 2015-10-23 15:50:04,371 INFO : Completed test suite (00:20:19) 15:50:04 INFO - 2015-10-23 15:50:04,371 DEBUG : Working with test: dromaeo_css 15:50:04 INFO - 2015-10-23 15:50:04,371 DEBUG : Generating results file: dromaeo_css 15:50:04 INFO - 2015-10-23 15:50:04,372 DEBUG : Working with test: kraken 15:50:04 INFO - 2015-10-23 15:50:04,372 DEBUG : Generating results file: kraken 15:50:04 INFO - 2015-10-23 15:50:04,373 INFO : javascript benchmark 15:50:04 INFO - 2015-10-23 15:50:04,373 DEBUG : Working with test: v8_7 15:50:04 INFO - 2015-10-23 15:50:04,373 DEBUG : Generating results file: v8_7 15:50:04 INFO - 2015-10-23 15:50:04,373 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:50:07 INFO - 2015-10-23 15:50:07,049 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 15:50:07 INFO - 2015-10-23 15:50:07,049 DEBUG : process_Request line: dromaeo_css 6091.86 graph.html#tests=[[72,132,35]] 15:50:07 INFO - 2015-10-23 15:50:07,049 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:50:08 INFO - 2015-10-23 15:50:08,392 DEBUG : process_Request line: kraken 1491.90 graph.html#tests=[[232,132,35]] 15:50:08 INFO - 2015-10-23 15:50:08,392 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:50:08 INFO - 2015-10-23 15:50:08,979 DEBUG : process_Request line: v8_7 19876.24 graph.html#tests=[[230,132,35]] 15:50:08 INFO - 2015-10-23 15:50:08,980 INFO : javascript benchmark 15:50:09 INFO - 2015-10-23 15:50:08,984 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [358.11902719310496, 359.62778524227423, 359.6852753840389, 366.03184576794365, 366.3881318198608, 12847.80728289074, 13173.34133293334, 15383.230838458074, 16397.344106235752, 17414.82585174146, 14916.477923272687, 14959.102453852776, 16253.756193657075, 16280.83719162808, 16313.347466101342, 4712.0575884823, 4840.854774356775, 4845.3216549683075, 4847.951520484803, 5009.023240468101, 3169.2393825481836, 3247.0421225738346, 4656.650751193657, 4768.64235182361, 4789.90420191596, 4687.789049492781, 4708.929366059512, 4714.387129673138, 4719.174144524694, 4730.314104454852, 4555.612772914306, 4649.628029757611, 4651.79066941985, 4655.930161047587, 4699.530046995307, 4006.0, 4015.8393664253394, 4019.9598004019876, 4020.296448121567, 4024.8993775155564, 12763.5532756354, 12921.095523313372, 13211.405486753023, 13229.073964822466, 13248.801267980987, 624.0, 1701.0899168944554, 1741.947741567755, 1780.64387122576, 1809.3513007822628, 9340.906590934072, 9384.20234280087, 9459.66891158813, 9608.615655373776, 9660.855087173699, 1599.8800089993297, 1604.7592861070932, 1614.73356896112, 1643.5808868738516, 1669.8330166983326, 54283.72858135724, 55903.16145257824, 56013.879722405734, 56558.151627725616, 56647.0, 6471.482281417475, 6539.673016349164, 6547.050677651714, 6594.0, 6632.734690612418, 7683.462157648911, 7716.691332346643, 7742.651580678883, 7744.883826742604, 7762.961185194038, 5288.338957630296, 5301.416844147141, 5310.415854256029, 5329.760160792774, 5353.0899747043095, 5260.579153667697, 5270.973645131749, 5357.758900849393, 5478.616496845182, 5480.725963701799, 3042.3154790172475, 3085.5988721466065, 3094.8297843618816, 3113.579666745006, 3116.1897906544464, 1049.223574554824, 1088.50473034769, 1089.096050278267, 1137.8748337682848, 1139.5214010115772, 411.9320312148522, 423.54468945882684, 432.67765514691126, 445.98662040138845, 451.5552181101612, 11105.500252488657, 11584.304941703356, 11600.94199528997, 11613.210212487553, 11703.765924681458, 386.1735885205662, 392.86249812565376, 397.66794726403776, 397.92240513099665, 398.38847369288004, 5450.591205659592, 6122.54080943931, 6148.197993152126, 6386.936130638727, 6431.5819471734185, 528438.0, 529637.0, 532384.0, 535698.0, 539080.0, 67768.0, 73014.63492682608, 73402.63298683579, 73497.26502734904, 73846.0, 469.15786163836, 493.45719708321275, 496.08967544555424, 497.8431793984883, 498.1581127893848, 10133.746656333651, 10372.27394082407, 10478.79042419132, 10535.367877927349, 10551.788964220827, 29376.55935161017, 29426.705732943254, 30044.3991120172, 30456.39087218199, 31328.0, 38261.617383825804, 39270.803645981585, 39468.0, 45350.54649453463, 45403.77298113488, 6171.876562468636, 6328.367163283635, 6374.1394911688185, 6375.713092910923, 6376.3623637635865, 11236.719082023015, 11257.493412796608, 11575.594854180063, 11644.88355116438, 11655.650330490098, 8271.379646526415, 8374.748757537283, 9746.26902982265, 9812.313138080266, 10225.539850706587, 9575.707279517175, 9883.209343252667, 9939.602415903282, 9978.351407158512, 10241.79801342715, 9578.994205608311, 9928.156106731009, 10040.598376065167, 10203.642872499428, 10252.333598316085, 6141.3551577085545, 6252.124702541739, 6410.038494225903, 6453.419192272718, 6461.353864613689, 10102.949485252526, 10222.080012798884, 10325.32885362449, 10365.326253793479, 10492.317999330018], "dojo.html": [2628.697699764527, 2722.2649884531165, 2739.6301499297615, 2746.46443943431, 2758.2828464599197, 4756.405449318835, 4880.951190488103, 4981.701097934127, 4998.100341938454, 5015.799368025275, 4832.395950506187, 4857.902841943159, 4919.77860996256, 4921.335619691341, 4922.704637721739, 4507.188706032913, 4541.137183935059, 4556.0660064686745, 4566.155261276658, 4612.561806628365, 4338.392625032498, 4567.200739870526, 4568.862934111982, 4573.405457290548, 4609.9308510372375, 4473.530279320657, 4498.662600304974, 4523.095380923795, 4603.125406172817, 4612.377329060601, 4558.361829343895, 4566.132434837404, 4568.0, 4576.8626941191815, 4611.239145540982, 4542.364069030338, 4554.544545545419, 4557.567031132037, 4563.429571303587, 4605.30920361945, 4564.109998550284, 4672.57946784791, 4684.32077348786, 4685.625149987993, 4688.929666055012, 5231.764570594332, 5232.555232805216, 5250.369955605352, 5254.343207099113, 5257.395399529027, 5260.710660913648, 5265.210218467222, 5270.367555893317, 5281.313429254211, 5329.493698098674, 4658.138244424792, 4772.451168115642, 4775.21209000518, 4891.510848915151, 4897.020595880838, 5220.686758794484, 5306.7611957462, 5307.336582927134, 5312.415634280226, 5345.679259244458, 5102.69383836971, 5107.923381149286, 5108.259302401131, 5110.131277682803, 5119.795208191631, 5001.89996200074, 5132.974335128375, 5147.7683504242395, 5255.868603284948, 5256.6320357574605, 5115.053715062725, 5206.921896171561, 5217.843464696065, 5221.6344855859725, 5262.105442074857, 5151.0470562945975, 5153.510416510426, 5165.560927321219, 5169.095408303532, 5215.348081489814, 4126.607972242632, 4235.30117530604, 4237.851675191415, 4286.0, 4293.549177336335, 3691.501647277637, 3705.7035437164964, 3732.9440058399146, 3739.7382183247455, 3765.039914821703, 4511.661625378109, 4534.433195850519, 4537.0, 4545.2954792007295, 4562.270036794097, 4970.080535101018, 5092.624991252341, 5107.514786095315, 5199.0641684496395, 5255.737213139328, 4419.292913133883, 4469.195544801902, 4475.865724028285, 4528.592426681615, 4532.864014079583, 4586.197415452282, 4609.6542759292515, 4615.515370886009, 4624.05206932578, 4670.089332580114, 4740.502247263988, 4847.515248475124, 4854.8786280341865, 4976.2286845539, 4986.426560945538, 5097.566706829813, 5172.120739474373, 5181.481851814789, 5193.792248310026, 5226.9215961761365, 4935.728534930613, 4944.085344211332, 4944.777485013111, 4956.330895329084, 4993.500649934977, 4868.342773725643, 4996.750162491788, 5000.699958002531, 5117.590592752496, 5119.180931051014, 5094.617903657167, 5185.637005409585, 5189.377274727057, 5194.428612852507, 5210.5831533477985, 5022.196448568212, 5039.924401134059, 5048.343715316985, 5051.191809310492, 5087.974560127176, 4814.470408255019, 4931.2849636803185, 4940.555350018516, 5031.6729412588065, 5036.445990941067, 4810.5670489656095, 4896.730679812645, 4897.632677549269, 4908.263760435821, 4932.8766780830765, 5067.037262920034, 5082.517160869859, 5093.592512599057, 5095.796168153232, 5140.12617854973, 4727.290906364073, 4843.297721830385, 4853.757312134449, 4954.430240522386, 5006.799728010838], "mootools.html": [1230.8215308780232, 1478.8669019788217, 1607.116086152616, 1712.246611490944, 1877.906104694765, 7419.814504637387, 8545.359098067647, 8824.426412283197, 8838.469691818495, 8838.734837954855, 8452.154784521545, 8477.872831907527, 8493.405461617689, 8496.32029437645, 8602.354823388256, 2208.745994210662, 2228.465168359598, 2245.5059886824874, 2246.4945387287894, 2246.5506898620342, 2225.610518159324, 2243.8204943604474, 2315.3748487908256, 2318.6174281243575, 2321.0483701682315, 2244.8316376271764, 2268.7050683411135, 2282.8744419056943, 2285.1430713482446, 2297.1041293895396, 2234.19568955176, 2269.4212975691175, 2270.5345404192185, 2276.4195130241765, 2277.3054218463362, 2101.443117573844, 2115.4076858479652, 2115.672070829024, 2115.756687980871, 2118.5445129297277, 7098.432125429953, 7200.711971521133, 8438.409311348209, 8474.83050338996, 8480.872786908201, 4579.67942244043, 4705.482396936334, 4714.175019371596, 4716.764161791897, 4720.103180395714, 2904.9273768155754, 3008.7893847430687, 3039.528873024685, 3084.552739852709, 3088.042706760911, 715.3383120613412, 871.1941454154882, 881.5107615273521, 893.660409044559, 894.6287290774321, 13078.215307081511, 13226.0, 13250.86749132506, 13252.536161234408, 13255.86744132556, 4659.044895796354, 4689.788959496831, 4721.952780472151, 4823.517648235148, 4830.396200474941, 10956.945215273872, 11038.11695064393, 11042.116630669527, 11052.115830733523, 11054.170937179744, 4995.17579599362, 4996.375453068366, 4996.425411077773, 5000.449950505442, 5004.699718016858, 4249.745015299092, 4413.786208792543, 4415.205263052617, 4418.9337159942625, 4421.867343979686, 3861.2084522672785, 3865.903352416212, 3874.6512813846325, 3889.7082718796205, 3899.53205615328, 1183.627157445402, 1183.7040739815047, 1194.5042807235075, 1197.4551579031695, 1218.2690385768467, 1174.7356844710043, 1184.1296646964474, 1203.6990752311922, 1210.4552951172009, 1224.455117472734, 8167.550784706779, 8251.628676709563, 8263.628136733862, 8310.958445207736, 8362.331013518904, 447.917135329965, 449.4965638484918, 454.56816024776595, 454.7680682851769, 463.46006901959515, 6253.1245625612455, 6283.842903927439, 6293.685315734195, 6309.3690630936535, 6309.968450157719, 9875.950620246853, 10716.0, 11217.887821121847, 11231.269967452254, 11233.94383028096, 9946.950265248772, 10943.890561094287, 11144.721381965353, 11175.776484470265, 11183.83224251637, 8045.517268963881, 8111.634976426075, 8141.592920353959, 8177.4684645497855, 8193.672253110048, 8157.8776318354085, 8187.672493100209, 8199.385046121446, 8236.588170591567, 8238.50568965864, 8952.507612081397, 9044.276457883221, 9251.35240533183, 9257.490838003974, 9258.305627077862, 9261.861072084059, 9598.760030999281, 9611.375260608038, 9613.51932403363, 9629.32594718363, 7356.0, 7425.257474252531, 7429.591372474566, 7453.0, 7456.0, 8246.216609422096, 8362.540060296498, 8485.660573576988, 8575.95712021436, 8640.179182977607, 7764.689412423666, 7890.9605451972375, 7920.168382319774, 7936.0, 7962.522248665098, 7647.541147531166, 7671.501352412075, 7862.764117076496, 7884.763457096296, 7950.443468957117, 7760.961195193988, 7766.534007959541, 7772.805679858049, 7775.416843736629, 7789.61051947389, 7216.9639151806, 7249.456290778318, 7304.452166087458, 7337.633118343954, 7344.449166312655, 6981.0, 7117.395021423237, 7119.6084215368655, 7143.964280178566, 7281.162666293232], "ext.html": [558.8546977785776, 562.5274769193876, 565.9264295641568, 566.798786430817, 569.441946892046, 28896.422071558583, 29597.704022959762, 37911.24177516448, 38334.4249836252, 38347.80826095873, 41288.174236515326, 41608.79195604025, 41848.16303673925, 41941.370879436836, 41964.0, 7196.0, 8086.47437916535, 8272.669093236293, 8273.255407013368, 8275.54484503352, 7279.381252593509, 10402.271840971134, 10661.893381066206, 10662.093722033636, 10663.093637040862, 10335.896641033607, 10430.791384172311, 10450.843237351446, 10454.529546170403, 10455.73860653486, 7401.962990185015, 7591.202923693043, 10356.948215258913, 10478.476076196197, 10524.894751052469, 10251.743706407326, 10408.531616077295, 10424.94787526065, 10425.0, 10433.16534677224, 38693.613063869285, 38863.0, 38885.80557097225, 38891.0, 38900.61099389027, 2689.367998520346, 2761.552827114872, 2828.1939647200447, 3415.3852306584804, 3624.5288112545463, 28664.644610288575, 28713.56929646057, 28811.85594072016, 29095.0, 29744.55383169254, 2486.527559763639, 2519.433127546306, 2547.541442540342, 2632.565626671597, 2633.986830065857, 244310.0, 244482.0, 244617.0, 244997.0, 245548.0, 57058.14412783812, 57350.426495735344, 57571.0, 57573.42426575765, 57599.71200143972, 61279.6936015326, 61303.08045379323, 61339.0, 61459.69270153621, 61617.691911540154, 13747.450101995808, 14293.714125717635, 14329.78505322421, 14338.211398373189, 14339.928300358431, 10911.23621346514, 10977.506012229469, 11048.613298534674, 11059.889401106047, 11061.281016733887, 18210.45368638943, 18353.082345882918, 18355.81644183568, 18387.816121838878, 18473.1687074082, 8008.719694810654, 8145.918540814635, 8245.340372770164, 8270.172982701803, 8295.377846661524, 861.5433820075244, 871.7820544863785, 881.3830318776882, 927.9860802087974, 971.6162115964155, 27141.0, 27357.726422735916, 27488.725112748616, 27552.586711199347, 27567.586486202723, 868.405142477405, 942.4151502938292, 984.2077127911956, 1076.381080878498, 1095.1074873977682, 13262.137961032502, 13606.523771667944, 14130.788038179435, 14163.221022843842, 14355.78466323006, 287107.0, 290737.0, 290841.0, 290967.5451622728, 292297.0, 38507.2298554033, 39571.40642890359, 44244.778776105915, 45771.542284577394, 45846.0, 1149.8620165580016, 1220.3776074202221, 1226.6013545597716, 1236.7897457432077, 1237.4369661803858, 24107.27678169658, 24415.633765493178, 24952.625710614717, 27481.17556473309, 29904.551431728105, 44004.0, 44372.77813610911, 44425.33533978886, 44448.33327500155, 44497.332540012576, 229641.0, 231618.0, 232814.8359258193, 232819.0, 233007.0, 28582.714172858006, 28989.0, 29024.419511609227, 29774.702252977193, 30447.543286850272, 35416.93749187529, 36285.27429451343, 36360.09099772527, 38824.0, 40200.597994020856, 32994.835025824716, 33298.833505832314, 34121.317573648885, 34397.31205375829, 34541.0, 31546.842265788524, 33358.66641333556, 35108.64891351054, 36132.63867361293, 37185.814070929475, 33698.326033478705, 34162.31675366528, 34381.828090860385, 34414.655853441145, 34450.48324275088, 30201.546976794925, 30209.0, 30560.235994100327, 30803.691963080084, 30853.0, 23413.41466463352, 23436.648450273602, 23459.88270058639, 23756.287311380685, 23806.64290035616], "prototype.html": [304.29555578835, 315.71585572984316, 317.5078628126405, 329.61032514271534, 330.86765293882456, 5108.642395032344, 5156.303898973638, 5159.251908473274, 5159.871003224921, 5165.664231824938, 5078.4413714491375, 5081.339425874631, 5081.898362032757, 5084.135696931521, 5095.566876815476, 3907.081835768592, 3965.504311961005, 4021.6380525752675, 4111.54772974974, 4112.7326723762935, 4041.4341992121126, 4068.2677118118727, 4070.837166513336, 4073.5315438724483, 4074.979625101885, 4034.4150098235737, 4035.455213546163, 4036.031352475414, 4037.818298176589, 4041.898952526181, 3864.439656249856, 3924.803759811998, 3950.683945284399, 3991.1419044905483, 4014.197160567898, 3553.200529880782, 3561.198730285691, 3564.9643503565153, 3568.660977207187, 3571.4464258040043, 4829.637777166691, 4887.902241955141, 4890.24201248807, 4895.143349913787, 4899.657024008321, 4508.977455112704, 4510.391097201868, 4515.887102822456, 4517.028838799673, 4523.705959112647, 5161.767720452589, 5222.529972302511, 5232.6860388376435, 5264.473552644743, 5271.077561426735, 3788.0340513168967, 3790.2987947229576, 3791.0, 3791.203847192093, 3792.924141517154, 5425.810096646638, 5458.6724796512335, 5499.285092937893, 5501.202325662756, 5511.779528818883, 3903.5706072332023, 3909.5308562972054, 3911.5501717302873, 3917.3536366499206, 3919.6864250859862, 3902.1610353774076, 3955.960440395617, 3962.445257663929, 3962.484876965976, 3964.147708242742, 4472.418585583853, 4475.530069342737, 4475.6419486441655, 4477.037436951006, 4478.037221997221, 5255.369355677343, 5256.6320357574605, 5259.658122222043, 5264.2630031794815, 5268.15709486488, 1411.1392050848974, 1412.3856122586708, 1413.1662319231702, 1413.2439145057344, 1414.886809055273, 978.4611474680696, 981.9803603927882, 998.495759641391, 1004.4977511244377, 1005.9899401006043, 4792.976035119872, 4798.184308667535, 4798.47216806151, 4798.664093513421, 4805.038992201504, 5510.448955104538, 5519.641223320552, 5521.033819081645, 5527.336719593674, 5530.253415788817, 4789.4971028042255, 4791.880202994953, 4796.736179510161, 4798.376211092535, 4798.976005119952, 2864.069177517315, 2909.767218622505, 3000.3099287164073, 3010.1270631516613, 3036.362363903561, 5197.272381866542, 5217.399999000164, 5220.034293655686, 5238.057149713089, 5239.47605239473, 5593.664380137205, 5596.776128954878, 5602.663840169603, 5608.523275521627, 5614.887702246014, 5220.0, 5220.738963051908, 5221.008008478377, 5222.738863056832, 5233.0, 5397.568194544506, 5564.304461942257, 5566.693831839126, 5568.081266590967, 5573.972130139324, 5448.591355648263, 5453.291072160594, 5455.099908515051, 5456.154296084113, 5456.290682211287, 5292.603054770831, 5295.0, 5295.099833028471, 5296.602754793329, 5301.231321458444, 3864.053306939818, 3942.3889297158985, 3967.6032396760093, 3973.463582416337, 3973.7417067890497, 5430.918536222039, 5433.212184233185, 5433.646812957145, 5433.994710978482, 5436.673799572039, 5239.764210610608, 5240.764165612481, 5241.60687948413, 5245.737713114406, 5251.501107394792, 5229.529342359206, 5235.554977826928, 5235.973820131027, 5239.47605239473, 5240.868978275574, 5009.899802004013, 5141.126008578625, 5223.425423203521, 5226.425093239664, 5234.816781412632, 5363.597730170175, 5364.892702146013, 5370.275012873212, 5371.731413429235, 5372.704501252312, 5187.610929180402, 5212.635115542027, 5215.452377500308, 5220.686758794484, 5221.269022336952], "yui.html": [691.5815931361523, 719.9892001619974, 732.7362149626134, 732.8314487667836, 736.797380720302, 10463.47682615869, 10590.41752703601, 10605.204609654269, 10617.946910265438, 10623.309484883486, 10929.56281748731, 11024.779504409908, 11035.282706624064, 11039.613613523528, 11046.116310695144, 622.6544267931297, 631.5452873930763, 801.9919800802005, 804.3484777330367, 818.5375262976399, 749.6776386153952, 795.1094773853292, 808.0142226483681, 815.2988429950268, 815.9143289954559, 839.0434904209206, 840.3109450250797, 848.6011574559977, 849.9915000850006, 850.4259624753298, 657.1522735671002, 665.7070888808933, 845.1084106267884, 857.8198578298565, 858.8883445152153, 633.2527617411453, 633.7053270229319, 633.71482832725, 635.2155088465787, 636.4144986612328, 10963.232573719843, 11105.500252488577, 11108.61119860809, 11115.72210694731, 11121.05471034963, 10212.540435680412, 10412.79174416515, 10558.577656893714, 10703.197260205437, 10795.676129716121, 8270.83458330836, 8354.775538534046, 8524.8721269181, 8601.0, 8803.471791692518, 2768.6123942648046, 2793.106206014056, 2794.9720502794917, 2797.846118463484, 2839.2050225936564, 32597.185070372958, 32909.17727056819, 33037.66962330394, 33086.17284567881, 33183.502247466065, 5945.316288626863, 6069.393060693984, 6097.512199024068, 6202.038684003986, 6284.685765711696, 9575.425474471554, 9591.760205994906, 9592.472414017157, 15415.922920385327, 15587.0, 6002.789902353396, 6020.127081573148, 6080.209572755602, 6186.659733714599, 6199.16311297969, 3232.1596384939617, 3285.490748933919, 3371.780834245766, 3492.5634295713035, 3565.3760591896316, 2654.7876169906363, 2683.2889284339667, 2690.3139699376534, 2690.9192724218306, 2694.6901106372625, 418.4142200918738, 419.0299456757596, 428.14584903118475, 428.7213311347649, 428.9056407590325, 390.83389559437126, 399.2215180398235, 399.39890464850214, 411.88497067557705, 414.50880706363057, 6953.687084081229, 7014.859702805916, 7664.310212080828, 7702.629767722806, 7720.575368354795, 439.4155772822203, 448.7868262575316, 469.4413647759156, 480.0518975024299, 502.4347608939943, 3233.288676491168, 3280.507923811447, 3366.915827104293, 3376.3584918865336, 3416.9487457688156, 39430.211395772494, 39792.40311395331, 39793.40309895354, 39809.0, 43237.56762432399, 33318.333633327195, 33462.0, 33481.162970925434, 33485.16287092842, 33498.330033399194, 32319.676803232138, 32329.51505727416, 32710.0, 32743.181420464203, 32789.0, 6823.454123669995, 6866.313368663294, 7279.854402911807, 7437.442191835526, 7443.739469118772, 23123.653145202497, 23411.76588234096, 23856.926438310664, 23889.402764931016, 23907.40231494157, 30872.69127308788, 31080.844595776878, 31211.531827023067, 33915.15212119717, 33915.3216935655, 9215.44707317563, 9398.812023759623, 9417.0, 9521.333506654744, 9638.036196380306, 9490.715278541655, 9526.618935242514, 9589.376690515093, 9604.567794449127, 10039.69880903574, 9052.728418147466, 9126.45241285525, 9229.723108306762, 9336.906630933603, 9535.38020028696, 9125.087491250822, 9162.221211197122, 9170.44977301364, 9225.815483690154, 9389.154976051916, 8982.09819991566, 9004.32467564922, 9013.022448220265, 9198.908010919806, 9272.728181595552, 7647.0, 7740.26467485588, 7839.686412543434, 7887.290143887078, 7937.6031198438695, 7428.861991266165, 7456.96271518639, 7665.731699390494, 7688.423368247292, 7733.458657894119]}, "summary": {"suite": 6091.860490986675, "subtests": {"jquery.html": {"filtered": 6483.553118226998, "value": 6483.553118226998}, "dojo.html": {"filtered": 4756.844536646529, "value": 4756.844536646529}, "mootools.html": {"filtered": 4676.539130567848, "value": 4676.539130567848}, "ext.html": {"filtered": 17463.008668311788, "value": 17463.008668311788}, "prototype.html": {"filtered": 4051.302870567415, "value": 4051.302870567415}, "yui.html": {"filtered": 5008.263076939845, "value": 5008.263076939845}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-057"}, "testrun": {"date": 1445639385, "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": "44.0a1", "id": "20151023150531", "branch": "Fx-Team-Non-PGO", "revision": "599cddea4a027034f05a3b99c8050c592a7241c8"}}, {"talos_counters": {}, "results": {"audio-dft": [160.0, 159.0, 159.0, 159.0, 160.0, 160.0, 157.0, 160.0, 160.0, 161.0], "ai-astar": [110.0, 114.0, 107.0, 112.0, 113.0, 113.0, 102.0, 111.0, 103.0, 111.0], "imaging-gaussian-blur": [110.0, 109.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "audio-beat-detection": [132.0, 130.0, 142.0, 155.0, 129.0, 130.0, 131.0, 129.0, 157.0, 128.0], "json-stringify-tinderbox": [68.0, 69.0, 70.0, 68.0, 69.0, 69.0, 68.0, 68.0, 68.0, 68.0], "stanford-crypto-pbkdf2": [128.0, 139.0, 136.0, 139.0, 141.0, 127.0, 140.0, 137.0, 133.0, 130.0], "json-parse-financial": [69.0, 68.0, 70.0, 69.0, 68.0, 68.0, 69.0, 76.0, 68.0, 66.0], "stanford-crypto-sha256-iterative": [71.0, 72.0, 73.0, 70.0, 71.0, 70.0, 71.0, 69.0, 71.0, 70.0], "audio-fft": [73.0, 71.0, 74.0, 84.0, 70.0, 71.0, 73.0, 75.0, 80.0, 70.0], "imaging-darkroom": [147.0, 148.0, 147.0, 148.0, 149.0, 147.0, 148.0, 148.0, 147.0, 148.0], "stanford-crypto-ccm": [128.0, 118.0, 123.0, 116.0, 126.0, 131.0, 119.0, 133.0, 132.0, 124.0], "audio-oscillator": [95.0, 95.0, 131.0, 95.0, 93.0, 95.0, 135.0, 95.0, 94.0, 134.0], "stanford-crypto-aes": [81.0, 82.0, 83.0, 83.0, 83.0, 92.0, 83.0, 83.0, 93.0, 82.0], "imaging-desaturate": [96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0]}, "summary": {"suite": 1491.9, "subtests": {"audio-fft": {"filtered": 74.1, "value": 74.1}, "stanford-crypto-pbkdf2": {"filtered": 135.0, "value": 135.0}, "audio-beat-detection": {"filtered": 136.3, "value": 136.3}, "stanford-crypto-ccm": {"filtered": 125.0, "value": 125.0}, "imaging-darkroom": {"filtered": 147.7, "value": 147.7}, "json-parse-financial": {"filtered": 69.1, "value": 69.1}, "audio-oscillator": {"filtered": 106.2, "value": 106.2}, "ai-astar": {"filtered": 109.6, "value": 109.6}, "audio-dft": {"filtered": 159.5, "value": 159.5}, "stanford-crypto-sha256-iterative": {"filtered": 70.8, "value": 70.8}, "json-stringify-tinderbox": {"filtered": 68.5, "value": 68.5}, "imaging-gaussian-blur": {"filtered": 110.0, "value": 110.0}, "stanford-crypto-aes": {"filtered": 84.5, "value": 84.5}, "imaging-desaturate": {"filtered": 95.6, "value": 95.6}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-057"}, "testrun": {"date": 1445639385, "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": "44.0a1", "id": "20151023150531", "branch": "Fx-Team-Non-PGO", "revision": "599cddea4a027034f05a3b99c8050c592a7241c8"}}, {"talos_counters": {}, "results": {"DeltaBlue": [185.11662347278786], "Encrypt": [281.135788585887], "NavierStokes": [4840.579710144928], "Decrypt": [5020.0], "Splay": [607.3582629674306], "Richards": [165.0982334489021], "RegExp": [27189.18918918919], "Earley": [789.2659826361484], "Boyer": [11823.529411764706], "RayTrace": [2010.0401606425703]}, "summary": {"suite": 19876.240612578167, "subtests": {"DeltaBlue": {"filtered": 357.16943599999996, "value": 357.16943599999996}, "Encrypt": {"filtered": 946.8058169999996, "value": 946.8058169999996}, "NavierStokes": {"filtered": 306.5748502994012, "value": 306.5748502994012}, "Decrypt": {"filtered": 53.0241035856574, "value": 53.0241035856574}, "Splay": {"filtered": 134.1728679245283, "value": 134.1728679245283}, "RegExp": {"filtered": 33.505412524850904, "value": 33.505412524850904}, "Richards": {"filtered": 213.824214, "value": 213.824214}, "Earley": {"filtered": 844.4086210000003, "value": 844.4086210000003}, "Boyer": {"filtered": 56.36751741293535, "value": 56.36751741293535}, "RayTrace": {"filtered": 368.1463756243757, "value": 368.1463756243757}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-057"}, "testrun": {"date": 1445639385, "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": "44.0a1", "id": "20151023150531", "branch": "Fx-Team-Non-PGO", "revision": "599cddea4a027034f05a3b99c8050c592a7241c8"}}] 15:50:09 INFO - RETURN: dromaeo_css: 6091.86 15:50:09 INFO - RETURN: kraken: 1491.90 15:50:09 INFO - RETURN: v8_7: 19876.24 15:50:09 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19876.24"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1491.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6091.86"}}} 15:50:09 INFO - Return code: 0 15:50:09 INFO - # TBPL SUCCESS # 15:50:09 INFO - Running post-action listener: _resource_record_post_action 15:50:09 INFO - Running post-run listener: _resource_record_post_run 15:50:10 INFO - Total resource usage - Wall time: 1238s; CPU: 13.0%; Read bytes: 8015872; Write bytes: 405823488; Read time: 1984; Write time: 347912 15:50:10 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 13291520; Read time: 0; Write time: 4060 15:50:10 INFO - run-tests - Wall time: 1224s; CPU: 13.0%; Read bytes: 5750784; Write bytes: 392531968; Read time: 1760; Write time: 343852 15:50:10 INFO - Running post-run listener: _upload_blobber_files 15:50:10 INFO - Blob upload gear active. 15:50:10 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:50:10 INFO - Copying logs to upload dir... 15:50:10 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1286.977627 ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-10-23 15:50:10.122354) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-23 15:50:10.126256) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1445638716.984502-36503012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009980 build_url: 'https://queue.taskcluster.net/v1/task/2JBsbp7LTMGxcntLrHm-Og/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2' ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-23 15:50:10.177320) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 15:50:10.177678) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1445638716.984502-36503012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 15:50:10.227080) ========= ========= Started reboot slave lost (results: 0, elapsed: 4 secs) (at 2015-10-23 15:50:10.227423) ========= ========= Finished reboot slave lost (results: 0, elapsed: 4 secs) (at 2015-10-23 15:50:14.336655) =========