builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-033 starttime: 1448341719.31 results: success (0) buildid: 20151123203633 builduid: b31e97283d164f19990ec0a07fe5811b revision: f6cccadd2eed5ef737f26006f58bcdec048d4e34 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 21:08:39.308220) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 21:08:39.308837) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 21:08:39.309331) ========= 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=a194aa7faa1be204aaca7d660000020b-1448333501.707837-785713483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.009097 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 21:08:39.354034) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 21:08:39.354444) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 21:08:39.371433) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 21:08:39.371883) ========= 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=a194aa7faa1be204aaca7d660000020b-1448333501.707837-785713483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004620 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 21:08:39.427532) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 21:08:39.428007) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 21:08:39.428578) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 21:08:39.429075) ========= 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=a194aa7faa1be204aaca7d660000020b-1448333501.707837-785713483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 21:08:39-- 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% 216M=0s 2015-11-23 21:08:39 (216 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177924 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 21:08:39.619665) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 21:08:39.620015) ========= 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=a194aa7faa1be204aaca7d660000020b-1448333501.707837-785713483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015748 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 21:08:39.669513) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 21:08:39.669843) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f6cccadd2eed5ef737f26006f58bcdec048d4e34 --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 f6cccadd2eed5ef737f26006f58bcdec048d4e34 --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=a194aa7faa1be204aaca7d660000020b-1448333501.707837-785713483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 21:08:39,702 truncating revision to first 12 chars 2015-11-23 21:08:39,703 Setting DEBUG logging. 2015-11-23 21:08:39,703 attempt 1/10 2015-11-23 21:08:39,703 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f6cccadd2eed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 21:08:39,965 unpacking tar archive at: fx-team-f6cccadd2eed/testing/mozharness/ program finished with exit code 0 elapsedTime=0.542036 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 21:08:40.226601) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 21:08:40.227100) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 21:08:40.237531) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 21:08:40.238155) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 21:08:40.238914) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 36 secs) (at 2015-11-23 21:08:40.239407) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a194aa7faa1be204aaca7d660000020b-1448333501.707837-785713483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:08:40 INFO - MultiFileLogger online at 20151123 21:08:40 in /builds/slave/test 21:08:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 21:08:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:08:40 INFO - {'append_to_log': False, 21:08:40 INFO - 'base_work_dir': '/builds/slave/test', 21:08:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:08:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:08:40 INFO - 'branch': 'Fx-Team-Non-PGO', 21:08:40 INFO - 'buildbot_json_path': 'buildprops.json', 21:08:40 INFO - 'config_files': ('talos/linux_config.py',), 21:08:40 INFO - 'default_actions': ('clobber', 21:08:40 INFO - 'read-buildbot-config', 21:08:40 INFO - 'download-and-extract', 21:08:40 INFO - 'populate-webroot', 21:08:40 INFO - 'create-virtualenv', 21:08:40 INFO - 'install', 21:08:40 INFO - 'run-tests'), 21:08:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:08:40 INFO - 'download_minidump_stackwalk': True, 21:08:40 INFO - 'download_symbols': 'ondemand', 21:08:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:08:40 INFO - 'tooltool.py': '/tools/tooltool.py', 21:08:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:08:40 INFO - '/tools/misc-python/virtualenv.py')}, 21:08:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:08:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:08:40 INFO - 'installer_path': 'installer.exe', 21:08:40 INFO - 'log_level': 'info', 21:08:40 INFO - 'log_name': 'talos', 21:08:40 INFO - 'log_to_console': True, 21:08:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:08:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:08:40 INFO - 'opt_config_files': (), 21:08:40 INFO - 'pip_index': False, 21:08:40 INFO - 'sps_profile': False, 21:08:40 INFO - 'sps_profile_interval': 0, 21:08:40 INFO - 'suite': 'dromaeojs-e10s', 21:08:40 INFO - 'system_bits': '64', 21:08:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:08:40 INFO - 'title': 'talos-linux64-ix-033', 21:08:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:08:40 INFO - 'use_talos_json': True, 21:08:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:08:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:08:40 INFO - 'work_dir': 'build'} 21:08:40 INFO - ##### 21:08:40 INFO - ##### Running clobber step. 21:08:40 INFO - ##### 21:08:40 INFO - Running pre-action listener: _resource_record_pre_action 21:08:40 INFO - Running main action method: clobber 21:08:40 INFO - rmtree: /builds/slave/test/build 21:08:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:08:41 INFO - Running post-action listener: _resource_record_post_action 21:08:41 INFO - ##### 21:08:41 INFO - ##### Running read-buildbot-config step. 21:08:41 INFO - ##### 21:08:41 INFO - Running pre-action listener: _resource_record_pre_action 21:08:41 INFO - Running main action method: read_buildbot_config 21:08:41 INFO - Using buildbot properties: 21:08:41 INFO - { 21:08:41 INFO - "properties": { 21:08:41 INFO - "buildnumber": 718, 21:08:41 INFO - "product": "firefox", 21:08:41 INFO - "script_repo_revision": "production", 21:08:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 21:08:41 INFO - "repository": "", 21:08:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 21:08:41 INFO - "buildid": "20151123203633", 21:08:41 INFO - "slavename": "talos-linux64-ix-033", 21:08:41 INFO - "pgo_build": "False", 21:08:41 INFO - "basedir": "/builds/slave/test", 21:08:41 INFO - "project": "", 21:08:41 INFO - "platform": "ubuntu64_hw", 21:08:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:08:41 INFO - "slavebuilddir": "test", 21:08:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:08:41 INFO - "branch": "fx-team", 21:08:41 INFO - "repo_path": "integration/fx-team", 21:08:41 INFO - "stage_platform": "linux64", 21:08:41 INFO - "builduid": "b31e97283d164f19990ec0a07fe5811b", 21:08:41 INFO - "revision": "f6cccadd2eed5ef737f26006f58bcdec048d4e34" 21:08:41 INFO - }, 21:08:41 INFO - "sourcestamp": { 21:08:41 INFO - "repository": "", 21:08:41 INFO - "hasPatch": false, 21:08:41 INFO - "project": "", 21:08:41 INFO - "branch": "fx-team-linux64-talos", 21:08:41 INFO - "changes": [ 21:08:41 INFO - { 21:08:41 INFO - "category": null, 21:08:41 INFO - "files": [ 21:08:41 INFO - { 21:08:41 INFO - "url": null, 21:08:41 INFO - "name": "https://queue.taskcluster.net/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 21:08:41 INFO - } 21:08:41 INFO - ], 21:08:41 INFO - "repository": "", 21:08:41 INFO - "rev": "f6cccadd2eed5ef737f26006f58bcdec048d4e34", 21:08:41 INFO - "who": "nchen@mozilla.com", 21:08:41 INFO - "when": 1448341655, 21:08:41 INFO - "number": 6698904, 21:08:41 INFO - "comments": "Bug 1221270 - Schedule and perform GMP updates in AddonUpdateService; r=snorp\nThis patch moves the GMP update process from browser.js startup to\nAddonUpdateService. It also uses the Gecko:ScheduleRun event in\nGeckoService to schedule headless runs in order to perform updates\nperiodically.", 21:08:41 INFO - "project": "", 21:08:41 INFO - "at": "Mon 23 Nov 2015 21:07:35", 21:08:41 INFO - "branch": "fx-team-linux64-talos", 21:08:41 INFO - "revlink": "", 21:08:41 INFO - "properties": [ 21:08:41 INFO - [ 21:08:41 INFO - "buildid", 21:08:41 INFO - "20151123203633", 21:08:41 INFO - "Change" 21:08:41 INFO - ], 21:08:41 INFO - [ 21:08:41 INFO - "builduid", 21:08:41 INFO - "b31e97283d164f19990ec0a07fe5811b", 21:08:41 INFO - "Change" 21:08:41 INFO - ], 21:08:41 INFO - [ 21:08:41 INFO - "pgo_build", 21:08:41 INFO - "False", 21:08:41 INFO - "Change" 21:08:41 INFO - ] 21:08:41 INFO - ], 21:08:41 INFO - "revision": "f6cccadd2eed5ef737f26006f58bcdec048d4e34" 21:08:41 INFO - } 21:08:41 INFO - ], 21:08:41 INFO - "revision": "f6cccadd2eed5ef737f26006f58bcdec048d4e34" 21:08:41 INFO - } 21:08:41 INFO - } 21:08:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 21:08:41 INFO - Running post-action listener: _resource_record_post_action 21:08:41 INFO - ##### 21:08:41 INFO - ##### Running download-and-extract step. 21:08:41 INFO - ##### 21:08:41 INFO - Running pre-action listener: _resource_record_pre_action 21:08:41 INFO - Running main action method: download_and_extract 21:08:41 INFO - mkdir: /builds/slave/test/build/tests 21:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:41 INFO - https://queue.taskcluster.net/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:08:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/test_packages.json 21:08:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/test_packages.json 21:08:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 21:08:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 21:08:43 INFO - Downloaded 1302 bytes. 21:08:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 21:08:43 INFO - Using the following test package requirements: 21:08:43 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:08:43 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:08:43 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:43 INFO - u'jsshell-linux-x86_64.zip'], 21:08:43 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:08:43 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:08:43 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:08:43 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:08:43 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:08:43 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:08:43 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:08:43 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:08: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')]} 21:08:43 INFO - https://queue.taskcluster.net/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:08:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:08:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:08:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:08:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:09:04 INFO - Downloaded 21341300 bytes. 21:09:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 21:09:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:09:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:09:05 INFO - Return code: 0 21:09:05 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:05 INFO - https://queue.taskcluster.net/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:09:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:09:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:09:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:09:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:09:08 INFO - Downloaded 21341300 bytes. 21:09:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 21:09:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:09:08 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:09:10 INFO - Return code: 0 21:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:10 INFO - https://queue.taskcluster.net/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:09:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:09:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:09:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:09:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:09:12 INFO - Downloaded 11130997 bytes. 21:09:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 21:09:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:09:12 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 21:09:12 INFO - Return code: 0 21:09: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')]} 21:09:12 INFO - https://queue.taskcluster.net/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:09:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:09:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:09:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:09:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:09:16 INFO - Downloaded 56070505 bytes. 21:09:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:09:16 INFO - mkdir: /builds/slave/test/properties 21:09:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:09:16 INFO - Writing to file /builds/slave/test/properties/build_url 21:09:16 INFO - Contents: 21:09:16 INFO - build_url:https://queue.taskcluster.net/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:09:16 INFO - Running post-action listener: _resource_record_post_action 21:09:16 INFO - Running post-action listener: set_extra_try_arguments 21:09:16 INFO - ##### 21:09:16 INFO - ##### Running populate-webroot step. 21:09:16 INFO - ##### 21:09:16 INFO - Running pre-action listener: _resource_record_pre_action 21:09:16 INFO - Running main action method: populate_webroot 21:09:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:09:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:09:16 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 21:09:16 INFO - '../fennec_ids.txt'], 21:09:16 INFO - 'tests': ['tcheck2']}, 21:09:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:09:16 INFO - '--tppagecycles', 21:09:16 INFO - '7'], 21:09:16 INFO - 'tests': ['tsvgm']}}, 21:09:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:09:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:09:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:09:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:09:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:09:16 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:09:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:09:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:09:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:09:16 INFO - 'talos_options': ['--e10s'], 21:09:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:09:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:09:16 INFO - 'tests': ['damp', 'tps']}, 21:09:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:09:16 INFO - 'talos_options': ['--e10s'], 21:09:16 INFO - 'tests': ['damp', 'tps']}, 21:09:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:09:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:09:16 INFO - 'other': {'tests': ['a11yr', 21:09:16 INFO - 'ts_paint', 21:09:16 INFO - 'tpaint', 21:09:16 INFO - 'sessionrestore', 21:09:16 INFO - 'sessionrestore_no_auto_restore']}, 21:09:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:09:16 INFO - 'tests': ['a11yr', 21:09:16 INFO - 'ts_paint', 21:09:16 INFO - 'tpaint', 21:09:16 INFO - 'sessionrestore', 21:09:16 INFO - 'sessionrestore_no_auto_restore']}, 21:09:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:09:16 INFO - 'tests': ['a11yr', 21:09:16 INFO - 'ts_paint', 21:09:16 INFO - 'tpaint', 21:09:16 INFO - 'sessionrestore', 21:09:16 INFO - 'sessionrestore_no_auto_restore']}, 21:09:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:09:16 INFO - 'tests': ['a11yr', 21:09:16 INFO - 'ts_paint', 21:09:16 INFO - 'tpaint', 21:09:16 INFO - 'sessionrestore', 21:09:16 INFO - 'sessionrestore_no_auto_restore']}, 21:09:16 INFO - 'other_l64': {'tests': ['a11yr', 21:09:16 INFO - 'ts_paint', 21:09:16 INFO - 'tpaint', 21:09:16 INFO - 'sessionrestore', 21:09:16 INFO - 'sessionrestore_no_auto_restore']}, 21:09:16 INFO - 'other_nol64': {'tests': ['a11yr', 21:09:16 INFO - 'ts_paint', 21:09:16 INFO - 'tpaint', 21:09:16 INFO - 'sessionrestore', 21:09:16 INFO - 'sessionrestore_no_auto_restore']}, 21:09:16 INFO - 'svgr': {'tests': ['tsvgx', 21:09:16 INFO - 'tsvgr_opacity', 21:09:16 INFO - 'tart', 21:09:16 INFO - 'tscrollx', 21:09:16 INFO - 'cart']}, 21:09:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:09:16 INFO - 'tests': ['tsvgx', 21:09:16 INFO - 'tsvgr_opacity', 21:09:16 INFO - 'tart', 21:09:16 INFO - 'tscrollx', 21:09:16 INFO - 'cart']}, 21:09:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:09:16 INFO - 'tests': ['tp5o']}, 21:09:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:09:16 INFO - 'talos_options': ['--e10s'], 21:09:16 INFO - 'tests': ['tp5o']}, 21:09:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:09:16 INFO - 'talos_options': ['--xperf_path', 21:09:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:09:16 INFO - 'tests': ['tp5n']}, 21:09:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:09:16 INFO - 'talos_options': ['--e10s', 21:09:16 INFO - '--xperf_path', 21:09:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:09:16 INFO - 'tests': ['tp5n']}}, 21:09:16 INFO - 'talos.zip': {'path': '', 21:09:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:09:16 INFO - Running post-action listener: _resource_record_post_action 21:09:16 INFO - ##### 21:09:16 INFO - ##### Running create-virtualenv step. 21:09:16 INFO - ##### 21:09:16 INFO - Running pre-action listener: _resource_record_pre_action 21:09:16 INFO - Running main action method: create_virtualenv 21:09:16 INFO - Creating virtualenv /builds/slave/test/build/venv 21:09:16 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 21:09:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:09:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:09:16 INFO - Using real prefix '/usr' 21:09:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:09:17 INFO - Installing distribute.............................................................................................................................................................................................done. 21:09:19 INFO - Installing pip.................done. 21:09:19 INFO - Return code: 0 21:09:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f409c4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e54900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ab70>, '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 0x1eebdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eec250>, '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': 'a194aa7faa1be204aaca7d660000020b-1448333501.707837-785713483', '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 21:09:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:09:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:09:19 INFO - Using env: {'DISPLAY': ':0', 21:09:19 INFO - 'HOME': '/home/cltbld', 21:09:19 INFO - 'LANG': 'en_US.UTF-8', 21:09:19 INFO - 'LANGUAGE': 'en_US:en', 21:09:19 INFO - 'LOGNAME': 'cltbld', 21:09:19 INFO - 'MAIL': '/var/mail/cltbld', 21:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:19 INFO - 'MOZ_NO_REMOTE': '1', 21:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:19 INFO - 'NO_EM_RESTART': '1', 21:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:19 INFO - 'PWD': '/builds/slave/test', 21:09:19 INFO - 'SHELL': '/bin/bash', 21:09:19 INFO - 'SHLVL': '1', 21:09:19 INFO - 'TERM': 'linux', 21:09:19 INFO - 'TMOUT': '86400', 21:09:19 INFO - 'USER': 'cltbld', 21:09:19 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448333501.707837-785713483', 21:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:19 INFO - '_': '/tools/buildbot/bin/python'} 21:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:19 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 21:09:19 INFO - Cleaning up... 21:09:19 INFO - Return code: 0 21:09:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3f409c4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e54900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ab70>, '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 0x1eebdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eec250>, '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': 'a194aa7faa1be204aaca7d660000020b-1448333501.707837-785713483', '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 21:09:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 21:09:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:09:19 INFO - Using env: {'DISPLAY': ':0', 21:09:19 INFO - 'HOME': '/home/cltbld', 21:09:19 INFO - 'LANG': 'en_US.UTF-8', 21:09:19 INFO - 'LANGUAGE': 'en_US:en', 21:09:19 INFO - 'LOGNAME': 'cltbld', 21:09:19 INFO - 'MAIL': '/var/mail/cltbld', 21:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:19 INFO - 'MOZ_NO_REMOTE': '1', 21:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:19 INFO - 'NO_EM_RESTART': '1', 21:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:19 INFO - 'PWD': '/builds/slave/test', 21:09:19 INFO - 'SHELL': '/bin/bash', 21:09:19 INFO - 'SHLVL': '1', 21:09:19 INFO - 'TERM': 'linux', 21:09:19 INFO - 'TMOUT': '86400', 21:09:19 INFO - 'USER': 'cltbld', 21:09:19 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448333501.707837-785713483', 21:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:19 INFO - '_': '/tools/buildbot/bin/python'} 21:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:19 INFO - Downloading/unpacking psutil>=0.7.1 21:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:21 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 21:09:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:09:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:09:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:09:21 INFO - Installing collected packages: psutil 21:09:21 INFO - Running setup.py install for psutil 21:09:21 INFO - building 'psutil._psutil_linux' extension 21:09:21 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 21:09:21 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 21:09:21 INFO - building 'psutil._psutil_posix' extension 21:09:21 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 21:09:21 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 21:09:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:09:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:09:21 INFO - Successfully installed psutil 21:09:21 INFO - Cleaning up... 21:09:21 INFO - Return code: 0 21:09:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3f409c4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e54900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ab70>, '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 0x1eebdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eec250>, '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': 'a194aa7faa1be204aaca7d660000020b-1448333501.707837-785713483', '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 21:09:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 21:09:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 21:09:21 INFO - Using env: {'DISPLAY': ':0', 21:09:22 INFO - 'HOME': '/home/cltbld', 21:09:22 INFO - 'LANG': 'en_US.UTF-8', 21:09:22 INFO - 'LANGUAGE': 'en_US:en', 21:09:22 INFO - 'LOGNAME': 'cltbld', 21:09:22 INFO - 'MAIL': '/var/mail/cltbld', 21:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:22 INFO - 'MOZ_NO_REMOTE': '1', 21:09:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:22 INFO - 'NO_EM_RESTART': '1', 21:09:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:22 INFO - 'PWD': '/builds/slave/test', 21:09:22 INFO - 'SHELL': '/bin/bash', 21:09:22 INFO - 'SHLVL': '1', 21:09:22 INFO - 'TERM': 'linux', 21:09:22 INFO - 'TMOUT': '86400', 21:09:22 INFO - 'USER': 'cltbld', 21:09:22 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448333501.707837-785713483', 21:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:22 INFO - '_': '/tools/buildbot/bin/python'} 21:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:09:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:09:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:09:23 INFO - Installing collected packages: mozsystemmonitor 21:09:23 INFO - Running setup.py install for mozsystemmonitor 21:09:24 INFO - Successfully installed mozsystemmonitor 21:09:24 INFO - Cleaning up... 21:09:24 INFO - Return code: 0 21:09:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:09:24 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')]} 21:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:24 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')]} 21:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:24 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 0x7f3f409c4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e54900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ab70>, '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 0x1eebdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eec250>, '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': 'a194aa7faa1be204aaca7d660000020b-1448333501.707837-785713483', '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 21:09:24 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 21:09:24 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 21:09:24 INFO - Using env: {'DISPLAY': ':0', 21:09:24 INFO - 'HOME': '/home/cltbld', 21:09:24 INFO - 'LANG': 'en_US.UTF-8', 21:09:24 INFO - 'LANGUAGE': 'en_US:en', 21:09:24 INFO - 'LOGNAME': 'cltbld', 21:09:24 INFO - 'MAIL': '/var/mail/cltbld', 21:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:24 INFO - 'MOZ_NO_REMOTE': '1', 21:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:24 INFO - 'NO_EM_RESTART': '1', 21:09:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:24 INFO - 'PWD': '/builds/slave/test', 21:09:24 INFO - 'SHELL': '/bin/bash', 21:09:24 INFO - 'SHLVL': '1', 21:09:24 INFO - 'TERM': 'linux', 21:09:24 INFO - 'TMOUT': '86400', 21:09:24 INFO - 'USER': 'cltbld', 21:09:24 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448333501.707837-785713483', 21:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:24 INFO - '_': '/tools/buildbot/bin/python'} 21:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:24 INFO - Downloading/unpacking blobuploader==1.2.4 21:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:25 INFO - Downloading blobuploader-1.2.4.tar.gz 21:09:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:09:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:09:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:09:26 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 21:09:26 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 21:09:26 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 21:09:26 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 21:09:26 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 21:09:26 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 21:09:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:09:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:29 INFO - Downloading docopt-0.6.1.tar.gz 21:09:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:09:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:09:29 INFO - Installing collected packages: blobuploader, requests, docopt 21:09:29 INFO - Running setup.py install for blobuploader 21:09:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:09:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:09:29 INFO - Running setup.py install for requests 21:09:29 INFO - Running setup.py install for docopt 21:09:29 INFO - Successfully installed blobuploader requests docopt 21:09:29 INFO - Cleaning up... 21:09:30 INFO - Return code: 0 21:09:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:09: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')]} 21:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09: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')]} 21:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:30 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 0x7f3f409c4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e54900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ab70>, '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 0x1eebdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eec250>, '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': 'a194aa7faa1be204aaca7d660000020b-1448333501.707837-785713483', '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 21:09:30 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 21:09:30 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 21:09:30 INFO - Using env: {'DISPLAY': ':0', 21:09:30 INFO - 'HOME': '/home/cltbld', 21:09:30 INFO - 'LANG': 'en_US.UTF-8', 21:09:30 INFO - 'LANGUAGE': 'en_US:en', 21:09:30 INFO - 'LOGNAME': 'cltbld', 21:09:30 INFO - 'MAIL': '/var/mail/cltbld', 21:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:30 INFO - 'MOZ_NO_REMOTE': '1', 21:09:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:30 INFO - 'NO_EM_RESTART': '1', 21:09:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:30 INFO - 'PWD': '/builds/slave/test', 21:09:30 INFO - 'SHELL': '/bin/bash', 21:09:30 INFO - 'SHLVL': '1', 21:09:30 INFO - 'TERM': 'linux', 21:09:30 INFO - 'TMOUT': '86400', 21:09:30 INFO - 'USER': 'cltbld', 21:09:30 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448333501.707837-785713483', 21:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:30 INFO - '_': '/tools/buildbot/bin/python'} 21:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:09:30 INFO - Running setup.py (path:/tmp/pip-GEFX7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:09:30 INFO - Running setup.py (path:/tmp/pip-44CbBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:09:30 INFO - Running setup.py (path:/tmp/pip-zm_3LG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:09:30 INFO - Running setup.py (path:/tmp/pip-8L3eki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:09:30 INFO - Running setup.py (path:/tmp/pip-_P_lYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:09:30 INFO - Running setup.py (path:/tmp/pip-sT9IF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:09:30 INFO - Running setup.py (path:/tmp/pip-4efDPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:09:30 INFO - Running setup.py (path:/tmp/pip-gslLkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:09:30 INFO - Running setup.py (path:/tmp/pip-Nnd5pV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:09:31 INFO - Running setup.py (path:/tmp/pip-OTA1Tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:09:31 INFO - Running setup.py (path:/tmp/pip-CdnVFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:09:31 INFO - Running setup.py (path:/tmp/pip-p8qe0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:09:31 INFO - Running setup.py (path:/tmp/pip-2_G4ZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:09:31 INFO - Running setup.py (path:/tmp/pip-fT_Fvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:31 INFO - Running setup.py (path:/tmp/pip-T92HdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:09:31 INFO - Running setup.py (path:/tmp/pip-EKuLfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:09:31 INFO - Running setup.py (path:/tmp/pip-I2iFa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:09:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:09:31 INFO - Running setup.py install for manifestparser 21:09:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:09:31 INFO - Running setup.py install for mozcrash 21:09:31 INFO - Running setup.py install for mozdebug 21:09:31 INFO - Running setup.py install for mozdevice 21:09:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:09:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:09:32 INFO - Running setup.py install for mozfile 21:09:32 INFO - Running setup.py install for mozhttpd 21:09:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:09:32 INFO - Running setup.py install for mozinfo 21:09:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:09:32 INFO - Running setup.py install for mozInstall 21:09:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:09:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:09:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:09:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:09:32 INFO - Running setup.py install for mozleak 21:09:32 INFO - Running setup.py install for mozlog 21:09:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:09:32 INFO - Running setup.py install for moznetwork 21:09:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:09:32 INFO - Running setup.py install for mozprocess 21:09:32 INFO - Running setup.py install for mozprofile 21:09:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:09:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:09:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:09:32 INFO - Running setup.py install for mozrunner 21:09:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:09:33 INFO - Running setup.py install for mozscreenshot 21:09:33 INFO - Running setup.py install for moztest 21:09:33 INFO - Running setup.py install for mozversion 21:09:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:09:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:09:33 INFO - Cleaning up... 21:09:33 INFO - Return code: 0 21:09:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f3f409c4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e54900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ab70>, '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 0x1eebdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eec250>, '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': 'a194aa7faa1be204aaca7d660000020b-1448333501.707837-785713483', '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 21:09:33 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 21:09:33 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 21:09:33 INFO - Using env: {'DISPLAY': ':0', 21:09:33 INFO - 'HOME': '/home/cltbld', 21:09:33 INFO - 'LANG': 'en_US.UTF-8', 21:09:33 INFO - 'LANGUAGE': 'en_US:en', 21:09:33 INFO - 'LOGNAME': 'cltbld', 21:09:33 INFO - 'MAIL': '/var/mail/cltbld', 21:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:33 INFO - 'MOZ_NO_REMOTE': '1', 21:09:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:33 INFO - 'NO_EM_RESTART': '1', 21:09:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:33 INFO - 'PWD': '/builds/slave/test', 21:09:33 INFO - 'SHELL': '/bin/bash', 21:09:33 INFO - 'SHLVL': '1', 21:09:33 INFO - 'TERM': 'linux', 21:09:33 INFO - 'TMOUT': '86400', 21:09:33 INFO - 'USER': 'cltbld', 21:09:33 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448333501.707837-785713483', 21:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:33 INFO - '_': '/tools/buildbot/bin/python'} 21:09:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:09:33 INFO - Running setup.py (path:/tmp/pip-6PBXuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:09:33 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)) 21:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:09:33 INFO - Running setup.py (path:/tmp/pip-olUz89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:09:33 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)) 21:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:09:33 INFO - Running setup.py (path:/tmp/pip-OD76iX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:09:33 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)) 21:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:09:33 INFO - Running setup.py (path:/tmp/pip-OKrmaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:09:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:09:33 INFO - Running setup.py (path:/tmp/pip-fGFYod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:09:33 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)) 21:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:09:33 INFO - Running setup.py (path:/tmp/pip-Jxqptb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:09:34 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)) 21:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:09:34 INFO - Running setup.py (path:/tmp/pip-Avjrnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:09:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:09:34 INFO - Running setup.py (path:/tmp/pip-0amF74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:09:34 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)) 21:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:09:34 INFO - Running setup.py (path:/tmp/pip-sG23HI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:09:34 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)) 21:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:09:34 INFO - Running setup.py (path:/tmp/pip-1627Yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:09:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:09:34 INFO - Running setup.py (path:/tmp/pip-wfskNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:09:34 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)) 21:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:09:34 INFO - Running setup.py (path:/tmp/pip-MZ7Y9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:09:34 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)) 21:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:09:34 INFO - Running setup.py (path:/tmp/pip-hzYElk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:09:34 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)) 21:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:09:34 INFO - Running setup.py (path:/tmp/pip-DmKRfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:09:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:34 INFO - Running setup.py (path:/tmp/pip-YtjSRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:34 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)) 21:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:09:34 INFO - Running setup.py (path:/tmp/pip-c1fyp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:09:34 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)) 21:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:09:34 INFO - Running setup.py (path:/tmp/pip-ruSRTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:09:34 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)) 21:09:34 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)) 21:09:34 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)) 21:09:34 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)) 21:09:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:09:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:09:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:36 INFO - Downloading blessings-1.5.1.tar.gz 21:09:36 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 21:09:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:09:36 INFO - Installing collected packages: blessings 21:09:36 INFO - Running setup.py install for blessings 21:09:36 INFO - Successfully installed blessings 21:09:36 INFO - Cleaning up... 21:09:36 INFO - Return code: 0 21:09:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:09:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:09:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:09:36 INFO - Reading from file tmpfile_stdout 21:09:36 INFO - Current package versions: 21:09:36 INFO - argparse == 1.2.1 21:09:36 INFO - blessings == 1.5.1 21:09:36 INFO - blobuploader == 1.2.4 21:09:36 INFO - docopt == 0.6.1 21:09:36 INFO - manifestparser == 1.1 21:09:36 INFO - mozInstall == 1.12 21:09:36 INFO - mozcrash == 0.16 21:09:36 INFO - mozdebug == 0.1 21:09:36 INFO - mozdevice == 0.47 21:09:36 INFO - mozfile == 1.2 21:09:36 INFO - mozhttpd == 0.7 21:09:36 INFO - mozinfo == 0.9 21:09:36 INFO - mozleak == 0.1 21:09:36 INFO - mozlog == 3.1 21:09:36 INFO - moznetwork == 0.27 21:09:36 INFO - mozprocess == 0.22 21:09:36 INFO - mozprofile == 0.27 21:09:36 INFO - mozrunner == 6.11 21:09:36 INFO - mozscreenshot == 0.1 21:09:36 INFO - mozsystemmonitor == 0.0 21:09:36 INFO - moztest == 0.7 21:09:36 INFO - mozversion == 1.4 21:09:36 INFO - psutil == 3.1.1 21:09:36 INFO - requests == 1.2.3 21:09:36 INFO - wsgiref == 0.1.2 21:09:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:09:36 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')]} 21:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:36 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')]} 21:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:36 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 0x7f3f409c4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e54900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ab70>, '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 0x1eebdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eec250>, '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': 'a194aa7faa1be204aaca7d660000020b-1448333501.707837-785713483', '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 21:09:36 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 21:09:36 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 21:09:36 INFO - Using env: {'DISPLAY': ':0', 21:09:36 INFO - 'HOME': '/home/cltbld', 21:09:36 INFO - 'LANG': 'en_US.UTF-8', 21:09:36 INFO - 'LANGUAGE': 'en_US:en', 21:09:36 INFO - 'LOGNAME': 'cltbld', 21:09:36 INFO - 'MAIL': '/var/mail/cltbld', 21:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:36 INFO - 'MOZ_NO_REMOTE': '1', 21:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:36 INFO - 'NO_EM_RESTART': '1', 21:09:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:36 INFO - 'PWD': '/builds/slave/test', 21:09:36 INFO - 'SHELL': '/bin/bash', 21:09:36 INFO - 'SHLVL': '1', 21:09:36 INFO - 'TERM': 'linux', 21:09:36 INFO - 'TMOUT': '86400', 21:09:36 INFO - 'USER': 'cltbld', 21:09:36 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448333501.707837-785713483', 21:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:36 INFO - '_': '/tools/buildbot/bin/python'} 21:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:37 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)) 21:09:37 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)) 21:09:37 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)) 21:09:37 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)) 21:09:37 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)) 21:09:37 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)) 21:09:37 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)) 21:09:37 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)) 21:09:37 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)) 21:09:37 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)) 21:09:37 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)) 21:09:37 INFO - Cleaning up... 21:09:37 INFO - Return code: 0 21:09:37 INFO - Running post-action listener: _resource_record_post_action 21:09:37 INFO - Running post-action listener: _start_resource_monitoring 21:09:37 INFO - Starting resource monitoring. 21:09:37 INFO - ##### 21:09:37 INFO - ##### Running install step. 21:09:37 INFO - ##### 21:09:37 INFO - Running pre-action listener: _resource_record_pre_action 21:09:37 INFO - Running main action method: install 21:09:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:09:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:09:37 INFO - Reading from file tmpfile_stdout 21:09:37 INFO - Detecting whether we're running mozinstall >=1.0... 21:09:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:09:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:09:37 INFO - Reading from file tmpfile_stdout 21:09:37 INFO - Output received: 21:09:37 INFO - Usage: mozinstall [options] installer 21:09:37 INFO - Options: 21:09:37 INFO - -h, --help show this help message and exit 21:09:37 INFO - -d DEST, --destination=DEST 21:09:37 INFO - Directory to install application into. [default: 21:09:37 INFO - "/builds/slave/test"] 21:09:37 INFO - --app=APP Application being installed. [default: firefox] 21:09:37 INFO - mkdir: /builds/slave/test/build/application 21:09:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:09:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:09:51 INFO - Reading from file tmpfile_stdout 21:09:51 INFO - Output received: 21:09:51 INFO - /builds/slave/test/build/application/firefox/firefox 21:09:51 INFO - Running post-action listener: _resource_record_post_action 21:09:51 INFO - ##### 21:09:51 INFO - ##### Running run-tests step. 21:09:51 INFO - ##### 21:09:51 INFO - Running pre-action listener: _resource_record_pre_action 21:09:51 INFO - Running main action method: run_tests 21:09:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:09:51 INFO - Python 2.7.3 21:09:51 INFO - Return code: 0 21:09:51 INFO - grabbing minidump binary from tooltool 21:09:51 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')]} 21:09:51 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 0x1e9ab70>, '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 0x1eebdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eec250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:09:51 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 21:09:51 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 21:09:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:09:51 INFO - Return code: 0 21:09:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:09:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:09:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:09:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:09:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:09:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] in /builds/slave/test/build 21:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost 21:09:51 INFO - Using env: {'DISPLAY': ':0', 21:09:51 INFO - 'HOME': '/home/cltbld', 21:09:51 INFO - 'LANG': 'en_US.UTF-8', 21:09:51 INFO - 'LANGUAGE': 'en_US:en', 21:09:51 INFO - 'LOGNAME': 'cltbld', 21:09:51 INFO - 'MAIL': '/var/mail/cltbld', 21:09:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:09:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:09:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:51 INFO - 'MOZ_NO_REMOTE': '1', 21:09:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:09:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:51 INFO - 'NO_EM_RESTART': '1', 21:09:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:51 INFO - 'PWD': '/builds/slave/test', 21:09:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:09:51 INFO - 'SHELL': '/bin/bash', 21:09:51 INFO - 'SHLVL': '1', 21:09:51 INFO - 'TERM': 'linux', 21:09:51 INFO - 'TMOUT': '86400', 21:09:51 INFO - 'USER': 'cltbld', 21:09:51 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448333501.707837-785713483', 21:09:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:51 INFO - '_': '/tools/buildbot/bin/python'} 21:09:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] with output_timeout 3600 21:09:51 INFO - mozversion INFO | application_buildid: 20151123203633 21:09:51 INFO - mozversion INFO | application_changeset: f6cccadd2eed5ef737f26006f58bcdec048d4e34 21:09:51 INFO - mozversion INFO | application_display_name: Nightly 21:09:51 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:09:51 INFO - mozversion INFO | application_name: Firefox 21:09:51 INFO - mozversion INFO | application_remotingname: firefox 21:09:51 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 21:09:51 INFO - mozversion INFO | application_vendor: Mozilla 21:09:51 INFO - mozversion INFO | application_version: 45.0a1 21:09:51 INFO - mozversion INFO | platform_buildid: 20151123203633 21:09:51 INFO - mozversion INFO | platform_changeset: f6cccadd2eed5ef737f26006f58bcdec048d4e34 21:09:51 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 21:09:51 INFO - mozversion INFO | platform_version: 45.0a1 21:09:51 INFO - 2015-11-23 21:09:51,925 DEBUG : using testdate: 1448341791 21:09:51 INFO - 2015-11-23 21:09:51,925 DEBUG : actual date: 1448341791 21:09:51 INFO - 2015-11-23 21:09:51,972 INFO : starting webserver on 'localhost:48689' 21:09:51 INFO - 2015-11-23 21:09:51,973 INFO : Starting test suite talos-linux64-ix-033.e 21:09:51 INFO - 2015-11-23 21:09:51,973 INFO : Starting test dromaeo_css 21:09:51 INFO - 2015-11-23 21:09:51,973 DEBUG : operating with platform_type : linux_ 21:09:51 INFO - 2015-11-23 21:09:51,974 INFO : Initialising browser for dromaeo_css test... 21:09:51 INFO - 2015-11-23 21:09:51,990 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQC8dkU/profile http://localhost:48689/getInfo.html 21:09:58 INFO - 2015-11-23 21:09:58,101 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:09:58 INFO - 2015-11-23 21:09:58,101 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:09:58 INFO - 2015-11-23 21:09:58,101 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:09:58 INFO - 2015-11-23 21:09:58,101 DEBUG : BROWSER_OUTPUT: __metrics 21:09:59 INFO - 2015-11-23 21:09:59,681 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 21:10:00 INFO - 2015-11-23 21:10:00,737 INFO : Browser initialized. 21:10:00 INFO - 2015-11-23 21:10:00,738 INFO : Running cycle 1/1 for dromaeo_css test... 21:10:00 INFO - 2015-11-23 21:10:00,738 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQC8dkU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:10:12 INFO - 2015-11-23 21:10:12,736 DEBUG : BROWSER_OUTPUT: RSS: Main: 142295040 21:10:12 INFO - 2015-11-23 21:10:12,737 DEBUG : BROWSER_OUTPUT: 21:11:02 INFO - 2015-11-23 21:11:02,401 DEBUG : BROWSER_OUTPUT: 1448341862399 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] 21:13:13 INFO - 2015-11-23 21:13:13,954 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48689/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48689/tests/dromaeo/cssquery-ext.html) 21:13:15 INFO - 2015-11-23 21:13:15,146 DEBUG : BROWSER_OUTPUT: RSS: Main: 144584704 21:13:15 INFO - 2015-11-23 21:13:15,146 DEBUG : BROWSER_OUTPUT: 21:16:17 INFO - 2015-11-23 21:16:17,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48689/tests/dromaeo/cssquery-ext.html (next: http://localhost:48689/tests/dromaeo/cssquery-jquery.html) 21:16:17 INFO - 2015-11-23 21:16:17,704 DEBUG : BROWSER_OUTPUT: RSS: Main: 141475840 21:16:17 INFO - 2015-11-23 21:16:17,704 DEBUG : BROWSER_OUTPUT: 21:19:19 INFO - 2015-11-23 21:19:19,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48689/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48689/tests/dromaeo/cssquery-mootools.html) 21:19:19 INFO - 2015-11-23 21:19:19,998 DEBUG : BROWSER_OUTPUT: RSS: Main: 141905920 21:19:19 INFO - 2015-11-23 21:19:19,998 DEBUG : BROWSER_OUTPUT: 21:22:21 INFO - 2015-11-23 21:22:21,760 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48689/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48689/tests/dromaeo/cssquery-prototype.html) 21:22:22 INFO - 2015-11-23 21:22:22,361 DEBUG : BROWSER_OUTPUT: RSS: Main: 141504512 21:22:22 INFO - 2015-11-23 21:22:22,362 DEBUG : BROWSER_OUTPUT: 21:25:25 INFO - 2015-11-23 21:25:25,004 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48689/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48689/tests/dromaeo/cssquery-yui.html) 21:25:25 INFO - 2015-11-23 21:25:25,605 DEBUG : BROWSER_OUTPUT: RSS: Main: 141635584 21:25:25 INFO - 2015-11-23 21:25:25,605 DEBUG : BROWSER_OUTPUT: 21:28:27 INFO - 2015-11-23 21:28:27,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48689/tests/dromaeo/cssquery-yui.html (next: http://localhost:48689/tests/dromaeo/cssquery-dojo.html) 21:28:27 INFO - 2015-11-23 21:28:27,992 DEBUG : BROWSER_OUTPUT: RSS: Main: 144678912 21:28:27 INFO - 2015-11-23 21:28:27,992 DEBUG : BROWSER_OUTPUT: 21:28:27 INFO - 2015-11-23 21:28:27,993 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:28:27 INFO - 2015-11-23 21:28:27,994 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:28:27 INFO - 2015-11-23 21:28:27,994 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:28:27 INFO - 2015-11-23 21:28:27,994 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:28:27 INFO - 2015-11-23 21:28:27,995 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2648.854313012784;2654.641623380843;2690.7040225575183;2700.1089640418663;2726.1140129457926;4461.598456138955;4595.402597662308;4611;4634.907301853965;4658.860234192975;4547.272436410175;4603.884902877421;4606.539346065392;4678.812847486105;4691.460482044566;4241.363795430695;4313.331433627793;4327.285997810365;4440.622547083485;4454.888627784315;4368.759718215497;4420.20436321462;4423.137488189788;4428.623566996793;4463.73217606943;4168.374743788426;4244.745315281062;4278.935815962732;4353.760543170124;4364.192624364503;4337.934930976038;4342.131573685244;4353.346997950302;4361.236783562864;4385.2106620808245;4177.582241775828;4334.479862416499;4338.58783415575;4342.978285108586;4395.802188901475;4510.639148868083;4565.0641618468135;4587.24310488769;4602.907941841145;4617.58441740245;5015.548600625962;5102.36220472441;5104.846854594368;5105.055564720538;5157.7936882524655;4901.240307752304;5108.974455127738;5117.7185254810975;5121.641485096045;5170.095233334189;4559.99680070384;4575.450945886515;4631.652626053059;4641.675082744243;4673.6728429009645;5156.071907056766;5166;5166.509181627739;5171.974140129275;5188.377394712583;4790.952090479121;4877.951240483313;4973.403191617029;4976.975115124474;5028.949710502921;4928.926066109011;4971.080350135237;4975.776090075955;5032.672876263031;5185.740712964337;4948.356713627206;4961.751912404366;4973.477784832613;4980.402351717817;5016.147254966664;4916.950830491649;4943.332650092263;4944.134776414113;4951.3810773653295;5000.2499625056535;4047.6559492442884;4078.6940979426663;4134.937975930364;4137.606927341898;4141.4409054777825;3608.9458658120147;3631.6913062389995;3641.2717456508803;3646.690031347312;3651.653092956165;4301.354796780508;4326.134773045404;4356.564343565618;4357.891052723708;4398.032432864765;4843.200871856105;4930.975345123252;4941.160002799533;5009.44896061433;5029.1450453423;4337.7614231217585;4348.847790327323;4368.650507959355;4371.825126994948;4390.736555806662;4399.428074350378;4431.534688857623;4434.17967675981;4472.306792447176;4495.168393847149;4576.748278844629;4628.768561571841;4664.323673067318;4674.509176536482;4726.574608285271;4985.925211121908;5019.071471777733;5029.170186919264;5068.366454193226;5110.207917772751;4706.741129237925;4727.645426592951;4746.525347465225;4762.928556071731;4807.831725889717;4724.456687480983;4842.297866809364;4849.58778503817;4890.951090489192;4921;4961.330220420197;4970.155073637418;5002.599792016703;5005.549500544823;5030.37120359955;4722.150012997693;4828.010257897053;4866.489018653132;4866.780994855169;4900.509949005071;4607.124646317189;4719.197736384892;4736.73947932867;4775.379200704026;4776.952230477651;4690.085433340466;4690.15577196108;4738.123447162286;4765.309030190534;4820.855374338776;4696.765161741968;4787.593054590398;4854.9514504855915;4875.878103047452;4883.731394773322;4711.505291944297;4777.976110119427;4780.760961951819;4799.160146974195;4838.830640927551 21:28:27 INFO - 2015-11-23 21:28:27,996 DEBUG : BROWSER_OUTPUT: |1;ext.html;544.7407711277849;569.7948738454156;579.4466284698113;584.2288179602923;590.5187272373016;32434.513482297756;33120.17199570009;33165.66834331656;33166.33667326652;33380;37250.25499490008;38545.61454385455;38569.22861542767;38592.42111368332;38677.226455470874;7708.537487750753;7860.331871790904;7869.095054068769;7906.051273847146;7917.366610671162;7671.462997590171;7692;7705.653245603933;7745.1867553906595;7760.262775036363;7963.681452741884;7984.560849153294;7990.880136797953;8050.5974701264995;8052.114267430578;7600.353969912564;7750.689972401154;7775.261350171724;7793.96103019487;7803.453758236926;7857.1357150713375;7909.05091389037;7989.600519973978;7994.840103197962;7994.920050799476;36239.63760362389;36344.45483317752;36412.63587364119;36525.26949461023;36604.084897877765;2504.186139504668;2608.89541445679;2657.322382792395;2776.9028084016963;3326.6839650233187;27109;27211.727882721116;27382.589261160898;27490.725092749217;27618;3345.1135449106005;3362.7646064775477;3393.7963722176746;3414.163529935157;3439.724822014233;217884;218718;220351;220442;220741.9999999984;36994.26011479755;37679.42045505672;51781.7410912943;51925;52061.73969130206;36257.8187109068;36316.636833631856;36366.09084772902;36462.63537364645;36536.45195322072;13037.869621303666;13211.66970825737;13268.53560125391;13274.402651880688;13279.933600331937;10345.37927724339;10369.585216591402;10428;10436;10462;12590;12879.806802897963;13059.542915997894;13075.411606477732;13101.606951791271;5306.28365170697;5404.83785486436;5415.241866138744;5501.339839219319;5501.862453438616;786.8465649198351;799.520287827299;866.3675516872718;871.5511511571545;988.7824678570703;24728.381790455023;25042;25359.746402535737;25400.364990875005;25544.48911021769;913.1690161952591;971.4608392342318;1011.8482227665909;1015.4821041269006;1040.0385052423708;13146.079774415699;13162.210267383987;13296.73406531864;13334.733305333839;13377.130486518345;326122.27960623614;329864;330050;330064;331210;45467.31799023017;46115.769421152676;46155.30767038497;46158.30762538565;46272.07455850932;1193.797054500737;1199.648738086617;1201.3152503073165;1203.8796120388067;1204.4218774988055;24950.37624059413;25411.745882540938;25485.23544293674;25550;25789.613155803054;37010;37099.62900370962;37469;37480.437793432575;37553;242658;243249;243979;244284;245627;28791.424171516035;29308.413831723672;40626;41445;41941.161176775684;38800;39033.2193356137;39252;39300.2139957205;39660.40509392304;32707;33383.33233335368;33727;33807;34279.65720342765;33469.33061338808;34139.82930085334;34162.31675366528;34332.65667343394;34497;33054.66945330612;33090;33271.48301111365;33559.83220083884;33577.83211083929;28727.42545149127;30236.752311819877;30668.693313067477;30701.846490767402;30815.53776693396;24318.639472058105;24391.390215244763;24408.87795561082;24489.632655510537;24619.87690061538 21:28:27 INFO - 2015-11-23 21:28:27,998 DEBUG : BROWSER_OUTPUT: |2;jquery.html;317.91734149121237;330.9541847761075;331.3224455987505;333.092323418684;336.90735047861835;14553.41786328547;15105.848941510581;15513.92243038786;15991.760123598126;16188.595285117877;9602.135807777298;9808.509574521264;12660.873391266085;15198;15198.924005379986;4515.412996310483;4684.765761711901;4704.294355846616;4794.568488836004;5021.6986980781085;4994.350734404522;5021.774020169083;5026.648134630577;5036.345275114249;5057.41839688435;4803.111424386482;4955.900881982358;4957.652964292501;4973.278874563186;5014.749262536877;4864.100141473803;4943.283223932528;4945.381827271591;4945.950540494621;4982.551570358667;4908.0429316283335;4910.754462276872;4919.385076865392;4953.529414705597;4955.207166853286;11828.467718952668;11839.171258011942;11872.821907671392;16172.35310587575;18052;1706.4709939918541;1713.2119225156443;1747.100243374663;1789.8836575622543;1829.86276029297;8907.643694252221;9168.449893006375;9389.295802814748;10824.621138260201;12822.551210707581;1635.6156303268722;1679.3954176496452;1705.1389048530414;1735.9218835152321;1755.6313174233298;51064;53151.20273195905;53518.64813518656;53614.73192634051;54462.45537544653;9238.353315267866;9374.109459601463;9688.515574221261;9942.502874856229;9999.950000250097;12375.938120309342;12468.251904885554;12476.00191984639;12521.436535355931;12523.874761252453;7150.10623672041;7159.498835081598;7162.892556611655;7324.121105467378;7345.816354591071;6874.106366172366;6887.655617219119;6892.965535172292;7023.227444981048;7030.613316267654;4129.483814523184;4205.621494065549;4211.925958880466;4215.346621273708;4248.299030659969;1702.208473060033;1752.2202619834306;1766.4612293250425;1774.210476338017;1783.5184500185137;741.610654406441;788.9092754333325;804.3846457460048;823.4359463767219;912.9774652389366;15361.385544578316;15404.845951540341;15611.765823512656;16093.517194484184;16154.434594789125;800.3957012455559;803.658445160816;814.5072231300096;822.1203312455615;859.3254295378098;8730.126987301219;8774.912250877409;8925.687600934067;8953.955230223808;9102.81794364109;446288;447003;447104;450004;452873;63745.68127159335;66517.6674116636;66652.33347666461;66925.33074669288;67057.32942670511;1013.9239557033104;1014.7767491151935;1016.6441745389203;1021.5045702834119;1023.2785885950387;13787.793183102061;13904.930475347559;14090;14115.929420352833;14131.717365652836;29155.85422072876;29690.55464167996;29738.256543586584;29746.85126574353;30251.243718907204;38588.421173681854;39118.80440597779;39411.40882886702;42400.57599423966;42689.786551067045;8454.661813527637;8533.31733461334;8604.956975215084;8644.697435589724;8799.47203167812;15528.22358882074;15647.843521564639;15653.37386504527;15830.52508424749;16171.919140404694;13378.93310533441;13479.326033698471;13552;13606.319684015562;13685;12361;13577.864221358055;13648.454061837416;13681.452741890611;13897.930510347383;13793.655158620713;13876;14142.858571414567;14197.787033194716;14257.714845703234;8777;8975.820483590422;9025.774355641162;9063.365564410691;9088.636454541744;13516.189028658311;13630.591082267549;13922.721545569235;13925.303734813016;13945.093568917988 21:28:28 INFO - 2015-11-23 21:28:28,001 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1488.5980785188005;1566.7101586206552;1627.2677295217156;1631.5921019745065;1639.1394517878111;6470.547061705683;6608.669566521667;6703.564268322556;6794.218664853537;6837.00863374811;6460.644664543448;6490.643014634205;6562.47500199984;6565.441937435312;6571.539992200548;1906.3327835257687;1926.1043614719154;1926.9036548172605;1928.5757133430623;1936.6126774645056;2074.2429013410074;2094.350751267112;2095.779943105967;2128.1806504495803;2128.2019242783954;1941.4466876940076;1978.465814230157;1992.4321568353023;2020.4342784020498;2049.4466494046596;1996.9600607987904;2077.2833372486466;2080.053575623088;2084.9887804415;2085.98957005214;2081.9271325503687;2126.946826329339;2127.57448510297;2127.7765834587453;2135.4874830040835;6879.690413931385;6886.449084073312;6937.68780404883;6963.09479767632;6966.860662786767;3981.3828856527284;4051.6353528182603;4052.371882358239;4062.8577999770164;4068.7965601720093;2730.167298973812;2734.3164208947765;2737.712540183272;2770.8337499749878;2773.55623100303;840.4579046515024;886.6409104312763;908.3006085314337;913.0777914306532;917.8806755121858;8966.282697384193;8982.86525702115;9009.369344145978;9021.774455638595;9022;3808.923821523554;3879.86420475282;3920.0591857953887;3926;3947.3092208863336;7961.880571791427;7969.163237860057;7988.520688758693;8003.639836207385;8035.477693949874;4194.391813187131;4198.9370159447635;4238.978805105955;4247.723897946624;4277.037666525007;3826.8469261229798;3829.5787463379006;3854.248421557825;3862.6909847212155;3865.9948413412717;3245.0913744151676;3305.272839975202;3316.966830331714;3325.451300535433;3342.715869151101;1007.0533698323552;1028.881678606955;1029.6807989523272;1035.1460045462522;1050.406520316019;777.3975169243769;835.4110352201683;836.0803116571723;886.9888327306875;1053.947302634865;6041.818745437644;6090.20827292458;6105.725242364016;6109.327973922865;6123.2652081750475;555.9666420014812;572.4676051272356;576.1127863090793;576.3919065386058;712.1560950273941;4947.851564453073;4961.156603377434;4973;4980.302757613937;4997.400311962588;7818;7822.687092516349;8109.432339736162;8133.349332053422;8139.593020349077;7985.161558036322;8000.79998000043;8013.3589312856;8054.8791768122355;8103.594820258963;6397.26431460388;6410.679466026773;6435.581687190318;6437.9678101610125;6518.837029074311;6460.644664543307;6511.251206111168;6517.576357536745;6525.543211975116;6559.672016399257;7081.362677359062;7128.215896251512;7305.671244794104;7321.63391830417;7323.231060738546;6775.93224067753;6922.584644921119;6940.167179938439;7412.777616671293;7419.517731347445;5887.087501437284;5920.911186332122;5946.316173639913;5957.523398128053;5966.791162309299;6363.872722545616;6383.32975037633;6411.743530258737;6490.123833282447;6493.448056915215;6141.47797437205;6183.979643358795;6253;6266.248050234001;6316.052592111037;5759.51044161251;5921.970390148022;5937.584369094295;6005.424060653578;6157.138000679819;5899.852503687271;5937.2578427696535;5940.287165540163;5946.970265148647;5970.253718285215;5643.548516118783;5661.943380566142;5683.545316374597;5688.203651488712;5693.032184528723;5806.65160090396;5855.268091488564;5858.677772722541;5860.941390586039;5861.296644402699 21:28:28 INFO - 2015-11-23 21:28:28,001 DEBUG : BROWSER_OUTPUT: |4;prototype.html;296.3169198949963;296.9955450668239;304.44135012252514;309.521788836248;321.2659074015874;5541.5843811714085;5594.692291923942;5634.3802181759975;5680.0627896397145;5685.232493613361;5398.73006349682;5536.833894983147;5578.470045345696;5614.29821272341;5619.381867994528;4370.912581748363;4378.387025816372;4378.474583050031;4394.252976993918;4396.538363471837;4387;4387.7367357958465;4389.648828093761;4403.823847046115;4410.911781764363;4288.120935208275;4356.564343565649;4360.934585981213;4369.934450983238;4376.934345984812;4353.064091220371;4354.107407981356;4356.390105385232;4363.323684828857;4372.191144638252;3829.5596006459054;3830.0233440472502;3838.673712734421;3842.903927401809;3856.093817952779;5409.675419474805;5439.5104440600535;5441.401445840955;5450.700211488366;5464.3442786865435;4774.880627984294;4900.534449227318;5042.193249080129;5047.293378926953;5049.798008079672;5715.142728590703;5854.590178687494;5874.706264686749;5883.0881213411985;5886.3230728465915;4024.7987600619854;4033.1530378620523;4036.4550785643855;4042.413849991735;4045.110075783323;6180.567360284782;6222.595531290452;6227.657478838662;6244.094606282109;6254.6872656366995;4066.34938409853;4155.231282212801;4210.578942105765;4217.093324935154;4221.269279595351;4282.657387409;4284.807183676742;4285.571442855752;4290.034742183047;4295.8496452624;4936.950630493649;4938.333325001151;4941.728204948762;4947.060058588857;4954.529319714621;5915.7633694652595;5931.940680593225;5945.970270148708;5948.137520059568;5953.285605727254;1476.8375478697335;1503.090630168754;1513.9856296281298;1519.9088054716754;1529.2353823088456;1004.3271008424373;1008.470552959702;1015.7105225010985;1025.6051420203275;1026.573971801694;5107.923381149286;5119.564836988823;5133.050385678662;5133.23001549763;5145.176771716508;6071.908921366183;6109.327973922865;6130.417610327101;6135.5398345124295;6137.938620613737;5115.974420127875;5122.154844450699;5132.101882170605;5133.178691409356;5137.563307118937;3254.397936381777;3297.7526685498683;3326.4511355626532;3330.134165117087;3334.1664583854035;5725.570582206351;5750.971245143747;5774.2782152230975;5778.624389414675;5784;6290.622562646256;6290.811275661737;6301.747930082745;6311.810645680637;6316.242050953823;5591.10542313228;5611.382747897646;5707.429257074343;5715.799947001835;5750.137479378127;6196.628202307876;6214.036824292242;6226.844328891632;6246.1255424239735;6246.593971391845;6073.514118870568;6074.787382441594;6081.665508397081;6086.087086936818;6086.995645718407;5700.201971723879;5852.4147585241135;5861.912071319019;5877.94122058774;5911.586188966731;4130.524989626231;4154.4183814265425;4156.168766246702;4157.9605098725315;4159.750414975111;6231.9688401557705;6258.561900666909;6262.749490020348;6263.342349053466;6271.686415679106;5964.194833697569;5975.133605627073;5984.611000284967;5988.580799344004;6005.519558435402;5782.5663075268685;5987.491063259672;6013.30846952606;6013.338532761305;6032.577719559764;5823.4176582343125;5867.20792692981;5872.559558033079;5908.734106965111;5909.025010873158;6028.246469191351;6042.335343112342;6070.089486577049;6070.2412198475195;6075.544334175043;5695.572832037531;5895.882082358415;5898.734556944862;5901.645901245939;5904.61619994699 21:28:28 INFO - 2015-11-23 21:28:28,003 DEBUG : BROWSER_OUTPUT: |5;yui.html;576.809652814571;599.541350866587;674.6458109492515;678.2098854834118;726.8291951391425;10586.52360643771;10767.084797792197;10786.244962852603;10799.622013229538;10805.243632945698;10574.259801813876;10718.678439646803;10726.088282495997;10728.839067413996;11019.173561982843;731.3454458259854;732.1653315220652;755.056179775281;755.3390783064818;755.8903958925953;745.5824738146628;745.9589722565257;755.3994574313434;756.5838788666239;758.3591864874201;783.8628240057996;784.1061190243128;785.0579304834193;785.2226295967008;788.7436583110483;778.2489897249125;778.353966208046;778.9298963093293;779.719301051621;781.3241546062643;573.1545969694708;575.0913556580592;575.3412342867435;579.2701196492408;580.5326711996883;11159.497822597921;11229.71925701864;11285.661430157108;11292.661220163409;11303.378314192716;10217.744556386075;10847.294925829796;10905.127589792797;10917.290376125526;10952.466654668353;8924.464532128028;9094.181523662835;9142.497162656051;9251.259899208047;9420;3201.15169480088;3238.3847069057038;3244.4971029490466;3293.3907227162813;3326.251593391492;42930.356044659355;43281.13437731228;43418.34872476915;43538.346924796155;43636.94541382104;8399.748007559783;8492.830143397097;8547;8593.355498337649;8599.527026013504;15372.692546149014;15376.077435353915;15397.153156576496;15407.075575465507;15417.922910385376;6036.969815150984;6075.756969721162;6115.785947491817;6177.289611694623;6177.505799536027;3432.2792213635416;3523.2601153757996;3574.821258937043;3595.6224596417524;3617.5116359291687;2768.68160161584;2831.221414111136;2836.503611867915;2844.9857750711526;2856.757175640094;497.91286524858003;503.9974800125976;504.57867680487203;505.31277462650763;510.88249702567873;447.29327662293497;450.5854613755353;454.8771831605448;468.34197951877667;567.8608740858433;6258.374162583706;6398.136251606066;6534.411902928759;6535.215774107042;6535.477161827138;431.90282186508415;441.55182489772903;525.8133362656279;538.7656369479289;547.258464780225;3130.248740302311;3176.491761318178;3230.7415406767404;3235.6440791512914;3243.8378081095852;48973;49161;49429.50570494321;49651.0069798602;49652.50347496551;43381.0478528467;44109;44221;44464;44861.551384485734;40594.391084133764;41261.381079283834;41393.1721365577;42257.57742422536;42318.57681423208;6406.455451286693;6475.222973243241;6542.476601871934;6681.599104053772;6697.698603562754;28983.85508072446;29049.7095029047;29311.560326595543;29627.40745185127;31374.843125785137;39020.804895975336;39098.609013909496;39464.60535394724;40061.19877602373;40417.1916561673;8869.556522173736;9016.639334426549;9268.258539316703;9411.058894110534;9411.294152938694;9734.805303894023;9759.756006099904;9850.60597576089;9973;10108.696739097839;8679.696210632597;8706.47761134334;8734.82530349402;8836.690715824916;8995.325350598601;8903.688370906988;8988.595513202052;8994.325425592975;9039.59321830506;9305.162535371848;7950.165232650488;8478.703245386381;8660.48037117775;8781.660564827276;8863.423877447945;8090.676372945016;8123.147069557612;8342.79143021405;8418.158184181533;8554.333603028537;7042.471814613822;7168.749093781693;7409.646614566437;7556.697732090654;7777.844443110993 21:28:28 INFO - 2015-11-23 21:28:28,003 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:28:28 INFO - 2015-11-23 21:28:28,003 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:28:28 INFO - 2015-11-23 21:28:28,003 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,333 21:28:28 INFO - 2015-11-23 21:28:28,003 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:28:28 INFO - 2015-11-23 21:28:28,003 DEBUG : BROWSER_OUTPUT: __startTimestamp1448342907992__endTimestamp 21:28:28 INFO - 2015-11-23 21:28:28,003 DEBUG : BROWSER_OUTPUT: 21:28:28 INFO - 2015-11-23 21:28:28,003 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:28:28 INFO - 2015-11-23 21:28:28,003 DEBUG : BROWSER_OUTPUT: Number of tests: 6 21:28:28 INFO - 2015-11-23 21:28:28,004 DEBUG : BROWSER_OUTPUT: 21:28:28 INFO - 2015-11-23 21:28:28,004 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4608.97 Median:4696.77 stddev:478.07 (10.2%) stddev-sans-first:454.14 21:28:28 INFO - 2015-11-23 21:28:28,004 DEBUG : BROWSER_OUTPUT: Values: 2648.9 2654.6 2690.7 2700.1 2726.1 4461.6 4595.4 4611.0 4634.9 4658.9 4547.3 4603.9 4606.5 4678.8 4691.5 4241.4 4313.3 4327.3 4440.6 4454.9 4368.8 4420.2 4423.1 4428.6 4463.7 4168.4 4244.7 4278.9 4353.8 4364.2 4337.9 4342.1 4353.3 4361.2 4385.2 4177.6 4334.5 4338.6 4343.0 4395.8 4510.6 4565.1 4587.2 4602.9 4617.6 5015.5 5102.4 5104.8 5105.1 5157.8 4901.2 5109.0 5117.7 5121.6 5170.1 4560.0 4575.5 4631.7 4641.7 4673.7 5156.1 5166.0 5166.5 5172.0 5188.4 4791.0 4878.0 4973.4 4977.0 5028.9 4928.9 4971.1 4975.8 5032.7 5185.7 4948.4 4961.8 4973.5 4980.4 5016.1 4917.0 4943.3 4944.1 4951.4 5000.2 4047.7 4078.7 4134.9 4137.6 4141.4 3608.9 3631.7 3641.3 3646.7 3651.7 4301.4 4326.1 4356.6 4357.9 4398.0 4843.2 4931.0 4941.2 5009.4 5029.1 4337.8 4348.8 4368.7 4371.8 4390.7 4399.4 4431.5 4434.2 4472.3 4495.2 4576.7 4628.8 4664.3 4674.5 4726.6 4985.9 5019.1 5029.2 5068.4 5110.2 4706.7 4727.6 4746.5 4762.9 4807.8 4724.5 4842.3 4849.6 4891.0 4921.0 4961.3 4970.2 5002.6 5005.5 5030.4 4722.2 4828.0 4866.5 4866.8 4900.5 4607.1 4719.2 4736.7 4775.4 4777.0 4690.1 4690.2 4738.1 4765.3 4820.9 4696.8 4787.6 4855.0 4875.9 4883.7 4711.5 4778.0 4780.8 4799.2 4838.8 21:28:28 INFO - 2015-11-23 21:28:28,004 DEBUG : BROWSER_OUTPUT: 21:28:28 INFO - 2015-11-23 21:28:28,005 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41120.46 Median:33767.00 stddev:70347.18 (208.3%) stddev-sans-first:70478.55 21:28:28 INFO - 2015-11-23 21:28:28,005 DEBUG : BROWSER_OUTPUT: Values: 544.7 569.8 579.4 584.2 590.5 32434.5 33120.2 33165.7 33166.3 33380.0 37250.3 38545.6 38569.2 38592.4 38677.2 7708.5 7860.3 7869.1 7906.1 7917.4 7671.5 7692.0 7705.7 7745.2 7760.3 7963.7 7984.6 7990.9 8050.6 8052.1 7600.4 7750.7 7775.3 7794.0 7803.5 7857.1 7909.1 7989.6 7994.8 7994.9 36239.6 36344.5 36412.6 36525.3 36604.1 2504.2 2608.9 2657.3 2776.9 3326.7 27109.0 27211.7 27382.6 27490.7 27618.0 3345.1 3362.8 3393.8 3414.2 3439.7 217884.0 218718.0 220351.0 220442.0 220742.0 36994.3 37679.4 51781.7 51925.0 52061.7 36257.8 36316.6 36366.1 36462.6 36536.5 13037.9 13211.7 13268.5 13274.4 13279.9 10345.4 10369.6 10428.0 10436.0 10462.0 12590.0 12879.8 13059.5 13075.4 13101.6 5306.3 5404.8 5415.2 5501.3 5501.9 786.8 799.5 866.4 871.6 988.8 24728.4 25042.0 25359.7 25400.4 25544.5 913.2 971.5 1011.8 1015.5 1040.0 13146.1 13162.2 13296.7 13334.7 13377.1 326122.3 329864.0 330050.0 330064.0 331210.0 45467.3 46115.8 46155.3 46158.3 46272.1 1193.8 1199.6 1201.3 1203.9 1204.4 24950.4 25411.7 25485.2 25550.0 25789.6 37010.0 37099.6 37469.0 37480.4 37553.0 242658.0 243249.0 243979.0 244284.0 245627.0 28791.4 29308.4 40626.0 41445.0 41941.2 38800.0 39033.2 39252.0 39300.2 39660.4 32707.0 33383.3 33727.0 33807.0 34279.7 33469.3 34139.8 34162.3 34332.7 34497.0 33054.7 33090.0 33271.5 33559.8 33577.8 28727.4 30236.8 30668.7 30701.8 30815.5 24318.6 24391.4 24408.9 24489.6 24619.9 21:28:28 INFO - 2015-11-23 21:28:28,005 DEBUG : BROWSER_OUTPUT: 21:28:28 INFO - 2015-11-23 21:28:28,006 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24732.45 Median:4213.64 stddev:73213.15 (1737.5%) stddev-sans-first:73395.58 21:28:28 INFO - 2015-11-23 21:28:28,006 DEBUG : BROWSER_OUTPUT: Values: 317.9 331.0 331.3 333.1 336.9 14553.4 15105.8 15513.9 15991.8 16188.6 9602.1 9808.5 12660.9 15198.0 15198.9 4515.4 4684.8 4704.3 4794.6 5021.7 4994.4 5021.8 5026.6 5036.3 5057.4 4803.1 4955.9 4957.7 4973.3 5014.7 4864.1 4943.3 4945.4 4946.0 4982.6 4908.0 4910.8 4919.4 4953.5 4955.2 11828.5 11839.2 11872.8 16172.4 18052.0 1706.5 1713.2 1747.1 1789.9 1829.9 8907.6 9168.4 9389.3 10824.6 12822.6 1635.6 1679.4 1705.1 1735.9 1755.6 51064.0 53151.2 53518.6 53614.7 54462.5 9238.4 9374.1 9688.5 9942.5 10000.0 12375.9 12468.3 12476.0 12521.4 12523.9 7150.1 7159.5 7162.9 7324.1 7345.8 6874.1 6887.7 6893.0 7023.2 7030.6 4129.5 4205.6 4211.9 4215.3 4248.3 1702.2 1752.2 1766.5 1774.2 1783.5 741.6 788.9 804.4 823.4 913.0 15361.4 15404.8 15611.8 16093.5 16154.4 800.4 803.7 814.5 822.1 859.3 8730.1 8774.9 8925.7 8954.0 9102.8 446288.0 447003.0 447104.0 450004.0 452873.0 63745.7 66517.7 66652.3 66925.3 67057.3 1013.9 1014.8 1016.6 1021.5 1023.3 13787.8 13904.9 14090.0 14115.9 14131.7 29155.9 29690.6 29738.3 29746.9 30251.2 38588.4 39118.8 39411.4 42400.6 42689.8 8454.7 8533.3 8605.0 8644.7 8799.5 15528.2 15647.8 15653.4 15830.5 16171.9 13378.9 13479.3 13552.0 13606.3 13685.0 12361.0 13577.9 13648.5 13681.5 13897.9 13793.7 13876.0 14142.9 14197.8 14257.7 8777.0 8975.8 9025.8 9063.4 9088.6 13516.2 13630.6 13922.7 13925.3 13945.1 21:28:28 INFO - 2015-11-23 21:28:28,006 DEBUG : BROWSER_OUTPUT: 21:28:28 INFO - 2015-11-23 21:28:28,006 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4744.62 Median:5937.42 stddev:2413.88 (40.7%) stddev-sans-first:2408.25 21:28:28 INFO - 2015-11-23 21:28:28,007 DEBUG : BROWSER_OUTPUT: Values: 1488.6 1566.7 1627.3 1631.6 1639.1 6470.5 6608.7 6703.6 6794.2 6837.0 6460.6 6490.6 6562.5 6565.4 6571.5 1906.3 1926.1 1926.9 1928.6 1936.6 2074.2 2094.4 2095.8 2128.2 2128.2 1941.4 1978.5 1992.4 2020.4 2049.4 1997.0 2077.3 2080.1 2085.0 2086.0 2081.9 2126.9 2127.6 2127.8 2135.5 6879.7 6886.4 6937.7 6963.1 6966.9 3981.4 4051.6 4052.4 4062.9 4068.8 2730.2 2734.3 2737.7 2770.8 2773.6 840.5 886.6 908.3 913.1 917.9 8966.3 8982.9 9009.4 9021.8 9022.0 3808.9 3879.9 3920.1 3926.0 3947.3 7961.9 7969.2 7988.5 8003.6 8035.5 4194.4 4198.9 4239.0 4247.7 4277.0 3826.8 3829.6 3854.2 3862.7 3866.0 3245.1 3305.3 3317.0 3325.5 3342.7 1007.1 1028.9 1029.7 1035.1 1050.4 777.4 835.4 836.1 887.0 1053.9 6041.8 6090.2 6105.7 6109.3 6123.3 556.0 572.5 576.1 576.4 712.2 4947.9 4961.2 4973.0 4980.3 4997.4 7818.0 7822.7 8109.4 8133.3 8139.6 7985.2 8000.8 8013.4 8054.9 8103.6 6397.3 6410.7 6435.6 6438.0 6518.8 6460.6 6511.3 6517.6 6525.5 6559.7 7081.4 7128.2 7305.7 7321.6 7323.2 6775.9 6922.6 6940.2 7412.8 7419.5 5887.1 5920.9 5946.3 5957.5 5966.8 6363.9 6383.3 6411.7 6490.1 6493.4 6141.5 6184.0 6253.0 6266.2 6316.1 5759.5 5922.0 5937.6 6005.4 6157.1 5899.9 5937.3 5940.3 5947.0 5970.3 5643.5 5661.9 5683.5 5688.2 5693.0 5806.7 5855.3 5858.7 5860.9 5861.3 21:28:28 INFO - 2015-11-23 21:28:28,007 DEBUG : BROWSER_OUTPUT: 21:28:28 INFO - 2015-11-23 21:28:28,007 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4914.20 Median:5500.59 stddev:1457.04 (26.5%) stddev-sans-first:1419.31 21:28:28 INFO - 2015-11-23 21:28:28,007 DEBUG : BROWSER_OUTPUT: Values: 296.3 297.0 304.4 309.5 321.3 5541.6 5594.7 5634.4 5680.1 5685.2 5398.7 5536.8 5578.5 5614.3 5619.4 4370.9 4378.4 4378.5 4394.3 4396.5 4387.0 4387.7 4389.6 4403.8 4410.9 4288.1 4356.6 4360.9 4369.9 4376.9 4353.1 4354.1 4356.4 4363.3 4372.2 3829.6 3830.0 3838.7 3842.9 3856.1 5409.7 5439.5 5441.4 5450.7 5464.3 4774.9 4900.5 5042.2 5047.3 5049.8 5715.1 5854.6 5874.7 5883.1 5886.3 4024.8 4033.2 4036.5 4042.4 4045.1 6180.6 6222.6 6227.7 6244.1 6254.7 4066.3 4155.2 4210.6 4217.1 4221.3 4282.7 4284.8 4285.6 4290.0 4295.8 4937.0 4938.3 4941.7 4947.1 4954.5 5915.8 5931.9 5946.0 5948.1 5953.3 1476.8 1503.1 1514.0 1519.9 1529.2 1004.3 1008.5 1015.7 1025.6 1026.6 5107.9 5119.6 5133.1 5133.2 5145.2 6071.9 6109.3 6130.4 6135.5 6137.9 5116.0 5122.2 5132.1 5133.2 5137.6 3254.4 3297.8 3326.5 3330.1 3334.2 5725.6 5751.0 5774.3 5778.6 5784.0 6290.6 6290.8 6301.7 6311.8 6316.2 5591.1 5611.4 5707.4 5715.8 5750.1 6196.6 6214.0 6226.8 6246.1 6246.6 6073.5 6074.8 6081.7 6086.1 6087.0 5700.2 5852.4 5861.9 5877.9 5911.6 4130.5 4154.4 4156.2 4158.0 4159.8 6232.0 6258.6 6262.7 6263.3 6271.7 5964.2 5975.1 5984.6 5988.6 6005.5 5782.6 5987.5 6013.3 6013.3 6032.6 5823.4 5867.2 5872.6 5908.7 5909.0 6028.2 6042.3 6070.1 6070.2 6075.5 5695.6 5895.9 5898.7 5901.6 5904.6 21:28:28 INFO - 2015-11-23 21:28:28,008 DEBUG : BROWSER_OUTPUT: 21:28:28 INFO - 2015-11-23 21:28:28,008 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11758.40 Median:570.51 stddev:14030.32 (2459.3%) stddev-sans-first:14044.55 21:28:28 INFO - 2015-11-23 21:28:28,008 DEBUG : BROWSER_OUTPUT: Values: 576.8 599.5 674.6 678.2 726.8 10586.5 10767.1 10786.2 10799.6 10805.2 10574.3 10718.7 10726.1 10728.8 11019.2 731.3 732.2 755.1 755.3 755.9 745.6 746.0 755.4 756.6 758.4 783.9 784.1 785.1 785.2 788.7 778.2 778.4 778.9 779.7 781.3 573.2 575.1 575.3 579.3 580.5 11159.5 11229.7 11285.7 11292.7 11303.4 10217.7 10847.3 10905.1 10917.3 10952.5 8924.5 9094.2 9142.5 9251.3 9420.0 3201.2 3238.4 3244.5 3293.4 3326.3 42930.4 43281.1 43418.3 43538.3 43636.9 8399.7 8492.8 8547.0 8593.4 8599.5 15372.7 15376.1 15397.2 15407.1 15417.9 6037.0 6075.8 6115.8 6177.3 6177.5 3432.3 3523.3 3574.8 3595.6 3617.5 2768.7 2831.2 2836.5 2845.0 2856.8 497.9 504.0 504.6 505.3 510.9 447.3 450.6 454.9 468.3 567.9 6258.4 6398.1 6534.4 6535.2 6535.5 431.9 441.6 525.8 538.8 547.3 3130.2 3176.5 3230.7 3235.6 3243.8 48973.0 49161.0 49429.5 49651.0 49652.5 43381.0 44109.0 44221.0 44464.0 44861.6 40594.4 41261.4 41393.2 42257.6 42318.6 6406.5 6475.2 6542.5 6681.6 6697.7 28983.9 29049.7 29311.6 29627.4 31374.8 39020.8 39098.6 39464.6 40061.2 40417.2 8869.6 9016.6 9268.3 9411.1 9411.3 9734.8 9759.8 9850.6 9973.0 10108.7 8679.7 8706.5 8734.8 8836.7 8995.3 8903.7 8988.6 8994.3 9039.6 9305.2 7950.2 8478.7 8660.5 8781.7 8863.4 8090.7 8123.1 8342.8 8418.2 8554.3 7042.5 7168.7 7409.6 7556.7 7777.8 21:28:28 INFO - 2015-11-23 21:28:28,008 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:28:28 INFO - 2015-11-23 21:28:28,008 DEBUG : BROWSER_OUTPUT: 21:28:28 INFO - 2015-11-23 21:28:28,817 INFO : Browser exited with error code: 0 21:28:28 INFO - 2015-11-23 21:28:28,836 INFO : Completed test dromaeo_css (00:18:36) 21:28:28 INFO - 2015-11-23 21:28:28,836 INFO : Starting test kraken 21:28:28 INFO - 2015-11-23 21:28:28,836 DEBUG : operating with platform_type : linux_ 21:28:28 INFO - 2015-11-23 21:28:28,836 INFO : Initialising browser for kraken test... 21:28:28 INFO - 2015-11-23 21:28:28,842 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNtdA41/profile http://localhost:48689/getInfo.html 21:28:34 INFO - 2015-11-23 21:28:34,701 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:28:34 INFO - 2015-11-23 21:28:34,701 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:28:34 INFO - 2015-11-23 21:28:34,701 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:28:34 INFO - 2015-11-23 21:28:34,701 DEBUG : BROWSER_OUTPUT: __metrics 21:28:35 INFO - 2015-11-23 21:28:35,941 INFO : Browser initialized. 21:28:35 INFO - 2015-11-23 21:28:35,942 INFO : Running cycle 1/1 for kraken test... 21:28:35 INFO - 2015-11-23 21:28:35,942 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNtdA41/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:28:47 INFO - 2015-11-23 21:28:47,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 139452416 21:28:47 INFO - 2015-11-23 21:28:47,940 DEBUG : BROWSER_OUTPUT: 21:28:50 INFO - 2015-11-23 21:28:50,535 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48689/tests/kraken/driver.html?testName=audio-beat-detection) 21:28:51 INFO - 2015-11-23 21:28:51,150 DEBUG : BROWSER_OUTPUT: RSS: Main: 141709312 21:28:51 INFO - 2015-11-23 21:28:51,150 DEBUG : BROWSER_OUTPUT: 21:28:53 INFO - 2015-11-23 21:28:53,893 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48689/tests/kraken/driver.html?testName=audio-dft) 21:28:54 INFO - 2015-11-23 21:28:54,502 DEBUG : BROWSER_OUTPUT: RSS: Main: 141049856 21:28:54 INFO - 2015-11-23 21:28:54,503 DEBUG : BROWSER_OUTPUT: 21:28:57 INFO - 2015-11-23 21:28:57,421 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48689/tests/kraken/driver.html?testName=audio-fft) 21:28:58 INFO - 2015-11-23 21:28:58,003 DEBUG : BROWSER_OUTPUT: RSS: Main: 137732096 21:28:58 INFO - 2015-11-23 21:28:58,004 DEBUG : BROWSER_OUTPUT: 21:29:00 INFO - 2015-11-23 21:29:00,109 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48689/tests/kraken/driver.html?testName=audio-oscillator) 21:29:00 INFO - 2015-11-23 21:29:00,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 137318400 21:29:00 INFO - 2015-11-23 21:29:00,692 DEBUG : BROWSER_OUTPUT: 21:29:02 INFO - 2015-11-23 21:29:02,928 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48689/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:29:03 INFO - 2015-11-23 21:29:03,509 DEBUG : BROWSER_OUTPUT: RSS: Main: 139079680 21:29:03 INFO - 2015-11-23 21:29:03,509 DEBUG : BROWSER_OUTPUT: 21:29:06 INFO - 2015-11-23 21:29:06,589 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48689/tests/kraken/driver.html?testName=imaging-darkroom) 21:29:07 INFO - 2015-11-23 21:29:07,178 DEBUG : BROWSER_OUTPUT: RSS: Main: 139673600 21:29:07 INFO - 2015-11-23 21:29:07,179 DEBUG : BROWSER_OUTPUT: 21:29:10 INFO - 2015-11-23 21:29:10,733 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48689/tests/kraken/driver.html?testName=imaging-desaturate) 21:29:11 INFO - 2015-11-23 21:29:11,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 136597504 21:29:11 INFO - 2015-11-23 21:29:11,327 DEBUG : BROWSER_OUTPUT: 21:29:14 INFO - 2015-11-23 21:29:14,206 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48689/tests/kraken/driver.html?testName=json-parse-financial) 21:29:14 INFO - 2015-11-23 21:29:14,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 137248768 21:29:14 INFO - 2015-11-23 21:29:14,795 DEBUG : BROWSER_OUTPUT: 21:29:16 INFO - 2015-11-23 21:29:16,590 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48689/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:29:17 INFO - 2015-11-23 21:29:17,179 DEBUG : BROWSER_OUTPUT: RSS: Main: 139976704 21:29:17 INFO - 2015-11-23 21:29:17,179 DEBUG : BROWSER_OUTPUT: 21:29:19 INFO - 2015-11-23 21:29:19,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48689/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:29:19 INFO - 2015-11-23 21:29:19,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 138653696 21:29:19 INFO - 2015-11-23 21:29:19,721 DEBUG : BROWSER_OUTPUT: 21:29:21 INFO - 2015-11-23 21:29:21,874 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48689/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:29:22 INFO - 2015-11-23 21:29:22,467 DEBUG : BROWSER_OUTPUT: RSS: Main: 138588160 21:29:22 INFO - 2015-11-23 21:29:22,468 DEBUG : BROWSER_OUTPUT: 21:29:25 INFO - 2015-11-23 21:29:25,069 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:29:25 INFO - 2015-11-23 21:29:25,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 140210176 21:29:25 INFO - 2015-11-23 21:29:25,672 DEBUG : BROWSER_OUTPUT: 21:29:28 INFO - 2015-11-23 21:29:28,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:29:28 INFO - 2015-11-23 21:29:28,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 138752000 21:29:28 INFO - 2015-11-23 21:29:28,881 DEBUG : BROWSER_OUTPUT: 21:29:30 INFO - 2015-11-23 21:29:30,643 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48689/tests/kraken/driver.html?testName=ai-astar) 21:29:30 INFO - 2015-11-23 21:29:30,901 DEBUG : BROWSER_OUTPUT: RSS: Main: 140451840 21:29:30 INFO - 2015-11-23 21:29:30,901 DEBUG : BROWSER_OUTPUT: 21:29:30 INFO - 2015-11-23 21:29:30,901 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:29:30 INFO - 2015-11-23 21:29:30,901 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:29:30 INFO - 2015-11-23 21:29:30,902 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:29:30 INFO - 2015-11-23 21:29:30,902 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:29:30 INFO - 2015-11-23 21:29:30,902 DEBUG : BROWSER_OUTPUT: |0;ai-astar;116;109;116;115;114;126;116;113;115;113 21:29:30 INFO - 2015-11-23 21:29:30,902 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;131;163;175;132;160;160;134;175;138 21:29:30 INFO - 2015-11-23 21:29:30,902 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;161;162;161;164;163;178;160;163;163 21:29:30 INFO - 2015-11-23 21:29:30,902 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;75;73;150;73;78;72;72;149 21:29:30 INFO - 2015-11-23 21:29:30,903 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;131;94;95;93;129;94;94;129 21:29:30 INFO - 2015-11-23 21:29:30,903 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;111;110;110;111;111;110;110;110 21:29:30 INFO - 2015-11-23 21:29:30,903 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;147;148;148;149;148;147;147;147 21:29:30 INFO - 2015-11-23 21:29:30,903 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;97;95;95;99;96;95 21:29:30 INFO - 2015-11-23 21:29:30,903 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;75;74;75;74;74;74;74;74;72 21:29:30 INFO - 2015-11-23 21:29:30,903 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;68;71;69;68;68;68;68;68 21:29:30 INFO - 2015-11-23 21:29:30,904 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;84;83;84;83;83;83;85;84;85 21:29:30 INFO - 2015-11-23 21:29:30,904 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;146;131;123;129;131;127;125;134;131 21:29:30 INFO - 2015-11-23 21:29:30,904 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;150;148;149;148;152;149;152;149;148;138 21:29:30 INFO - 2015-11-23 21:29:30,904 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;68;72;72;70;69;71;70;68;69 21:29:30 INFO - 2015-11-23 21:29:30,904 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:29:30 INFO - 2015-11-23 21:29:30,905 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:29:30 INFO - 2015-11-23 21:29:30,905 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,782 21:29:30 INFO - 2015-11-23 21:29:30,905 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:29:30 INFO - 2015-11-23 21:29:30,905 DEBUG : BROWSER_OUTPUT: __startTimestamp1448342970896__endTimestamp 21:29:30 INFO - 2015-11-23 21:29:30,905 DEBUG : BROWSER_OUTPUT: 21:29:30 INFO - 2015-11-23 21:29:30,908 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:29:30 INFO - 2015-11-23 21:29:30,908 DEBUG : BROWSER_OUTPUT: Number of tests: 14 21:29:30 INFO - 2015-11-23 21:29:30,908 DEBUG : BROWSER_OUTPUT: 21:29:30 INFO - 2015-11-23 21:29:30,909 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.30 Median:115.50 stddev:4.32 (3.7%) stddev-sans-first:4.58 21:29:30 INFO - 2015-11-23 21:29:30,909 DEBUG : BROWSER_OUTPUT: Values: 116.0 109.0 116.0 115.0 114.0 126.0 116.0 113.0 115.0 113.0 21:29:30 INFO - 2015-11-23 21:29:30,909 DEBUG : BROWSER_OUTPUT: 21:29:30 INFO - 2015-11-23 21:29:30,909 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:152.10 Median:160.00 stddev:17.22 (10.8%) stddev-sans-first:18.26 21:29:30 INFO - 2015-11-23 21:29:30,909 DEBUG : BROWSER_OUTPUT: Values: 153.0 131.0 163.0 175.0 132.0 160.0 160.0 134.0 175.0 138.0 21:29:30 INFO - 2015-11-23 21:29:30,909 DEBUG : BROWSER_OUTPUT: 21:29:30 INFO - 2015-11-23 21:29:30,909 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:5.14 (3.2%) stddev-sans-first:5.44 21:29:30 INFO - 2015-11-23 21:29:30,909 DEBUG : BROWSER_OUTPUT: Values: 163.0 161.0 162.0 161.0 164.0 163.0 178.0 160.0 163.0 163.0 21:29:30 INFO - 2015-11-23 21:29:30,909 DEBUG : BROWSER_OUTPUT: 21:29:30 INFO - 2015-11-23 21:29:30,909 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.90 Median:73.00 stddev:31.99 (43.8%) stddev-sans-first:33.41 21:29:30 INFO - 2015-11-23 21:29:30,910 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 75.0 73.0 150.0 73.0 78.0 72.0 72.0 149.0 21:29:30 INFO - 2015-11-23 21:29:30,910 DEBUG : BROWSER_OUTPUT: 21:29:30 INFO - 2015-11-23 21:29:30,910 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.80 Median:94.00 stddev:17.18 (18.3%) stddev-sans-first:17.85 21:29:30 INFO - 2015-11-23 21:29:30,910 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 131.0 94.0 95.0 93.0 129.0 94.0 94.0 129.0 21:29:30 INFO - 2015-11-23 21:29:30,910 DEBUG : BROWSER_OUTPUT: 21:29:30 INFO - 2015-11-23 21:29:30,911 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 21:29:30 INFO - 2015-11-23 21:29:30,911 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 111.0 110.0 110.0 111.0 111.0 110.0 110.0 110.0 21:29:30 INFO - 2015-11-23 21:29:30,911 DEBUG : BROWSER_OUTPUT: 21:29:30 INFO - 2015-11-23 21:29:30,911 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 21:29:30 INFO - 2015-11-23 21:29:30,911 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 147.0 148.0 148.0 149.0 148.0 147.0 147.0 147.0 21:29:30 INFO - 2015-11-23 21:29:30,911 DEBUG : BROWSER_OUTPUT: 21:29:30 INFO - 2015-11-23 21:29:30,912 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:1.25 (1.3%) stddev-sans-first:1.32 21:29:30 INFO - 2015-11-23 21:29:30,912 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 97.0 95.0 95.0 99.0 96.0 95.0 21:29:30 INFO - 2015-11-23 21:29:30,912 DEBUG : BROWSER_OUTPUT: 21:29:30 INFO - 2015-11-23 21:29:30,912 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.00 Median:74.00 stddev:0.82 (1.1%) stddev-sans-first:0.87 21:29:30 INFO - 2015-11-23 21:29:30,912 DEBUG : BROWSER_OUTPUT: Values: 74.0 75.0 74.0 75.0 74.0 74.0 74.0 74.0 74.0 72.0 21:29:30 INFO - 2015-11-23 21:29:30,913 DEBUG : BROWSER_OUTPUT: 21:29:30 INFO - 2015-11-23 21:29:30,913 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:68.50 stddev:0.97 (1.4%) stddev-sans-first:1.01 21:29:30 INFO - 2015-11-23 21:29:30,913 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 71.0 69.0 68.0 68.0 68.0 68.0 68.0 21:29:30 INFO - 2015-11-23 21:29:30,913 DEBUG : BROWSER_OUTPUT: 21:29:30 INFO - 2015-11-23 21:29:30,913 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:84.00 stddev:1.18 (1.4%) stddev-sans-first:0.83 21:29:30 INFO - 2015-11-23 21:29:30,913 DEBUG : BROWSER_OUTPUT: Values: 81.0 84.0 83.0 84.0 83.0 83.0 83.0 85.0 84.0 85.0 21:29:30 INFO - 2015-11-23 21:29:30,913 DEBUG : BROWSER_OUTPUT: 21:29:30 INFO - 2015-11-23 21:29:30,913 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:130.70 Median:131.00 stddev:6.27 (4.8%) stddev-sans-first:6.65 21:29:30 INFO - 2015-11-23 21:29:30,913 DEBUG : BROWSER_OUTPUT: Values: 130.0 146.0 131.0 123.0 129.0 131.0 127.0 125.0 134.0 131.0 21:29:30 INFO - 2015-11-23 21:29:30,913 DEBUG : BROWSER_OUTPUT: 21:29:30 INFO - 2015-11-23 21:29:30,914 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.30 Median:149.00 stddev:3.92 (2.6%) stddev-sans-first:4.11 21:29:30 INFO - 2015-11-23 21:29:30,914 DEBUG : BROWSER_OUTPUT: Values: 150.0 148.0 149.0 148.0 152.0 149.0 152.0 149.0 148.0 138.0 21:29:30 INFO - 2015-11-23 21:29:30,914 DEBUG : BROWSER_OUTPUT: 21:29:30 INFO - 2015-11-23 21:29:30,914 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:1.48 (2.1%) stddev-sans-first:1.54 21:29:30 INFO - 2015-11-23 21:29:30,914 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 72.0 72.0 70.0 69.0 71.0 70.0 68.0 69.0 21:29:30 INFO - 2015-11-23 21:29:30,914 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:29:30 INFO - 2015-11-23 21:29:30,914 DEBUG : BROWSER_OUTPUT: 21:29:31 INFO - 2015-11-23 21:29:31,943 INFO : Browser exited with error code: 0 21:29:31 INFO - 2015-11-23 21:29:31,990 INFO : Completed test kraken (00:01:03) 21:29:31 INFO - 2015-11-23 21:29:31,991 INFO : Starting test v8_7 21:29:31 INFO - 2015-11-23 21:29:31,991 DEBUG : operating with platform_type : linux_ 21:29:31 INFO - 2015-11-23 21:29:31,991 INFO : Initialising browser for v8_7 test... 21:29:31 INFO - 2015-11-23 21:29:31,997 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp62BheA/profile http://localhost:48689/getInfo.html 21:29:38 INFO - 2015-11-23 21:29:38,091 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:29:38 INFO - 2015-11-23 21:29:38,091 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:29:38 INFO - 2015-11-23 21:29:38,092 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:29:38 INFO - 2015-11-23 21:29:38,092 DEBUG : BROWSER_OUTPUT: __metrics 21:29:39 INFO - 2015-11-23 21:29:39,657 INFO : Browser initialized. 21:29:39 INFO - 2015-11-23 21:29:39,658 INFO : Running cycle 1/1 for v8_7 test... 21:29:39 INFO - 2015-11-23 21:29:39,658 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp62BheA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:29:51 INFO - 2015-11-23 21:29:51,585 DEBUG : BROWSER_OUTPUT: RSS: Main: 141615104 21:29:51 INFO - 2015-11-23 21:29:51,586 DEBUG : BROWSER_OUTPUT: 21:30:13 INFO - 2015-11-23 21:30:13,119 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48689/tests/v8_7/run.html (next: http://localhost:48689/tests/v8_7/run.html) 21:30:13 INFO - 2015-11-23 21:30:13,365 DEBUG : BROWSER_OUTPUT: RSS: Main: 138629120 21:30:13 INFO - 2015-11-23 21:30:13,365 DEBUG : BROWSER_OUTPUT: 21:30:13 INFO - 2015-11-23 21:30:13,367 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:30:13 INFO - 2015-11-23 21:30:13,367 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:30:13 INFO - 2015-11-23 21:30:13,367 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:30:13 INFO - 2015-11-23 21:30:13,367 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:30:13 INFO - 2015-11-23 21:30:13,367 DEBUG : BROWSER_OUTPUT: |0;Richards;187.68768768768768 21:30:13 INFO - 2015-11-23 21:30:13,367 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.87360594795538 21:30:13 INFO - 2015-11-23 21:30:13,368 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.2516056967328 21:30:13 INFO - 2015-11-23 21:30:13,368 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5020 21:30:13 INFO - 2015-11-23 21:30:13,368 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1044.932079414838 21:30:13 INFO - 2015-11-23 21:30:13,368 DEBUG : BROWSER_OUTPUT: |5;Earley;701.2622720897616 21:30:13 INFO - 2015-11-23 21:30:13,368 DEBUG : BROWSER_OUTPUT: |6;Boyer;12345.67901234568 21:30:13 INFO - 2015-11-23 21:30:13,369 DEBUG : BROWSER_OUTPUT: |7;RegExp;25500 21:30:13 INFO - 2015-11-23 21:30:13,369 DEBUG : BROWSER_OUTPUT: |8;Splay;786.7820613690008 21:30:13 INFO - 2015-11-23 21:30:13,369 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 21:30:13 INFO - 2015-11-23 21:30:13,369 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:30:13 INFO - 2015-11-23 21:30:13,369 DEBUG : BROWSER_OUTPUT: __startTimestamp1448343013366__endTimestamp 21:30:13 INFO - 2015-11-23 21:30:13,370 DEBUG : BROWSER_OUTPUT: 21:30:13 INFO - 2015-11-23 21:30:13,370 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:30:13 INFO - 2015-11-23 21:30:13,370 DEBUG : BROWSER_OUTPUT: Number of tests: 10 21:30:13 INFO - 2015-11-23 21:30:13,370 DEBUG : BROWSER_OUTPUT: 21:30:13 INFO - 2015-11-23 21:30:13,370 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:187.69 Median:187.69 stddev:0.00 (0.0%) 21:30:13 INFO - 2015-11-23 21:30:13,370 DEBUG : BROWSER_OUTPUT: Values: 187.7 21:30:13 INFO - 2015-11-23 21:30:13,371 DEBUG : BROWSER_OUTPUT: 21:30:13 INFO - 2015-11-23 21:30:13,371 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.87 Median:185.87 stddev:0.00 (0.0%) 21:30:13 INFO - 2015-11-23 21:30:13,371 DEBUG : BROWSER_OUTPUT: Values: 185.9 21:30:13 INFO - 2015-11-23 21:30:13,371 DEBUG : BROWSER_OUTPUT: 21:30:13 INFO - 2015-11-23 21:30:13,371 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 21:30:13 INFO - 2015-11-23 21:30:13,371 DEBUG : BROWSER_OUTPUT: Values: 279.3 21:30:13 INFO - 2015-11-23 21:30:13,372 DEBUG : BROWSER_OUTPUT: 21:30:13 INFO - 2015-11-23 21:30:13,372 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5020.00 Median:5020.00 stddev:0.00 (0.0%) 21:30:13 INFO - 2015-11-23 21:30:13,373 DEBUG : BROWSER_OUTPUT: Values: 5020.0 21:30:13 INFO - 2015-11-23 21:30:13,373 DEBUG : BROWSER_OUTPUT: 21:30:13 INFO - 2015-11-23 21:30:13,373 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1044.93 Median:1044.93 stddev:0.00 (0.0%) 21:30:13 INFO - 2015-11-23 21:30:13,373 DEBUG : BROWSER_OUTPUT: Values: 1044.9 21:30:13 INFO - 2015-11-23 21:30:13,373 DEBUG : BROWSER_OUTPUT: 21:30:13 INFO - 2015-11-23 21:30:13,373 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:701.26 Median:701.26 stddev:0.00 (0.0%) 21:30:13 INFO - 2015-11-23 21:30:13,373 DEBUG : BROWSER_OUTPUT: Values: 701.3 21:30:13 INFO - 2015-11-23 21:30:13,373 DEBUG : BROWSER_OUTPUT: 21:30:13 INFO - 2015-11-23 21:30:13,374 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 21:30:13 INFO - 2015-11-23 21:30:13,374 DEBUG : BROWSER_OUTPUT: Values: 12345.7 21:30:13 INFO - 2015-11-23 21:30:13,374 DEBUG : BROWSER_OUTPUT: 21:30:13 INFO - 2015-11-23 21:30:13,374 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25500.00 Median:25500.00 stddev:0.00 (0.0%) 21:30:13 INFO - 2015-11-23 21:30:13,374 DEBUG : BROWSER_OUTPUT: Values: 25500.0 21:30:13 INFO - 2015-11-23 21:30:13,374 DEBUG : BROWSER_OUTPUT: 21:30:13 INFO - 2015-11-23 21:30:13,374 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:786.78 Median:786.78 stddev:0.00 (0.0%) 21:30:13 INFO - 2015-11-23 21:30:13,374 DEBUG : BROWSER_OUTPUT: Values: 786.8 21:30:13 INFO - 2015-11-23 21:30:13,374 DEBUG : BROWSER_OUTPUT: 21:30:13 INFO - 2015-11-23 21:30:13,374 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 21:30:13 INFO - 2015-11-23 21:30:13,374 DEBUG : BROWSER_OUTPUT: Values: 4830.9 21:30:13 INFO - 2015-11-23 21:30:13,374 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:30:13 INFO - 2015-11-23 21:30:13,374 DEBUG : BROWSER_OUTPUT: 21:30:14 INFO - 2015-11-23 21:30:14,510 INFO : Browser exited with error code: 0 21:30:14 INFO - 2015-11-23 21:30:14,526 INFO : Completed test v8_7 (00:00:42) 21:30:14 INFO - 2015-11-23 21:30:14,866 INFO : Completed test suite (00:20:22) 21:30:14 INFO - 2015-11-23 21:30:14,866 DEBUG : Working with test: dromaeo_css 21:30:14 INFO - 2015-11-23 21:30:14,866 DEBUG : Generating results file: dromaeo_css 21:30:14 INFO - 2015-11-23 21:30:14,867 DEBUG : Working with test: kraken 21:30:14 INFO - 2015-11-23 21:30:14,867 DEBUG : Generating results file: kraken 21:30:14 INFO - 2015-11-23 21:30:14,868 INFO : javascript benchmark 21:30:14 INFO - 2015-11-23 21:30:14,868 DEBUG : Working with test: v8_7 21:30:14 INFO - 2015-11-23 21:30:14,868 DEBUG : Generating results file: v8_7 21:30:14 INFO - 2015-11-23 21:30:14,868 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:30:14 INFO - 2015-11-23 21:30:14,914 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 21:30:14 INFO - 2015-11-23 21:30:14,914 DEBUG : process_Request line: dromaeo_css 6158.80 graph.html#tests=[[72,132,43]] 21:30:14 INFO - 2015-11-23 21:30:14,914 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:30:14 INFO - 2015-11-23 21:30:14,942 DEBUG : process_Request line: kraken 1553.60 graph.html#tests=[[232,132,43]] 21:30:14 INFO - 2015-11-23 21:30:14,943 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:30:15 INFO - 2015-11-23 21:30:15,047 DEBUG : process_Request line: v8_7 20714.94 graph.html#tests=[[230,132,43]] 21:30:15 INFO - 2015-11-23 21:30:15,048 INFO : javascript benchmark 21:30:15 INFO - 2015-11-23 21:30:15,052 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2648.854313012784, 2654.641623380843, 2690.7040225575183, 2700.1089640418663, 2726.1140129457926, 4461.598456138955, 4595.402597662308, 4611.0, 4634.907301853965, 4658.860234192975, 4547.272436410175, 4603.884902877421, 4606.539346065392, 4678.812847486105, 4691.460482044566, 4241.363795430695, 4313.331433627793, 4327.285997810365, 4440.622547083485, 4454.888627784315, 4368.759718215497, 4420.20436321462, 4423.137488189788, 4428.623566996793, 4463.73217606943, 4168.374743788426, 4244.745315281062, 4278.935815962732, 4353.760543170124, 4364.192624364503, 4337.934930976038, 4342.131573685244, 4353.346997950302, 4361.236783562864, 4385.2106620808245, 4177.582241775828, 4334.479862416499, 4338.58783415575, 4342.978285108586, 4395.802188901475, 4510.639148868083, 4565.0641618468135, 4587.24310488769, 4602.907941841145, 4617.58441740245, 5015.548600625962, 5102.36220472441, 5104.846854594368, 5105.055564720538, 5157.7936882524655, 4901.240307752304, 5108.974455127738, 5117.7185254810975, 5121.641485096045, 5170.095233334189, 4559.99680070384, 4575.450945886515, 4631.652626053059, 4641.675082744243, 4673.6728429009645, 5156.071907056766, 5166.0, 5166.509181627739, 5171.974140129275, 5188.377394712583, 4790.952090479121, 4877.951240483313, 4973.403191617029, 4976.975115124474, 5028.949710502921, 4928.926066109011, 4971.080350135237, 4975.776090075955, 5032.672876263031, 5185.740712964337, 4948.356713627206, 4961.751912404366, 4973.477784832613, 4980.402351717817, 5016.147254966664, 4916.950830491649, 4943.332650092263, 4944.134776414113, 4951.3810773653295, 5000.2499625056535, 4047.6559492442884, 4078.6940979426663, 4134.937975930364, 4137.606927341898, 4141.4409054777825, 3608.9458658120147, 3631.6913062389995, 3641.2717456508803, 3646.690031347312, 3651.653092956165, 4301.354796780508, 4326.134773045404, 4356.564343565618, 4357.891052723708, 4398.032432864765, 4843.200871856105, 4930.975345123252, 4941.160002799533, 5009.44896061433, 5029.1450453423, 4337.7614231217585, 4348.847790327323, 4368.650507959355, 4371.825126994948, 4390.736555806662, 4399.428074350378, 4431.534688857623, 4434.17967675981, 4472.306792447176, 4495.168393847149, 4576.748278844629, 4628.768561571841, 4664.323673067318, 4674.509176536482, 4726.574608285271, 4985.925211121908, 5019.071471777733, 5029.170186919264, 5068.366454193226, 5110.207917772751, 4706.741129237925, 4727.645426592951, 4746.525347465225, 4762.928556071731, 4807.831725889717, 4724.456687480983, 4842.297866809364, 4849.58778503817, 4890.951090489192, 4921.0, 4961.330220420197, 4970.155073637418, 5002.599792016703, 5005.549500544823, 5030.37120359955, 4722.150012997693, 4828.010257897053, 4866.489018653132, 4866.780994855169, 4900.509949005071, 4607.124646317189, 4719.197736384892, 4736.73947932867, 4775.379200704026, 4776.952230477651, 4690.085433340466, 4690.15577196108, 4738.123447162286, 4765.309030190534, 4820.855374338776, 4696.765161741968, 4787.593054590398, 4854.9514504855915, 4875.878103047452, 4883.731394773322, 4711.505291944297, 4777.976110119427, 4780.760961951819, 4799.160146974195, 4838.830640927551], "unit": "ms", "name": "dojo.html", "value": 4579.440369663598}, {"lowerIsBetter": false, "replicates": [544.7407711277849, 569.7948738454156, 579.4466284698113, 584.2288179602923, 590.5187272373016, 32434.513482297756, 33120.17199570009, 33165.66834331656, 33166.33667326652, 33380.0, 37250.25499490008, 38545.61454385455, 38569.22861542767, 38592.42111368332, 38677.226455470874, 7708.537487750753, 7860.331871790904, 7869.095054068769, 7906.051273847146, 7917.366610671162, 7671.462997590171, 7692.0, 7705.653245603933, 7745.1867553906595, 7760.262775036363, 7963.681452741884, 7984.560849153294, 7990.880136797953, 8050.5974701264995, 8052.114267430578, 7600.353969912564, 7750.689972401154, 7775.261350171724, 7793.96103019487, 7803.453758236926, 7857.1357150713375, 7909.05091389037, 7989.600519973978, 7994.840103197962, 7994.920050799476, 36239.63760362389, 36344.45483317752, 36412.63587364119, 36525.26949461023, 36604.084897877765, 2504.186139504668, 2608.89541445679, 2657.322382792395, 2776.9028084016963, 3326.6839650233187, 27109.0, 27211.727882721116, 27382.589261160898, 27490.725092749217, 27618.0, 3345.1135449106005, 3362.7646064775477, 3393.7963722176746, 3414.163529935157, 3439.724822014233, 217884.0, 218718.0, 220351.0, 220442.0, 220741.9999999984, 36994.26011479755, 37679.42045505672, 51781.7410912943, 51925.0, 52061.73969130206, 36257.8187109068, 36316.636833631856, 36366.09084772902, 36462.63537364645, 36536.45195322072, 13037.869621303666, 13211.66970825737, 13268.53560125391, 13274.402651880688, 13279.933600331937, 10345.37927724339, 10369.585216591402, 10428.0, 10436.0, 10462.0, 12590.0, 12879.806802897963, 13059.542915997894, 13075.411606477732, 13101.606951791271, 5306.28365170697, 5404.83785486436, 5415.241866138744, 5501.339839219319, 5501.862453438616, 786.8465649198351, 799.520287827299, 866.3675516872718, 871.5511511571545, 988.7824678570703, 24728.381790455023, 25042.0, 25359.746402535737, 25400.364990875005, 25544.48911021769, 913.1690161952591, 971.4608392342318, 1011.8482227665909, 1015.4821041269006, 1040.0385052423708, 13146.079774415699, 13162.210267383987, 13296.73406531864, 13334.733305333839, 13377.130486518345, 326122.27960623614, 329864.0, 330050.0, 330064.0, 331210.0, 45467.31799023017, 46115.769421152676, 46155.30767038497, 46158.30762538565, 46272.07455850932, 1193.797054500737, 1199.648738086617, 1201.3152503073165, 1203.8796120388067, 1204.4218774988055, 24950.37624059413, 25411.745882540938, 25485.23544293674, 25550.0, 25789.613155803054, 37010.0, 37099.62900370962, 37469.0, 37480.437793432575, 37553.0, 242658.0, 243249.0, 243979.0, 244284.0, 245627.0, 28791.424171516035, 29308.413831723672, 40626.0, 41445.0, 41941.161176775684, 38800.0, 39033.2193356137, 39252.0, 39300.2139957205, 39660.40509392304, 32707.0, 33383.33233335368, 33727.0, 33807.0, 34279.65720342765, 33469.33061338808, 34139.82930085334, 34162.31675366528, 34332.65667343394, 34497.0, 33054.66945330612, 33090.0, 33271.48301111365, 33559.83220083884, 33577.83211083929, 28727.42545149127, 30236.752311819877, 30668.693313067477, 30701.846490767402, 30815.53776693396, 24318.639472058105, 24391.390215244763, 24408.87795561082, 24489.632655510537, 24619.87690061538], "unit": "ms", "name": "ext.html", "value": 16205.709897335111}, {"lowerIsBetter": false, "replicates": [317.91734149121237, 330.9541847761075, 331.3224455987505, 333.092323418684, 336.90735047861835, 14553.41786328547, 15105.848941510581, 15513.92243038786, 15991.760123598126, 16188.595285117877, 9602.135807777298, 9808.509574521264, 12660.873391266085, 15198.0, 15198.924005379986, 4515.412996310483, 4684.765761711901, 4704.294355846616, 4794.568488836004, 5021.6986980781085, 4994.350734404522, 5021.774020169083, 5026.648134630577, 5036.345275114249, 5057.41839688435, 4803.111424386482, 4955.900881982358, 4957.652964292501, 4973.278874563186, 5014.749262536877, 4864.100141473803, 4943.283223932528, 4945.381827271591, 4945.950540494621, 4982.551570358667, 4908.0429316283335, 4910.754462276872, 4919.385076865392, 4953.529414705597, 4955.207166853286, 11828.467718952668, 11839.171258011942, 11872.821907671392, 16172.35310587575, 18052.0, 1706.4709939918541, 1713.2119225156443, 1747.100243374663, 1789.8836575622543, 1829.86276029297, 8907.643694252221, 9168.449893006375, 9389.295802814748, 10824.621138260201, 12822.551210707581, 1635.6156303268722, 1679.3954176496452, 1705.1389048530414, 1735.9218835152321, 1755.6313174233298, 51064.0, 53151.20273195905, 53518.64813518656, 53614.73192634051, 54462.45537544653, 9238.353315267866, 9374.109459601463, 9688.515574221261, 9942.502874856229, 9999.950000250097, 12375.938120309342, 12468.251904885554, 12476.00191984639, 12521.436535355931, 12523.874761252453, 7150.10623672041, 7159.498835081598, 7162.892556611655, 7324.121105467378, 7345.816354591071, 6874.106366172366, 6887.655617219119, 6892.965535172292, 7023.227444981048, 7030.613316267654, 4129.483814523184, 4205.621494065549, 4211.925958880466, 4215.346621273708, 4248.299030659969, 1702.208473060033, 1752.2202619834306, 1766.4612293250425, 1774.210476338017, 1783.5184500185137, 741.610654406441, 788.9092754333325, 804.3846457460048, 823.4359463767219, 912.9774652389366, 15361.385544578316, 15404.845951540341, 15611.765823512656, 16093.517194484184, 16154.434594789125, 800.3957012455559, 803.658445160816, 814.5072231300096, 822.1203312455615, 859.3254295378098, 8730.126987301219, 8774.912250877409, 8925.687600934067, 8953.955230223808, 9102.81794364109, 446288.0, 447003.0, 447104.0, 450004.0, 452873.0, 63745.68127159335, 66517.6674116636, 66652.33347666461, 66925.33074669288, 67057.32942670511, 1013.9239557033104, 1014.7767491151935, 1016.6441745389203, 1021.5045702834119, 1023.2785885950387, 13787.793183102061, 13904.930475347559, 14090.0, 14115.929420352833, 14131.717365652836, 29155.85422072876, 29690.55464167996, 29738.256543586584, 29746.85126574353, 30251.243718907204, 38588.421173681854, 39118.80440597779, 39411.40882886702, 42400.57599423966, 42689.786551067045, 8454.661813527637, 8533.31733461334, 8604.956975215084, 8644.697435589724, 8799.47203167812, 15528.22358882074, 15647.843521564639, 15653.37386504527, 15830.52508424749, 16171.919140404694, 13378.93310533441, 13479.326033698471, 13552.0, 13606.319684015562, 13685.0, 12361.0, 13577.864221358055, 13648.454061837416, 13681.452741890611, 13897.930510347383, 13793.655158620713, 13876.0, 14142.858571414567, 14197.787033194716, 14257.714845703234, 8777.0, 8975.820483590422, 9025.774355641162, 9063.365564410691, 9088.636454541744, 13516.189028658311, 13630.591082267549, 13922.721545569235, 13925.303734813016, 13945.093568917988], "unit": "ms", "name": "jquery.html", "value": 8035.270122378732}, {"lowerIsBetter": false, "replicates": [1488.5980785188005, 1566.7101586206552, 1627.2677295217156, 1631.5921019745065, 1639.1394517878111, 6470.547061705683, 6608.669566521667, 6703.564268322556, 6794.218664853537, 6837.00863374811, 6460.644664543448, 6490.643014634205, 6562.47500199984, 6565.441937435312, 6571.539992200548, 1906.3327835257687, 1926.1043614719154, 1926.9036548172605, 1928.5757133430623, 1936.6126774645056, 2074.2429013410074, 2094.350751267112, 2095.779943105967, 2128.1806504495803, 2128.2019242783954, 1941.4466876940076, 1978.465814230157, 1992.4321568353023, 2020.4342784020498, 2049.4466494046596, 1996.9600607987904, 2077.2833372486466, 2080.053575623088, 2084.9887804415, 2085.98957005214, 2081.9271325503687, 2126.946826329339, 2127.57448510297, 2127.7765834587453, 2135.4874830040835, 6879.690413931385, 6886.449084073312, 6937.68780404883, 6963.09479767632, 6966.860662786767, 3981.3828856527284, 4051.6353528182603, 4052.371882358239, 4062.8577999770164, 4068.7965601720093, 2730.167298973812, 2734.3164208947765, 2737.712540183272, 2770.8337499749878, 2773.55623100303, 840.4579046515024, 886.6409104312763, 908.3006085314337, 913.0777914306532, 917.8806755121858, 8966.282697384193, 8982.86525702115, 9009.369344145978, 9021.774455638595, 9022.0, 3808.923821523554, 3879.86420475282, 3920.0591857953887, 3926.0, 3947.3092208863336, 7961.880571791427, 7969.163237860057, 7988.520688758693, 8003.639836207385, 8035.477693949874, 4194.391813187131, 4198.9370159447635, 4238.978805105955, 4247.723897946624, 4277.037666525007, 3826.8469261229798, 3829.5787463379006, 3854.248421557825, 3862.6909847212155, 3865.9948413412717, 3245.0913744151676, 3305.272839975202, 3316.966830331714, 3325.451300535433, 3342.715869151101, 1007.0533698323552, 1028.881678606955, 1029.6807989523272, 1035.1460045462522, 1050.406520316019, 777.3975169243769, 835.4110352201683, 836.0803116571723, 886.9888327306875, 1053.947302634865, 6041.818745437644, 6090.20827292458, 6105.725242364016, 6109.327973922865, 6123.2652081750475, 555.9666420014812, 572.4676051272356, 576.1127863090793, 576.3919065386058, 712.1560950273941, 4947.851564453073, 4961.156603377434, 4973.0, 4980.302757613937, 4997.400311962588, 7818.0, 7822.687092516349, 8109.432339736162, 8133.349332053422, 8139.593020349077, 7985.161558036322, 8000.79998000043, 8013.3589312856, 8054.8791768122355, 8103.594820258963, 6397.26431460388, 6410.679466026773, 6435.581687190318, 6437.9678101610125, 6518.837029074311, 6460.644664543307, 6511.251206111168, 6517.576357536745, 6525.543211975116, 6559.672016399257, 7081.362677359062, 7128.215896251512, 7305.671244794104, 7321.63391830417, 7323.231060738546, 6775.93224067753, 6922.584644921119, 6940.167179938439, 7412.777616671293, 7419.517731347445, 5887.087501437284, 5920.911186332122, 5946.316173639913, 5957.523398128053, 5966.791162309299, 6363.872722545616, 6383.32975037633, 6411.743530258737, 6490.123833282447, 6493.448056915215, 6141.47797437205, 6183.979643358795, 6253.0, 6266.248050234001, 6316.052592111037, 5759.51044161251, 5921.970390148022, 5937.584369094295, 6005.424060653578, 6157.138000679819, 5899.852503687271, 5937.2578427696535, 5940.287165540163, 5946.970265148647, 5970.253718285215, 5643.548516118783, 5661.943380566142, 5683.545316374597, 5688.203651488712, 5693.032184528723, 5806.65160090396, 5855.268091488564, 5858.677772722541, 5860.941390586039, 5861.296644402699], "unit": "ms", "name": "mootools.html", "value": 3883.0209682766144}, {"lowerIsBetter": false, "replicates": [296.3169198949963, 296.9955450668239, 304.44135012252514, 309.521788836248, 321.2659074015874, 5541.5843811714085, 5594.692291923942, 5634.3802181759975, 5680.0627896397145, 5685.232493613361, 5398.73006349682, 5536.833894983147, 5578.470045345696, 5614.29821272341, 5619.381867994528, 4370.912581748363, 4378.387025816372, 4378.474583050031, 4394.252976993918, 4396.538363471837, 4387.0, 4387.7367357958465, 4389.648828093761, 4403.823847046115, 4410.911781764363, 4288.120935208275, 4356.564343565649, 4360.934585981213, 4369.934450983238, 4376.934345984812, 4353.064091220371, 4354.107407981356, 4356.390105385232, 4363.323684828857, 4372.191144638252, 3829.5596006459054, 3830.0233440472502, 3838.673712734421, 3842.903927401809, 3856.093817952779, 5409.675419474805, 5439.5104440600535, 5441.401445840955, 5450.700211488366, 5464.3442786865435, 4774.880627984294, 4900.534449227318, 5042.193249080129, 5047.293378926953, 5049.798008079672, 5715.142728590703, 5854.590178687494, 5874.706264686749, 5883.0881213411985, 5886.3230728465915, 4024.7987600619854, 4033.1530378620523, 4036.4550785643855, 4042.413849991735, 4045.110075783323, 6180.567360284782, 6222.595531290452, 6227.657478838662, 6244.094606282109, 6254.6872656366995, 4066.34938409853, 4155.231282212801, 4210.578942105765, 4217.093324935154, 4221.269279595351, 4282.657387409, 4284.807183676742, 4285.571442855752, 4290.034742183047, 4295.8496452624, 4936.950630493649, 4938.333325001151, 4941.728204948762, 4947.060058588857, 4954.529319714621, 5915.7633694652595, 5931.940680593225, 5945.970270148708, 5948.137520059568, 5953.285605727254, 1476.8375478697335, 1503.090630168754, 1513.9856296281298, 1519.9088054716754, 1529.2353823088456, 1004.3271008424373, 1008.470552959702, 1015.7105225010985, 1025.6051420203275, 1026.573971801694, 5107.923381149286, 5119.564836988823, 5133.050385678662, 5133.23001549763, 5145.176771716508, 6071.908921366183, 6109.327973922865, 6130.417610327101, 6135.5398345124295, 6137.938620613737, 5115.974420127875, 5122.154844450699, 5132.101882170605, 5133.178691409356, 5137.563307118937, 3254.397936381777, 3297.7526685498683, 3326.4511355626532, 3330.134165117087, 3334.1664583854035, 5725.570582206351, 5750.971245143747, 5774.2782152230975, 5778.624389414675, 5784.0, 6290.622562646256, 6290.811275661737, 6301.747930082745, 6311.810645680637, 6316.242050953823, 5591.10542313228, 5611.382747897646, 5707.429257074343, 5715.799947001835, 5750.137479378127, 6196.628202307876, 6214.036824292242, 6226.844328891632, 6246.1255424239735, 6246.593971391845, 6073.514118870568, 6074.787382441594, 6081.665508397081, 6086.087086936818, 6086.995645718407, 5700.201971723879, 5852.4147585241135, 5861.912071319019, 5877.94122058774, 5911.586188966731, 4130.524989626231, 4154.4183814265425, 4156.168766246702, 4157.9605098725315, 4159.750414975111, 6231.9688401557705, 6258.561900666909, 6262.749490020348, 6263.342349053466, 6271.686415679106, 5964.194833697569, 5975.133605627073, 5984.611000284967, 5988.580799344004, 6005.519558435402, 5782.5663075268685, 5987.491063259672, 6013.30846952606, 6013.338532761305, 6032.577719559764, 5823.4176582343125, 5867.20792692981, 5872.559558033079, 5908.734106965111, 5909.025010873158, 6028.246469191351, 6042.335343112342, 6070.089486577049, 6070.2412198475195, 6075.544334175043, 5695.572832037531, 5895.882082358415, 5898.734556944862, 5901.645901245939, 5904.61619994699], "unit": "ms", "name": "prototype.html", "value": 4439.512759649939}, {"lowerIsBetter": false, "replicates": [576.809652814571, 599.541350866587, 674.6458109492515, 678.2098854834118, 726.8291951391425, 10586.52360643771, 10767.084797792197, 10786.244962852603, 10799.622013229538, 10805.243632945698, 10574.259801813876, 10718.678439646803, 10726.088282495997, 10728.839067413996, 11019.173561982843, 731.3454458259854, 732.1653315220652, 755.056179775281, 755.3390783064818, 755.8903958925953, 745.5824738146628, 745.9589722565257, 755.3994574313434, 756.5838788666239, 758.3591864874201, 783.8628240057996, 784.1061190243128, 785.0579304834193, 785.2226295967008, 788.7436583110483, 778.2489897249125, 778.353966208046, 778.9298963093293, 779.719301051621, 781.3241546062643, 573.1545969694708, 575.0913556580592, 575.3412342867435, 579.2701196492408, 580.5326711996883, 11159.497822597921, 11229.71925701864, 11285.661430157108, 11292.661220163409, 11303.378314192716, 10217.744556386075, 10847.294925829796, 10905.127589792797, 10917.290376125526, 10952.466654668353, 8924.464532128028, 9094.181523662835, 9142.497162656051, 9251.259899208047, 9420.0, 3201.15169480088, 3238.3847069057038, 3244.4971029490466, 3293.3907227162813, 3326.251593391492, 42930.356044659355, 43281.13437731228, 43418.34872476915, 43538.346924796155, 43636.94541382104, 8399.748007559783, 8492.830143397097, 8547.0, 8593.355498337649, 8599.527026013504, 15372.692546149014, 15376.077435353915, 15397.153156576496, 15407.075575465507, 15417.922910385376, 6036.969815150984, 6075.756969721162, 6115.785947491817, 6177.289611694623, 6177.505799536027, 3432.2792213635416, 3523.2601153757996, 3574.821258937043, 3595.6224596417524, 3617.5116359291687, 2768.68160161584, 2831.221414111136, 2836.503611867915, 2844.9857750711526, 2856.757175640094, 497.91286524858003, 503.9974800125976, 504.57867680487203, 505.31277462650763, 510.88249702567873, 447.29327662293497, 450.5854613755353, 454.8771831605448, 468.34197951877667, 567.8608740858433, 6258.374162583706, 6398.136251606066, 6534.411902928759, 6535.215774107042, 6535.477161827138, 431.90282186508415, 441.55182489772903, 525.8133362656279, 538.7656369479289, 547.258464780225, 3130.248740302311, 3176.491761318178, 3230.7415406767404, 3235.6440791512914, 3243.8378081095852, 48973.0, 49161.0, 49429.50570494321, 49651.0069798602, 49652.50347496551, 43381.0478528467, 44109.0, 44221.0, 44464.0, 44861.551384485734, 40594.391084133764, 41261.381079283834, 41393.1721365577, 42257.57742422536, 42318.57681423208, 6406.455451286693, 6475.222973243241, 6542.476601871934, 6681.599104053772, 6697.698603562754, 28983.85508072446, 29049.7095029047, 29311.560326595543, 29627.40745185127, 31374.843125785137, 39020.804895975336, 39098.609013909496, 39464.60535394724, 40061.19877602373, 40417.1916561673, 8869.556522173736, 9016.639334426549, 9268.258539316703, 9411.058894110534, 9411.294152938694, 9734.805303894023, 9759.756006099904, 9850.60597576089, 9973.0, 10108.696739097839, 8679.696210632597, 8706.47761134334, 8734.82530349402, 8836.690715824916, 8995.325350598601, 8903.688370906988, 8988.595513202052, 8994.325425592975, 9039.59321830506, 9305.162535371848, 7950.165232650488, 8478.703245386381, 8660.48037117775, 8781.660564827276, 8863.423877447945, 8090.676372945016, 8123.147069557612, 8342.79143021405, 8418.158184181533, 8554.333603028537, 7042.471814613822, 7168.749093781693, 7409.646614566437, 7556.697732090654, 7777.844443110993], "unit": "ms", "name": "yui.html", "value": 5308.223649423183}], "name": "dromaeo_css", "value": 6158.806282671988}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 109.0, 116.0, 115.0, 114.0, 126.0, 116.0, 113.0, 115.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 115.3}, {"lowerIsBetter": true, "replicates": [153.0, 131.0, 163.0, 175.0, 132.0, 160.0, 160.0, 134.0, 175.0, 138.0], "unit": "ms", "name": "audio-beat-detection", "value": 152.1}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 162.0, 161.0, 164.0, 163.0, 178.0, 160.0, 163.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 163.8}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 75.0, 73.0, 150.0, 73.0, 78.0, 72.0, 72.0, 149.0], "unit": "ms", "name": "audio-fft", "value": 88.9}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 131.0, 94.0, 95.0, 93.0, 129.0, 94.0, 94.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 104.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 111.0, 110.0, 110.0, 111.0, 111.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 148.0, 148.0, 149.0, 148.0, 147.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 97.0, 95.0, 95.0, 99.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 74.0, 75.0, 74.0, 74.0, 74.0, 74.0, 74.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 74.0}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 71.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [81.0, 84.0, 83.0, 84.0, 83.0, 83.0, 83.0, 85.0, 84.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.5}, {"lowerIsBetter": true, "replicates": [130.0, 146.0, 131.0, 123.0, 129.0, 131.0, 127.0, 125.0, 134.0, 131.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 130.7}, {"lowerIsBetter": true, "replicates": [150.0, 148.0, 149.0, 148.0, 152.0, 149.0, 152.0, 149.0, 148.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.3}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 72.0, 72.0, 70.0, 69.0, 71.0, 70.0, 68.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.8}], "name": "kraken", "value": 1553.5999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [187.68768768768768], "unit": "score", "name": "Richards", "value": 188.08905600000006}, {"lowerIsBetter": false, "replicates": [185.87360594795538], "unit": "score", "name": "DeltaBlue", "value": 355.71483999999987}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5020.0], "unit": "score", "name": "Decrypt", "value": 53.0241035856574}, {"lowerIsBetter": false, "replicates": [1044.932079414838], "unit": "score", "name": "RayTrace", "value": 708.1694730000004}, {"lowerIsBetter": false, "replicates": [701.2622720897616], "unit": "score", "name": "Earley", "value": 950.3762380000003}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [25500.0], "unit": "score", "name": "RegExp", "value": 35.72490196078431}, {"lowerIsBetter": false, "replicates": [786.7820613690008], "unit": "score", "name": "Splay", "value": 103.57506099999998}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20714.937582495448}]} 21:30:15 INFO - RETURN: dromaeo_css: 6158.80 21:30:15 INFO - RETURN: kraken: 1553.60 21:30:15 INFO - RETURN: v8_7: 20714.94 21:30:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20714.94"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1553.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6158.80"}}} 21:30:15 INFO - Return code: 0 21:30:15 INFO - # TBPL SUCCESS # 21:30:15 INFO - Running post-action listener: _resource_record_post_action 21:30:15 INFO - Running post-run listener: _resource_record_post_run 21:30:16 INFO - Total resource usage - Wall time: 1237s; CPU: 13.0%; Read bytes: 303104; Write bytes: 271781888; Read time: 228; Write time: 626160 21:30:16 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 512000; Read time: 0; Write time: 116 21:30:16 INFO - run-tests - Wall time: 1223s; CPU: 13.0%; Read bytes: 274432; Write bytes: 271269888; Read time: 152; Write time: 626044 21:30:16 INFO - Running post-run listener: _upload_blobber_files 21:30:16 INFO - Blob upload gear active. 21:30:16 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 21:30:16 INFO - Copying logs to upload dir... 21:30:16 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1296.014015 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 36 secs) (at 2015-11-23 21:30:16.279592) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 21:30:16.283441) ========= 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=a194aa7faa1be204aaca7d660000020b-1448333501.707837-785713483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.008642 build_url: 'https://queue.taskcluster.net/v1/task/Q7AwK8s9T9CWKmhU_QG3Dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 21:30:16.330809) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 21:30:16.331170) ========= 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=a194aa7faa1be204aaca7d660000020b-1448333501.707837-785713483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 21:30:16.380725) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 21:30:16.381043) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 21:30:16.381337) ========= ========= Total master_lag: 0.26 =========