builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-065 starttime: 1448456064.49 results: success (0) buildid: 20151125023015 builduid: ddb878b2f0d6449c9155a8e9898f1072 revision: 80cc747d4e5e64f9e37e2eba98be52fcc772ad19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.486527) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.487194) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.487517) ========= bash -c pwd in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20aa3857bbc5a756c598c738000001bb-1448440387.270590-314216107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009059 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.527487) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.527798) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.569880) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.570359) ========= rm -rf properties in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20aa3857bbc5a756c598c738000001bb-1448440387.270590-314216107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004592 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.639698) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.639968) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.640331) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.640602) ========= 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-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20aa3857bbc5a756c598c738000001bb-1448440387.270590-314216107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-25 04:54:26-- 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% 221M=0s 2015-11-25 04:54:26 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157525 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.825327) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.825631) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20aa3857bbc5a756c598c738000001bb-1448440387.270590-314216107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019434 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.874613) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.874955) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 80cc747d4e5e64f9e37e2eba98be52fcc772ad19 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 80cc747d4e5e64f9e37e2eba98be52fcc772ad19 --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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20aa3857bbc5a756c598c738000001bb-1448440387.270590-314216107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-25 04:54:26,302 truncating revision to first 12 chars 2015-11-25 04:54:26,302 Setting DEBUG logging. 2015-11-25 04:54:26,302 attempt 1/10 2015-11-25 04:54:26,302 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/80cc747d4e5e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-25 04:54:26,556 unpacking tar archive at: fx-team-80cc747d4e5e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.528080 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:25.415408) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:25.415688) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:25.424882) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:25.425156) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:25.425526) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-11-25 04:54:25.425805) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (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', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20aa3857bbc5a756c598c738000001bb-1448440387.270590-314216107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:54:26 INFO - MultiFileLogger online at 20151125 04:54:26 in /builds/slave/test-pgo 04:54:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:54:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:54:26 INFO - {'append_to_log': False, 04:54:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:54:26 INFO - 'blob_upload_branch': 'Fx-Team', 04:54:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:54:26 INFO - 'branch': 'Fx-Team', 04:54:26 INFO - 'buildbot_json_path': 'buildprops.json', 04:54:26 INFO - 'config_files': ('talos/linux_config.py',), 04:54:26 INFO - 'default_actions': ('clobber', 04:54:26 INFO - 'read-buildbot-config', 04:54:26 INFO - 'download-and-extract', 04:54:26 INFO - 'populate-webroot', 04:54:26 INFO - 'create-virtualenv', 04:54:26 INFO - 'install', 04:54:26 INFO - 'run-tests'), 04:54:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:54:26 INFO - 'download_minidump_stackwalk': True, 04:54:26 INFO - 'download_symbols': 'ondemand', 04:54:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:54:26 INFO - 'tooltool.py': '/tools/tooltool.py', 04:54:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:54:26 INFO - '/tools/misc-python/virtualenv.py')}, 04:54:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:54:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:54:26 INFO - 'installer_path': 'installer.exe', 04:54:26 INFO - 'log_level': 'info', 04:54:26 INFO - 'log_name': 'talos', 04:54:26 INFO - 'log_to_console': True, 04:54:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:54:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:54:26 INFO - 'opt_config_files': (), 04:54:26 INFO - 'pip_index': False, 04:54:26 INFO - 'sps_profile': False, 04:54:26 INFO - 'sps_profile_interval': 0, 04:54:26 INFO - 'suite': 'dromaeojs-e10s', 04:54:26 INFO - 'system_bits': '64', 04:54:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:54:26 INFO - 'title': 'talos-linux64-ix-065', 04:54:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:54:26 INFO - 'use_talos_json': True, 04:54:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:54:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:54:26 INFO - 'work_dir': 'build'} 04:54:26 INFO - ##### 04:54:26 INFO - ##### Running clobber step. 04:54:26 INFO - ##### 04:54:26 INFO - Running pre-action listener: _resource_record_pre_action 04:54:26 INFO - Running main action method: clobber 04:54:26 INFO - rmtree: /builds/slave/test-pgo/build 04:54:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:54:27 INFO - Running post-action listener: _resource_record_post_action 04:54:27 INFO - ##### 04:54:27 INFO - ##### Running read-buildbot-config step. 04:54:27 INFO - ##### 04:54:27 INFO - Running pre-action listener: _resource_record_pre_action 04:54:27 INFO - Running main action method: read_buildbot_config 04:54:27 INFO - Using buildbot properties: 04:54:27 INFO - { 04:54:27 INFO - "properties": { 04:54:27 INFO - "buildnumber": 72, 04:54:27 INFO - "product": "firefox", 04:54:27 INFO - "script_repo_revision": "production", 04:54:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:54:27 INFO - "repository": "", 04:54:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 04:54:27 INFO - "buildid": "20151125023015", 04:54:27 INFO - "slavename": "talos-linux64-ix-065", 04:54:27 INFO - "pgo_build": "True", 04:54:27 INFO - "basedir": "/builds/slave/test-pgo", 04:54:27 INFO - "project": "", 04:54:27 INFO - "platform": "ubuntu64_hw", 04:54:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:54:27 INFO - "slavebuilddir": "test", 04:54:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:54:27 INFO - "branch": "fx-team", 04:54:27 INFO - "repo_path": "integration/fx-team", 04:54:27 INFO - "stage_platform": "linux64-pgo", 04:54:27 INFO - "builduid": "ddb878b2f0d6449c9155a8e9898f1072", 04:54:27 INFO - "revision": "80cc747d4e5e64f9e37e2eba98be52fcc772ad19" 04:54:27 INFO - }, 04:54:27 INFO - "sourcestamp": { 04:54:27 INFO - "repository": "", 04:54:27 INFO - "hasPatch": false, 04:54:27 INFO - "project": "", 04:54:27 INFO - "branch": "fx-team-linux64-pgo-talos", 04:54:27 INFO - "changes": [ 04:54:27 INFO - { 04:54:27 INFO - "category": null, 04:54:27 INFO - "files": [ 04:54:27 INFO - { 04:54:27 INFO - "url": null, 04:54:27 INFO - "name": "https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:54:27 INFO - } 04:54:27 INFO - ], 04:54:27 INFO - "repository": "", 04:54:27 INFO - "rev": "80cc747d4e5e64f9e37e2eba98be52fcc772ad19", 04:54:27 INFO - "who": "sendchange", 04:54:27 INFO - "when": 1448455991, 04:54:27 INFO - "number": 6705408, 04:54:27 INFO - "comments": "", 04:54:27 INFO - "project": "", 04:54:27 INFO - "at": "Wed 25 Nov 2015 04:53:11", 04:54:27 INFO - "branch": "fx-team-linux64-pgo-talos", 04:54:27 INFO - "revlink": "", 04:54:27 INFO - "properties": [ 04:54:27 INFO - [ 04:54:27 INFO - "buildid", 04:54:27 INFO - "20151125023015", 04:54:27 INFO - "Change" 04:54:27 INFO - ], 04:54:27 INFO - [ 04:54:27 INFO - "builduid", 04:54:27 INFO - "ddb878b2f0d6449c9155a8e9898f1072", 04:54:27 INFO - "Change" 04:54:27 INFO - ], 04:54:27 INFO - [ 04:54:27 INFO - "pgo_build", 04:54:27 INFO - "True", 04:54:27 INFO - "Change" 04:54:27 INFO - ] 04:54:27 INFO - ], 04:54:27 INFO - "revision": "80cc747d4e5e64f9e37e2eba98be52fcc772ad19" 04:54:27 INFO - } 04:54:27 INFO - ], 04:54:27 INFO - "revision": "80cc747d4e5e64f9e37e2eba98be52fcc772ad19" 04:54:27 INFO - } 04:54:27 INFO - } 04:54:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:54:27 INFO - Running post-action listener: _resource_record_post_action 04:54:27 INFO - ##### 04:54:27 INFO - ##### Running download-and-extract step. 04:54:27 INFO - ##### 04:54:27 INFO - Running pre-action listener: _resource_record_pre_action 04:54:27 INFO - Running main action method: download_and_extract 04:54:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:54:27 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')]} 04:54:27 INFO - https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:54:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/test_packages.json 04:54:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/test_packages.json 04:54:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:54:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:54:34 INFO - Downloaded 1302 bytes. 04:54:34 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:54:34 INFO - Using the following test package requirements: 04:54:34 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:54:34 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:54:34 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:34 INFO - u'jsshell-linux-x86_64.zip'], 04:54:34 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:54:34 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:54:34 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:54:34 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:54:34 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:54:34 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:54:34 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:54:34 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:34 INFO - https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:54:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:54:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:54:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:54:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:54:41 INFO - Downloaded 22530506 bytes. 04:54:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:54:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:54:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:54:42 INFO - Return code: 0 04:54:42 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 04:54:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:42 INFO - https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:54:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:54:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:54:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:54:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:54:46 INFO - Downloaded 22530506 bytes. 04:54:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:54:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:54:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:54:47 INFO - Return code: 0 04:54:47 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')]} 04:54:47 INFO - https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:54:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:54:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:54:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:54:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:54:48 INFO - Downloaded 11131717 bytes. 04:54:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 04:54:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:54:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:54:48 INFO - Return code: 0 04:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:48 INFO - https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:54:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:54:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:54:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:54:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:54:50 INFO - Downloaded 58388435 bytes. 04:54:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:54:50 INFO - mkdir: /builds/slave/test-pgo/properties 04:54:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:54:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:54:50 INFO - Contents: 04:54:50 INFO - build_url:https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:54:50 INFO - Running post-action listener: _resource_record_post_action 04:54:50 INFO - Running post-action listener: set_extra_try_arguments 04:54:50 INFO - ##### 04:54:50 INFO - ##### Running populate-webroot step. 04:54:50 INFO - ##### 04:54:50 INFO - Running pre-action listener: _resource_record_pre_action 04:54:50 INFO - Running main action method: populate_webroot 04:54:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:54:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:54:50 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:54:50 INFO - '../fennec_ids.txt'], 04:54:50 INFO - 'tests': ['tcheck2']}, 04:54:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:54:50 INFO - '--tppagecycles', 04:54:50 INFO - '7'], 04:54:50 INFO - 'tests': ['tsvgm']}}, 04:54:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:54:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:54:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:54:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:54:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:54:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:54:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:54:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:50 INFO - 'talos_options': ['--e10s'], 04:54:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:54:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:50 INFO - 'tests': ['damp', 'tps']}, 04:54:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:50 INFO - 'talos_options': ['--e10s'], 04:54:50 INFO - 'tests': ['damp', 'tps']}, 04:54:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:54:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:54:50 INFO - 'other': {'tests': ['a11yr', 04:54:50 INFO - 'ts_paint', 04:54:50 INFO - 'tpaint', 04:54:50 INFO - 'sessionrestore', 04:54:50 INFO - 'sessionrestore_no_auto_restore']}, 04:54:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:54:50 INFO - 'tests': ['a11yr', 04:54:50 INFO - 'ts_paint', 04:54:50 INFO - 'tpaint', 04:54:50 INFO - 'sessionrestore', 04:54:50 INFO - 'sessionrestore_no_auto_restore']}, 04:54:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:54:50 INFO - 'tests': ['a11yr', 04:54:50 INFO - 'ts_paint', 04:54:50 INFO - 'tpaint', 04:54:50 INFO - 'sessionrestore', 04:54:50 INFO - 'sessionrestore_no_auto_restore']}, 04:54:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:54:50 INFO - 'tests': ['a11yr', 04:54:50 INFO - 'ts_paint', 04:54:50 INFO - 'tpaint', 04:54:50 INFO - 'sessionrestore', 04:54:50 INFO - 'sessionrestore_no_auto_restore']}, 04:54:50 INFO - 'other_l64': {'tests': ['a11yr', 04:54:50 INFO - 'ts_paint', 04:54:50 INFO - 'tpaint', 04:54:50 INFO - 'sessionrestore', 04:54:50 INFO - 'sessionrestore_no_auto_restore']}, 04:54:50 INFO - 'other_nol64': {'tests': ['a11yr', 04:54:50 INFO - 'ts_paint', 04:54:50 INFO - 'tpaint', 04:54:50 INFO - 'sessionrestore', 04:54:50 INFO - 'sessionrestore_no_auto_restore']}, 04:54:50 INFO - 'svgr': {'tests': ['tsvgx', 04:54:50 INFO - 'tsvgr_opacity', 04:54:50 INFO - 'tart', 04:54:50 INFO - 'tscrollx', 04:54:50 INFO - 'cart']}, 04:54:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:54:50 INFO - 'tests': ['tsvgx', 04:54:50 INFO - 'tsvgr_opacity', 04:54:50 INFO - 'tart', 04:54:50 INFO - 'tscrollx', 04:54:50 INFO - 'cart']}, 04:54:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:50 INFO - 'tests': ['tp5o']}, 04:54:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:50 INFO - 'talos_options': ['--e10s'], 04:54:50 INFO - 'tests': ['tp5o']}, 04:54:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:50 INFO - 'talos_options': ['--xperf_path', 04:54:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:54:50 INFO - 'tests': ['tp5n']}, 04:54:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:50 INFO - 'talos_options': ['--e10s', 04:54:50 INFO - '--xperf_path', 04:54:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:54:50 INFO - 'tests': ['tp5n']}}, 04:54:50 INFO - 'talos.zip': {'path': '', 04:54:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:54:50 INFO - Running post-action listener: _resource_record_post_action 04:54:50 INFO - ##### 04:54:50 INFO - ##### Running create-virtualenv step. 04:54:50 INFO - ##### 04:54:50 INFO - Running pre-action listener: _resource_record_pre_action 04:54:50 INFO - Running main action method: create_virtualenv 04:54:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:54:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 04:54:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:54:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:54:50 INFO - Using real prefix '/usr' 04:54:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:54:50 INFO - Installing distribute.............................................................................................................................................................................................done. 04:54:52 INFO - Installing pip.................done. 04:54:52 INFO - Return code: 0 04:54:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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 0x1ba7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd47d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e63640>, '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 0x1e64540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e649d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448440387.270590-314216107', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 04:54:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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-pgo/build 04:54:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/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 04:54:52 INFO - Using env: {'DISPLAY': ':0', 04:54:52 INFO - 'HOME': '/home/cltbld', 04:54:52 INFO - 'LANG': 'en_US.UTF-8', 04:54:52 INFO - 'LANGUAGE': 'en_US:en', 04:54:52 INFO - 'LOGNAME': 'cltbld', 04:54:52 INFO - 'MAIL': '/var/mail/cltbld', 04:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:52 INFO - 'MOZ_NO_REMOTE': '1', 04:54:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:52 INFO - 'NO_EM_RESTART': '1', 04:54:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:54:52 INFO - 'PWD': '/builds/slave/test-pgo', 04:54:52 INFO - 'SHELL': '/bin/bash', 04:54:52 INFO - 'SHLVL': '1', 04:54:52 INFO - 'TERM': 'linux', 04:54:52 INFO - 'TMOUT': '86400', 04:54:52 INFO - 'USER': 'cltbld', 04:54:52 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448440387.270590-314216107', 04:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:52 INFO - '_': '/tools/buildbot/bin/python'} 04:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:54:53 INFO - Cleaning up... 04:54:53 INFO - Return code: 0 04:54:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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 0x1ba7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd47d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e63640>, '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 0x1e64540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e649d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448440387.270590-314216107', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 04:54:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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-pgo/build 04:54:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/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 04:54:53 INFO - Using env: {'DISPLAY': ':0', 04:54:53 INFO - 'HOME': '/home/cltbld', 04:54:53 INFO - 'LANG': 'en_US.UTF-8', 04:54:53 INFO - 'LANGUAGE': 'en_US:en', 04:54:53 INFO - 'LOGNAME': 'cltbld', 04:54:53 INFO - 'MAIL': '/var/mail/cltbld', 04:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:53 INFO - 'MOZ_NO_REMOTE': '1', 04:54:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:53 INFO - 'NO_EM_RESTART': '1', 04:54:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:54:53 INFO - 'PWD': '/builds/slave/test-pgo', 04:54:53 INFO - 'SHELL': '/bin/bash', 04:54:53 INFO - 'SHLVL': '1', 04:54:53 INFO - 'TERM': 'linux', 04:54:53 INFO - 'TMOUT': '86400', 04:54:53 INFO - 'USER': 'cltbld', 04:54:53 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448440387.270590-314216107', 04:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:53 INFO - '_': '/tools/buildbot/bin/python'} 04:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:53 INFO - Downloading/unpacking psutil>=0.7.1 04:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:55 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:54:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:54:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:54:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:54:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:54:55 INFO - Installing collected packages: psutil 04:54:55 INFO - Running setup.py install for psutil 04:54:55 INFO - building 'psutil._psutil_linux' extension 04:54:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:54:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:54:55 INFO - building 'psutil._psutil_posix' extension 04:54:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:54:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:54:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:54:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:54:55 INFO - Successfully installed psutil 04:54:55 INFO - Cleaning up... 04:54:55 INFO - Return code: 0 04:54:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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 0x1ba7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd47d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e63640>, '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 0x1e64540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e649d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448440387.270590-314216107', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 04:54:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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-pgo/build 04:54:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/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 04:54:55 INFO - Using env: {'DISPLAY': ':0', 04:54:55 INFO - 'HOME': '/home/cltbld', 04:54:55 INFO - 'LANG': 'en_US.UTF-8', 04:54:55 INFO - 'LANGUAGE': 'en_US:en', 04:54:55 INFO - 'LOGNAME': 'cltbld', 04:54:55 INFO - 'MAIL': '/var/mail/cltbld', 04:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:55 INFO - 'MOZ_NO_REMOTE': '1', 04:54:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:55 INFO - 'NO_EM_RESTART': '1', 04:54:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:54:55 INFO - 'PWD': '/builds/slave/test-pgo', 04:54:55 INFO - 'SHELL': '/bin/bash', 04:54:55 INFO - 'SHLVL': '1', 04:54:55 INFO - 'TERM': 'linux', 04:54:55 INFO - 'TMOUT': '86400', 04:54:55 INFO - 'USER': 'cltbld', 04:54:55 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448440387.270590-314216107', 04:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:55 INFO - '_': '/tools/buildbot/bin/python'} 04:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:54:55 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 04:54:55 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 04:54:55 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 04:54:55 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 04:54:55 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 04:54:55 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 04:54:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:54:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:54:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:54:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:54:58 INFO - Installing collected packages: mozsystemmonitor 04:54:58 INFO - Running setup.py install for mozsystemmonitor 04:54:58 INFO - Successfully installed mozsystemmonitor 04:54:58 INFO - Cleaning up... 04:54:58 INFO - Return code: 0 04:54:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:54:58 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')]} 04:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:58 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')]} 04:54:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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 0x1ba7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd47d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e63640>, '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 0x1e64540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e649d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448440387.270590-314216107', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 04:54:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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-pgo/build 04:54:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/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 04:54:58 INFO - Using env: {'DISPLAY': ':0', 04:54:58 INFO - 'HOME': '/home/cltbld', 04:54:58 INFO - 'LANG': 'en_US.UTF-8', 04:54:58 INFO - 'LANGUAGE': 'en_US:en', 04:54:58 INFO - 'LOGNAME': 'cltbld', 04:54:58 INFO - 'MAIL': '/var/mail/cltbld', 04:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:58 INFO - 'MOZ_NO_REMOTE': '1', 04:54:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:58 INFO - 'NO_EM_RESTART': '1', 04:54:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:54:58 INFO - 'PWD': '/builds/slave/test-pgo', 04:54:58 INFO - 'SHELL': '/bin/bash', 04:54:58 INFO - 'SHLVL': '1', 04:54:58 INFO - 'TERM': 'linux', 04:54:58 INFO - 'TMOUT': '86400', 04:54:58 INFO - 'USER': 'cltbld', 04:54:58 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448440387.270590-314216107', 04:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:58 INFO - '_': '/tools/buildbot/bin/python'} 04:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:59 INFO - Downloading/unpacking blobuploader==1.2.4 04:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:00 INFO - Downloading blobuploader-1.2.4.tar.gz 04:55:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:55:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:55:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:55:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:55:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:55:01 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 04:55:01 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 04:55:01 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 04:55:01 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 04:55:01 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 04:55:01 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 04:55:01 INFO - Downloading docopt-0.6.1.tar.gz 04:55:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:55:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:55:01 INFO - Installing collected packages: blobuploader, requests, docopt 04:55:01 INFO - Running setup.py install for blobuploader 04:55:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:55:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:55:01 INFO - Running setup.py install for requests 04:55:02 INFO - Running setup.py install for docopt 04:55:02 INFO - Successfully installed blobuploader requests docopt 04:55:02 INFO - Cleaning up... 04:55:02 INFO - Return code: 0 04:55:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x1ba7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd47d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e63640>, '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 0x1e64540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e649d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448440387.270590-314216107', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 04:55:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 04:55:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 04:55:02 INFO - Using env: {'DISPLAY': ':0', 04:55:02 INFO - 'HOME': '/home/cltbld', 04:55:02 INFO - 'LANG': 'en_US.UTF-8', 04:55:02 INFO - 'LANGUAGE': 'en_US:en', 04:55:02 INFO - 'LOGNAME': 'cltbld', 04:55:02 INFO - 'MAIL': '/var/mail/cltbld', 04:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:02 INFO - 'MOZ_NO_REMOTE': '1', 04:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:02 INFO - 'NO_EM_RESTART': '1', 04:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:55:02 INFO - 'PWD': '/builds/slave/test-pgo', 04:55:02 INFO - 'SHELL': '/bin/bash', 04:55:02 INFO - 'SHLVL': '1', 04:55:02 INFO - 'TERM': 'linux', 04:55:02 INFO - 'TMOUT': '86400', 04:55:02 INFO - 'USER': 'cltbld', 04:55:02 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448440387.270590-314216107', 04:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:02 INFO - '_': '/tools/buildbot/bin/python'} 04:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:55:02 INFO - Running setup.py (path:/tmp/pip-Va8mO7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:55:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:55:02 INFO - Running setup.py (path:/tmp/pip-FNkDXO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:55:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:55:02 INFO - Running setup.py (path:/tmp/pip-Lyl4XL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:55:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:55:02 INFO - Running setup.py (path:/tmp/pip-XiHSr1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:55:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:55:02 INFO - Running setup.py (path:/tmp/pip-huBL2R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:55:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:55:02 INFO - Running setup.py (path:/tmp/pip-nkS7Xw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:55:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:55:02 INFO - Running setup.py (path:/tmp/pip-_jQyLc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:55:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:55:02 INFO - Running setup.py (path:/tmp/pip-zNgKht-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:55:03 INFO - Running setup.py (path:/tmp/pip-KzbScZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:55:03 INFO - Running setup.py (path:/tmp/pip-JdrEa1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:55:03 INFO - Running setup.py (path:/tmp/pip-Irx87Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:55:03 INFO - Running setup.py (path:/tmp/pip-CAALFH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:55:03 INFO - Running setup.py (path:/tmp/pip-VZl7mA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:55:03 INFO - Running setup.py (path:/tmp/pip-MmdRQa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:55:03 INFO - Running setup.py (path:/tmp/pip-ewWC2H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:55:03 INFO - Running setup.py (path:/tmp/pip-D7dYhx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:55:03 INFO - Running setup.py (path:/tmp/pip-f5A8xB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:55:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:55:03 INFO - Running setup.py install for manifestparser 04:55:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:55:03 INFO - Running setup.py install for mozcrash 04:55:03 INFO - Running setup.py install for mozdebug 04:55:03 INFO - Running setup.py install for mozdevice 04:55:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:55:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:55:04 INFO - Running setup.py install for mozfile 04:55:04 INFO - Running setup.py install for mozhttpd 04:55:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:55:04 INFO - Running setup.py install for mozinfo 04:55:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:55:04 INFO - Running setup.py install for mozInstall 04:55:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:55:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:55:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:55:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:55:04 INFO - Running setup.py install for mozleak 04:55:04 INFO - Running setup.py install for mozlog 04:55:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:55:04 INFO - Running setup.py install for moznetwork 04:55:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:55:04 INFO - Running setup.py install for mozprocess 04:55:04 INFO - Running setup.py install for mozprofile 04:55:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:55:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:55:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:55:05 INFO - Running setup.py install for mozrunner 04:55:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:55:05 INFO - Running setup.py install for mozscreenshot 04:55:05 INFO - Running setup.py install for moztest 04:55:05 INFO - Running setup.py install for mozversion 04:55:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:55:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:55:05 INFO - Cleaning up... 04:55:05 INFO - Return code: 0 04:55:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:55: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')]} 04:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55: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')]} 04:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x1ba7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd47d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e63640>, '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 0x1e64540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e649d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448440387.270590-314216107', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 04:55:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 04:55:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 04:55:05 INFO - Using env: {'DISPLAY': ':0', 04:55:05 INFO - 'HOME': '/home/cltbld', 04:55:05 INFO - 'LANG': 'en_US.UTF-8', 04:55:05 INFO - 'LANGUAGE': 'en_US:en', 04:55:05 INFO - 'LOGNAME': 'cltbld', 04:55:05 INFO - 'MAIL': '/var/mail/cltbld', 04:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:05 INFO - 'MOZ_NO_REMOTE': '1', 04:55:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:05 INFO - 'NO_EM_RESTART': '1', 04:55:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:55:05 INFO - 'PWD': '/builds/slave/test-pgo', 04:55:05 INFO - 'SHELL': '/bin/bash', 04:55:05 INFO - 'SHLVL': '1', 04:55:05 INFO - 'TERM': 'linux', 04:55:05 INFO - 'TMOUT': '86400', 04:55:05 INFO - 'USER': 'cltbld', 04:55:05 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448440387.270590-314216107', 04:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:05 INFO - '_': '/tools/buildbot/bin/python'} 04:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:55:05 INFO - Running setup.py (path:/tmp/pip-SbbRHk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:55:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 04:55:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:55:05 INFO - Running setup.py (path:/tmp/pip-WBtDHC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:55:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:55:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:55:05 INFO - Running setup.py (path:/tmp/pip-foaGx0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:55:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:55:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:55:05 INFO - Running setup.py (path:/tmp/pip-2cjLUI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:55:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:55:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:55:05 INFO - Running setup.py (path:/tmp/pip-XiPBT3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:55:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 04:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:55:06 INFO - Running setup.py (path:/tmp/pip-a0loNV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:55:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 04:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:55:06 INFO - Running setup.py (path:/tmp/pip-01w36_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:55:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 04:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:55:06 INFO - Running setup.py (path:/tmp/pip-KbGegV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:55:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 04:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:55:06 INFO - Running setup.py (path:/tmp/pip-U05Pnp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:55:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 04:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:55:06 INFO - Running setup.py (path:/tmp/pip-BWzcsG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:55:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:55:06 INFO - Running setup.py (path:/tmp/pip-rSf91Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:55:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 04:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:55:06 INFO - Running setup.py (path:/tmp/pip-V3qP9v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:55:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 04:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:55:06 INFO - Running setup.py (path:/tmp/pip-H96yS3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:55:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 04:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:55:06 INFO - Running setup.py (path:/tmp/pip-6sea74-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:55:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 04:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:55:06 INFO - Running setup.py (path:/tmp/pip-mNb1Bv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:55:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 04:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:55:06 INFO - Running setup.py (path:/tmp/pip-rnGamp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:55:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 04:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:55:06 INFO - Running setup.py (path:/tmp/pip-E3aWXv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:55:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 04:55:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:55:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:55:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:55:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:55:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:55:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:55:06 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 04:55:06 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 04:55:06 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 04:55:06 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 04:55:06 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 04:55:06 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 04:55:08 INFO - Downloading blessings-1.5.1.tar.gz 04:55:08 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:55:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:55:08 INFO - Installing collected packages: blessings 04:55:08 INFO - Running setup.py install for blessings 04:55:08 INFO - Successfully installed blessings 04:55:08 INFO - Cleaning up... 04:55:08 INFO - Return code: 0 04:55:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:55:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:55:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:55:09 INFO - Reading from file tmpfile_stdout 04:55:09 INFO - Current package versions: 04:55:09 INFO - argparse == 1.2.1 04:55:09 INFO - blessings == 1.5.1 04:55:09 INFO - blobuploader == 1.2.4 04:55:09 INFO - docopt == 0.6.1 04:55:09 INFO - manifestparser == 1.1 04:55:09 INFO - mozInstall == 1.12 04:55:09 INFO - mozcrash == 0.16 04:55:09 INFO - mozdebug == 0.1 04:55:09 INFO - mozdevice == 0.47 04:55:09 INFO - mozfile == 1.2 04:55:09 INFO - mozhttpd == 0.7 04:55:09 INFO - mozinfo == 0.9 04:55:09 INFO - mozleak == 0.1 04:55:09 INFO - mozlog == 3.1 04:55:09 INFO - moznetwork == 0.27 04:55:09 INFO - mozprocess == 0.22 04:55:09 INFO - mozprofile == 0.27 04:55:09 INFO - mozrunner == 6.11 04:55:09 INFO - mozscreenshot == 0.1 04:55:09 INFO - mozsystemmonitor == 0.0 04:55:09 INFO - moztest == 0.7 04:55:09 INFO - mozversion == 1.4 04:55:09 INFO - psutil == 3.1.1 04:55:09 INFO - requests == 1.2.3 04:55:09 INFO - wsgiref == 0.1.2 04:55:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:55:09 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')]} 04:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:09 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')]} 04:55:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x1ba7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd47d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e63640>, '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 0x1e64540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e649d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448440387.270590-314216107', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 04:55:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/talos 04:55:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 04:55:09 INFO - Using env: {'DISPLAY': ':0', 04:55:09 INFO - 'HOME': '/home/cltbld', 04:55:09 INFO - 'LANG': 'en_US.UTF-8', 04:55:09 INFO - 'LANGUAGE': 'en_US:en', 04:55:09 INFO - 'LOGNAME': 'cltbld', 04:55:09 INFO - 'MAIL': '/var/mail/cltbld', 04:55:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:09 INFO - 'MOZ_NO_REMOTE': '1', 04:55:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:09 INFO - 'NO_EM_RESTART': '1', 04:55:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:55:09 INFO - 'PWD': '/builds/slave/test-pgo', 04:55:09 INFO - 'SHELL': '/bin/bash', 04:55:09 INFO - 'SHLVL': '1', 04:55:09 INFO - 'TERM': 'linux', 04:55:09 INFO - 'TMOUT': '86400', 04:55:09 INFO - 'USER': 'cltbld', 04:55:09 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448440387.270590-314216107', 04:55:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:09 INFO - '_': '/tools/buildbot/bin/python'} 04:55:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 04:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 04:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 04:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 04:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 04:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 04:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 04:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 04:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:55:09 INFO - Cleaning up... 04:55:09 INFO - Return code: 0 04:55:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:55:09 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')]} 04:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:09 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')]} 04:55:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd47d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e63640>, '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 0x1e64540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e649d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448440387.270590-314216107', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 04:55:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 04:55:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:55:09 INFO - Using env: {'DISPLAY': ':0', 04:55:09 INFO - 'HOME': '/home/cltbld', 04:55:09 INFO - 'LANG': 'en_US.UTF-8', 04:55:09 INFO - 'LANGUAGE': 'en_US:en', 04:55:09 INFO - 'LOGNAME': 'cltbld', 04:55:09 INFO - 'MAIL': '/var/mail/cltbld', 04:55:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:09 INFO - 'MOZ_NO_REMOTE': '1', 04:55:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:09 INFO - 'NO_EM_RESTART': '1', 04:55:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:55:09 INFO - 'PWD': '/builds/slave/test-pgo', 04:55:09 INFO - 'SHELL': '/bin/bash', 04:55:09 INFO - 'SHLVL': '1', 04:55:09 INFO - 'TERM': 'linux', 04:55:09 INFO - 'TMOUT': '86400', 04:55:09 INFO - 'USER': 'cltbld', 04:55:09 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448440387.270590-314216107', 04:55:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:09 INFO - '_': '/tools/buildbot/bin/python'} 04:55:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:09 INFO - Downloading/unpacking jsonschema 04:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:55:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:55:11 INFO - Downloading/unpacking functools32 (from jsonschema) 04:55:11 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 04:55:11 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 04:55:11 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 04:55:11 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 04:55:11 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 04:55:11 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 04:55:11 INFO - Downloading functools32-3.2.3-2.tar.gz 04:55:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:55:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:55:11 INFO - warning: no files found matching '*.txt' 04:55:11 INFO - no previously-included directories found matching 'build' 04:55:11 INFO - no previously-included directories found matching 'dist' 04:55:11 INFO - no previously-included directories found matching '.git*' 04:55:11 INFO - Installing collected packages: jsonschema, functools32 04:55:11 INFO - Running setup.py install for functools32 04:55:11 INFO - warning: no files found matching '*.txt' 04:55:11 INFO - no previously-included directories found matching 'build' 04:55:11 INFO - no previously-included directories found matching 'dist' 04:55:11 INFO - no previously-included directories found matching '.git*' 04:55:11 INFO - Successfully installed jsonschema functools32 04:55:11 INFO - Cleaning up... 04:55:11 INFO - Return code: 0 04:55:11 INFO - Running post-action listener: _resource_record_post_action 04:55:11 INFO - Running post-action listener: _start_resource_monitoring 04:55:11 INFO - Starting resource monitoring. 04:55:11 INFO - ##### 04:55:11 INFO - ##### Running install step. 04:55:11 INFO - ##### 04:55:11 INFO - Running pre-action listener: _resource_record_pre_action 04:55:11 INFO - Running main action method: install 04:55:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:55:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:55:11 INFO - Reading from file tmpfile_stdout 04:55:11 INFO - Detecting whether we're running mozinstall >=1.0... 04:55:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:55:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:55:11 INFO - Reading from file tmpfile_stdout 04:55:11 INFO - Output received: 04:55:11 INFO - Usage: mozinstall [options] installer 04:55:11 INFO - Options: 04:55:11 INFO - -h, --help show this help message and exit 04:55:11 INFO - -d DEST, --destination=DEST 04:55:11 INFO - Directory to install application into. [default: 04:55:11 INFO - "/builds/slave/test-pgo"] 04:55:11 INFO - --app=APP Application being installed. [default: firefox] 04:55:11 INFO - mkdir: /builds/slave/test-pgo/build/application 04:55:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 04:55:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 04:55:26 INFO - Reading from file tmpfile_stdout 04:55:26 INFO - Output received: 04:55:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:55:26 INFO - Running post-action listener: _resource_record_post_action 04:55:26 INFO - ##### 04:55:26 INFO - ##### Running run-tests step. 04:55:26 INFO - ##### 04:55:26 INFO - Running pre-action listener: _resource_record_pre_action 04:55:26 INFO - Running main action method: run_tests 04:55:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:55:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:55:26 INFO - Python 2.7.3 04:55:26 INFO - Return code: 0 04:55:26 INFO - grabbing minidump binary from tooltool 04:55:26 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')]} 04:55:26 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-pgo/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 0x1e63640>, '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 0x1e64540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e649d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:55:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 04:55:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:55:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:55:26 INFO - Return code: 0 04:55:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:55:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:55:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:55:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:55:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:55:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 04:55:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost 04:55:26 INFO - Using env: {'DISPLAY': ':0', 04:55:26 INFO - 'HOME': '/home/cltbld', 04:55:26 INFO - 'LANG': 'en_US.UTF-8', 04:55:26 INFO - 'LANGUAGE': 'en_US:en', 04:55:26 INFO - 'LOGNAME': 'cltbld', 04:55:26 INFO - 'MAIL': '/var/mail/cltbld', 04:55:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:55:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:55:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:26 INFO - 'MOZ_NO_REMOTE': '1', 04:55:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:55:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:26 INFO - 'NO_EM_RESTART': '1', 04:55:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:55:26 INFO - 'PWD': '/builds/slave/test-pgo', 04:55:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:55:26 INFO - 'SHELL': '/bin/bash', 04:55:26 INFO - 'SHLVL': '1', 04:55:26 INFO - 'TERM': 'linux', 04:55:26 INFO - 'TMOUT': '86400', 04:55:26 INFO - 'USER': 'cltbld', 04:55:26 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448440387.270590-314216107', 04:55:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:26 INFO - '_': '/tools/buildbot/bin/python'} 04:55:26 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost'] with output_timeout 3600 04:55:26 INFO - mozversion INFO | application_buildid: 20151125023015 04:55:26 INFO - mozversion INFO | application_changeset: 80cc747d4e5e64f9e37e2eba98be52fcc772ad19 04:55:26 INFO - mozversion INFO | application_display_name: Nightly 04:55:26 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:55:26 INFO - mozversion INFO | application_name: Firefox 04:55:26 INFO - mozversion INFO | application_remotingname: firefox 04:55:26 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 04:55:26 INFO - mozversion INFO | application_vendor: Mozilla 04:55:26 INFO - mozversion INFO | application_version: 45.0a1 04:55:26 INFO - mozversion INFO | platform_buildid: 20151125023015 04:55:26 INFO - mozversion INFO | platform_changeset: 80cc747d4e5e64f9e37e2eba98be52fcc772ad19 04:55:26 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 04:55:26 INFO - mozversion INFO | platform_version: 45.0a1 04:55:26 INFO - 2015-11-25 04:55:26,794 DEBUG : using testdate: 1448456126 04:55:26 INFO - 2015-11-25 04:55:26,794 DEBUG : actual date: 1448456126 04:55:26 INFO - 2015-11-25 04:55:26,841 INFO : starting webserver on 'localhost:53245' 04:55:26 INFO - 2015-11-25 04:55:26,842 INFO : Starting test suite talos-linux64-ix-065.e 04:55:26 INFO - 2015-11-25 04:55:26,843 INFO : Starting test dromaeo_css 04:55:26 INFO - 2015-11-25 04:55:26,843 DEBUG : operating with platform_type : linux_ 04:55:26 INFO - 2015-11-25 04:55:26,843 INFO : Initialising browser for dromaeo_css test... 04:55:26 INFO - 2015-11-25 04:55:26,857 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprNwXP7/profile http://localhost:53245/getInfo.html 04:55:31 INFO - 2015-11-25 04:55:31,638 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:55:31 INFO - 2015-11-25 04:55:31,638 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:55:31 INFO - 2015-11-25 04:55:31,638 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:55:31 INFO - 2015-11-25 04:55:31,638 DEBUG : BROWSER_OUTPUT: __metrics 04:55:32 INFO - 2015-11-25 04:55:32,627 INFO : Browser initialized. 04:55:32 INFO - 2015-11-25 04:55:32,627 INFO : Running cycle 1/1 for dromaeo_css test... 04:55:32 INFO - 2015-11-25 04:55:32,628 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprNwXP7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:55:44 INFO - 2015-11-25 04:55:44,358 DEBUG : BROWSER_OUTPUT: RSS: Main: 140476416 04:55:44 INFO - 2015-11-25 04:55:44,358 DEBUG : BROWSER_OUTPUT: 04:56:33 INFO - 2015-11-25 04:56:33,990 DEBUG : BROWSER_OUTPUT: 1448456193988 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] 04:58:42 INFO - 2015-11-25 04:58:42,729 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53245/tests/dromaeo/cssquery-ext.html) 04:58:43 INFO - 2015-11-25 04:58:43,961 DEBUG : BROWSER_OUTPUT: RSS: Main: 148262912 04:58:43 INFO - 2015-11-25 04:58:43,961 DEBUG : BROWSER_OUTPUT: 05:01:45 INFO - 2015-11-25 05:01:45,850 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53245/tests/dromaeo/cssquery-ext.html (next: http://localhost:53245/tests/dromaeo/cssquery-jquery.html) 05:01:46 INFO - 2015-11-25 05:01:46,439 DEBUG : BROWSER_OUTPUT: RSS: Main: 142331904 05:01:46 INFO - 2015-11-25 05:01:46,440 DEBUG : BROWSER_OUTPUT: 05:04:48 INFO - 2015-11-25 05:04:48,116 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53245/tests/dromaeo/cssquery-mootools.html) 05:04:48 INFO - 2015-11-25 05:04:48,705 DEBUG : BROWSER_OUTPUT: RSS: Main: 142819328 05:04:48 INFO - 2015-11-25 05:04:48,705 DEBUG : BROWSER_OUTPUT: 05:07:50 INFO - 2015-11-25 05:07:50,302 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53245/tests/dromaeo/cssquery-prototype.html) 05:07:50 INFO - 2015-11-25 05:07:50,908 DEBUG : BROWSER_OUTPUT: RSS: Main: 142020608 05:07:50 INFO - 2015-11-25 05:07:50,908 DEBUG : BROWSER_OUTPUT: 05:10:53 INFO - 2015-11-25 05:10:53,210 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53245/tests/dromaeo/cssquery-yui.html) 05:10:53 INFO - 2015-11-25 05:10:53,812 DEBUG : BROWSER_OUTPUT: RSS: Main: 142839808 05:10:53 INFO - 2015-11-25 05:10:53,812 DEBUG : BROWSER_OUTPUT: 05:13:56 INFO - 2015-11-25 05:13:56,206 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53245/tests/dromaeo/cssquery-yui.html (next: http://localhost:53245/tests/dromaeo/cssquery-dojo.html) 05:13:56 INFO - 2015-11-25 05:13:56,456 DEBUG : BROWSER_OUTPUT: RSS: Main: 145534976 05:13:56 INFO - 2015-11-25 05:13:56,457 DEBUG : BROWSER_OUTPUT: 05:13:56 INFO - 2015-11-25 05:13:56,457 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:13:56 INFO - 2015-11-25 05:13:56,457 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:13:56 INFO - 2015-11-25 05:13:56,457 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:13:56 INFO - 2015-11-25 05:13:56,457 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:13:56 INFO - 2015-11-25 05:13:56,458 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3219.452693042183;3276.4921437177245;3296.653851345607;3317.1541256979467;3325.634180240175;5257.789688412459;5443.537299329551;5492.148716948869;5529.419410961847;5552.722363881805;5429.778394735003;5456.7544460499275;5528.170774383844;5586.162075688649;5587.938291724569;4873.707577545341;4966.3792025996845;4986.177280748672;5081.28861959326;5115.769790359443;4760.500147484516;5031.11955407804;5076.796928122871;5102.234664800272;5151.381834179903;4864.805407783684;4911.312416261709;4911.9754401227765;4919.360483137187;5004.649674522785;4918.803247870081;4930.087933732271;4939.110960027194;4959.380077490314;4987.900241995139;4889.217725163957;4938.530839570235;4944.184209605411;4959.504049595048;4996.4254110777365;5184.637075404723;5284.365876094893;5299.629025968184;5344;5360.249565060894;5954.4938680212235;5958.493528050121;5964.254468191476;5974.044152935553;5990.7903223386975;5748.16651585522;5981.641101533878;5999.460048595603;6000.8499787505225;6008.038713805814;5495.697736624484;5523.889522209573;5538.6122971391615;5574.219609254707;5582.720863956826;5986.491148252448;5990.940090599038;6032.426919442733;6040.033594624839;6064.120702498113;5628.127640215773;5792.710364481759;5839.795607153729;5843.2403787507355;5860.648361098348;5816.796412125555;5868.178455016301;5912.290525136925;5923.318818335946;5987.401259873977;5898;5910.024845900464;5911.290645122527;5914.201582786355;5920.733566989496;5655.1517272409465;5754.223179870748;5893.734781934823;5910.172575839386;5921.230240068763;4481.574250446202;4527.185106680763;4536.705114167568;4565.452145742533;4573.588377046015;4055.6349928506575;4066.369712694537;4072.1448495815616;4082.1631565528996;4101.364288535282;5501.257330260363;5578.219049333096;5673.092305231144;5680.460356266148;5714.228579141763;5979.970100149471;5999.940000600025;6020.969895150496;6024.4879185268865;6077.1491991121275;5663.32040155184;5678.261825962599;5732.541396688255;5735.741891614887;5745;4975.626827987915;5029.823956161516;5071.41678706946;5150.9227361588855;5213.478652134832;6079.665618391119;6082.330943596201;6086.786962456381;6092.573519853568;6097.878042439126;5910.586258961831;5929.525637948867;5942.435468630473;5952.76188952437;5960.731767070579;5876.08920617305;5967.313758917607;6047.516198704181;6092.2689277285235;6144;5766.826995190151;5782.277215348082;5802.274715660543;5821.330546987151;5861.296644402699;5770.769169233184;5905.114232865105;5906.881862362815;5910.1134829774155;5920.2895652521975;5717;5765.56758243125;5828.912566311424;5832.445917637818;5879.2944846618675;5766;5829.47534721877;5839.678817665069;5840.591158618856;5846.970765146147;5527.640703354269;5649.406812284816;5665;5717.028105222205;5721.170430287668;5684.118961560965;5715.057015592547;5765.91351129725;5872.647641141545;5917.497012753965;5595.444663834546;5647.661140331593;5672.262605861211;5685.488306052475;5704 05:13:56 INFO - 2015-11-25 05:13:56,458 DEBUG : BROWSER_OUTPUT: |1;ext.html;556.7633755653846;569.8831739493406;577.7169187098323;592.9762809487621;595.8212536239129;39193.60806391935;40148.39777403334;40360.39459408104;40509.39235911464;40605.79697101514;42159.156816863644;42442.787786061024;42664;42849.57150428503;42940.926476838096;8518.74443766688;8718.433301835392;8736.737897863042;8760.605772740242;8771.517566533837;8508.31933445326;8515.020772611137;8576.271016963565;8576.828463430727;8578;8537.146285371444;8640.783980400478;8662;8665.956670216672;8666.52334121623;8560.914390856075;8573.099824518398;8631.827363452727;8634.093420190853;8634.784130396727;8489.533075680834;8599.4840309581;8604.5697715114;8627.266682332009;8630.65477380904;39060.60939390598;39336.803315983525;39462.60537394618;39500;39508.407373889415;3201.27971206479;3226.725728313096;3280.0323904448246;3552.5559305086863;3553.0406790166767;28828.279293017844;28999.710002899912;29240.8537957311;29468.705312947026;29522.55716164259;3621.4567814827724;3628.5827129880136;3675.5773086095173;3701.4632878232774;3781.4516895050338;267279;267510.66244668845;269471;269553;269882;49459.75270123698;55323;55494;55581.72209138928;55804.720976394856;47633.28550071752;59877;60071.69964150239;60432.69783651054;60801.39198607957;13505.12216705911;13696.794548081787;13724.382402791898;13768.862311376959;13792.655183620489;11082.667519974413;11099.44502774858;11101.5559377624;11166.330020198815;11187.664370068911;18594.907025464785;18798.436046918614;18873.62252754937;18879.81120188808;18967.81032189688;7615.276548727862;7878.566678832719;7909.367250619936;7910.52536847791;7923.207679232146;876.412803421709;892.3040028777564;978.2076518020426;1025.1644909398817;1045.0751085289573;27980.38767168272;28396.432071358457;28682.282942926595;28797.28006799805;28853.422931541252;1129.9152563557766;1149.1553708024596;1170.1341007654444;1176.8643259254861;1192.8986036186848;14621.78067328991;14792.704145917236;14896.851031489763;15060.171690556905;15114.470993515393;332655;336214;338368;338677;340388;50964.490355096714;51221.743891281054;51366;51505.48494515082;51557.74221128946;1291.5156816193928;1331.8468376136868;1334.0661536924192;1338.7523308188017;1339.5512503311304;26848.59727104056;28101.578476322462;28203;28233.858830705714;29003.854980724962;44196;44333.11333773371;44358.3346249813;44529;44681;215969;216887;216889;217140;217290;29321.85339073291;31256.68743312538;31785.36429271448;31826.52260216145;31979;38384.23231535409;39165.41251881281;39512;39651;39867.2026559473;34759;35305.64694353126;36124.73563425268;36129.27741445104;36207.818960905024;36103.27793444169;36153.63846361608;36255.99936535631;36574.817125914204;36610.63389366179;35352.64647353494;35427.468587971714;35560.46659300164;36064.27871442504;36094;29354;31854.840725796224;32303.676963230067;32663.67336326606;32802.83598581992;24487.51024979526;25043.499130016935;25072.74927250704;25360.619590705785;25448.491030178924 05:13:56 INFO - 2015-11-25 05:13:56,459 DEBUG : BROWSER_OUTPUT: |2;jquery.html;345.5740700284006;347.140826454525;349.8006136502193;352.32705532433056;356.57567494681325;16497.50507484776;17358.566035849093;17821.108944552754;18527.25890964363;18930.390916772074;11262.774744505105;12635.936820315885;16311.510654680349;16355.672886542263;16452.83547164528;4717.433907931053;4887.364642596457;4903.950960490385;4907.2148456247005;4924.064427758733;4880.316755654211;4908.190148625473;5065.189569668853;5472.1244600863865;5472.753726082316;5108.5913126949945;5300.363956325246;5328.893422131555;5403.135498320269;5453.481919217668;5293.470652934695;5304.230886521452;5304.549113325372;5329.813456529022;5341.305630268079;5253.605979551511;5281.445448227919;5299.814506492293;5348.812791552277;5360.865978350573;12367.07246956473;12816.231026138368;12830.679233019157;12875.227486350848;13154.013448991363;2140.069069954575;2221.1892659179284;2241.7197850268717;2248.8650680959195;2257.0294773247497;9603.32776705631;9693.369930954465;9724.513774311255;9845.901540984642;9906.455144967023;1743.4246698589436;1813.519417354402;1816.7184086466618;1842.649896519657;1898.9935334272857;62511;67172;69863.65068174627;70744.6462767688;71629;15122.243887805565;16297.34810607586;16326.34694612226;16344.673106537803;16401.58996025109;23476.64785028226;23478.765212348;23737.287881363587;23753.40616484567;23821.523569528857;8865.157810008039;8887.244584210286;8941.46351218929;9057.139571740674;9312.068793120634;7496.812579685551;7568.205338439495;7605.733799316998;7636.961815190888;7678.424118191047;7977.561234132062;8031.277185053374;8032.236937490929;8049.315808156372;8063.516189028677;1885.651154536415;3199.2481766784786;3199.9200019999685;3229.0797122819886;3365.0746044837374;917.9173874351341;932.7854593443546;1014.7108074198818;1025.5333823110466;1059.443792009186;15879.206039697969;16199.43301984425;16402.507924762278;16823.747643785355;17065.14674266282;865.2040123086775;886.3972498700946;914.9359544831931;915.4232833314969;921.9815603687889;9825.950870245746;10082.294239403318;10090.44502552352;10099.69700908974;10232.744181395376;575675;576193;582161;590745;591284;81185;83497.58251208827;84034;84055;85010;1112.165875593305;1148.5692865175558;1148.655403378983;1154.1113342726053;1160.5589875847124;15178.620534486285;15399.461018864286;15403.76894346608;15457.690846183239;15601.375944962074;36231;36468.635313646526;37252.39233253646;37254.44118338173;37325.253494929406;47539.52460475489;48094.519054809;49053.754731226116;49352.50647493479;50390;9306.022867599075;9611.086946740048;9690.418574885529;9699.418034917928;9743.074407931235;11256.380899050631;11302.321860688386;11359.602413915472;16396.672066558363;17438.651226975137;11385.487653055798;13832.930835345758;14626.488072917822;14886.77669834975;15121;14706.55880323592;14833.703325933637;14858.777118343018;15285.770713439086;15416.46042388511;15274;15345.309461074501;15504.83713721498;15728.528144155694;15849.286782095063;9732.12410883024;9784.706458806248;9983.400995940267;9987.500624968869;10044.698659040241;10289.228307876789;12860.549880754128;15118.319675614845;15164.469243576863;15367.692646147238 05:13:56 INFO - 2015-11-25 05:13:56,460 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1486.0340778493985;1698.3206717313074;1738.5219064757193;1741.8258174182583;1747.0653200537715;6655.767048153316;6679.265280819106;7000.439964802817;7430.07124109487;7437.55374677519;7029.121359830021;7199.460040496958;7206.747763828267;7263.963680181605;7295.8540829183385;2190.9561808763815;2206.249875042485;2214.512807182425;2219.4784225707026;2221.2891874600136;2227.8329125315668;2266.5353602511445;2294.403455101677;2296.781805728453;2297.8506397084134;2197.8131858791944;2202.6475763877784;2235.0277629231337;2241.3276017194858;2250.7524172341027;2208.536207396449;2222.533268013719;2237.5748607764554;2251.594712951668;2252.560750653623;2245.36007237938;2258.7967082962614;2264.501809601885;2274.1130958926033;2278.829087818404;7418.703251869919;7432.7026918923175;7483.850322993564;7498.962505187439;7504.774856754306;4481.103779244164;4533.637309015271;4557.134144512532;4569.908601827978;4577.084583083363;2858.9142325730263;2951.719586639266;2964.659064207622;2991.1774262077884;3000.339925216449;986.6743974488402;987.5111819649247;995.6067353395441;1010.525053224983;1026.4816267784795;10117.797644047152;10144.137748291405;10178.541965611565;10181.592736290539;10199.33704309225;4099.7745124017865;4100;4148.0666849959125;4159.188958153191;4173.1862286854375;8638.956805215934;8669.956650216709;8685.522296273766;8709.085546017704;8717.65129394817;4529.026259354255;4530;4535.047639995638;4559.338895860082;4559.772011399483;3710.7588006779474;3794.6395092466173;4139.0480189555965;4219.303814870512;4228.936565951513;3610.476480910306;3639;3668.1013151777984;3698.7780733156096;3707.3141468828353;1223.4005337384617;1237.2514628649717;1239.1883316427754;1241.2552468518998;1246.7755803955374;1030.9123724483502;1034.736142283728;1040.8230600797883;1189.3636904256182;1344.5294147048455;6899.896501552481;6976.511644184859;6981.0924579804305;7029.22678505364;7087.184973728087;485.52418629742346;488.679914655901;492.1780626353997;492.52471365132817;495.4401526275358;5573.888522229533;5573.888522229533;5601.411851755507;5610.354809196913;5618.775248989995;8507.61715722794;8508.361872859561;8802.559872006374;8861.202491775643;8892.59983300753;8616;8639.95680021596;8647.783805404915;8656.220940115294;8684.43551169172;6922.307769223037;6983.965080174668;6988;7035.894461583081;7054.188768291712;6793.354631310018;6824.624645644537;6834.692438840363;6838.042674025541;6888.48336374784;7653.770386888402;7809.4142939278645;7864.4888082274465;7878.881816772639;7996.800079998046;7913.248241417056;7940.920590794018;7954.085280192852;7955.443118981616;7977.920220797718;6315.55791094619;6533.41199292066;6578.210614726264;6588.670566471753;6643.60138391698;7155.642217889189;7207.71169153228;7250.673719682522;7253.310935461122;7257;6633.568818026813;6886.311368863074;6928.584284942919;6930.203026652;7023;6693.397594216543;6796.35434633709;6885.518013739191;6895.931040689529;6898.620575868375;6683.598984060972;6707.865842683216;6870.62211578368;6911.723531058902;6998.965005174941;6267.9373206267355;6280.905786413299;6305.4009869062365;6312.779052733133;6318.210223722035;6452;6464.321246269074;6471.094046833541;6477.4494167996245;6533.118029066015 05:13:56 INFO - 2015-11-25 05:13:56,461 DEBUG : BROWSER_OUTPUT: |4;prototype.html;311.1428015816425;315.5550673550294;321.3556818578749;323.10655128085136;324.7742818740973;6264.185655864737;6350.206224221973;6353.761016601765;6378.234611846579;6510.80467585972;6302.369763023696;6328;6354.809355719324;6355.8411039723915;6370.713317900694;4631.861044168681;4755.239161734124;4769.427668679763;4770.2606096055;4778.641601879855;4764.190087685084;4771.737554434505;4780.378550788392;4788.88027799306;4791.712497250159;4714.693544919586;4719.575238228559;4721.7639118044135;4723.811047558111;4736.123817093831;4723.267893476499;4733.124371991193;4735.834245801415;4741.146593613148;4749.287606858964;3981.144054028398;4083.571225021389;4085.8569950051606;4087.0395457067566;4087.97956010221;5967.6121052131475;5969.074793406985;5977.342492325841;5983.850403739898;5993.700314984277;5479.3424789025175;5482.314710661168;5484.2596249506605;5492.423295553989;5492.945070549284;6494.870102597969;6627.569208001464;6629.900551491732;6638.5684930479365;6646.202455705346;4451.688381813275;4500.729956202638;4501.482329532113;4508.391367165424;4517.9774101129615;6784.898226526606;6901.75843845468;6938.895916561256;6949.791506254821;6958.721651133898;4658.440987081572;4670.369500117441;4673.345731597579;4685.1800934836265;4688.718676879398;4647.837325693585;4725.9366642505165;4739;4751.738654373973;4754.381930349102;5493.066178749622;5509.972450137804;5510.008198524304;5517.227588137664;5522.2544956431175;6725.697343619451;6736.326367363225;6736.865262694719;6737.427318677967;6742.696578653874;1664.592174917153;1686.5277722237793;1688.4343744845614;1693.0772728862798;1694.5848267174622;1084.7830433913248;1093.3494570730402;1097.2922465010024;1111.8109921313396;1123.8258069999163;6423.74305027803;6515.348465153542;6519.674016299166;6534.379233972765;6605.976073708583;7036.366726994595;7047.660944420543;7051.153861536648;7055.541389809749;7066.646667666699;6562.179727534059;6598.076269322299;6612.041254018237;6621.039949207338;6625.701843417058;3736.1593641431004;3794.4687743715904;3834.7890866002635;3841.1741475582885;3843.5195600549932;7259.600721960237;7267.491275610762;7276.417886569062;7278.672459739324;7285.417166626763;7151.678174482161;7190.101237345332;7222.638868056576;7224.241454647292;7228.963855180796;7063.117110361205;7199.460040496983;7232.312930271721;7271.563706177646;7287.927120728831;7022.2275549688475;7024.964875175591;7029.05107810439;7049.541779784297;7056.259092795388;6880.518363714692;6901.275366086689;6927.618980956096;6943.861122777415;6971.477139214478;7088.929110708827;7249.275072492708;7260.818479538054;7266.491345605757;7273.709051638087;4643.814247430065;4702.717836929795;4702.76486175683;4702.952970470252;4705.529447055267;6889.517733758589;6980.581165130108;7003.894941575983;7014.228434872058;7029.051078104595;6652.368025037614;6794.150731158606;6795.626240556817;6804.659767011729;6816.829579260559;6719.664016799043;6759.155105611799;6774.695138718671;6783.728650853911;6783.762568310085;6510.804675859732;6639.269680335063;6642.767503137367;6646.302138275411;6649.335066493312;6663.333666633298;6776.186857577122;6846.863062738617;6852.965735171292;6872.759453419107;6514.706838192387;6622.403983641495;6626.403623673892;6647.5014373921185;6655 05:13:56 INFO - 2015-11-25 05:13:56,462 DEBUG : BROWSER_OUTPUT: |5;yui.html;737.7749786315175;738.2433006168677;804.8913396691445;843.2242337049912;849.7110982266029;12772.744545109092;12998.41507132179;13064.281464519436;13078.542251021216;13121.803172952414;13074.934625326883;13256.072074954756;13366.19802811832;13692.383842727077;13814.240216788072;821.6590115102225;827.6813426830653;829.5478963964623;833.9617176615122;836.3100442135233;826.8594338962391;836.5022811427191;837.736113124367;837.8073043200068;838.0278876503257;868.179570306061;873.1574031060026;876.3514998900831;877.6971944679076;879.1560102301798;866.7226487523994;867.7787164273133;870.0559892516627;870.6778491957984;871.1071152069117;635.9570304700295;637.5377851057946;638.4892086330963;640.2509064394669;642.3223499208333;12193.329366884907;12327.075469339836;12378.257304561756;12421.1926224796;12426.130170888042;10829.404382758945;11044.392558409285;11108;11233.006920997641;11247.66257012291;9606.807863842754;9826.339287936347;10018.499075046218;10072.597096116147;10187.439690817002;3462.515247865301;3472.44440889459;3508.8947331580093;3522.3131489359585;3533.434650455915;48064.519354806354;48370.516294836954;48386.51613483891;48497.75751121257;48507.272390914164;8057.717979870794;8221.260086592236;8359.8328033439;8462.788430289293;8479.95760021196;16839.91580042092;16844.831551684572;16872.24074916607;16982.660346792996;17052.2326495308;7251.419886409075;7384.4830861839155;7461.888071678929;7560.281773231534;7625.6568454419685;4024.476818013698;4155.168966206771;4169.353750168729;4169.708120431601;4189.366147202593;2881.8270903745424;2903.5209190483756;2909.854507274628;2921.8750780949485;2925.414917016605;476.5115756349769;495.83141731811355;496.78389900393444;500.5995203836916;504.9899002019939;507.7359772918062;565.7341049706631;609.7987664070846;646.6831252686244;673.1114928294604;8461.873071903927;8728.345374096969;8731.301495880314;8854.29165666745;8874.467531948103;657.6777379084215;668.6489592963636;670.1388715500558;685.3591891581387;700.3906601256939;3561.5013898054294;3831.1746226798537;3898.278818418545;3907;3947.1513624570857;59000;59321.40678593159;59533.40466595279;59733.70133149393;60191;51903.221451678255;52604.736976314874;53023;53496.73251633795;54014.45985540173;47551.28673069907;48039.75980120147;49567.256491152664;50149.24776128361;50795.746021270395;8400.705975291079;8447.408681392244;8546.401751877309;8546.658133674584;8897.110288971051;34011.48982765211;34336.48495272523;34862;36167.27665446624;36347.45478817873;43347.34978975381;43439.56560434355;44555;45957.31064034109;47179;10375.844362334721;10934.617288394868;11186.944065279622;11688.18182727235;11759.47082381312;12120.33338166374;12155.392230388623;12247.69380765488;12628.368581570701;13108.737825243632;11033.834492482458;11366.772664546828;11557;11934.582289619822;12390.81413778776;11621.186516943733;11886.940565297464;12018.459169337226;12024.819627705767;12415.37923103823;10602.045815876609;10643.680689579325;10726.570937162425;10849.511771970438;11160.274582152135;9807.656732014346;9918.652847150604;10016.499175041365;10156.847647285444;10381.273310868166;9183.770405739642;9440.575174117044;9450.196733277473;9702.9029709702;9963.50182490858 05:13:56 INFO - 2015-11-25 05:13:56,462 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:13:56 INFO - 2015-11-25 05:13:56,462 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:13:56 INFO - 2015-11-25 05:13:56,462 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,300 05:13:56 INFO - 2015-11-25 05:13:56,462 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:13:56 INFO - 2015-11-25 05:13:56,462 DEBUG : BROWSER_OUTPUT: __startTimestamp1448457236453__endTimestamp 05:13:56 INFO - 2015-11-25 05:13:56,463 DEBUG : BROWSER_OUTPUT: 05:13:56 INFO - 2015-11-25 05:13:56,463 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:13:56 INFO - 2015-11-25 05:13:56,463 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:13:56 INFO - 2015-11-25 05:13:56,463 DEBUG : BROWSER_OUTPUT: 05:13:56 INFO - 2015-11-25 05:13:56,463 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5480.41 Median:5714.23 stddev:618.44 (10.8%) stddev-sans-first:594.36 05:13:56 INFO - 2015-11-25 05:13:56,463 DEBUG : BROWSER_OUTPUT: Values: 3219.5 3276.5 3296.7 3317.2 3325.6 5257.8 5443.5 5492.1 5529.4 5552.7 5429.8 5456.8 5528.2 5586.2 5587.9 4873.7 4966.4 4986.2 5081.3 5115.8 4760.5 5031.1 5076.8 5102.2 5151.4 4864.8 4911.3 4912.0 4919.4 5004.6 4918.8 4930.1 4939.1 4959.4 4987.9 4889.2 4938.5 4944.2 4959.5 4996.4 5184.6 5284.4 5299.6 5344.0 5360.2 5954.5 5958.5 5964.3 5974.0 5990.8 5748.2 5981.6 5999.5 6000.8 6008.0 5495.7 5523.9 5538.6 5574.2 5582.7 5986.5 5990.9 6032.4 6040.0 6064.1 5628.1 5792.7 5839.8 5843.2 5860.6 5816.8 5868.2 5912.3 5923.3 5987.4 5898.0 5910.0 5911.3 5914.2 5920.7 5655.2 5754.2 5893.7 5910.2 5921.2 4481.6 4527.2 4536.7 4565.5 4573.6 4055.6 4066.4 4072.1 4082.2 4101.4 5501.3 5578.2 5673.1 5680.5 5714.2 5980.0 5999.9 6021.0 6024.5 6077.1 5663.3 5678.3 5732.5 5735.7 5745.0 4975.6 5029.8 5071.4 5150.9 5213.5 6079.7 6082.3 6086.8 6092.6 6097.9 5910.6 5929.5 5942.4 5952.8 5960.7 5876.1 5967.3 6047.5 6092.3 6144.0 5766.8 5782.3 5802.3 5821.3 5861.3 5770.8 5905.1 5906.9 5910.1 5920.3 5717.0 5765.6 5828.9 5832.4 5879.3 5766.0 5829.5 5839.7 5840.6 5847.0 5527.6 5649.4 5665.0 5717.0 5721.2 5684.1 5715.1 5765.9 5872.6 5917.5 5595.4 5647.7 5672.3 5685.5 5704.0 05:13:56 INFO - 2015-11-25 05:13:56,463 DEBUG : BROWSER_OUTPUT: 05:13:56 INFO - 2015-11-25 05:13:56,463 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44288.35 Median:36127.01 stddev:72875.39 (201.7%) stddev-sans-first:73005.85 05:13:56 INFO - 2015-11-25 05:13:56,464 DEBUG : BROWSER_OUTPUT: Values: 556.8 569.9 577.7 593.0 595.8 39193.6 40148.4 40360.4 40509.4 40605.8 42159.2 42442.8 42664.0 42849.6 42940.9 8518.7 8718.4 8736.7 8760.6 8771.5 8508.3 8515.0 8576.3 8576.8 8578.0 8537.1 8640.8 8662.0 8666.0 8666.5 8560.9 8573.1 8631.8 8634.1 8634.8 8489.5 8599.5 8604.6 8627.3 8630.7 39060.6 39336.8 39462.6 39500.0 39508.4 3201.3 3226.7 3280.0 3552.6 3553.0 28828.3 28999.7 29240.9 29468.7 29522.6 3621.5 3628.6 3675.6 3701.5 3781.5 267279.0 267510.7 269471.0 269553.0 269882.0 49459.8 55323.0 55494.0 55581.7 55804.7 47633.3 59877.0 60071.7 60432.7 60801.4 13505.1 13696.8 13724.4 13768.9 13792.7 11082.7 11099.4 11101.6 11166.3 11187.7 18594.9 18798.4 18873.6 18879.8 18967.8 7615.3 7878.6 7909.4 7910.5 7923.2 876.4 892.3 978.2 1025.2 1045.1 27980.4 28396.4 28682.3 28797.3 28853.4 1129.9 1149.2 1170.1 1176.9 1192.9 14621.8 14792.7 14896.9 15060.2 15114.5 332655.0 336214.0 338368.0 338677.0 340388.0 50964.5 51221.7 51366.0 51505.5 51557.7 1291.5 1331.8 1334.1 1338.8 1339.6 26848.6 28101.6 28203.0 28233.9 29003.9 44196.0 44333.1 44358.3 44529.0 44681.0 215969.0 216887.0 216889.0 217140.0 217290.0 29321.9 31256.7 31785.4 31826.5 31979.0 38384.2 39165.4 39512.0 39651.0 39867.2 34759.0 35305.6 36124.7 36129.3 36207.8 36103.3 36153.6 36256.0 36574.8 36610.6 35352.6 35427.5 35560.5 36064.3 36094.0 29354.0 31854.8 32303.7 32663.7 32802.8 24487.5 25043.5 25072.7 25360.6 25448.5 05:13:56 INFO - 2015-11-25 05:13:56,465 DEBUG : BROWSER_OUTPUT: 05:13:56 INFO - 2015-11-25 05:13:56,465 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30833.74 Median:351.06 stddev:95309.42 (27148.7%) stddev-sans-first:95549.30 05:13:56 INFO - 2015-11-25 05:13:56,466 DEBUG : BROWSER_OUTPUT: Values: 345.6 347.1 349.8 352.3 356.6 16497.5 17358.6 17821.1 18527.3 18930.4 11262.8 12635.9 16311.5 16355.7 16452.8 4717.4 4887.4 4904.0 4907.2 4924.1 4880.3 4908.2 5065.2 5472.1 5472.8 5108.6 5300.4 5328.9 5403.1 5453.5 5293.5 5304.2 5304.5 5329.8 5341.3 5253.6 5281.4 5299.8 5348.8 5360.9 12367.1 12816.2 12830.7 12875.2 13154.0 2140.1 2221.2 2241.7 2248.9 2257.0 9603.3 9693.4 9724.5 9845.9 9906.5 1743.4 1813.5 1816.7 1842.6 1899.0 62511.0 67172.0 69863.7 70744.6 71629.0 15122.2 16297.3 16326.3 16344.7 16401.6 23476.6 23478.8 23737.3 23753.4 23821.5 8865.2 8887.2 8941.5 9057.1 9312.1 7496.8 7568.2 7605.7 7637.0 7678.4 7977.6 8031.3 8032.2 8049.3 8063.5 1885.7 3199.2 3199.9 3229.1 3365.1 917.9 932.8 1014.7 1025.5 1059.4 15879.2 16199.4 16402.5 16823.7 17065.1 865.2 886.4 914.9 915.4 922.0 9826.0 10082.3 10090.4 10099.7 10232.7 575675.0 576193.0 582161.0 590745.0 591284.0 81185.0 83497.6 84034.0 84055.0 85010.0 1112.2 1148.6 1148.7 1154.1 1160.6 15178.6 15399.5 15403.8 15457.7 15601.4 36231.0 36468.6 37252.4 37254.4 37325.3 47539.5 48094.5 49053.8 49352.5 50390.0 9306.0 9611.1 9690.4 9699.4 9743.1 11256.4 11302.3 11359.6 16396.7 17438.7 11385.5 13832.9 14626.5 14886.8 15121.0 14706.6 14833.7 14858.8 15285.8 15416.5 15274.0 15345.3 15504.8 15728.5 15849.3 9732.1 9784.7 9983.4 9987.5 10044.7 10289.2 12860.5 15118.3 15164.5 15367.7 05:13:56 INFO - 2015-11-25 05:13:56,466 DEBUG : BROWSER_OUTPUT: 05:13:56 INFO - 2015-11-25 05:13:56,467 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5217.35 Median:6314.17 stddev:2661.27 (42.1%) stddev-sans-first:2653.95 05:13:56 INFO - 2015-11-25 05:13:56,467 DEBUG : BROWSER_OUTPUT: Values: 1486.0 1698.3 1738.5 1741.8 1747.1 6655.8 6679.3 7000.4 7430.1 7437.6 7029.1 7199.5 7206.7 7264.0 7295.9 2191.0 2206.2 2214.5 2219.5 2221.3 2227.8 2266.5 2294.4 2296.8 2297.9 2197.8 2202.6 2235.0 2241.3 2250.8 2208.5 2222.5 2237.6 2251.6 2252.6 2245.4 2258.8 2264.5 2274.1 2278.8 7418.7 7432.7 7483.9 7499.0 7504.8 4481.1 4533.6 4557.1 4569.9 4577.1 2858.9 2951.7 2964.7 2991.2 3000.3 986.7 987.5 995.6 1010.5 1026.5 10117.8 10144.1 10178.5 10181.6 10199.3 4099.8 4100.0 4148.1 4159.2 4173.2 8639.0 8670.0 8685.5 8709.1 8717.7 4529.0 4530.0 4535.0 4559.3 4559.8 3710.8 3794.6 4139.0 4219.3 4228.9 3610.5 3639.0 3668.1 3698.8 3707.3 1223.4 1237.3 1239.2 1241.3 1246.8 1030.9 1034.7 1040.8 1189.4 1344.5 6899.9 6976.5 6981.1 7029.2 7087.2 485.5 488.7 492.2 492.5 495.4 5573.9 5573.9 5601.4 5610.4 5618.8 8507.6 8508.4 8802.6 8861.2 8892.6 8616.0 8640.0 8647.8 8656.2 8684.4 6922.3 6984.0 6988.0 7035.9 7054.2 6793.4 6824.6 6834.7 6838.0 6888.5 7653.8 7809.4 7864.5 7878.9 7996.8 7913.2 7940.9 7954.1 7955.4 7977.9 6315.6 6533.4 6578.2 6588.7 6643.6 7155.6 7207.7 7250.7 7253.3 7257.0 6633.6 6886.3 6928.6 6930.2 7023.0 6693.4 6796.4 6885.5 6895.9 6898.6 6683.6 6707.9 6870.6 6911.7 6999.0 6267.9 6280.9 6305.4 6312.8 6318.2 6452.0 6464.3 6471.1 6477.4 6533.1 05:13:56 INFO - 2015-11-25 05:13:56,467 DEBUG : BROWSER_OUTPUT: 05:13:56 INFO - 2015-11-25 05:13:56,467 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5613.71 Median:6502.84 stddev:1733.00 (26.6%) stddev-sans-first:1691.54 05:13:56 INFO - 2015-11-25 05:13:56,467 DEBUG : BROWSER_OUTPUT: Values: 311.1 315.6 321.4 323.1 324.8 6264.2 6350.2 6353.8 6378.2 6510.8 6302.4 6328.0 6354.8 6355.8 6370.7 4631.9 4755.2 4769.4 4770.3 4778.6 4764.2 4771.7 4780.4 4788.9 4791.7 4714.7 4719.6 4721.8 4723.8 4736.1 4723.3 4733.1 4735.8 4741.1 4749.3 3981.1 4083.6 4085.9 4087.0 4088.0 5967.6 5969.1 5977.3 5983.9 5993.7 5479.3 5482.3 5484.3 5492.4 5492.9 6494.9 6627.6 6629.9 6638.6 6646.2 4451.7 4500.7 4501.5 4508.4 4518.0 6784.9 6901.8 6938.9 6949.8 6958.7 4658.4 4670.4 4673.3 4685.2 4688.7 4647.8 4725.9 4739.0 4751.7 4754.4 5493.1 5510.0 5510.0 5517.2 5522.3 6725.7 6736.3 6736.9 6737.4 6742.7 1664.6 1686.5 1688.4 1693.1 1694.6 1084.8 1093.3 1097.3 1111.8 1123.8 6423.7 6515.3 6519.7 6534.4 6606.0 7036.4 7047.7 7051.2 7055.5 7066.6 6562.2 6598.1 6612.0 6621.0 6625.7 3736.2 3794.5 3834.8 3841.2 3843.5 7259.6 7267.5 7276.4 7278.7 7285.4 7151.7 7190.1 7222.6 7224.2 7229.0 7063.1 7199.5 7232.3 7271.6 7287.9 7022.2 7025.0 7029.1 7049.5 7056.3 6880.5 6901.3 6927.6 6943.9 6971.5 7088.9 7249.3 7260.8 7266.5 7273.7 4643.8 4702.7 4702.8 4703.0 4705.5 6889.5 6980.6 7003.9 7014.2 7029.1 6652.4 6794.2 6795.6 6804.7 6816.8 6719.7 6759.2 6774.7 6783.7 6783.8 6510.8 6639.3 6642.8 6646.3 6649.3 6663.3 6776.2 6846.9 6853.0 6872.8 6514.7 6622.4 6626.4 6647.5 6655.0 05:13:56 INFO - 2015-11-25 05:13:56,467 DEBUG : BROWSER_OUTPUT: 05:13:56 INFO - 2015-11-25 05:13:56,467 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13852.72 Median:48378.52 stddev:16442.57 (34.0%) stddev-sans-first:16459.20 05:13:56 INFO - 2015-11-25 05:13:56,469 DEBUG : BROWSER_OUTPUT: Values: 737.8 738.2 804.9 843.2 849.7 12772.7 12998.4 13064.3 13078.5 13121.8 13074.9 13256.1 13366.2 13692.4 13814.2 821.7 827.7 829.5 834.0 836.3 826.9 836.5 837.7 837.8 838.0 868.2 873.2 876.4 877.7 879.2 866.7 867.8 870.1 870.7 871.1 636.0 637.5 638.5 640.3 642.3 12193.3 12327.1 12378.3 12421.2 12426.1 10829.4 11044.4 11108.0 11233.0 11247.7 9606.8 9826.3 10018.5 10072.6 10187.4 3462.5 3472.4 3508.9 3522.3 3533.4 48064.5 48370.5 48386.5 48497.8 48507.3 8057.7 8221.3 8359.8 8462.8 8480.0 16839.9 16844.8 16872.2 16982.7 17052.2 7251.4 7384.5 7461.9 7560.3 7625.7 4024.5 4155.2 4169.4 4169.7 4189.4 2881.8 2903.5 2909.9 2921.9 2925.4 476.5 495.8 496.8 500.6 505.0 507.7 565.7 609.8 646.7 673.1 8461.9 8728.3 8731.3 8854.3 8874.5 657.7 668.6 670.1 685.4 700.4 3561.5 3831.2 3898.3 3907.0 3947.2 59000.0 59321.4 59533.4 59733.7 60191.0 51903.2 52604.7 53023.0 53496.7 54014.5 47551.3 48039.8 49567.3 50149.2 50795.7 8400.7 8447.4 8546.4 8546.7 8897.1 34011.5 34336.5 34862.0 36167.3 36347.5 43347.3 43439.6 44555.0 45957.3 47179.0 10375.8 10934.6 11186.9 11688.2 11759.5 12120.3 12155.4 12247.7 12628.4 13108.7 11033.8 11366.8 11557.0 11934.6 12390.8 11621.2 11886.9 12018.5 12024.8 12415.4 10602.0 10643.7 10726.6 10849.5 11160.3 9807.7 9918.7 10016.5 10156.8 10381.3 9183.8 9440.6 9450.2 9702.9 9963.5 05:13:56 INFO - 2015-11-25 05:13:56,469 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:13:56 INFO - 2015-11-25 05:13:56,469 DEBUG : BROWSER_OUTPUT: 05:13:57 INFO - 2015-11-25 05:13:57,151 INFO : Browser exited with error code: 0 05:13:57 INFO - 2015-11-25 05:13:57,172 INFO : Completed test dromaeo_css (00:18:30) 05:13:57 INFO - 2015-11-25 05:13:57,172 INFO : Starting test kraken 05:13:57 INFO - 2015-11-25 05:13:57,172 DEBUG : operating with platform_type : linux_ 05:13:57 INFO - 2015-11-25 05:13:57,173 INFO : Initialising browser for kraken test... 05:13:57 INFO - 2015-11-25 05:13:57,179 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKbpiyL/profile http://localhost:53245/getInfo.html 05:14:01 INFO - 2015-11-25 05:14:01,864 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:14:01 INFO - 2015-11-25 05:14:01,864 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:14:01 INFO - 2015-11-25 05:14:01,865 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:14:01 INFO - 2015-11-25 05:14:01,865 DEBUG : BROWSER_OUTPUT: __metrics 05:14:02 INFO - 2015-11-25 05:14:02,895 INFO : Browser initialized. 05:14:02 INFO - 2015-11-25 05:14:02,895 INFO : Running cycle 1/1 for kraken test... 05:14:02 INFO - 2015-11-25 05:14:02,896 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKbpiyL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:14:14 INFO - 2015-11-25 05:14:14,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 138649600 05:14:14 INFO - 2015-11-25 05:14:14,640 DEBUG : BROWSER_OUTPUT: 05:14:17 INFO - 2015-11-25 05:14:17,141 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53245/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53245/tests/kraken/driver.html?testName=audio-beat-detection) 05:14:17 INFO - 2015-11-25 05:14:17,747 DEBUG : BROWSER_OUTPUT: RSS: Main: 140632064 05:14:17 INFO - 2015-11-25 05:14:17,747 DEBUG : BROWSER_OUTPUT: 05:14:20 INFO - 2015-11-25 05:14:20,412 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53245/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53245/tests/kraken/driver.html?testName=audio-dft) 05:14:21 INFO - 2015-11-25 05:14:21,018 DEBUG : BROWSER_OUTPUT: RSS: Main: 141275136 05:14:21 INFO - 2015-11-25 05:14:21,018 DEBUG : BROWSER_OUTPUT: 05:14:23 INFO - 2015-11-25 05:14:23,858 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53245/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53245/tests/kraken/driver.html?testName=audio-fft) 05:14:24 INFO - 2015-11-25 05:14:24,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 136515584 05:14:24 INFO - 2015-11-25 05:14:24,431 DEBUG : BROWSER_OUTPUT: 05:14:26 INFO - 2015-11-25 05:14:26,544 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53245/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53245/tests/kraken/driver.html?testName=audio-oscillator) 05:14:27 INFO - 2015-11-25 05:14:27,154 DEBUG : BROWSER_OUTPUT: RSS: Main: 137072640 05:14:27 INFO - 2015-11-25 05:14:27,154 DEBUG : BROWSER_OUTPUT: 05:14:29 INFO - 2015-11-25 05:14:29,393 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53245/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53245/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:14:29 INFO - 2015-11-25 05:14:29,967 DEBUG : BROWSER_OUTPUT: RSS: Main: 137256960 05:14:29 INFO - 2015-11-25 05:14:29,967 DEBUG : BROWSER_OUTPUT: 05:14:33 INFO - 2015-11-25 05:14:33,028 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53245/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53245/tests/kraken/driver.html?testName=imaging-darkroom) 05:14:33 INFO - 2015-11-25 05:14:33,609 DEBUG : BROWSER_OUTPUT: RSS: Main: 137904128 05:14:33 INFO - 2015-11-25 05:14:33,609 DEBUG : BROWSER_OUTPUT: 05:14:36 INFO - 2015-11-25 05:14:36,980 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53245/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53245/tests/kraken/driver.html?testName=imaging-desaturate) 05:14:37 INFO - 2015-11-25 05:14:37,586 DEBUG : BROWSER_OUTPUT: RSS: Main: 138244096 05:14:37 INFO - 2015-11-25 05:14:37,586 DEBUG : BROWSER_OUTPUT: 05:14:40 INFO - 2015-11-25 05:14:40,376 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53245/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53245/tests/kraken/driver.html?testName=json-parse-financial) 05:14:40 INFO - 2015-11-25 05:14:40,962 DEBUG : BROWSER_OUTPUT: RSS: Main: 138473472 05:14:40 INFO - 2015-11-25 05:14:40,962 DEBUG : BROWSER_OUTPUT: 05:14:42 INFO - 2015-11-25 05:14:42,550 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53245/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53245/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:14:43 INFO - 2015-11-25 05:14:43,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 137277440 05:14:43 INFO - 2015-11-25 05:14:43,133 DEBUG : BROWSER_OUTPUT: 05:14:44 INFO - 2015-11-25 05:14:44,982 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53245/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53245/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:14:45 INFO - 2015-11-25 05:14:45,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 138653696 05:14:45 INFO - 2015-11-25 05:14:45,596 DEBUG : BROWSER_OUTPUT: 05:14:47 INFO - 2015-11-25 05:14:47,689 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53245/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53245/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:14:48 INFO - 2015-11-25 05:14:48,275 DEBUG : BROWSER_OUTPUT: RSS: Main: 138645504 05:14:48 INFO - 2015-11-25 05:14:48,275 DEBUG : BROWSER_OUTPUT: 05:14:50 INFO - 2015-11-25 05:14:50,751 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53245/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:14:51 INFO - 2015-11-25 05:14:51,336 DEBUG : BROWSER_OUTPUT: RSS: Main: 138539008 05:14:51 INFO - 2015-11-25 05:14:51,336 DEBUG : BROWSER_OUTPUT: 05:14:53 INFO - 2015-11-25 05:14:53,952 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:14:54 INFO - 2015-11-25 05:14:54,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 138309632 05:14:54 INFO - 2015-11-25 05:14:54,538 DEBUG : BROWSER_OUTPUT: 05:14:56 INFO - 2015-11-25 05:14:56,212 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53245/tests/kraken/driver.html?testName=ai-astar) 05:14:56 INFO - 2015-11-25 05:14:56,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 137646080 05:14:56 INFO - 2015-11-25 05:14:56,471 DEBUG : BROWSER_OUTPUT: 05:14:56 INFO - 2015-11-25 05:14:56,471 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:14:56 INFO - 2015-11-25 05:14:56,471 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:14:56 INFO - 2015-11-25 05:14:56,471 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:14:56 INFO - 2015-11-25 05:14:56,471 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:14:56 INFO - 2015-11-25 05:14:56,471 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;107;113;111;113;123;110;112;113;111 05:14:56 INFO - 2015-11-25 05:14:56,471 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;163;125;152;168;126;162;150;126;165;127 05:14:56 INFO - 2015-11-25 05:14:56,471 DEBUG : BROWSER_OUTPUT: |2;audio-dft;165;162;162;164;161;162;161;163;172;169 05:14:56 INFO - 2015-11-25 05:14:56,471 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;71;72;72;71;70;138;72;72 05:14:56 INFO - 2015-11-25 05:14:56,471 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;95;144;93;93;94;134;93;93;145 05:14:56 INFO - 2015-11-25 05:14:56,471 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;111;110;109;112;110;112;110 05:14:56 INFO - 2015-11-25 05:14:56,471 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;146;147;148;147;146;147;147;146 05:14:56 INFO - 2015-11-25 05:14:56,471 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;96;96;98;96;96;96;96;96 05:14:56 INFO - 2015-11-25 05:14:56,472 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;63;61;62;60;61;62;62;59;59 05:14:56 INFO - 2015-11-25 05:14:56,472 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;74;70;70;70;70;71;70;70;69;69 05:14:56 INFO - 2015-11-25 05:14:56,472 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;87;87;87;96;84;85;85;90;85 05:14:56 INFO - 2015-11-25 05:14:56,472 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;121;131;120;122;123;125;132;128;130 05:14:56 INFO - 2015-11-25 05:14:56,472 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;154;150;164;151;153;153;150;151;151 05:14:56 INFO - 2015-11-25 05:14:56,472 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;72;69;69;69;66;65;68;68;66 05:14:56 INFO - 2015-11-25 05:14:56,472 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:14:56 INFO - 2015-11-25 05:14:56,472 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:14:56 INFO - 2015-11-25 05:14:56,472 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,721 05:14:56 INFO - 2015-11-25 05:14:56,472 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:14:56 INFO - 2015-11-25 05:14:56,472 DEBUG : BROWSER_OUTPUT: __startTimestamp1448457296465__endTimestamp 05:14:56 INFO - 2015-11-25 05:14:56,473 DEBUG : BROWSER_OUTPUT: 05:14:56 INFO - 2015-11-25 05:14:56,473 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:14:56 INFO - 2015-11-25 05:14:56,473 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:14:56 INFO - 2015-11-25 05:14:56,473 DEBUG : BROWSER_OUTPUT: 05:14:56 INFO - 2015-11-25 05:14:56,473 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:4.12 (3.6%) stddev-sans-first:4.36 05:14:56 INFO - 2015-11-25 05:14:56,473 DEBUG : BROWSER_OUTPUT: Values: 113.0 107.0 113.0 111.0 113.0 123.0 110.0 112.0 113.0 111.0 05:14:56 INFO - 2015-11-25 05:14:56,473 DEBUG : BROWSER_OUTPUT: 05:14:56 INFO - 2015-11-25 05:14:56,473 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.40 Median:157.00 stddev:18.39 (11.7%) stddev-sans-first:18.49 05:14:56 INFO - 2015-11-25 05:14:56,473 DEBUG : BROWSER_OUTPUT: Values: 163.0 125.0 152.0 168.0 126.0 162.0 150.0 126.0 165.0 127.0 05:14:56 INFO - 2015-11-25 05:14:56,473 DEBUG : BROWSER_OUTPUT: 05:14:56 INFO - 2015-11-25 05:14:56,474 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:3.67 (2.2%) stddev-sans-first:3.87 05:14:56 INFO - 2015-11-25 05:14:56,475 DEBUG : BROWSER_OUTPUT: Values: 165.0 162.0 162.0 164.0 161.0 162.0 161.0 163.0 172.0 169.0 05:14:56 INFO - 2015-11-25 05:14:56,475 DEBUG : BROWSER_OUTPUT: 05:14:56 INFO - 2015-11-25 05:14:56,475 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.30 Median:72.00 stddev:20.99 (29.2%) stddev-sans-first:22.18 05:14:56 INFO - 2015-11-25 05:14:56,475 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 71.0 72.0 72.0 71.0 70.0 138.0 72.0 72.0 05:14:56 INFO - 2015-11-25 05:14:56,475 DEBUG : BROWSER_OUTPUT: 05:14:56 INFO - 2015-11-25 05:14:56,475 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.70 Median:93.00 stddev:23.17 (24.9%) stddev-sans-first:23.95 05:14:56 INFO - 2015-11-25 05:14:56,475 DEBUG : BROWSER_OUTPUT: Values: 93.0 95.0 144.0 93.0 93.0 94.0 134.0 93.0 93.0 145.0 05:14:56 INFO - 2015-11-25 05:14:56,475 DEBUG : BROWSER_OUTPUT: 05:14:56 INFO - 2015-11-25 05:14:56,475 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:1.06 (1.0%) stddev-sans-first:1.01 05:14:56 INFO - 2015-11-25 05:14:56,475 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 111.0 110.0 109.0 112.0 110.0 112.0 110.0 05:14:56 INFO - 2015-11-25 05:14:56,475 DEBUG : BROWSER_OUTPUT: 05:14:56 INFO - 2015-11-25 05:14:56,475 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 05:14:56 INFO - 2015-11-25 05:14:56,476 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 146.0 147.0 148.0 147.0 146.0 147.0 147.0 146.0 05:14:56 INFO - 2015-11-25 05:14:56,476 DEBUG : BROWSER_OUTPUT: 05:14:56 INFO - 2015-11-25 05:14:56,476 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 05:14:56 INFO - 2015-11-25 05:14:56,476 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 96.0 96.0 98.0 96.0 96.0 96.0 96.0 96.0 05:14:56 INFO - 2015-11-25 05:14:56,476 DEBUG : BROWSER_OUTPUT: 05:14:56 INFO - 2015-11-25 05:14:56,476 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.20 Median:62.00 stddev:1.48 (2.4%) stddev-sans-first:1.41 05:14:56 INFO - 2015-11-25 05:14:56,476 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 61.0 62.0 60.0 61.0 62.0 62.0 59.0 59.0 05:14:56 INFO - 2015-11-25 05:14:56,476 DEBUG : BROWSER_OUTPUT: 05:14:56 INFO - 2015-11-25 05:14:56,476 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:70.00 stddev:1.42 (2.0%) stddev-sans-first:0.60 05:14:56 INFO - 2015-11-25 05:14:56,476 DEBUG : BROWSER_OUTPUT: Values: 74.0 70.0 70.0 70.0 70.0 71.0 70.0 70.0 69.0 69.0 05:14:56 INFO - 2015-11-25 05:14:56,477 DEBUG : BROWSER_OUTPUT: 05:14:56 INFO - 2015-11-25 05:14:56,477 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:87.00 stddev:3.57 (4.1%) stddev-sans-first:3.71 05:14:56 INFO - 2015-11-25 05:14:56,477 DEBUG : BROWSER_OUTPUT: Values: 85.0 87.0 87.0 87.0 96.0 84.0 85.0 85.0 90.0 85.0 05:14:56 INFO - 2015-11-25 05:14:56,477 DEBUG : BROWSER_OUTPUT: 05:14:56 INFO - 2015-11-25 05:14:56,477 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.30 Median:126.50 stddev:4.57 (3.6%) stddev-sans-first:4.58 05:14:56 INFO - 2015-11-25 05:14:56,477 DEBUG : BROWSER_OUTPUT: Values: 121.0 121.0 131.0 120.0 122.0 123.0 125.0 132.0 128.0 130.0 05:14:56 INFO - 2015-11-25 05:14:56,477 DEBUG : BROWSER_OUTPUT: 05:14:56 INFO - 2015-11-25 05:14:56,477 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.80 Median:152.00 stddev:5.59 (3.7%) stddev-sans-first:4.36 05:14:56 INFO - 2015-11-25 05:14:56,477 DEBUG : BROWSER_OUTPUT: Values: 141.0 154.0 150.0 164.0 151.0 153.0 153.0 150.0 151.0 151.0 05:14:56 INFO - 2015-11-25 05:14:56,477 DEBUG : BROWSER_OUTPUT: 05:14:56 INFO - 2015-11-25 05:14:56,478 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.50 stddev:2.02 (3.0%) stddev-sans-first:2.12 05:14:56 INFO - 2015-11-25 05:14:56,478 DEBUG : BROWSER_OUTPUT: Values: 67.0 72.0 69.0 69.0 69.0 66.0 65.0 68.0 68.0 66.0 05:14:56 INFO - 2015-11-25 05:14:56,478 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:14:56 INFO - 2015-11-25 05:14:56,478 DEBUG : BROWSER_OUTPUT: 05:14:57 INFO - 2015-11-25 05:14:57,355 INFO : Browser exited with error code: 0 05:14:57 INFO - 2015-11-25 05:14:57,408 INFO : Completed test kraken (00:01:00) 05:14:57 INFO - 2015-11-25 05:14:57,408 INFO : Starting test v8_7 05:14:57 INFO - 2015-11-25 05:14:57,408 DEBUG : operating with platform_type : linux_ 05:14:57 INFO - 2015-11-25 05:14:57,408 INFO : Initialising browser for v8_7 test... 05:14:57 INFO - 2015-11-25 05:14:57,414 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpILBwSl/profile http://localhost:53245/getInfo.html 05:15:02 INFO - 2015-11-25 05:15:02,076 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:15:02 INFO - 2015-11-25 05:15:02,077 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:15:02 INFO - 2015-11-25 05:15:02,077 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:15:02 INFO - 2015-11-25 05:15:02,077 DEBUG : BROWSER_OUTPUT: __metrics 05:15:03 INFO - 2015-11-25 05:15:03,111 INFO : Browser initialized. 05:15:03 INFO - 2015-11-25 05:15:03,112 INFO : Running cycle 1/1 for v8_7 test... 05:15:03 INFO - 2015-11-25 05:15:03,112 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpILBwSl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:15:14 INFO - 2015-11-25 05:15:14,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 139157504 05:15:14 INFO - 2015-11-25 05:15:14,850 DEBUG : BROWSER_OUTPUT: 05:15:36 INFO - 2015-11-25 05:15:36,309 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53245/tests/v8_7/run.html (next: http://localhost:53245/tests/v8_7/run.html) 05:15:36 INFO - 2015-11-25 05:15:36,559 DEBUG : BROWSER_OUTPUT: RSS: Main: 137613312 05:15:36 INFO - 2015-11-25 05:15:36,560 DEBUG : BROWSER_OUTPUT: 05:15:36 INFO - 2015-11-25 05:15:36,560 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:15:36 INFO - 2015-11-25 05:15:36,560 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:15:36 INFO - 2015-11-25 05:15:36,561 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:15:36 INFO - 2015-11-25 05:15:36,562 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:15:36 INFO - 2015-11-25 05:15:36,562 DEBUG : BROWSER_OUTPUT: |0;Richards;166.08536787908986 05:15:36 INFO - 2015-11-25 05:15:36,562 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.25442354255912 05:15:36 INFO - 2015-11-25 05:15:36,562 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.2690582959641 05:15:36 INFO - 2015-11-25 05:15:36,563 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5159.79381443299 05:15:36 INFO - 2015-11-25 05:15:36,563 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1047.1204188481674 05:15:36 INFO - 2015-11-25 05:15:36,563 DEBUG : BROWSER_OUTPUT: |5;Earley;740.1924500370096 05:15:36 INFO - 2015-11-25 05:15:36,563 DEBUG : BROWSER_OUTPUT: |6;Boyer;12132.530120481928 05:15:36 INFO - 2015-11-25 05:15:36,563 DEBUG : BROWSER_OUTPUT: |7;RegExp;25175 05:15:36 INFO - 2015-11-25 05:15:36,563 DEBUG : BROWSER_OUTPUT: |8;Splay;689.6077081899518 05:15:36 INFO - 2015-11-25 05:15:36,563 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 05:15:36 INFO - 2015-11-25 05:15:36,564 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:15:36 INFO - 2015-11-25 05:15:36,564 DEBUG : BROWSER_OUTPUT: __startTimestamp1448457336559__endTimestamp 05:15:36 INFO - 2015-11-25 05:15:36,564 DEBUG : BROWSER_OUTPUT: 05:15:36 INFO - 2015-11-25 05:15:36,564 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:15:36 INFO - 2015-11-25 05:15:36,565 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:15:36 INFO - 2015-11-25 05:15:36,565 DEBUG : BROWSER_OUTPUT: 05:15:36 INFO - 2015-11-25 05:15:36,565 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.09 Median:166.09 stddev:0.00 (0.0%) 05:15:36 INFO - 2015-11-25 05:15:36,565 DEBUG : BROWSER_OUTPUT: Values: 166.1 05:15:36 INFO - 2015-11-25 05:15:36,566 DEBUG : BROWSER_OUTPUT: 05:15:36 INFO - 2015-11-25 05:15:36,566 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.25 Median:186.25 stddev:0.00 (0.0%) 05:15:36 INFO - 2015-11-25 05:15:36,566 DEBUG : BROWSER_OUTPUT: Values: 186.3 05:15:36 INFO - 2015-11-25 05:15:36,566 DEBUG : BROWSER_OUTPUT: 05:15:36 INFO - 2015-11-25 05:15:36,567 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.27 Median:280.27 stddev:0.00 (0.0%) 05:15:36 INFO - 2015-11-25 05:15:36,567 DEBUG : BROWSER_OUTPUT: Values: 280.3 05:15:36 INFO - 2015-11-25 05:15:36,567 DEBUG : BROWSER_OUTPUT: 05:15:36 INFO - 2015-11-25 05:15:36,567 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 05:15:36 INFO - 2015-11-25 05:15:36,568 DEBUG : BROWSER_OUTPUT: Values: 5159.8 05:15:36 INFO - 2015-11-25 05:15:36,568 DEBUG : BROWSER_OUTPUT: 05:15:36 INFO - 2015-11-25 05:15:36,568 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1047.12 Median:1047.12 stddev:0.00 (0.0%) 05:15:36 INFO - 2015-11-25 05:15:36,568 DEBUG : BROWSER_OUTPUT: Values: 1047.1 05:15:36 INFO - 2015-11-25 05:15:36,568 DEBUG : BROWSER_OUTPUT: 05:15:36 INFO - 2015-11-25 05:15:36,569 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:740.19 Median:740.19 stddev:0.00 (0.0%) 05:15:36 INFO - 2015-11-25 05:15:36,569 DEBUG : BROWSER_OUTPUT: Values: 740.2 05:15:36 INFO - 2015-11-25 05:15:36,569 DEBUG : BROWSER_OUTPUT: 05:15:36 INFO - 2015-11-25 05:15:36,569 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12132.53 Median:12132.53 stddev:0.00 (0.0%) 05:15:36 INFO - 2015-11-25 05:15:36,570 DEBUG : BROWSER_OUTPUT: Values: 12132.5 05:15:36 INFO - 2015-11-25 05:15:36,570 DEBUG : BROWSER_OUTPUT: 05:15:36 INFO - 2015-11-25 05:15:36,570 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25175.00 Median:25175.00 stddev:0.00 (0.0%) 05:15:36 INFO - 2015-11-25 05:15:36,570 DEBUG : BROWSER_OUTPUT: Values: 25175.0 05:15:36 INFO - 2015-11-25 05:15:36,571 DEBUG : BROWSER_OUTPUT: 05:15:36 INFO - 2015-11-25 05:15:36,571 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:689.61 Median:689.61 stddev:0.00 (0.0%) 05:15:36 INFO - 2015-11-25 05:15:36,571 DEBUG : BROWSER_OUTPUT: Values: 689.6 05:15:36 INFO - 2015-11-25 05:15:36,571 DEBUG : BROWSER_OUTPUT: 05:15:36 INFO - 2015-11-25 05:15:36,572 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 05:15:36 INFO - 2015-11-25 05:15:36,572 DEBUG : BROWSER_OUTPUT: Values: 4835.7 05:15:36 INFO - 2015-11-25 05:15:36,572 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:15:36 INFO - 2015-11-25 05:15:36,572 DEBUG : BROWSER_OUTPUT: 05:15:37 INFO - 2015-11-25 05:15:37,399 INFO : Browser exited with error code: 0 05:15:37 INFO - 2015-11-25 05:15:37,416 INFO : Completed test v8_7 (00:00:40) 05:15:37 INFO - 2015-11-25 05:15:37,570 INFO : Completed test suite (00:20:10) 05:15:37 INFO - 2015-11-25 05:15:37,570 DEBUG : Working with test: dromaeo_css 05:15:37 INFO - 2015-11-25 05:15:37,570 DEBUG : Generating results file: dromaeo_css 05:15:37 INFO - 2015-11-25 05:15:37,571 DEBUG : Working with test: kraken 05:15:37 INFO - 2015-11-25 05:15:37,571 DEBUG : Generating results file: kraken 05:15:37 INFO - 2015-11-25 05:15:37,572 INFO : javascript benchmark 05:15:37 INFO - 2015-11-25 05:15:37,572 DEBUG : Working with test: v8_7 05:15:37 INFO - 2015-11-25 05:15:37,572 DEBUG : Generating results file: v8_7 05:15:37 INFO - 2015-11-25 05:15:37,572 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:15:37 INFO - 2015-11-25 05:15:37,636 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 05:15:37 INFO - 2015-11-25 05:15:37,636 DEBUG : process_Request line: dromaeo_css 7051.38 graph.html#tests=[[72,64,43]] 05:15:37 INFO - 2015-11-25 05:15:37,636 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:15:37 INFO - 2015-11-25 05:15:37,671 DEBUG : process_Request line: kraken 1526.20 graph.html#tests=[[232,64,43]] 05:15:37 INFO - 2015-11-25 05:15:37,671 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:15:37 INFO - 2015-11-25 05:15:37,709 DEBUG : process_Request line: v8_7 21118.90 graph.html#tests=[[230,64,43]] 05:15:37 INFO - 2015-11-25 05:15:37,714 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3219.452693042183, 3276.4921437177245, 3296.653851345607, 3317.1541256979467, 3325.634180240175, 5257.789688412459, 5443.537299329551, 5492.148716948869, 5529.419410961847, 5552.722363881805, 5429.778394735003, 5456.7544460499275, 5528.170774383844, 5586.162075688649, 5587.938291724569, 4873.707577545341, 4966.3792025996845, 4986.177280748672, 5081.28861959326, 5115.769790359443, 4760.500147484516, 5031.11955407804, 5076.796928122871, 5102.234664800272, 5151.381834179903, 4864.805407783684, 4911.312416261709, 4911.9754401227765, 4919.360483137187, 5004.649674522785, 4918.803247870081, 4930.087933732271, 4939.110960027194, 4959.380077490314, 4987.900241995139, 4889.217725163957, 4938.530839570235, 4944.184209605411, 4959.504049595048, 4996.4254110777365, 5184.637075404723, 5284.365876094893, 5299.629025968184, 5344.0, 5360.249565060894, 5954.4938680212235, 5958.493528050121, 5964.254468191476, 5974.044152935553, 5990.7903223386975, 5748.16651585522, 5981.641101533878, 5999.460048595603, 6000.8499787505225, 6008.038713805814, 5495.697736624484, 5523.889522209573, 5538.6122971391615, 5574.219609254707, 5582.720863956826, 5986.491148252448, 5990.940090599038, 6032.426919442733, 6040.033594624839, 6064.120702498113, 5628.127640215773, 5792.710364481759, 5839.795607153729, 5843.2403787507355, 5860.648361098348, 5816.796412125555, 5868.178455016301, 5912.290525136925, 5923.318818335946, 5987.401259873977, 5898.0, 5910.024845900464, 5911.290645122527, 5914.201582786355, 5920.733566989496, 5655.1517272409465, 5754.223179870748, 5893.734781934823, 5910.172575839386, 5921.230240068763, 4481.574250446202, 4527.185106680763, 4536.705114167568, 4565.452145742533, 4573.588377046015, 4055.6349928506575, 4066.369712694537, 4072.1448495815616, 4082.1631565528996, 4101.364288535282, 5501.257330260363, 5578.219049333096, 5673.092305231144, 5680.460356266148, 5714.228579141763, 5979.970100149471, 5999.940000600025, 6020.969895150496, 6024.4879185268865, 6077.1491991121275, 5663.32040155184, 5678.261825962599, 5732.541396688255, 5735.741891614887, 5745.0, 4975.626827987915, 5029.823956161516, 5071.41678706946, 5150.9227361588855, 5213.478652134832, 6079.665618391119, 6082.330943596201, 6086.786962456381, 6092.573519853568, 6097.878042439126, 5910.586258961831, 5929.525637948867, 5942.435468630473, 5952.76188952437, 5960.731767070579, 5876.08920617305, 5967.313758917607, 6047.516198704181, 6092.2689277285235, 6144.0, 5766.826995190151, 5782.277215348082, 5802.274715660543, 5821.330546987151, 5861.296644402699, 5770.769169233184, 5905.114232865105, 5906.881862362815, 5910.1134829774155, 5920.2895652521975, 5717.0, 5765.56758243125, 5828.912566311424, 5832.445917637818, 5879.2944846618675, 5766.0, 5829.47534721877, 5839.678817665069, 5840.591158618856, 5846.970765146147, 5527.640703354269, 5649.406812284816, 5665.0, 5717.028105222205, 5721.170430287668, 5684.118961560965, 5715.057015592547, 5765.91351129725, 5872.647641141545, 5917.497012753965, 5595.444663834546, 5647.661140331593, 5672.262605861211, 5685.488306052475, 5704.0], "unit": "ms", "name": "dojo.html", "value": 5439.841718684612}, {"lowerIsBetter": false, "replicates": [556.7633755653846, 569.8831739493406, 577.7169187098323, 592.9762809487621, 595.8212536239129, 39193.60806391935, 40148.39777403334, 40360.39459408104, 40509.39235911464, 40605.79697101514, 42159.156816863644, 42442.787786061024, 42664.0, 42849.57150428503, 42940.926476838096, 8518.74443766688, 8718.433301835392, 8736.737897863042, 8760.605772740242, 8771.517566533837, 8508.31933445326, 8515.020772611137, 8576.271016963565, 8576.828463430727, 8578.0, 8537.146285371444, 8640.783980400478, 8662.0, 8665.956670216672, 8666.52334121623, 8560.914390856075, 8573.099824518398, 8631.827363452727, 8634.093420190853, 8634.784130396727, 8489.533075680834, 8599.4840309581, 8604.5697715114, 8627.266682332009, 8630.65477380904, 39060.60939390598, 39336.803315983525, 39462.60537394618, 39500.0, 39508.407373889415, 3201.27971206479, 3226.725728313096, 3280.0323904448246, 3552.5559305086863, 3553.0406790166767, 28828.279293017844, 28999.710002899912, 29240.8537957311, 29468.705312947026, 29522.55716164259, 3621.4567814827724, 3628.5827129880136, 3675.5773086095173, 3701.4632878232774, 3781.4516895050338, 267279.0, 267510.66244668845, 269471.0, 269553.0, 269882.0, 49459.75270123698, 55323.0, 55494.0, 55581.72209138928, 55804.720976394856, 47633.28550071752, 59877.0, 60071.69964150239, 60432.69783651054, 60801.39198607957, 13505.12216705911, 13696.794548081787, 13724.382402791898, 13768.862311376959, 13792.655183620489, 11082.667519974413, 11099.44502774858, 11101.5559377624, 11166.330020198815, 11187.664370068911, 18594.907025464785, 18798.436046918614, 18873.62252754937, 18879.81120188808, 18967.81032189688, 7615.276548727862, 7878.566678832719, 7909.367250619936, 7910.52536847791, 7923.207679232146, 876.412803421709, 892.3040028777564, 978.2076518020426, 1025.1644909398817, 1045.0751085289573, 27980.38767168272, 28396.432071358457, 28682.282942926595, 28797.28006799805, 28853.422931541252, 1129.9152563557766, 1149.1553708024596, 1170.1341007654444, 1176.8643259254861, 1192.8986036186848, 14621.78067328991, 14792.704145917236, 14896.851031489763, 15060.171690556905, 15114.470993515393, 332655.0, 336214.0, 338368.0, 338677.0, 340388.0, 50964.490355096714, 51221.743891281054, 51366.0, 51505.48494515082, 51557.74221128946, 1291.5156816193928, 1331.8468376136868, 1334.0661536924192, 1338.7523308188017, 1339.5512503311304, 26848.59727104056, 28101.578476322462, 28203.0, 28233.858830705714, 29003.854980724962, 44196.0, 44333.11333773371, 44358.3346249813, 44529.0, 44681.0, 215969.0, 216887.0, 216889.0, 217140.0, 217290.0, 29321.85339073291, 31256.68743312538, 31785.36429271448, 31826.52260216145, 31979.0, 38384.23231535409, 39165.41251881281, 39512.0, 39651.0, 39867.2026559473, 34759.0, 35305.64694353126, 36124.73563425268, 36129.27741445104, 36207.818960905024, 36103.27793444169, 36153.63846361608, 36255.99936535631, 36574.817125914204, 36610.63389366179, 35352.64647353494, 35427.468587971714, 35560.46659300164, 36064.27871442504, 36094.0, 29354.0, 31854.840725796224, 32303.676963230067, 32663.67336326606, 32802.83598581992, 24487.51024979526, 25043.499130016935, 25072.74927250704, 25360.619590705785, 25448.491030178924], "unit": "ms", "name": "ext.html", "value": 18051.686473553742}, {"lowerIsBetter": false, "replicates": [345.5740700284006, 347.140826454525, 349.8006136502193, 352.32705532433056, 356.57567494681325, 16497.50507484776, 17358.566035849093, 17821.108944552754, 18527.25890964363, 18930.390916772074, 11262.774744505105, 12635.936820315885, 16311.510654680349, 16355.672886542263, 16452.83547164528, 4717.433907931053, 4887.364642596457, 4903.950960490385, 4907.2148456247005, 4924.064427758733, 4880.316755654211, 4908.190148625473, 5065.189569668853, 5472.1244600863865, 5472.753726082316, 5108.5913126949945, 5300.363956325246, 5328.893422131555, 5403.135498320269, 5453.481919217668, 5293.470652934695, 5304.230886521452, 5304.549113325372, 5329.813456529022, 5341.305630268079, 5253.605979551511, 5281.445448227919, 5299.814506492293, 5348.812791552277, 5360.865978350573, 12367.07246956473, 12816.231026138368, 12830.679233019157, 12875.227486350848, 13154.013448991363, 2140.069069954575, 2221.1892659179284, 2241.7197850268717, 2248.8650680959195, 2257.0294773247497, 9603.32776705631, 9693.369930954465, 9724.513774311255, 9845.901540984642, 9906.455144967023, 1743.4246698589436, 1813.519417354402, 1816.7184086466618, 1842.649896519657, 1898.9935334272857, 62511.0, 67172.0, 69863.65068174627, 70744.6462767688, 71629.0, 15122.243887805565, 16297.34810607586, 16326.34694612226, 16344.673106537803, 16401.58996025109, 23476.64785028226, 23478.765212348, 23737.287881363587, 23753.40616484567, 23821.523569528857, 8865.157810008039, 8887.244584210286, 8941.46351218929, 9057.139571740674, 9312.068793120634, 7496.812579685551, 7568.205338439495, 7605.733799316998, 7636.961815190888, 7678.424118191047, 7977.561234132062, 8031.277185053374, 8032.236937490929, 8049.315808156372, 8063.516189028677, 1885.651154536415, 3199.2481766784786, 3199.9200019999685, 3229.0797122819886, 3365.0746044837374, 917.9173874351341, 932.7854593443546, 1014.7108074198818, 1025.5333823110466, 1059.443792009186, 15879.206039697969, 16199.43301984425, 16402.507924762278, 16823.747643785355, 17065.14674266282, 865.2040123086775, 886.3972498700946, 914.9359544831931, 915.4232833314969, 921.9815603687889, 9825.950870245746, 10082.294239403318, 10090.44502552352, 10099.69700908974, 10232.744181395376, 575675.0, 576193.0, 582161.0, 590745.0, 591284.0, 81185.0, 83497.58251208827, 84034.0, 84055.0, 85010.0, 1112.165875593305, 1148.5692865175558, 1148.655403378983, 1154.1113342726053, 1160.5589875847124, 15178.620534486285, 15399.461018864286, 15403.76894346608, 15457.690846183239, 15601.375944962074, 36231.0, 36468.635313646526, 37252.39233253646, 37254.44118338173, 37325.253494929406, 47539.52460475489, 48094.519054809, 49053.754731226116, 49352.50647493479, 50390.0, 9306.022867599075, 9611.086946740048, 9690.418574885529, 9699.418034917928, 9743.074407931235, 11256.380899050631, 11302.321860688386, 11359.602413915472, 16396.672066558363, 17438.651226975137, 11385.487653055798, 13832.930835345758, 14626.488072917822, 14886.77669834975, 15121.0, 14706.55880323592, 14833.703325933637, 14858.777118343018, 15285.770713439086, 15416.46042388511, 15274.0, 15345.309461074501, 15504.83713721498, 15728.528144155694, 15849.286782095063, 9732.12410883024, 9784.706458806248, 9983.400995940267, 9987.500624968869, 10044.698659040241, 10289.228307876789, 12860.549880754128, 15118.319675614845, 15164.469243576863, 15367.692646147238], "unit": "ms", "name": "jquery.html", "value": 9377.81053688661}, {"lowerIsBetter": false, "replicates": [1486.0340778493985, 1698.3206717313074, 1738.5219064757193, 1741.8258174182583, 1747.0653200537715, 6655.767048153316, 6679.265280819106, 7000.439964802817, 7430.07124109487, 7437.55374677519, 7029.121359830021, 7199.460040496958, 7206.747763828267, 7263.963680181605, 7295.8540829183385, 2190.9561808763815, 2206.249875042485, 2214.512807182425, 2219.4784225707026, 2221.2891874600136, 2227.8329125315668, 2266.5353602511445, 2294.403455101677, 2296.781805728453, 2297.8506397084134, 2197.8131858791944, 2202.6475763877784, 2235.0277629231337, 2241.3276017194858, 2250.7524172341027, 2208.536207396449, 2222.533268013719, 2237.5748607764554, 2251.594712951668, 2252.560750653623, 2245.36007237938, 2258.7967082962614, 2264.501809601885, 2274.1130958926033, 2278.829087818404, 7418.703251869919, 7432.7026918923175, 7483.850322993564, 7498.962505187439, 7504.774856754306, 4481.103779244164, 4533.637309015271, 4557.134144512532, 4569.908601827978, 4577.084583083363, 2858.9142325730263, 2951.719586639266, 2964.659064207622, 2991.1774262077884, 3000.339925216449, 986.6743974488402, 987.5111819649247, 995.6067353395441, 1010.525053224983, 1026.4816267784795, 10117.797644047152, 10144.137748291405, 10178.541965611565, 10181.592736290539, 10199.33704309225, 4099.7745124017865, 4100.0, 4148.0666849959125, 4159.188958153191, 4173.1862286854375, 8638.956805215934, 8669.956650216709, 8685.522296273766, 8709.085546017704, 8717.65129394817, 4529.026259354255, 4530.0, 4535.047639995638, 4559.338895860082, 4559.772011399483, 3710.7588006779474, 3794.6395092466173, 4139.0480189555965, 4219.303814870512, 4228.936565951513, 3610.476480910306, 3639.0, 3668.1013151777984, 3698.7780733156096, 3707.3141468828353, 1223.4005337384617, 1237.2514628649717, 1239.1883316427754, 1241.2552468518998, 1246.7755803955374, 1030.9123724483502, 1034.736142283728, 1040.8230600797883, 1189.3636904256182, 1344.5294147048455, 6899.896501552481, 6976.511644184859, 6981.0924579804305, 7029.22678505364, 7087.184973728087, 485.52418629742346, 488.679914655901, 492.1780626353997, 492.52471365132817, 495.4401526275358, 5573.888522229533, 5573.888522229533, 5601.411851755507, 5610.354809196913, 5618.775248989995, 8507.61715722794, 8508.361872859561, 8802.559872006374, 8861.202491775643, 8892.59983300753, 8616.0, 8639.95680021596, 8647.783805404915, 8656.220940115294, 8684.43551169172, 6922.307769223037, 6983.965080174668, 6988.0, 7035.894461583081, 7054.188768291712, 6793.354631310018, 6824.624645644537, 6834.692438840363, 6838.042674025541, 6888.48336374784, 7653.770386888402, 7809.4142939278645, 7864.4888082274465, 7878.881816772639, 7996.800079998046, 7913.248241417056, 7940.920590794018, 7954.085280192852, 7955.443118981616, 7977.920220797718, 6315.55791094619, 6533.41199292066, 6578.210614726264, 6588.670566471753, 6643.60138391698, 7155.642217889189, 7207.71169153228, 7250.673719682522, 7253.310935461122, 7257.0, 6633.568818026813, 6886.311368863074, 6928.584284942919, 6930.203026652, 7023.0, 6693.397594216543, 6796.35434633709, 6885.518013739191, 6895.931040689529, 6898.620575868375, 6683.598984060972, 6707.865842683216, 6870.62211578368, 6911.723531058902, 6998.965005174941, 6267.9373206267355, 6280.905786413299, 6305.4009869062365, 6312.779052733133, 6318.210223722035, 6452.0, 6464.321246269074, 6471.094046833541, 6477.4494167996245, 6533.118029066015], "unit": "ms", "name": "mootools.html", "value": 4256.673270219684}, {"lowerIsBetter": false, "replicates": [311.1428015816425, 315.5550673550294, 321.3556818578749, 323.10655128085136, 324.7742818740973, 6264.185655864737, 6350.206224221973, 6353.761016601765, 6378.234611846579, 6510.80467585972, 6302.369763023696, 6328.0, 6354.809355719324, 6355.8411039723915, 6370.713317900694, 4631.861044168681, 4755.239161734124, 4769.427668679763, 4770.2606096055, 4778.641601879855, 4764.190087685084, 4771.737554434505, 4780.378550788392, 4788.88027799306, 4791.712497250159, 4714.693544919586, 4719.575238228559, 4721.7639118044135, 4723.811047558111, 4736.123817093831, 4723.267893476499, 4733.124371991193, 4735.834245801415, 4741.146593613148, 4749.287606858964, 3981.144054028398, 4083.571225021389, 4085.8569950051606, 4087.0395457067566, 4087.97956010221, 5967.6121052131475, 5969.074793406985, 5977.342492325841, 5983.850403739898, 5993.700314984277, 5479.3424789025175, 5482.314710661168, 5484.2596249506605, 5492.423295553989, 5492.945070549284, 6494.870102597969, 6627.569208001464, 6629.900551491732, 6638.5684930479365, 6646.202455705346, 4451.688381813275, 4500.729956202638, 4501.482329532113, 4508.391367165424, 4517.9774101129615, 6784.898226526606, 6901.75843845468, 6938.895916561256, 6949.791506254821, 6958.721651133898, 4658.440987081572, 4670.369500117441, 4673.345731597579, 4685.1800934836265, 4688.718676879398, 4647.837325693585, 4725.9366642505165, 4739.0, 4751.738654373973, 4754.381930349102, 5493.066178749622, 5509.972450137804, 5510.008198524304, 5517.227588137664, 5522.2544956431175, 6725.697343619451, 6736.326367363225, 6736.865262694719, 6737.427318677967, 6742.696578653874, 1664.592174917153, 1686.5277722237793, 1688.4343744845614, 1693.0772728862798, 1694.5848267174622, 1084.7830433913248, 1093.3494570730402, 1097.2922465010024, 1111.8109921313396, 1123.8258069999163, 6423.74305027803, 6515.348465153542, 6519.674016299166, 6534.379233972765, 6605.976073708583, 7036.366726994595, 7047.660944420543, 7051.153861536648, 7055.541389809749, 7066.646667666699, 6562.179727534059, 6598.076269322299, 6612.041254018237, 6621.039949207338, 6625.701843417058, 3736.1593641431004, 3794.4687743715904, 3834.7890866002635, 3841.1741475582885, 3843.5195600549932, 7259.600721960237, 7267.491275610762, 7276.417886569062, 7278.672459739324, 7285.417166626763, 7151.678174482161, 7190.101237345332, 7222.638868056576, 7224.241454647292, 7228.963855180796, 7063.117110361205, 7199.460040496983, 7232.312930271721, 7271.563706177646, 7287.927120728831, 7022.2275549688475, 7024.964875175591, 7029.05107810439, 7049.541779784297, 7056.259092795388, 6880.518363714692, 6901.275366086689, 6927.618980956096, 6943.861122777415, 6971.477139214478, 7088.929110708827, 7249.275072492708, 7260.818479538054, 7266.491345605757, 7273.709051638087, 4643.814247430065, 4702.717836929795, 4702.76486175683, 4702.952970470252, 4705.529447055267, 6889.517733758589, 6980.581165130108, 7003.894941575983, 7014.228434872058, 7029.051078104595, 6652.368025037614, 6794.150731158606, 6795.626240556817, 6804.659767011729, 6816.829579260559, 6719.664016799043, 6759.155105611799, 6774.695138718671, 6783.728650853911, 6783.762568310085, 6510.804675859732, 6639.269680335063, 6642.767503137367, 6646.302138275411, 6649.335066493312, 6663.333666633298, 6776.186857577122, 6846.863062738617, 6852.965735171292, 6872.759453419107, 6514.706838192387, 6622.403983641495, 6626.403623673892, 6647.5014373921185, 6655.0], "unit": "ms", "name": "prototype.html", "value": 5035.6537333711085}, {"lowerIsBetter": false, "replicates": [737.7749786315175, 738.2433006168677, 804.8913396691445, 843.2242337049912, 849.7110982266029, 12772.744545109092, 12998.41507132179, 13064.281464519436, 13078.542251021216, 13121.803172952414, 13074.934625326883, 13256.072074954756, 13366.19802811832, 13692.383842727077, 13814.240216788072, 821.6590115102225, 827.6813426830653, 829.5478963964623, 833.9617176615122, 836.3100442135233, 826.8594338962391, 836.5022811427191, 837.736113124367, 837.8073043200068, 838.0278876503257, 868.179570306061, 873.1574031060026, 876.3514998900831, 877.6971944679076, 879.1560102301798, 866.7226487523994, 867.7787164273133, 870.0559892516627, 870.6778491957984, 871.1071152069117, 635.9570304700295, 637.5377851057946, 638.4892086330963, 640.2509064394669, 642.3223499208333, 12193.329366884907, 12327.075469339836, 12378.257304561756, 12421.1926224796, 12426.130170888042, 10829.404382758945, 11044.392558409285, 11108.0, 11233.006920997641, 11247.66257012291, 9606.807863842754, 9826.339287936347, 10018.499075046218, 10072.597096116147, 10187.439690817002, 3462.515247865301, 3472.44440889459, 3508.8947331580093, 3522.3131489359585, 3533.434650455915, 48064.519354806354, 48370.516294836954, 48386.51613483891, 48497.75751121257, 48507.272390914164, 8057.717979870794, 8221.260086592236, 8359.8328033439, 8462.788430289293, 8479.95760021196, 16839.91580042092, 16844.831551684572, 16872.24074916607, 16982.660346792996, 17052.2326495308, 7251.419886409075, 7384.4830861839155, 7461.888071678929, 7560.281773231534, 7625.6568454419685, 4024.476818013698, 4155.168966206771, 4169.353750168729, 4169.708120431601, 4189.366147202593, 2881.8270903745424, 2903.5209190483756, 2909.854507274628, 2921.8750780949485, 2925.414917016605, 476.5115756349769, 495.83141731811355, 496.78389900393444, 500.5995203836916, 504.9899002019939, 507.7359772918062, 565.7341049706631, 609.7987664070846, 646.6831252686244, 673.1114928294604, 8461.873071903927, 8728.345374096969, 8731.301495880314, 8854.29165666745, 8874.467531948103, 657.6777379084215, 668.6489592963636, 670.1388715500558, 685.3591891581387, 700.3906601256939, 3561.5013898054294, 3831.1746226798537, 3898.278818418545, 3907.0, 3947.1513624570857, 59000.0, 59321.40678593159, 59533.40466595279, 59733.70133149393, 60191.0, 51903.221451678255, 52604.736976314874, 53023.0, 53496.73251633795, 54014.45985540173, 47551.28673069907, 48039.75980120147, 49567.256491152664, 50149.24776128361, 50795.746021270395, 8400.705975291079, 8447.408681392244, 8546.401751877309, 8546.658133674584, 8897.110288971051, 34011.48982765211, 34336.48495272523, 34862.0, 36167.27665446624, 36347.45478817873, 43347.34978975381, 43439.56560434355, 44555.0, 45957.31064034109, 47179.0, 10375.844362334721, 10934.617288394868, 11186.944065279622, 11688.18182727235, 11759.47082381312, 12120.33338166374, 12155.392230388623, 12247.69380765488, 12628.368581570701, 13108.737825243632, 11033.834492482458, 11366.772664546828, 11557.0, 11934.582289619822, 12390.81413778776, 11621.186516943733, 11886.940565297464, 12018.459169337226, 12024.819627705767, 12415.37923103823, 10602.045815876609, 10643.680689579325, 10726.570937162425, 10849.511771970438, 11160.274582152135, 9807.656732014346, 9918.652847150604, 10016.499175041365, 10156.847647285444, 10381.273310868166, 9183.770405739642, 9440.575174117044, 9450.196733277473, 9702.9029709702, 9963.50182490858], "unit": "ms", "name": "yui.html", "value": 6226.967689856379}], "name": "dromaeo_css"}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 107.0, 113.0, 111.0, 113.0, 123.0, 110.0, 112.0, 113.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 112.6}, {"lowerIsBetter": true, "replicates": [163.0, 125.0, 152.0, 168.0, 126.0, 162.0, 150.0, 126.0, 165.0, 127.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.4}, {"lowerIsBetter": true, "replicates": [165.0, 162.0, 162.0, 164.0, 161.0, 162.0, 161.0, 163.0, 172.0, 169.0], "unit": "ms", "name": "audio-dft", "value": 164.1}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 71.0, 72.0, 72.0, 71.0, 70.0, 138.0, 72.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 78.3}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 144.0, 93.0, 93.0, 94.0, 134.0, 93.0, 93.0, 145.0], "unit": "ms", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 111.0, 110.0, 109.0, 112.0, 110.0, 112.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 146.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 61.0, 62.0, 60.0, 61.0, 62.0, 62.0, 59.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 61.2}, {"lowerIsBetter": true, "replicates": [74.0, 70.0, 70.0, 70.0, 70.0, 71.0, 70.0, 70.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.3}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 87.0, 87.0, 96.0, 84.0, 85.0, 85.0, 90.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.1}, {"lowerIsBetter": true, "replicates": [121.0, 121.0, 131.0, 120.0, 122.0, 123.0, 125.0, 132.0, 128.0, 130.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.3}, {"lowerIsBetter": true, "replicates": [141.0, 154.0, 150.0, 164.0, 151.0, 153.0, 153.0, 150.0, 151.0, 151.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 151.8}, {"lowerIsBetter": true, "replicates": [67.0, 72.0, 69.0, 69.0, 69.0, 66.0, 65.0, 68.0, 68.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken"}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.08536787908986], "unit": "score", "name": "Richards", "value": 212.55334200000007}, {"lowerIsBetter": false, "replicates": [186.25442354255912], "unit": "score", "name": "DeltaBlue", "value": 354.98754199999996}, {"lowerIsBetter": false, "replicates": [280.2690582959641], "unit": "score", "name": "Encrypt", "value": 949.7338080000005}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [1047.1204188481674], "unit": "score", "name": "RayTrace", "value": 706.6894950000002}, {"lowerIsBetter": false, "replicates": [740.1924500370096], "unit": "score", "name": "Earley", "value": 900.3915129999997}, {"lowerIsBetter": false, "replicates": [12132.530120481928], "unit": "score", "name": "Boyer", "value": 54.93190566037737}, {"lowerIsBetter": false, "replicates": [25175.0], "unit": "score", "name": "RegExp", "value": 36.186097318768596}, {"lowerIsBetter": false, "replicates": [689.6077081899518], "unit": "score", "name": "Splay", "value": 118.1700828343313}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7"}]} 05:15:37 INFO - RETURN: dromaeo_css: 7051.38 05:15:37 INFO - RETURN: kraken: 1526.20 05:15:37 INFO - RETURN: v8_7: 21118.90 05:15:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21118.90"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1526.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "7051.38"}}} 05:15:37 INFO - Return code: 0 05:15:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:15:37 INFO - # TBPL SUCCESS # 05:15:37 INFO - Running post-action listener: _resource_record_post_action 05:15:37 INFO - Running post-run listener: _resource_record_post_run 05:15:38 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 4096; Write bytes: 511389696; Read time: 12; Write time: 515492 05:15:38 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 235773952; Read time: 0; Write time: 313528 05:15:38 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275615744; Read time: 12; Write time: 201964 05:15:38 INFO - Running post-run listener: _upload_blobber_files 05:15:38 INFO - Blob upload gear active. 05:15:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:15:38 INFO - Copying logs to upload dir... 05:15:38 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1272.150561 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-11-25 05:15:37.589093) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 05:15:37.592479) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/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-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20aa3857bbc5a756c598c738000001bb-1448440387.270590-314216107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010123 build_url: 'https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 05:15:37.648437) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 05:15:37.649311) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20aa3857bbc5a756c598c738000001bb-1448440387.270590-314216107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 05:15:37.703971) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 05:15:37.704613) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 05:15:37.705247) ========= ========= Total master_lag: 0.27 =========