builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1448477557.77 results: success (0) buildid: 20151125083151 builduid: 1798f140ff5f4eccb2c778dcc7718b4b revision: f516533b96a46764f288d336415e5a8aa3468e21 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:37.769946) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:37.770468) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:37.770799) ========= 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=6587686cb2da90a5f91b3170000001be-1448475139.858636-186839823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006652 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:37.805710) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:37.806098) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:37.875889) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:37.876179) ========= 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=6587686cb2da90a5f91b3170000001be-1448475139.858636-186839823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019719 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:37.927677) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:37.927952) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:37.928334) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:37.928602) ========= 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=6587686cb2da90a5f91b3170000001be-1448475139.858636-186839823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-25 10:52:37-- 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% 46.8M=0s 2015-11-25 10:52:38 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106580 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:38.047619) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:38.048007) ========= 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=6587686cb2da90a5f91b3170000001be-1448475139.858636-186839823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.026198 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:38.099868) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-25 10:52:38.100225) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f516533b96a46764f288d336415e5a8aa3468e21 --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 f516533b96a46764f288d336415e5a8aa3468e21 --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=6587686cb2da90a5f91b3170000001be-1448475139.858636-186839823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-25 10:52:38,126 truncating revision to first 12 chars 2015-11-25 10:52:38,126 Setting DEBUG logging. 2015-11-25 10:52:38,126 attempt 1/10 2015-11-25 10:52:38,126 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f516533b96a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-25 10:52:39,211 unpacking tar archive at: fx-team-f516533b96a4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.377972 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-25 10:52:39.493997) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:39.494300) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:39.511914) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:39.512219) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:39.512592) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-11-25 10:52:39.512874) ========= /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=6587686cb2da90a5f91b3170000001be-1448475139.858636-186839823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:52:39 INFO - MultiFileLogger online at 20151125 10:52:39 in /builds/slave/test-pgo 10:52:39 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 10:52:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:52:39 INFO - {'append_to_log': False, 10:52:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:52:39 INFO - 'blob_upload_branch': 'Fx-Team', 10:52:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:52:39 INFO - 'branch': 'Fx-Team', 10:52:39 INFO - 'buildbot_json_path': 'buildprops.json', 10:52:39 INFO - 'config_files': ('talos/linux_config.py',), 10:52:39 INFO - 'default_actions': ('clobber', 10:52:39 INFO - 'read-buildbot-config', 10:52:39 INFO - 'download-and-extract', 10:52:39 INFO - 'populate-webroot', 10:52:39 INFO - 'create-virtualenv', 10:52:39 INFO - 'install', 10:52:39 INFO - 'run-tests'), 10:52:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:52:39 INFO - 'download_minidump_stackwalk': True, 10:52:39 INFO - 'download_symbols': 'ondemand', 10:52:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:52:39 INFO - 'tooltool.py': '/tools/tooltool.py', 10:52:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:52:39 INFO - '/tools/misc-python/virtualenv.py')}, 10:52:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:52:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:52:39 INFO - 'installer_path': 'installer.exe', 10:52:39 INFO - 'log_level': 'info', 10:52:39 INFO - 'log_name': 'talos', 10:52:39 INFO - 'log_to_console': True, 10:52:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:52:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:52:39 INFO - 'opt_config_files': (), 10:52:39 INFO - 'pip_index': False, 10:52:39 INFO - 'sps_profile': False, 10:52:39 INFO - 'sps_profile_interval': 0, 10:52:39 INFO - 'suite': 'dromaeojs-e10s', 10:52:39 INFO - 'system_bits': '64', 10:52:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:52:39 INFO - 'title': 'talos-linux64-ix-017', 10:52:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:52:39 INFO - 'use_talos_json': True, 10:52:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:52:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:52:39 INFO - 'work_dir': 'build'} 10:52:39 INFO - ##### 10:52:39 INFO - ##### Running clobber step. 10:52:39 INFO - ##### 10:52:39 INFO - Running pre-action listener: _resource_record_pre_action 10:52:39 INFO - Running main action method: clobber 10:52:39 INFO - rmtree: /builds/slave/test-pgo/build 10:52:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:52:40 INFO - Running post-action listener: _resource_record_post_action 10:52:40 INFO - ##### 10:52:40 INFO - ##### Running read-buildbot-config step. 10:52:40 INFO - ##### 10:52:40 INFO - Running pre-action listener: _resource_record_pre_action 10:52:40 INFO - Running main action method: read_buildbot_config 10:52:40 INFO - Using buildbot properties: 10:52:40 INFO - { 10:52:40 INFO - "properties": { 10:52:40 INFO - "buildnumber": 357, 10:52:40 INFO - "product": "firefox", 10:52:40 INFO - "script_repo_revision": "production", 10:52:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:52:40 INFO - "repository": "", 10:52:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 10:52:40 INFO - "buildid": "20151125083151", 10:52:40 INFO - "slavename": "talos-linux64-ix-017", 10:52:40 INFO - "pgo_build": "True", 10:52:40 INFO - "basedir": "/builds/slave/test-pgo", 10:52:40 INFO - "project": "", 10:52:40 INFO - "platform": "ubuntu64_hw", 10:52:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:52:40 INFO - "slavebuilddir": "test", 10:52:40 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:52:40 INFO - "branch": "fx-team", 10:52:40 INFO - "repo_path": "integration/fx-team", 10:52:40 INFO - "stage_platform": "linux64-pgo", 10:52:40 INFO - "builduid": "1798f140ff5f4eccb2c778dcc7718b4b", 10:52:40 INFO - "revision": "f516533b96a46764f288d336415e5a8aa3468e21" 10:52:40 INFO - }, 10:52:40 INFO - "sourcestamp": { 10:52:40 INFO - "repository": "", 10:52:40 INFO - "hasPatch": false, 10:52:40 INFO - "project": "", 10:52:40 INFO - "branch": "fx-team-linux64-pgo-talos", 10:52:40 INFO - "changes": [ 10:52:40 INFO - { 10:52:40 INFO - "category": null, 10:52:40 INFO - "files": [ 10:52:40 INFO - { 10:52:40 INFO - "url": null, 10:52:40 INFO - "name": "https://queue.taskcluster.net/v1/task/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 10:52:40 INFO - } 10:52:40 INFO - ], 10:52:40 INFO - "repository": "", 10:52:40 INFO - "rev": "f516533b96a46764f288d336415e5a8aa3468e21", 10:52:40 INFO - "who": "sendchange", 10:52:40 INFO - "when": 1448477513, 10:52:40 INFO - "number": 6706918, 10:52:40 INFO - "comments": "", 10:52:40 INFO - "project": "", 10:52:40 INFO - "at": "Wed 25 Nov 2015 10:51:53", 10:52:40 INFO - "branch": "fx-team-linux64-pgo-talos", 10:52:40 INFO - "revlink": "", 10:52:40 INFO - "properties": [ 10:52:40 INFO - [ 10:52:40 INFO - "buildid", 10:52:40 INFO - "20151125083151", 10:52:40 INFO - "Change" 10:52:40 INFO - ], 10:52:40 INFO - [ 10:52:40 INFO - "builduid", 10:52:40 INFO - "1798f140ff5f4eccb2c778dcc7718b4b", 10:52:40 INFO - "Change" 10:52:40 INFO - ], 10:52:40 INFO - [ 10:52:40 INFO - "pgo_build", 10:52:40 INFO - "True", 10:52:40 INFO - "Change" 10:52:40 INFO - ] 10:52:40 INFO - ], 10:52:40 INFO - "revision": "f516533b96a46764f288d336415e5a8aa3468e21" 10:52:40 INFO - } 10:52:40 INFO - ], 10:52:40 INFO - "revision": "f516533b96a46764f288d336415e5a8aa3468e21" 10:52:40 INFO - } 10:52:40 INFO - } 10:52:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 10:52:40 INFO - Running post-action listener: _resource_record_post_action 10:52:40 INFO - ##### 10:52:40 INFO - ##### Running download-and-extract step. 10:52:40 INFO - ##### 10:52:40 INFO - Running pre-action listener: _resource_record_pre_action 10:52:40 INFO - Running main action method: download_and_extract 10:52:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:52:40 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')]} 10:52:40 INFO - https://queue.taskcluster.net/v1/task/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:52:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/test_packages.json 10:52:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/test_packages.json 10:52:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:52:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:52:41 INFO - Downloaded 1302 bytes. 10:52:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:52:41 INFO - Using the following test package requirements: 10:52:41 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:52:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:52:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:41 INFO - u'jsshell-linux-x86_64.zip'], 10:52:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:52:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:52:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:52:41 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:52:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:52:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:52:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:52:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:41 INFO - https://queue.taskcluster.net/v1/task/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:52:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:52:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:52:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aDWjIoIrTay8dnyc3mY_dw/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 10:52:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aDWjIoIrTay8dnyc3mY_dw/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 10:52:42 INFO - Downloaded 22754332 bytes. 10:52:42 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 10:52:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:52:42 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 10:52:44 INFO - Return code: 0 10:52:44 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:44 INFO - https://queue.taskcluster.net/v1/task/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:52:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:52:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:52:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aDWjIoIrTay8dnyc3mY_dw/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 10:52:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aDWjIoIrTay8dnyc3mY_dw/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 10:52:45 INFO - Downloaded 22754332 bytes. 10:52:45 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 10:52:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:52:45 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 10:52:46 INFO - Return code: 0 10:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:46 INFO - https://queue.taskcluster.net/v1/task/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:52:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:52:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:52:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aDWjIoIrTay8dnyc3mY_dw/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 10:52:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aDWjIoIrTay8dnyc3mY_dw/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 10:52:47 INFO - Downloaded 11131717 bytes. 10:52:47 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 10:52:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:52:47 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 10:52:48 INFO - Return code: 0 10:52: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')]} 10:52:48 INFO - https://queue.taskcluster.net/v1/task/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:52:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:52:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:52:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aDWjIoIrTay8dnyc3mY_dw/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 10:52:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aDWjIoIrTay8dnyc3mY_dw/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 10:52:49 INFO - Downloaded 58387706 bytes. 10:52:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:52:49 INFO - mkdir: /builds/slave/test-pgo/properties 10:52:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:52:49 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:52:49 INFO - Contents: 10:52:49 INFO - build_url:https://queue.taskcluster.net/v1/task/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:52:49 INFO - Running post-action listener: _resource_record_post_action 10:52:49 INFO - Running post-action listener: set_extra_try_arguments 10:52:49 INFO - ##### 10:52:49 INFO - ##### Running populate-webroot step. 10:52:49 INFO - ##### 10:52:49 INFO - Running pre-action listener: _resource_record_pre_action 10:52:49 INFO - Running main action method: populate_webroot 10:52:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:52:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:52:49 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 10:52:49 INFO - '../fennec_ids.txt'], 10:52:49 INFO - 'tests': ['tcheck2']}, 10:52:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:52:49 INFO - '--tppagecycles', 10:52:49 INFO - '7'], 10:52:49 INFO - 'tests': ['tsvgm']}}, 10:52:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:52:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:52:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:52:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:52:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:52:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:52:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:52:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:49 INFO - 'talos_options': ['--e10s'], 10:52:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:52:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:49 INFO - 'tests': ['damp', 'tps']}, 10:52:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:49 INFO - 'talos_options': ['--e10s'], 10:52:49 INFO - 'tests': ['damp', 'tps']}, 10:52:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:52:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:52:49 INFO - 'other': {'tests': ['a11yr', 10:52:49 INFO - 'ts_paint', 10:52:49 INFO - 'tpaint', 10:52:49 INFO - 'sessionrestore', 10:52:49 INFO - 'sessionrestore_no_auto_restore']}, 10:52:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:52:49 INFO - 'tests': ['a11yr', 10:52:49 INFO - 'ts_paint', 10:52:49 INFO - 'tpaint', 10:52:49 INFO - 'sessionrestore', 10:52:49 INFO - 'sessionrestore_no_auto_restore']}, 10:52:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:52:49 INFO - 'tests': ['a11yr', 10:52:49 INFO - 'ts_paint', 10:52:49 INFO - 'tpaint', 10:52:49 INFO - 'sessionrestore', 10:52:49 INFO - 'sessionrestore_no_auto_restore']}, 10:52:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:52:49 INFO - 'tests': ['a11yr', 10:52:49 INFO - 'ts_paint', 10:52:49 INFO - 'tpaint', 10:52:49 INFO - 'sessionrestore', 10:52:49 INFO - 'sessionrestore_no_auto_restore']}, 10:52:49 INFO - 'other_l64': {'tests': ['a11yr', 10:52:49 INFO - 'ts_paint', 10:52:49 INFO - 'tpaint', 10:52:49 INFO - 'sessionrestore', 10:52:49 INFO - 'sessionrestore_no_auto_restore']}, 10:52:49 INFO - 'other_nol64': {'tests': ['a11yr', 10:52:49 INFO - 'ts_paint', 10:52:49 INFO - 'tpaint', 10:52:49 INFO - 'sessionrestore', 10:52:49 INFO - 'sessionrestore_no_auto_restore']}, 10:52:49 INFO - 'svgr': {'tests': ['tsvgx', 10:52:49 INFO - 'tsvgr_opacity', 10:52:49 INFO - 'tart', 10:52:49 INFO - 'tscrollx', 10:52:49 INFO - 'cart']}, 10:52:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:52:49 INFO - 'tests': ['tsvgx', 10:52:49 INFO - 'tsvgr_opacity', 10:52:49 INFO - 'tart', 10:52:49 INFO - 'tscrollx', 10:52:49 INFO - 'cart']}, 10:52:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:49 INFO - 'tests': ['tp5o']}, 10:52:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:49 INFO - 'talos_options': ['--e10s'], 10:52:49 INFO - 'tests': ['tp5o']}, 10:52:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:49 INFO - 'talos_options': ['--xperf_path', 10:52:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:52:49 INFO - 'tests': ['tp5n']}, 10:52:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:49 INFO - 'talos_options': ['--e10s', 10:52:49 INFO - '--xperf_path', 10:52:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:52:49 INFO - 'tests': ['tp5n']}}, 10:52:49 INFO - 'talos.zip': {'path': '', 10:52:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:52:49 INFO - Running post-action listener: _resource_record_post_action 10:52:49 INFO - ##### 10:52:49 INFO - ##### Running create-virtualenv step. 10:52:49 INFO - ##### 10:52:49 INFO - Running pre-action listener: _resource_record_pre_action 10:52:49 INFO - Running main action method: create_virtualenv 10:52:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:52:49 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 10:52:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:52:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:52:49 INFO - Using real prefix '/usr' 10:52:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:52:50 INFO - Installing distribute.............................................................................................................................................................................................done. 10:52:51 INFO - Installing pip.................done. 10:52:51 INFO - Return code: 0 10:52:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:51 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 0x18e1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9d640>, '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 0x1b9e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e9d0>, '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': '6587686cb2da90a5f91b3170000001be-1448475139.858636-186839823', '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 10:52:51 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 10:52:51 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 10:52:51 INFO - Using env: {'DISPLAY': ':0', 10:52:51 INFO - 'HOME': '/home/cltbld', 10:52:51 INFO - 'LANG': 'en_US.UTF-8', 10:52:51 INFO - 'LANGUAGE': 'en_US:en', 10:52:51 INFO - 'LOGNAME': 'cltbld', 10:52:51 INFO - 'MAIL': '/var/mail/cltbld', 10:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:51 INFO - 'MOZ_NO_REMOTE': '1', 10:52:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:51 INFO - 'NO_EM_RESTART': '1', 10:52:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:52:51 INFO - 'PWD': '/builds/slave/test-pgo', 10:52:51 INFO - 'SHELL': '/bin/bash', 10:52:51 INFO - 'SHLVL': '1', 10:52:51 INFO - 'TERM': 'linux', 10:52:51 INFO - 'TMOUT': '86400', 10:52:51 INFO - 'USER': 'cltbld', 10:52:51 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448475139.858636-186839823', 10:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:51 INFO - '_': '/tools/buildbot/bin/python'} 10:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:52 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 10:52:52 INFO - Cleaning up... 10:52:52 INFO - Return code: 0 10:52:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:52: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')]} 10:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52: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')]} 10:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52: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', '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 0x18e1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9d640>, '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 0x1b9e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e9d0>, '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': '6587686cb2da90a5f91b3170000001be-1448475139.858636-186839823', '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 10:52: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 10:52: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 psutil>=0.7.1 10:52:52 INFO - Using env: {'DISPLAY': ':0', 10:52:52 INFO - 'HOME': '/home/cltbld', 10:52:52 INFO - 'LANG': 'en_US.UTF-8', 10:52:52 INFO - 'LANGUAGE': 'en_US:en', 10:52:52 INFO - 'LOGNAME': 'cltbld', 10:52:52 INFO - 'MAIL': '/var/mail/cltbld', 10:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:52 INFO - 'MOZ_NO_REMOTE': '1', 10:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:52 INFO - 'NO_EM_RESTART': '1', 10:52:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:52:52 INFO - 'PWD': '/builds/slave/test-pgo', 10:52:52 INFO - 'SHELL': '/bin/bash', 10:52:52 INFO - 'SHLVL': '1', 10:52:52 INFO - 'TERM': 'linux', 10:52:52 INFO - 'TMOUT': '86400', 10:52:52 INFO - 'USER': 'cltbld', 10:52:52 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448475139.858636-186839823', 10:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:52 INFO - '_': '/tools/buildbot/bin/python'} 10:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:52 INFO - Downloading/unpacking psutil>=0.7.1 10:52:52 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 10:52:52 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 10:52:52 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 10:52:52 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 10:52:52 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 10:52:52 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 10:52:54 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:52:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:52:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:52:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:54 INFO - Installing collected packages: psutil 10:52:54 INFO - Running setup.py install for psutil 10:52:54 INFO - building 'psutil._psutil_linux' extension 10:52:54 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 10:52:54 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 10:52:54 INFO - building 'psutil._psutil_posix' extension 10:52:54 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 10:52:54 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 10:52:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:54 INFO - Successfully installed psutil 10:52:54 INFO - Cleaning up... 10:52:54 INFO - Return code: 0 10:52:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:52:54 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')]} 10:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:54 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')]} 10:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:54 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 0x18e1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9d640>, '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 0x1b9e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e9d0>, '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': '6587686cb2da90a5f91b3170000001be-1448475139.858636-186839823', '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 10:52:54 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 10:52:54 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 10:52:54 INFO - Using env: {'DISPLAY': ':0', 10:52:54 INFO - 'HOME': '/home/cltbld', 10:52:54 INFO - 'LANG': 'en_US.UTF-8', 10:52:54 INFO - 'LANGUAGE': 'en_US:en', 10:52:54 INFO - 'LOGNAME': 'cltbld', 10:52:54 INFO - 'MAIL': '/var/mail/cltbld', 10:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:54 INFO - 'MOZ_NO_REMOTE': '1', 10:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:54 INFO - 'NO_EM_RESTART': '1', 10:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:52:54 INFO - 'PWD': '/builds/slave/test-pgo', 10:52:54 INFO - 'SHELL': '/bin/bash', 10:52:54 INFO - 'SHLVL': '1', 10:52:54 INFO - 'TERM': 'linux', 10:52:54 INFO - 'TMOUT': '86400', 10:52:54 INFO - 'USER': 'cltbld', 10:52:54 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448475139.858636-186839823', 10:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:54 INFO - '_': '/tools/buildbot/bin/python'} 10:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:52:54 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 10:52:54 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 10:52:54 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 10:52:54 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 10:52:54 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 10:52:54 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 10:52:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:52:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:52:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:52:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:52:56 INFO - Installing collected packages: mozsystemmonitor 10:52:56 INFO - Running setup.py install for mozsystemmonitor 10:52:56 INFO - Successfully installed mozsystemmonitor 10:52:56 INFO - Cleaning up... 10:52:56 INFO - Return code: 0 10:52:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:56 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 0x18e1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9d640>, '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 0x1b9e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e9d0>, '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': '6587686cb2da90a5f91b3170000001be-1448475139.858636-186839823', '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 10:52:56 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 10:52:56 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 10:52:56 INFO - Using env: {'DISPLAY': ':0', 10:52:56 INFO - 'HOME': '/home/cltbld', 10:52:56 INFO - 'LANG': 'en_US.UTF-8', 10:52:56 INFO - 'LANGUAGE': 'en_US:en', 10:52:56 INFO - 'LOGNAME': 'cltbld', 10:52:56 INFO - 'MAIL': '/var/mail/cltbld', 10:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:56 INFO - 'MOZ_NO_REMOTE': '1', 10:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:56 INFO - 'NO_EM_RESTART': '1', 10:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:52:56 INFO - 'PWD': '/builds/slave/test-pgo', 10:52:56 INFO - 'SHELL': '/bin/bash', 10:52:56 INFO - 'SHLVL': '1', 10:52:56 INFO - 'TERM': 'linux', 10:52:56 INFO - 'TMOUT': '86400', 10:52:56 INFO - 'USER': 'cltbld', 10:52:56 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448475139.858636-186839823', 10:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:56 INFO - '_': '/tools/buildbot/bin/python'} 10:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:57 INFO - Downloading/unpacking blobuploader==1.2.4 10:52:57 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 10:52:57 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 10:52:57 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 10:52:57 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 10:52:57 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 10:52:57 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 10:53:00 INFO - Downloading blobuploader-1.2.4.tar.gz 10:53:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:53:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:53:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:53:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:53:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53:00 INFO - Downloading docopt-0.6.1.tar.gz 10:53:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:53:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:53:01 INFO - Installing collected packages: blobuploader, requests, docopt 10:53:01 INFO - Running setup.py install for blobuploader 10:53:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:53:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:53:01 INFO - Running setup.py install for requests 10:53:01 INFO - Running setup.py install for docopt 10:53:01 INFO - Successfully installed blobuploader requests docopt 10:53:01 INFO - Cleaning up... 10:53:01 INFO - Return code: 0 10:53:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:01 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 0x18e1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9d640>, '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 0x1b9e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e9d0>, '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': '6587686cb2da90a5f91b3170000001be-1448475139.858636-186839823', '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 10:53:01 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 10:53:01 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 10:53:01 INFO - Using env: {'DISPLAY': ':0', 10:53:01 INFO - 'HOME': '/home/cltbld', 10:53:01 INFO - 'LANG': 'en_US.UTF-8', 10:53:01 INFO - 'LANGUAGE': 'en_US:en', 10:53:01 INFO - 'LOGNAME': 'cltbld', 10:53:01 INFO - 'MAIL': '/var/mail/cltbld', 10:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:01 INFO - 'MOZ_NO_REMOTE': '1', 10:53:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:01 INFO - 'NO_EM_RESTART': '1', 10:53:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:01 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:01 INFO - 'SHELL': '/bin/bash', 10:53:01 INFO - 'SHLVL': '1', 10:53:01 INFO - 'TERM': 'linux', 10:53:01 INFO - 'TMOUT': '86400', 10:53:01 INFO - 'USER': 'cltbld', 10:53:01 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448475139.858636-186839823', 10:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:01 INFO - '_': '/tools/buildbot/bin/python'} 10:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:53:01 INFO - Running setup.py (path:/tmp/pip-IYudQn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:53:01 INFO - Running setup.py (path:/tmp/pip-tq3g7i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:53:02 INFO - Running setup.py (path:/tmp/pip-nYbySl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:53:02 INFO - Running setup.py (path:/tmp/pip-UMyHBj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:53:02 INFO - Running setup.py (path:/tmp/pip-TlrsNI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:53:02 INFO - Running setup.py (path:/tmp/pip-eUBfHf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:53:02 INFO - Running setup.py (path:/tmp/pip-AElb_U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:53:02 INFO - Running setup.py (path:/tmp/pip-vZSx2a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:53:02 INFO - Running setup.py (path:/tmp/pip-I4WeX1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:53:02 INFO - Running setup.py (path:/tmp/pip-jFcQO2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:53:02 INFO - Running setup.py (path:/tmp/pip-S9r2xG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:53:02 INFO - Running setup.py (path:/tmp/pip-pvp0ku-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:53:02 INFO - Running setup.py (path:/tmp/pip-QUrREw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:53:02 INFO - Running setup.py (path:/tmp/pip-Rw0CMe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:53:02 INFO - Running setup.py (path:/tmp/pip-qhj8cz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:53:02 INFO - Running setup.py (path:/tmp/pip-UHCwOz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:53:03 INFO - Running setup.py (path:/tmp/pip-dbbgib-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:53:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:53:03 INFO - Running setup.py install for manifestparser 10:53:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:53:03 INFO - Running setup.py install for mozcrash 10:53:03 INFO - Running setup.py install for mozdebug 10:53:03 INFO - Running setup.py install for mozdevice 10:53:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:53:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:53:03 INFO - Running setup.py install for mozfile 10:53:03 INFO - Running setup.py install for mozhttpd 10:53:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:53:03 INFO - Running setup.py install for mozinfo 10:53:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:53:03 INFO - Running setup.py install for mozInstall 10:53:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:53:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:53:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:53:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:53:03 INFO - Running setup.py install for mozleak 10:53:03 INFO - Running setup.py install for mozlog 10:53:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:53:04 INFO - Running setup.py install for moznetwork 10:53:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:53:04 INFO - Running setup.py install for mozprocess 10:53:04 INFO - Running setup.py install for mozprofile 10:53:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:53:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:53:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:53:04 INFO - Running setup.py install for mozrunner 10:53:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:53:04 INFO - Running setup.py install for mozscreenshot 10:53:04 INFO - Running setup.py install for moztest 10:53:04 INFO - Running setup.py install for mozversion 10:53:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:53:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:53:04 INFO - Cleaning up... 10:53:04 INFO - Return code: 0 10:53:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:04 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 0x18e1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9d640>, '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 0x1b9e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e9d0>, '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': '6587686cb2da90a5f91b3170000001be-1448475139.858636-186839823', '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 10:53:04 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 10:53:04 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 10:53:04 INFO - Using env: {'DISPLAY': ':0', 10:53:04 INFO - 'HOME': '/home/cltbld', 10:53:04 INFO - 'LANG': 'en_US.UTF-8', 10:53:04 INFO - 'LANGUAGE': 'en_US:en', 10:53:04 INFO - 'LOGNAME': 'cltbld', 10:53:04 INFO - 'MAIL': '/var/mail/cltbld', 10:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:04 INFO - 'MOZ_NO_REMOTE': '1', 10:53:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:04 INFO - 'NO_EM_RESTART': '1', 10:53:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:04 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:04 INFO - 'SHELL': '/bin/bash', 10:53:04 INFO - 'SHLVL': '1', 10:53:04 INFO - 'TERM': 'linux', 10:53:04 INFO - 'TMOUT': '86400', 10:53:04 INFO - 'USER': 'cltbld', 10:53:04 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448475139.858636-186839823', 10:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:04 INFO - '_': '/tools/buildbot/bin/python'} 10:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:53:05 INFO - Running setup.py (path:/tmp/pip-geV3GV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:53: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)) 10:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:53:05 INFO - Running setup.py (path:/tmp/pip-g4PXni-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:53: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)) 10:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:53:05 INFO - Running setup.py (path:/tmp/pip-RK5LNj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:53: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)) 10:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:53:05 INFO - Running setup.py (path:/tmp/pip-9_GD2h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:53: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)) 10:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:53:05 INFO - Running setup.py (path:/tmp/pip-Nyiyji-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:53:05 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)) 10:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:53:05 INFO - Running setup.py (path:/tmp/pip-UpZyix-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:53:05 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)) 10:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:53:05 INFO - Running setup.py (path:/tmp/pip-ySIomh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:53:05 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)) 10:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:53:05 INFO - Running setup.py (path:/tmp/pip-ZpqKVW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:53:05 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)) 10:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:53:05 INFO - Running setup.py (path:/tmp/pip-9f2t9l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:53:05 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)) 10:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:53:05 INFO - Running setup.py (path:/tmp/pip-AcZ4Ff-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:53:05 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)) 10:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:53:05 INFO - Running setup.py (path:/tmp/pip-9mGJfz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:53:05 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)) 10:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:53:05 INFO - Running setup.py (path:/tmp/pip-wRyI6Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:53:05 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)) 10:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:53:05 INFO - Running setup.py (path:/tmp/pip-pFb6Pg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:53: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)) 10:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:53:06 INFO - Running setup.py (path:/tmp/pip-89hKpY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:53: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)) 10:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:53:06 INFO - Running setup.py (path:/tmp/pip-OABg6a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:53: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)) 10:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:53:06 INFO - Running setup.py (path:/tmp/pip-jhwfyG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:53: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)) 10:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:53:06 INFO - Running setup.py (path:/tmp/pip-FtSY0t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:53: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)) 10:53: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)) 10:53: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)) 10:53: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)) 10:53: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)) 10:53: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)) 10:53:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53:07 INFO - Downloading blessings-1.5.1.tar.gz 10:53: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 10:53:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:53:08 INFO - Installing collected packages: blessings 10:53:08 INFO - Running setup.py install for blessings 10:53:08 INFO - Successfully installed blessings 10:53:08 INFO - Cleaning up... 10:53:08 INFO - Return code: 0 10:53:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:53:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:53:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:53:08 INFO - Reading from file tmpfile_stdout 10:53:08 INFO - Current package versions: 10:53:08 INFO - argparse == 1.2.1 10:53:08 INFO - blessings == 1.5.1 10:53:08 INFO - blobuploader == 1.2.4 10:53:08 INFO - docopt == 0.6.1 10:53:08 INFO - manifestparser == 1.1 10:53:08 INFO - mozInstall == 1.12 10:53:08 INFO - mozcrash == 0.16 10:53:08 INFO - mozdebug == 0.1 10:53:08 INFO - mozdevice == 0.47 10:53:08 INFO - mozfile == 1.2 10:53:08 INFO - mozhttpd == 0.7 10:53:08 INFO - mozinfo == 0.9 10:53:08 INFO - mozleak == 0.1 10:53:08 INFO - mozlog == 3.1 10:53:08 INFO - moznetwork == 0.27 10:53:08 INFO - mozprocess == 0.22 10:53:08 INFO - mozprofile == 0.27 10:53:08 INFO - mozrunner == 6.11 10:53:08 INFO - mozscreenshot == 0.1 10:53:08 INFO - mozsystemmonitor == 0.0 10:53:08 INFO - moztest == 0.7 10:53:08 INFO - mozversion == 1.4 10:53:08 INFO - psutil == 3.1.1 10:53:08 INFO - requests == 1.2.3 10:53:08 INFO - wsgiref == 0.1.2 10:53:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:08 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 0x18e1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9d640>, '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 0x1b9e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e9d0>, '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': '6587686cb2da90a5f91b3170000001be-1448475139.858636-186839823', '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 10:53:08 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 10:53:08 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 10:53:08 INFO - Using env: {'DISPLAY': ':0', 10:53:08 INFO - 'HOME': '/home/cltbld', 10:53:08 INFO - 'LANG': 'en_US.UTF-8', 10:53:08 INFO - 'LANGUAGE': 'en_US:en', 10:53:08 INFO - 'LOGNAME': 'cltbld', 10:53:08 INFO - 'MAIL': '/var/mail/cltbld', 10:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:08 INFO - 'MOZ_NO_REMOTE': '1', 10:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:08 INFO - 'NO_EM_RESTART': '1', 10:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:08 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:08 INFO - 'SHELL': '/bin/bash', 10:53:08 INFO - 'SHLVL': '1', 10:53:08 INFO - 'TERM': 'linux', 10:53:08 INFO - 'TMOUT': '86400', 10:53:08 INFO - 'USER': 'cltbld', 10:53:08 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448475139.858636-186839823', 10:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:08 INFO - '_': '/tools/buildbot/bin/python'} 10:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:08 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)) 10:53:08 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)) 10:53:08 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)) 10:53:08 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)) 10:53:08 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)) 10:53:08 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)) 10:53:08 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)) 10:53:08 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)) 10:53:08 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)) 10:53:08 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)) 10:53:08 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)) 10:53:08 INFO - Cleaning up... 10:53:08 INFO - Return code: 0 10:53:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:08 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 0x18e1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9d640>, '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 0x1b9e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e9d0>, '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': '6587686cb2da90a5f91b3170000001be-1448475139.858636-186839823', '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 10:53:08 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 10:53:08 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 10:53:08 INFO - Using env: {'DISPLAY': ':0', 10:53:08 INFO - 'HOME': '/home/cltbld', 10:53:08 INFO - 'LANG': 'en_US.UTF-8', 10:53:08 INFO - 'LANGUAGE': 'en_US:en', 10:53:08 INFO - 'LOGNAME': 'cltbld', 10:53:08 INFO - 'MAIL': '/var/mail/cltbld', 10:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:08 INFO - 'MOZ_NO_REMOTE': '1', 10:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:08 INFO - 'NO_EM_RESTART': '1', 10:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:08 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:08 INFO - 'SHELL': '/bin/bash', 10:53:08 INFO - 'SHLVL': '1', 10:53:08 INFO - 'TERM': 'linux', 10:53:08 INFO - 'TMOUT': '86400', 10:53:08 INFO - 'USER': 'cltbld', 10:53:08 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448475139.858636-186839823', 10:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:08 INFO - '_': '/tools/buildbot/bin/python'} 10:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:08 INFO - Downloading/unpacking jsonschema 10:53:08 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 10:53:08 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 10:53:08 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 10:53:08 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 10:53:08 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 10:53:08 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 10:53:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:53:10 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 10:53:10 INFO - Downloading/unpacking functools32 (from jsonschema) 10:53:10 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 10:53:10 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 10:53:10 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 10:53:10 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 10:53:10 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 10:53:10 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 10:53:10 INFO - Downloading functools32-3.2.3-2.tar.gz 10:53:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:53:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:53:10 INFO - warning: no files found matching '*.txt' 10:53:10 INFO - no previously-included directories found matching 'build' 10:53:10 INFO - no previously-included directories found matching 'dist' 10:53:10 INFO - no previously-included directories found matching '.git*' 10:53:10 INFO - Installing collected packages: jsonschema, functools32 10:53:10 INFO - Running setup.py install for functools32 10:53:10 INFO - warning: no files found matching '*.txt' 10:53:10 INFO - no previously-included directories found matching 'build' 10:53:10 INFO - no previously-included directories found matching 'dist' 10:53:10 INFO - no previously-included directories found matching '.git*' 10:53:10 INFO - Successfully installed jsonschema functools32 10:53:10 INFO - Cleaning up... 10:53:11 INFO - Return code: 0 10:53:11 INFO - Running post-action listener: _resource_record_post_action 10:53:11 INFO - Running post-action listener: _start_resource_monitoring 10:53:11 INFO - Starting resource monitoring. 10:53:11 INFO - ##### 10:53:11 INFO - ##### Running install step. 10:53:11 INFO - ##### 10:53:11 INFO - Running pre-action listener: _resource_record_pre_action 10:53:11 INFO - Running main action method: install 10:53:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:53:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:53:11 INFO - Reading from file tmpfile_stdout 10:53:11 INFO - Detecting whether we're running mozinstall >=1.0... 10:53:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:53:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:53:11 INFO - Reading from file tmpfile_stdout 10:53:11 INFO - Output received: 10:53:11 INFO - Usage: mozinstall [options] installer 10:53:11 INFO - Options: 10:53:11 INFO - -h, --help show this help message and exit 10:53:11 INFO - -d DEST, --destination=DEST 10:53:11 INFO - Directory to install application into. [default: 10:53:11 INFO - "/builds/slave/test-pgo"] 10:53:11 INFO - --app=APP Application being installed. [default: firefox] 10:53:11 INFO - mkdir: /builds/slave/test-pgo/build/application 10:53: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'] 10:53: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 10:53:26 INFO - Reading from file tmpfile_stdout 10:53:26 INFO - Output received: 10:53:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:53:26 INFO - Running post-action listener: _resource_record_post_action 10:53:26 INFO - ##### 10:53:26 INFO - ##### Running run-tests step. 10:53:26 INFO - ##### 10:53:26 INFO - Running pre-action listener: _resource_record_pre_action 10:53:26 INFO - Running main action method: run_tests 10:53:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:53:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:53:26 INFO - Python 2.7.3 10:53:26 INFO - Return code: 0 10:53:26 INFO - grabbing minidump binary from tooltool 10:53: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')]} 10:53: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 0x1b9d640>, '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 0x1b9e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:53: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 10:53: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 10:53:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:53:26 INFO - Return code: 0 10:53:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:53:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:53:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:53:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:53:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:53: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/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 10:53: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/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost 10:53:26 INFO - Using env: {'DISPLAY': ':0', 10:53:26 INFO - 'HOME': '/home/cltbld', 10:53:26 INFO - 'LANG': 'en_US.UTF-8', 10:53:26 INFO - 'LANGUAGE': 'en_US:en', 10:53:26 INFO - 'LOGNAME': 'cltbld', 10:53:26 INFO - 'MAIL': '/var/mail/cltbld', 10:53:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:53:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:26 INFO - 'MOZ_NO_REMOTE': '1', 10:53:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:53:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:26 INFO - 'NO_EM_RESTART': '1', 10:53:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:26 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:53:26 INFO - 'SHELL': '/bin/bash', 10:53:26 INFO - 'SHLVL': '1', 10:53:26 INFO - 'TERM': 'linux', 10:53:26 INFO - 'TMOUT': '86400', 10:53:26 INFO - 'USER': 'cltbld', 10:53:26 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448475139.858636-186839823', 10:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:26 INFO - '_': '/tools/buildbot/bin/python'} 10:53: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/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] with output_timeout 3600 10:53:26 INFO - mozversion INFO | application_buildid: 20151125083151 10:53:26 INFO - mozversion INFO | application_changeset: f516533b96a46764f288d336415e5a8aa3468e21 10:53:26 INFO - mozversion INFO | application_display_name: Nightly 10:53:26 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:53:26 INFO - mozversion INFO | application_name: Firefox 10:53:26 INFO - mozversion INFO | application_remotingname: firefox 10:53:26 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:53:26 INFO - mozversion INFO | application_vendor: Mozilla 10:53:26 INFO - mozversion INFO | application_version: 45.0a1 10:53:26 INFO - mozversion INFO | platform_buildid: 20151125083151 10:53:26 INFO - mozversion INFO | platform_changeset: f516533b96a46764f288d336415e5a8aa3468e21 10:53:26 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:53:26 INFO - mozversion INFO | platform_version: 45.0a1 10:53:26 INFO - 2015-11-25 10:53:26,280 DEBUG : using testdate: 1448477606 10:53:26 INFO - 2015-11-25 10:53:26,280 DEBUG : actual date: 1448477606 10:53:26 INFO - 2015-11-25 10:53:26,330 INFO : starting webserver on 'localhost:42506' 10:53:26 INFO - 2015-11-25 10:53:26,331 INFO : Starting test suite talos-linux64-ix-017.e 10:53:26 INFO - 2015-11-25 10:53:26,331 INFO : Starting test dromaeo_css 10:53:26 INFO - 2015-11-25 10:53:26,332 DEBUG : operating with platform_type : linux_ 10:53:26 INFO - 2015-11-25 10:53:26,332 INFO : Initialising browser for dromaeo_css test... 10:53:26 INFO - 2015-11-25 10:53:26,344 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaOG6IV/profile http://localhost:42506/getInfo.html 10:53:30 INFO - 2015-11-25 10:53:30,550 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:53:30 INFO - 2015-11-25 10:53:30,551 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:53:30 INFO - 2015-11-25 10:53:30,551 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:53:30 INFO - 2015-11-25 10:53:30,551 DEBUG : BROWSER_OUTPUT: __metrics 10:53:31 INFO - 2015-11-25 10:53:31,529 INFO : Browser initialized. 10:53:31 INFO - 2015-11-25 10:53:31,530 INFO : Running cycle 1/1 for dromaeo_css test... 10:53:31 INFO - 2015-11-25 10:53:31,530 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaOG6IV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:53:43 INFO - 2015-11-25 10:53:43,331 DEBUG : BROWSER_OUTPUT: RSS: Main: 138719232 10:53:43 INFO - 2015-11-25 10:53:43,331 DEBUG : BROWSER_OUTPUT: 10:54:32 INFO - 2015-11-25 10:54:32,971 DEBUG : BROWSER_OUTPUT: 1448477672970 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] 10:56:42 INFO - 2015-11-25 10:56:42,373 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42506/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42506/tests/dromaeo/cssquery-ext.html) 10:56:43 INFO - 2015-11-25 10:56:43,510 DEBUG : BROWSER_OUTPUT: RSS: Main: 148549632 10:56:43 INFO - 2015-11-25 10:56:43,511 DEBUG : BROWSER_OUTPUT: 10:59:45 INFO - 2015-11-25 10:59:45,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42506/tests/dromaeo/cssquery-ext.html (next: http://localhost:42506/tests/dromaeo/cssquery-jquery.html) 10:59:46 INFO - 2015-11-25 10:59:46,060 DEBUG : BROWSER_OUTPUT: RSS: Main: 143085568 10:59:46 INFO - 2015-11-25 10:59:46,060 DEBUG : BROWSER_OUTPUT: 11:02:47 INFO - 2015-11-25 11:02:47,674 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42506/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42506/tests/dromaeo/cssquery-mootools.html) 11:02:48 INFO - 2015-11-25 11:02:48,263 DEBUG : BROWSER_OUTPUT: RSS: Main: 143396864 11:02:48 INFO - 2015-11-25 11:02:48,263 DEBUG : BROWSER_OUTPUT: 11:05:49 INFO - 2015-11-25 11:05:49,920 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42506/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42506/tests/dromaeo/cssquery-prototype.html) 11:05:50 INFO - 2015-11-25 11:05:50,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 141586432 11:05:50 INFO - 2015-11-25 11:05:50,530 DEBUG : BROWSER_OUTPUT: 11:08:52 INFO - 2015-11-25 11:08:52,841 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42506/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42506/tests/dromaeo/cssquery-yui.html) 11:08:53 INFO - 2015-11-25 11:08:53,443 DEBUG : BROWSER_OUTPUT: RSS: Main: 141647872 11:08:53 INFO - 2015-11-25 11:08:53,443 DEBUG : BROWSER_OUTPUT: 11:11:55 INFO - 2015-11-25 11:11:55,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42506/tests/dromaeo/cssquery-yui.html (next: http://localhost:42506/tests/dromaeo/cssquery-dojo.html) 11:11:56 INFO - 2015-11-25 11:11:56,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 144838656 11:11:56 INFO - 2015-11-25 11:11:56,091 DEBUG : BROWSER_OUTPUT: 11:11:56 INFO - 2015-11-25 11:11:56,091 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:11:56 INFO - 2015-11-25 11:11:56,092 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:11:56 INFO - 2015-11-25 11:11:56,092 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:11:56 INFO - 2015-11-25 11:11:56,092 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:11:56 INFO - 2015-11-25 11:11:56,092 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3241.0600925731537;3246.977202181313;3275.88534401296;3280.6227283862363;3303.8513266902996;5289.206619007151;5413.052715774744;5420.105682562383;5434.239206511087;5445.292112025441;5376.973115134429;5393.4336894626085;5447.373552041517;5470.8085217017415;5566.86082847929;5004.949950500494;5062.063518249117;5138.922916156261;5144.6655967362185;5168.948310516903;4803.159447096744;5094.5160209780015;5243.108671525831;5247.973760131194;5290.444503327153;4955.132851750929;5046.520580544842;5076.593872490229;5147.022065807503;5158.896822063556;4929.408470983469;4988.127077761377;5022.84931452057;5057.039162559139;5064.696118232918;4951.836318465158;5006.69959802413;5018.172001619729;5021.246812978083;5062.519060689228;5173.896522069575;5319.707416092114;5335.893282134374;5375.22059301403;5379.65032272901;5860.17957485948;5884.735186916556;5961.433663801932;5965.4929331006915;6003.249593800775;5991.700414979234;6048.848778780522;6078.848028799272;6099.298580663191;6108.572399932006;5346.973265133688;5577.498025177753;5676.290463692038;5677.630953987978;5694.259746233005;5984.581079324493;6009.45914867664;6030.728617212236;6046.062860256668;6097.298810636745;5895.764169433174;5912.46787789101;5923.7926672566255;5942.435468630473;5954.970225148846;5784.132380143013;5908.261467316585;5936.762529498858;5947.226860508193;6045.637261764308;5940.138679891392;5988.9401105989255;6001.819945401645;6011.188489553854;6018.548608854266;5972.522198224132;5982.820515384546;5988.341282458926;5988.550858685616;5990.760369585168;4406.889827754268;4488.236999710057;4538.682292239511;4555.088982203572;4598.540145985375;4000.19996000801;4011.6389524942897;4028.798560071985;4057.168280502549;4104.199681062224;5665.8300250991715;5666.688332141772;5666.688332141772;5674.602777805514;5688.914666280009;5818.5636077294375;5957.6127551709;5967.104934259895;5991.400859914061;6042.093685947055;5544.362398324163;5553.250311208016;5564.33228012641;5635.6618602883955;5692.0323544997445;5187.792488300502;5193.428722840485;5194.091034069098;5204.0632686116105;5217.399999000164;5980.641161530409;6173.135760993465;6178.320384757673;6178.752849885954;6192.195014648157;5864.9413505866105;5867.5305975521005;5868.882622347614;5917.378675239038;5963.28440587115;6121.112438696453;6139.3553676863285;6147.477464415575;6167.321594624498;6181.81454556364;5775.537956963349;5873.2658417697785;5896.64620122794;5948.196993405835;5955.583109182316;6000.459958603747;6043.063325184427;6050.273967123973;6092.208012958287;6126.172966649624;5884.411558844081;5884.911726324194;5885.646861188171;5892.882142357043;5894.056950888009;5703.600747947769;5752.424757524214;5865.266841644794;5878.412158784087;5923.170756094064;5686.43135686428;5758.452946970031;5764.538836892954;5765.8558536036935;5775.249217601685;5865.4134586541;5875.001249787461;5880.941190588211;5926.1999630049395;5930.9110363343725;5593.440655934374;5727.11229759388;5744.080947048452;5758.89800222924;5790.363060063474 11:11:56 INFO - 2015-11-25 11:11:56,092 DEBUG : BROWSER_OUTPUT: |1;ext.html;550.9063459211934;596.6211455725614;604.4227762486822;606.1634943777588;609.5489337889962;36918;37483;37623.623763762385;37749.24501509968;37757.811210943975;41759.37360939589;42158.367624485654;42247;42318;42390.36414453778;8713.30293576514;8804.339674524404;8825.382223244376;8838.823223535557;8900.332475064364;8602.35482338824;8667.609957551926;8706.825863482727;8716;8721.345899057564;8673.089325620813;8701.738947831574;8752.168543988311;8757.51833649149;8769.342299327544;8640.697575584856;8714.694985675535;8726.432781869189;8747.868781968276;8778.912210877874;8544.273736732384;8605.569721513899;8645;8663.39356245063;8689.869651955225;39906.800465997774;40235.19529609421;40311.19377612461;40352;40485.59514404848;3240.821754803485;3264.6735326467165;3354.1446931032674;3401.1667141550233;3426.623071462137;29753.55369669435;30067.248318791986;30312.075578705484;30840.53739193914;31051.223719407197;3809.5619003814363;3868.303705333039;3891.8054097295303;3929.390944403622;3995.98002009991;259808;260003;260335;261864.9999999981;262833;43123.35314970278;43750.343744843856;57889.552761180465;58093.12860307099;58220.708896455246;41465.79267103645;41688;41767.37348939768;41792.164156716695;41876.790616046725;15350;15521.301541430663;15564.92217538905;15569;15577.688446231012;11404.087672986141;11589.420528973518;11598;11650.184487085991;11650.30098194111;14447.566573002827;14551.927240363942;14586.34361453737;14597;14619.707605847823;5524.861878452991;5564.33228012641;5569.8500079782925;5639.8590035249445;5656.830295091154;943.8725772020827;969.4183489906;996.4121168510613;1050.76883085721;1080.9028835731738;28527;28808;28882.559224211283;29335.55996660052;29400.411991760044;1033.5555711044324;1042.635077722791;1103.189155970361;1110.4725255503572;1158.0966845860241;15258.361373896729;15381.307841147176;15663.451779187673;15772.76340854888;15850.365985360457;352910;355561;356574;356745;356961;55688.16467752987;55764.442355576735;56044;56154.15768763472;56159.71920140455;1376.2224343246035;1414.9717005660034;1416.6529200345776;1418.432626949208;1425.8716715495448;28138.43723125567;29127;29132.126036218946;29137.56293655639;29340;46966.53033469622;47464.52535474601;47511;47581.524184759095;47719.28421073756;303753;308298;308915;309123;309882;28632.14103576896;29133;32710.34579308448;33591.83204083964;33684;39069.41395879121;39378.80310598543;40073.39889901712;40106.79946600365;40461.1907761849;35932.820335898155;36266.8186659065;37036.81481592575;37303.81348093242;38022.809885950395;36733.08167295732;36931.63068369282;37002.62997369992;37173.070673233386;37301.62698372982;41796.373054404816;41823.58176418197;42138.57861421347;42263.78868105763;42640.14719705527;31774.36451271008;31790;35278.647213528566;35499.645003550664;38357.232855343296;25472;25564.872175639004;26126.34684132836;26220.475590488466;26722.331941700835 11:11:56 INFO - 2015-11-25 11:11:56,092 DEBUG : BROWSER_OUTPUT: |2;jquery.html;360.864675746595;361.88419705694173;363.0470016207455;365.27857481474075;366.8037599884063;16785.41251056213;17331.30674773009;17790.288388464447;17985.280588776448;18437.539061523436;11281.153913456483;11296.378699171562;11369.431528423587;11436.19946603738;11447.885521144786;4868.415790105192;4879.51204879511;4993.575546078588;4997.275395067713;5008.674436161656;4942.110420124376;4980.551750342468;4981.701097934136;4984.177610694249;4984.302197692308;4987.251912213179;5034.270030845525;5630.239917611131;5812.767489300423;5827;5830.183774271605;5866.237389139427;5866.266716660418;5877.85305367365;6023.247094113236;5372.516473517363;5380.515753582157;5382.946170538284;5385.3268341457315;5404.405515393303;12837.358132093357;18119.637607247914;21492.89253553738;21611.02750376237;21856.125754969784;2116.841236907238;2135.135270215565;2150.537634408594;2165.4802847316532;2211.1266049910196;9777;9949.353292035994;11830.290182589073;13416.46334146633;13563.864361356358;1826.4611939477886;1853.481025312901;1877.4086162858655;1885.6982882738696;1905.9332923347615;62274.68862655703;63420;66179.3382066178;67139;68053;10232.181425485944;10374.429406382722;10448.164146868232;10565.36607803519;10586.682399528027;13941.721165576631;13941.790873136912;13950.651233719036;13966.86033139676;13972.672596103353;7569.205233450519;7816.68733250675;7932.325752311002;7950.403719720928;7982.600869956479;7852.136265010844;7900.249476299742;7901.525908445396;7906.683732650629;7949.880751788728;4530.501644819067;4567.634589232854;4593.448786145617;4613.308003799457;4631.814727410866;1830.4417152768267;1837.200817644329;1923.8460923126117;1964.950876228077;1965.1549833571416;884.7743825324501;918.9816203675889;925.5834874306589;961.7835986902891;1092.1099304067159;17288.481345559652;17486.825131748774;17710.91144544269;17856.28574857017;17913.37303194382;942.222666300305;942.3686130292721;966.3284017607696;969.4377261188494;970.7864269860619;10046.296759226783;10175.491225438698;10233.692989210336;10349.379037257788;10351.120154786777;536780;537307;539020;549702;550724;81986;82218.58890705628;82272;82349;83571.5821420889;1112.6217086190572;1149.494222542079;1152.4525850221078;1154.9307041577533;1160.6169963911889;15934;16038.358465661242;16086.919565402099;16142.273597687898;16384.262708178398;34633.134171645914;34682.82658586691;34828.477572836935;35911.82044089867;36286.63713362833;46992.29511557261;48125;48191.5180848187;49089.509104908495;49167.754161228964;9973.401595904268;10242.897571024194;10325.225608079274;10327.535260913428;10342.32774869631;16909.577260568585;17791.644167116843;18288.359907403177;18289.634207315514;18344.72482912784;9413.246940244628;9671.564779584794;9754.804903902024;10637.468126593794;14959.476418325306;8987.685431009882;9179.541022948959;10228.590856365661;10407.895921040692;10413.531391087268;10324.741881453023;10580.735481613021;10648.201384896318;10732;10898;15226;15400;15516.37934482608;15823.762643560585;15879.603009924382;15744.60638484047;15889.284982176061;16383.508494745176;16422.17889105564;16425.342986280415 11:11:56 INFO - 2015-11-25 11:11:56,092 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1482.6812235369393;1560.9843901560985;1611.6615510742743;1716.8626509879202;1836.4674244469113;7814;7930.841383172333;7995.84008319834;8022.839543209139;8140.470869393485;8034.156413576578;8104.513729176254;8110.553919534424;8146.877796833052;8186.590670466483;2289.713785776774;2314.2710046335433;2324.7675232476786;2326.581215381231;2344.3318654183477;2304.1820153845397;2332.242021343062;2338.0764597983784;2341.7658234176615;2343.4024323797407;2292.541491701658;2316.8262380321544;2341.3327201747506;2342.6603142544404;2346.5189636124637;2284.1776960294446;2310.5378924215142;2348.7416384197722;2352.5882970480097;2353.364591560269;2303.8041766449874;2314.9421264468524;2316.096722278313;2319.5476882008015;2334.0897050150456;7857;7947.483413578099;7957.403194760416;7961.562114083723;7963.084245311806;4788.80844766209;4861.368022157097;4870.707757534524;4894.486078961693;4903.632227582945;3066.3713938642527;3113.2683819302674;3155.0850253426706;3171;3189.888353907602;963.3882484622245;970.4129001953787;974.6491263145263;987.6641941739842;995.049727510226;10727.731806704816;10730.839037414446;10754.193435492369;10775.084117849992;10809.83785243222;4269.7224680395675;4327.069680018811;4340.30555111187;4379.64962802975;4396.164728701537;8638.697645582375;8712.477251364939;8724.69463568772;8741.213290803858;8744.256738177326;4841.491643377394;4854.393200849894;4855.830045948375;4859.319695242669;4862.3922009748785;4390.8024138913825;4405.911881762347;4435.1351486459835;4435.290353543418;4455.68810183284;3563.492142579564;3569.9286014280087;3584.856605735741;3598.8560457581925;3616.8914932552066;1089.4716062709579;1090.5201711247025;1106.4080716816466;1109.2567979453786;1132.2074547816562;1079.4764539198482;1089.6458650938318;1130.9208355415042;1265.5760320292804;1366.3987845348015;7436.144843342977;7458.105027396748;7525.285097915689;7558.622068896533;7561.621918904033;1160.1171089841737;1162.7848847963153;1166.6150170443734;1172.472387425645;1178.4107946026986;5856.6486010838635;5865.090910908731;5883.852648733541;5895.528357731371;5910.615809972338;9112.088791120967;9396.671116511026;9528.95235523818;9562.61749530011;9623.663171788954;9335.766605834908;9337.859932101024;9399.436033837992;9404.764880878032;9495.14543691071;7067.505274630829;7221.53060051095;7222.891656625155;7229.349358557755;7378.889316660255;7309.195988441161;7347.963260183665;7416.6291685414435;7431.479796414199;7441.590712510864;8296.668133274601;8387.53868537212;8402.95798521028;8455.66177352899;8520.10538893432;8446.155384461505;8599.054104048424;8621.913780862362;8626.56867156627;8653.17794809492;7012.123484564429;7066.823329416806;7088.787336379917;7089.680964356513;7091;7525.247475252431;7653.846923061396;7679.3856491481665;7692.42306826979;7735.574543400167;6318;7171.713131474683;7207.603581803051;7312.0128782613665;7434.405247580073;6463.224413070461;6660.400563949268;7042.542234754725;7120.145582530129;7195.928040719526;6756.729730810909;6825.761098361533;6845.383915447634;6868.381845633717;6971.58170509771;6531.804045878631;6540.149780528501;6551.115599394021;6558.344165583403;6559;6590.5716128451495;6614.933850661432;6616.966915165393;6617.933820661924;6697.196336439463 11:11:56 INFO - 2015-11-25 11:11:56,092 DEBUG : BROWSER_OUTPUT: |4;prototype.html;333.65300087908577;335.83711899728627;338.6917904706717;346.75900249326696;347.7583079759567;6160.383961603838;6205.81382558524;6243.875122497553;6263.906041409371;6354.904676429857;6168.62988220707;6211.285702144255;6215.160953271307;6216.502679785618;6223.471004964572;4735.692180008297;4747.881302967419;4749.881252968669;4764.857054288377;4774.904501909959;4746.477887432379;4762.499937506564;4764.404449443819;4766.451858036336;4770.7376094314795;4600.263957766758;4621.9306710399205;4658.138244424792;4681.812727490897;4684.929726054112;4688.765561721901;4707.5057119002695;4714.646401519865;4716.740579268139;4720.645951553647;4093.099518106012;4106.240345536085;4107.589241075869;4111.650509706678;4121.113960498477;5924.58527903047;5955.136505206764;5962.046072628359;5963.701814909237;5963.731632076524;5451.454854514556;5520.254765606672;5527.143292789624;5539.750711218005;5559.722013899289;6634.369734875179;6636.070950066995;6661.533692641517;6663;6664.366885145903;4553.2714765637675;4567.977160114211;4573.062522182944;4580.679352445331;4597.60920321773;6746.797596072126;6826.419754320888;6908.171019477695;6917.688704008332;6950.270221626707;4650.395448591661;4656.4412270527755;4661.254199328091;4663.230566956414;4667.649926255476;4688.601468875116;4707.586999425389;4718.0328032753205;4719.646026548023;4732.053589282157;5512.228288039678;5512.834614961557;5513.145462453326;5519.31008623922;5528.369131106253;6433.195850518685;6615.239247486505;6697.162854643169;6731.596104233761;6747.561408508432;1653.9503814885572;1665.050920975057;1666.5500314914905;1669.9165041747865;1673.3557580331417;1101.1466113761899;1107.8504401905639;1110.6168371911679;1126.4086354663866;1131.3268605179906;6488.967555162194;6496.610203387811;6497;6519.771807986698;6530.346965303432;6944.687489063004;6949.3745562899585;6951.443884489228;6970.756023539253;6973.651317434108;6370.458511026522;6496.382843629847;6498.642574658439;6539.215294164731;6551.050097735897;3767.416050512175;3767.811609419518;3781.3760729479327;3784.2053168834304;3788.962110378861;7152.17749958751;7165;7202.783916482514;7219.819504512324;7225.458090643223;7009.299070093052;7070.71717131309;7165.390941770008;7165.6417179140835;7177.995080688708;7129.180144283474;7159.319864612749;7188.209296977328;7204.56772593646;7227.566346019255;6985;6994.720211191699;7000.649967501707;7012.948057791372;7013.824654383681;6707.228668703162;6859.759908403182;6886.139232595926;6892.483063770337;6899.896501552581;7140.8214794628475;7198.064251647253;7201.243869393638;7213.3868621167785;7213.6753846076;4669.673122881366;4705.294205869147;4706.0823139487475;4714.269288260325;4717.080169366941;6850.246472887879;6948.305169483214;6948.33990770876;6973.476989225727;6995.825104372431;6738.292479289604;6746.190457145174;6749.831254218684;6750.088738020305;6752.831179220362;6606.504512161511;6739.59562426256;6755.966220169064;6787.457003439812;6811.557248778813;6585.440237579859;6608.867822643617;6610.305917878553;6614.570052946543;6628.668566571556;6777.762778302736;6810.5913645181445;6820.829479263058;6830.7609233676585;6834.897476537756;6493.220813502221;6592.110065141336;6636.303188165173;6649.434798042221;6653 11:11:56 INFO - 2015-11-25 11:11:56,093 DEBUG : BROWSER_OUTPUT: |5;yui.html;853.1596377568096;863.7970077031898;863.8047979260765;872.1104473437094;872.1975782280306;12421.31682757448;12605.558805441811;13942.860571394283;14103.647408814784;14118.505852295171;14004.509842155527;14281;14303.856961430383;14345.42618295267;14384.71230575388;833.9708110216144;845.0577605969331;847.7711018025129;850.90640029597;851.4976164063202;832.2925513313695;839.7186942374312;841.1378337204384;843.9451435656694;845.1970627903486;881.0616693221731;884.2528063786123;885.0441523154977;888.6356593796545;890.812929284851;861.6984055580559;885.406777459104;885.9512726800024;886.0784783824814;887.9422837515541;640.311664960165;641.0128402260514;643.4948565376204;645.3804347826093;646.7283740828863;13475.66310842227;13661;13725.313734313344;13737.519186828513;14029.719405611933;12534.74930501385;12618.936905315415;12712.555060572835;12744.80882786759;12842.614721558368;10676.507991920835;10765.300255483447;10907;11029.393383363911;11358.545658173663;3550.3609350316933;3595.658412450813;3624.3838547446735;3638.3632864248916;3720.293144302601;44407.55592444067;50947;51276.74361628168;51366.22950655743;51729.22406163911;10122.139618132542;10165.085142337077;10205.591776329013;10264.692059238234;10310.32982856112;17818.376356827448;18041.909790451227;18062.729059064124;18137.36519221821;18146.727799083023;7228.204897461275;7294.416446684359;7437;7620.085589729157;7658.425618078666;4374.759388233678;4399.560043995639;4417.160739459492;4420.292753159479;4496.595306422438;3056.2359410147465;3093.829839358857;3093.9535906961414;3098.6746391629003;3099.070278916316;555.0757987950018;556.5603173492976;562.6455333140177;563.5998441106779;565.7284503438373;627.6233467965449;651.7002178997619;656.5310959705736;686.1337162916858;717.867194568996;8275.710350137837;8318.168183181633;8398.118197589165;8524.147585241426;8556.871646925301;553.6788662575697;557.2504980800817;600.9849753756191;616.5930485879298;663.5885750834514;3981.7810020449156;4081.77550234734;4186.267403204427;4236.724612900151;4237.957620423818;52767.73616131895;60995;61248.387516125156;61343.693281533306;61406.38593614007;53175.734121329144;53657.1951420729;53835.461645383046;54490.18264726032;54706.45293547093;47834;47927.5207247923;48484.27273590899;49548;49725.50274497209;8454.619542120743;8665.696700615448;8893.110688931056;8914.420562663407;8981.82036359256;33886.83056584701;35150.472742908365;35540.64459355477;36052.27895442129;36107.458388123676;44939;47340.52659473361;47623;47642;47938.5206147948;10154.238432117769;10270.07569318765;10330.793384132425;10334.328268662513;10610.204234682584;11507;11658;11709.180357374902;11960.401979901144;12076.637700868989;10394.376337419779;10407.824505253042;10491.580336786443;10780.72666829716;11300.694845401784;10682;10818.984877975681;10886.129109671048;11194.832077519006;11654.242474239147;9524.904750952403;9799.069088436587;9880.35777674449;9919.107280344804;10203.948980255349;9436.292278079309;9505.762355941157;9564.970598047195;9574.47340396285;9822.263330250116;8810.515421651871;9312.906870931203;9385.953070234606;9401.341906066784;9582.760430989281 11:11:56 INFO - 2015-11-25 11:11:56,094 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:11:56 INFO - 2015-11-25 11:11:56,094 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:11:56 INFO - 2015-11-25 11:11:56,094 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,306 11:11:56 INFO - 2015-11-25 11:11:56,094 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:11:56 INFO - 2015-11-25 11:11:56,094 DEBUG : BROWSER_OUTPUT: __startTimestamp1448478716085__endTimestamp 11:11:56 INFO - 2015-11-25 11:11:56,094 DEBUG : BROWSER_OUTPUT: 11:11:56 INFO - 2015-11-25 11:11:56,094 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:11:56 INFO - 2015-11-25 11:11:56,094 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:11:56 INFO - 2015-11-25 11:11:56,094 DEBUG : BROWSER_OUTPUT: 11:11:56 INFO - 2015-11-25 11:11:56,094 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5528.49 Median:5758.90 stddev:632.69 (11.0%) stddev-sans-first:608.65 11:11:56 INFO - 2015-11-25 11:11:56,095 DEBUG : BROWSER_OUTPUT: Values: 3241.1 3247.0 3275.9 3280.6 3303.9 5289.2 5413.1 5420.1 5434.2 5445.3 5377.0 5393.4 5447.4 5470.8 5566.9 5004.9 5062.1 5138.9 5144.7 5168.9 4803.2 5094.5 5243.1 5248.0 5290.4 4955.1 5046.5 5076.6 5147.0 5158.9 4929.4 4988.1 5022.8 5057.0 5064.7 4951.8 5006.7 5018.2 5021.2 5062.5 5173.9 5319.7 5335.9 5375.2 5379.7 5860.2 5884.7 5961.4 5965.5 6003.2 5991.7 6048.8 6078.8 6099.3 6108.6 5347.0 5577.5 5676.3 5677.6 5694.3 5984.6 6009.5 6030.7 6046.1 6097.3 5895.8 5912.5 5923.8 5942.4 5955.0 5784.1 5908.3 5936.8 5947.2 6045.6 5940.1 5988.9 6001.8 6011.2 6018.5 5972.5 5982.8 5988.3 5988.6 5990.8 4406.9 4488.2 4538.7 4555.1 4598.5 4000.2 4011.6 4028.8 4057.2 4104.2 5665.8 5666.7 5666.7 5674.6 5688.9 5818.6 5957.6 5967.1 5991.4 6042.1 5544.4 5553.3 5564.3 5635.7 5692.0 5187.8 5193.4 5194.1 5204.1 5217.4 5980.6 6173.1 6178.3 6178.8 6192.2 5864.9 5867.5 5868.9 5917.4 5963.3 6121.1 6139.4 6147.5 6167.3 6181.8 5775.5 5873.3 5896.6 5948.2 5955.6 6000.5 6043.1 6050.3 6092.2 6126.2 5884.4 5884.9 5885.6 5892.9 5894.1 5703.6 5752.4 5865.3 5878.4 5923.2 5686.4 5758.5 5764.5 5765.9 5775.2 5865.4 5875.0 5880.9 5926.2 5930.9 5593.4 5727.1 5744.1 5758.9 5790.4 11:11:56 INFO - 2015-11-25 11:11:56,095 DEBUG : BROWSER_OUTPUT: 11:11:56 INFO - 2015-11-25 11:11:56,096 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47114.49 Median:37393.41 stddev:81394.38 (217.7%) stddev-sans-first:81547.63 11:11:56 INFO - 2015-11-25 11:11:56,096 DEBUG : BROWSER_OUTPUT: Values: 550.9 596.6 604.4 606.2 609.5 36918.0 37483.0 37623.6 37749.2 37757.8 41759.4 42158.4 42247.0 42318.0 42390.4 8713.3 8804.3 8825.4 8838.8 8900.3 8602.4 8667.6 8706.8 8716.0 8721.3 8673.1 8701.7 8752.2 8757.5 8769.3 8640.7 8714.7 8726.4 8747.9 8778.9 8544.3 8605.6 8645.0 8663.4 8689.9 39906.8 40235.2 40311.2 40352.0 40485.6 3240.8 3264.7 3354.1 3401.2 3426.6 29753.6 30067.2 30312.1 30840.5 31051.2 3809.6 3868.3 3891.8 3929.4 3996.0 259808.0 260003.0 260335.0 261865.0 262833.0 43123.4 43750.3 57889.6 58093.1 58220.7 41465.8 41688.0 41767.4 41792.2 41876.8 15350.0 15521.3 15564.9 15569.0 15577.7 11404.1 11589.4 11598.0 11650.2 11650.3 14447.6 14551.9 14586.3 14597.0 14619.7 5524.9 5564.3 5569.9 5639.9 5656.8 943.9 969.4 996.4 1050.8 1080.9 28527.0 28808.0 28882.6 29335.6 29400.4 1033.6 1042.6 1103.2 1110.5 1158.1 15258.4 15381.3 15663.5 15772.8 15850.4 352910.0 355561.0 356574.0 356745.0 356961.0 55688.2 55764.4 56044.0 56154.2 56159.7 1376.2 1415.0 1416.7 1418.4 1425.9 28138.4 29127.0 29132.1 29137.6 29340.0 46966.5 47464.5 47511.0 47581.5 47719.3 303753.0 308298.0 308915.0 309123.0 309882.0 28632.1 29133.0 32710.3 33591.8 33684.0 39069.4 39378.8 40073.4 40106.8 40461.2 35932.8 36266.8 37036.8 37303.8 38022.8 36733.1 36931.6 37002.6 37173.1 37301.6 41796.4 41823.6 42138.6 42263.8 42640.1 31774.4 31790.0 35278.6 35499.6 38357.2 25472.0 25564.9 26126.3 26220.5 26722.3 11:11:56 INFO - 2015-11-25 11:11:56,096 DEBUG : BROWSER_OUTPUT: 11:11:56 INFO - 2015-11-25 11:11:56,098 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29170.30 Median:12010.80 stddev:88770.36 (739.1%) stddev-sans-first:88993.02 11:11:56 INFO - 2015-11-25 11:11:56,098 DEBUG : BROWSER_OUTPUT: Values: 360.9 361.9 363.0 365.3 366.8 16785.4 17331.3 17790.3 17985.3 18437.5 11281.2 11296.4 11369.4 11436.2 11447.9 4868.4 4879.5 4993.6 4997.3 5008.7 4942.1 4980.6 4981.7 4984.2 4984.3 4987.3 5034.3 5630.2 5812.8 5827.0 5830.2 5866.2 5866.3 5877.9 6023.2 5372.5 5380.5 5382.9 5385.3 5404.4 12837.4 18119.6 21492.9 21611.0 21856.1 2116.8 2135.1 2150.5 2165.5 2211.1 9777.0 9949.4 11830.3 13416.5 13563.9 1826.5 1853.5 1877.4 1885.7 1905.9 62274.7 63420.0 66179.3 67139.0 68053.0 10232.2 10374.4 10448.2 10565.4 10586.7 13941.7 13941.8 13950.7 13966.9 13972.7 7569.2 7816.7 7932.3 7950.4 7982.6 7852.1 7900.2 7901.5 7906.7 7949.9 4530.5 4567.6 4593.4 4613.3 4631.8 1830.4 1837.2 1923.8 1965.0 1965.2 884.8 919.0 925.6 961.8 1092.1 17288.5 17486.8 17710.9 17856.3 17913.4 942.2 942.4 966.3 969.4 970.8 10046.3 10175.5 10233.7 10349.4 10351.1 536780.0 537307.0 539020.0 549702.0 550724.0 81986.0 82218.6 82272.0 82349.0 83571.6 1112.6 1149.5 1152.5 1154.9 1160.6 15934.0 16038.4 16086.9 16142.3 16384.3 34633.1 34682.8 34828.5 35911.8 36286.6 46992.3 48125.0 48191.5 49089.5 49167.8 9973.4 10242.9 10325.2 10327.5 10342.3 16909.6 17791.6 18288.4 18289.6 18344.7 9413.2 9671.6 9754.8 10637.5 14959.5 8987.7 9179.5 10228.6 10407.9 10413.5 10324.7 10580.7 10648.2 10732.0 10898.0 15226.0 15400.0 15516.4 15823.8 15879.6 15744.6 15889.3 16383.5 16422.2 16425.3 11:11:56 INFO - 2015-11-25 11:11:56,098 DEBUG : BROWSER_OUTPUT: 11:11:56 INFO - 2015-11-25 11:11:56,098 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5528.11 Median:6558.67 stddev:2833.79 (43.2%) stddev-sans-first:2825.43 11:11:56 INFO - 2015-11-25 11:11:56,100 DEBUG : BROWSER_OUTPUT: Values: 1482.7 1561.0 1611.7 1716.9 1836.5 7814.0 7930.8 7995.8 8022.8 8140.5 8034.2 8104.5 8110.6 8146.9 8186.6 2289.7 2314.3 2324.8 2326.6 2344.3 2304.2 2332.2 2338.1 2341.8 2343.4 2292.5 2316.8 2341.3 2342.7 2346.5 2284.2 2310.5 2348.7 2352.6 2353.4 2303.8 2314.9 2316.1 2319.5 2334.1 7857.0 7947.5 7957.4 7961.6 7963.1 4788.8 4861.4 4870.7 4894.5 4903.6 3066.4 3113.3 3155.1 3171.0 3189.9 963.4 970.4 974.6 987.7 995.0 10727.7 10730.8 10754.2 10775.1 10809.8 4269.7 4327.1 4340.3 4379.6 4396.2 8638.7 8712.5 8724.7 8741.2 8744.3 4841.5 4854.4 4855.8 4859.3 4862.4 4390.8 4405.9 4435.1 4435.3 4455.7 3563.5 3569.9 3584.9 3598.9 3616.9 1089.5 1090.5 1106.4 1109.3 1132.2 1079.5 1089.6 1130.9 1265.6 1366.4 7436.1 7458.1 7525.3 7558.6 7561.6 1160.1 1162.8 1166.6 1172.5 1178.4 5856.6 5865.1 5883.9 5895.5 5910.6 9112.1 9396.7 9529.0 9562.6 9623.7 9335.8 9337.9 9399.4 9404.8 9495.1 7067.5 7221.5 7222.9 7229.3 7378.9 7309.2 7348.0 7416.6 7431.5 7441.6 8296.7 8387.5 8403.0 8455.7 8520.1 8446.2 8599.1 8621.9 8626.6 8653.2 7012.1 7066.8 7088.8 7089.7 7091.0 7525.2 7653.8 7679.4 7692.4 7735.6 6318.0 7171.7 7207.6 7312.0 7434.4 6463.2 6660.4 7042.5 7120.1 7195.9 6756.7 6825.8 6845.4 6868.4 6971.6 6531.8 6540.1 6551.1 6558.3 6559.0 6590.6 6614.9 6617.0 6617.9 6697.2 11:11:56 INFO - 2015-11-25 11:11:56,100 DEBUG : BROWSER_OUTPUT: 11:11:56 INFO - 2015-11-25 11:11:56,100 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5586.00 Median:6401.83 stddev:1712.71 (26.8%) stddev-sans-first:1671.53 11:11:56 INFO - 2015-11-25 11:11:56,101 DEBUG : BROWSER_OUTPUT: Values: 333.7 335.8 338.7 346.8 347.8 6160.4 6205.8 6243.9 6263.9 6354.9 6168.6 6211.3 6215.2 6216.5 6223.5 4735.7 4747.9 4749.9 4764.9 4774.9 4746.5 4762.5 4764.4 4766.5 4770.7 4600.3 4621.9 4658.1 4681.8 4684.9 4688.8 4707.5 4714.6 4716.7 4720.6 4093.1 4106.2 4107.6 4111.7 4121.1 5924.6 5955.1 5962.0 5963.7 5963.7 5451.5 5520.3 5527.1 5539.8 5559.7 6634.4 6636.1 6661.5 6663.0 6664.4 4553.3 4568.0 4573.1 4580.7 4597.6 6746.8 6826.4 6908.2 6917.7 6950.3 4650.4 4656.4 4661.3 4663.2 4667.6 4688.6 4707.6 4718.0 4719.6 4732.1 5512.2 5512.8 5513.1 5519.3 5528.4 6433.2 6615.2 6697.2 6731.6 6747.6 1654.0 1665.1 1666.6 1669.9 1673.4 1101.1 1107.9 1110.6 1126.4 1131.3 6489.0 6496.6 6497.0 6519.8 6530.3 6944.7 6949.4 6951.4 6970.8 6973.7 6370.5 6496.4 6498.6 6539.2 6551.1 3767.4 3767.8 3781.4 3784.2 3789.0 7152.2 7165.0 7202.8 7219.8 7225.5 7009.3 7070.7 7165.4 7165.6 7178.0 7129.2 7159.3 7188.2 7204.6 7227.6 6985.0 6994.7 7000.6 7012.9 7013.8 6707.2 6859.8 6886.1 6892.5 6899.9 7140.8 7198.1 7201.2 7213.4 7213.7 4669.7 4705.3 4706.1 4714.3 4717.1 6850.2 6948.3 6948.3 6973.5 6995.8 6738.3 6746.2 6749.8 6750.1 6752.8 6606.5 6739.6 6756.0 6787.5 6811.6 6585.4 6608.9 6610.3 6614.6 6628.7 6777.8 6810.6 6820.8 6830.8 6834.9 6493.2 6592.1 6636.3 6649.4 6653.0 11:11:56 INFO - 2015-11-25 11:11:56,101 DEBUG : BROWSER_OUTPUT: 11:11:56 INFO - 2015-11-25 11:11:56,101 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14090.09 Median:49636.75 stddev:16695.14 (33.6%) stddev-sans-first:16712.38 11:11:56 INFO - 2015-11-25 11:11:56,101 DEBUG : BROWSER_OUTPUT: Values: 853.2 863.8 863.8 872.1 872.2 12421.3 12605.6 13942.9 14103.6 14118.5 14004.5 14281.0 14303.9 14345.4 14384.7 834.0 845.1 847.8 850.9 851.5 832.3 839.7 841.1 843.9 845.2 881.1 884.3 885.0 888.6 890.8 861.7 885.4 886.0 886.1 887.9 640.3 641.0 643.5 645.4 646.7 13475.7 13661.0 13725.3 13737.5 14029.7 12534.7 12618.9 12712.6 12744.8 12842.6 10676.5 10765.3 10907.0 11029.4 11358.5 3550.4 3595.7 3624.4 3638.4 3720.3 44407.6 50947.0 51276.7 51366.2 51729.2 10122.1 10165.1 10205.6 10264.7 10310.3 17818.4 18041.9 18062.7 18137.4 18146.7 7228.2 7294.4 7437.0 7620.1 7658.4 4374.8 4399.6 4417.2 4420.3 4496.6 3056.2 3093.8 3094.0 3098.7 3099.1 555.1 556.6 562.6 563.6 565.7 627.6 651.7 656.5 686.1 717.9 8275.7 8318.2 8398.1 8524.1 8556.9 553.7 557.3 601.0 616.6 663.6 3981.8 4081.8 4186.3 4236.7 4238.0 52767.7 60995.0 61248.4 61343.7 61406.4 53175.7 53657.2 53835.5 54490.2 54706.5 47834.0 47927.5 48484.3 49548.0 49725.5 8454.6 8665.7 8893.1 8914.4 8981.8 33886.8 35150.5 35540.6 36052.3 36107.5 44939.0 47340.5 47623.0 47642.0 47938.5 10154.2 10270.1 10330.8 10334.3 10610.2 11507.0 11658.0 11709.2 11960.4 12076.6 10394.4 10407.8 10491.6 10780.7 11300.7 10682.0 10819.0 10886.1 11194.8 11654.2 9524.9 9799.1 9880.4 9919.1 10203.9 9436.3 9505.8 9565.0 9574.5 9822.3 8810.5 9312.9 9386.0 9401.3 9582.8 11:11:56 INFO - 2015-11-25 11:11:56,101 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:11:56 INFO - 2015-11-25 11:11:56,102 DEBUG : BROWSER_OUTPUT: 11:11:56 INFO - 2015-11-25 11:11:56,773 INFO : Browser exited with error code: 0 11:11:56 INFO - 2015-11-25 11:11:56,792 INFO : Completed test dromaeo_css (00:18:30) 11:11:56 INFO - 2015-11-25 11:11:56,792 INFO : Starting test kraken 11:11:56 INFO - 2015-11-25 11:11:56,792 DEBUG : operating with platform_type : linux_ 11:11:56 INFO - 2015-11-25 11:11:56,792 INFO : Initialising browser for kraken test... 11:11:56 INFO - 2015-11-25 11:11:56,798 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_ChuPy/profile http://localhost:42506/getInfo.html 11:12:00 INFO - 2015-11-25 11:12:00,826 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:12:00 INFO - 2015-11-25 11:12:00,826 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:12:00 INFO - 2015-11-25 11:12:00,826 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:12:00 INFO - 2015-11-25 11:12:00,827 DEBUG : BROWSER_OUTPUT: __metrics 11:12:01 INFO - 2015-11-25 11:12:01,845 INFO : Browser initialized. 11:12:01 INFO - 2015-11-25 11:12:01,846 INFO : Running cycle 1/1 for kraken test... 11:12:01 INFO - 2015-11-25 11:12:01,846 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_ChuPy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:12:13 INFO - 2015-11-25 11:12:13,581 DEBUG : BROWSER_OUTPUT: RSS: Main: 138694656 11:12:13 INFO - 2015-11-25 11:12:13,581 DEBUG : BROWSER_OUTPUT: 11:12:16 INFO - 2015-11-25 11:12:16,025 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42506/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42506/tests/kraken/driver.html?testName=audio-beat-detection) 11:12:16 INFO - 2015-11-25 11:12:16,634 DEBUG : BROWSER_OUTPUT: RSS: Main: 141180928 11:12:16 INFO - 2015-11-25 11:12:16,635 DEBUG : BROWSER_OUTPUT: 11:12:19 INFO - 2015-11-25 11:12:19,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42506/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42506/tests/kraken/driver.html?testName=audio-dft) 11:12:19 INFO - 2015-11-25 11:12:19,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 140922880 11:12:19 INFO - 2015-11-25 11:12:19,841 DEBUG : BROWSER_OUTPUT: 11:12:22 INFO - 2015-11-25 11:12:22,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42506/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42506/tests/kraken/driver.html?testName=audio-fft) 11:12:23 INFO - 2015-11-25 11:12:23,252 DEBUG : BROWSER_OUTPUT: RSS: Main: 135950336 11:12:23 INFO - 2015-11-25 11:12:23,252 DEBUG : BROWSER_OUTPUT: 11:12:25 INFO - 2015-11-25 11:12:25,277 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42506/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42506/tests/kraken/driver.html?testName=audio-oscillator) 11:12:25 INFO - 2015-11-25 11:12:25,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 136122368 11:12:25 INFO - 2015-11-25 11:12:25,867 DEBUG : BROWSER_OUTPUT: 11:12:28 INFO - 2015-11-25 11:12:28,102 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42506/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42506/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:12:28 INFO - 2015-11-25 11:12:28,670 DEBUG : BROWSER_OUTPUT: RSS: Main: 137781248 11:12:28 INFO - 2015-11-25 11:12:28,670 DEBUG : BROWSER_OUTPUT: 11:12:31 INFO - 2015-11-25 11:12:31,636 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42506/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42506/tests/kraken/driver.html?testName=imaging-darkroom) 11:12:32 INFO - 2015-11-25 11:12:32,222 DEBUG : BROWSER_OUTPUT: RSS: Main: 137134080 11:12:32 INFO - 2015-11-25 11:12:32,222 DEBUG : BROWSER_OUTPUT: 11:12:35 INFO - 2015-11-25 11:12:35,624 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42506/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42506/tests/kraken/driver.html?testName=imaging-desaturate) 11:12:36 INFO - 2015-11-25 11:12:36,210 DEBUG : BROWSER_OUTPUT: RSS: Main: 137404416 11:12:36 INFO - 2015-11-25 11:12:36,210 DEBUG : BROWSER_OUTPUT: 11:12:39 INFO - 2015-11-25 11:12:39,027 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42506/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42506/tests/kraken/driver.html?testName=json-parse-financial) 11:12:39 INFO - 2015-11-25 11:12:39,608 DEBUG : BROWSER_OUTPUT: RSS: Main: 138117120 11:12:39 INFO - 2015-11-25 11:12:39,608 DEBUG : BROWSER_OUTPUT: 11:12:41 INFO - 2015-11-25 11:12:41,200 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42506/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42506/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:12:41 INFO - 2015-11-25 11:12:41,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 138395648 11:12:41 INFO - 2015-11-25 11:12:41,787 DEBUG : BROWSER_OUTPUT: 11:12:43 INFO - 2015-11-25 11:12:43,618 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42506/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42506/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:12:44 INFO - 2015-11-25 11:12:44,226 DEBUG : BROWSER_OUTPUT: RSS: Main: 137691136 11:12:44 INFO - 2015-11-25 11:12:44,226 DEBUG : BROWSER_OUTPUT: 11:12:46 INFO - 2015-11-25 11:12:46,299 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42506/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42506/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:12:46 INFO - 2015-11-25 11:12:46,886 DEBUG : BROWSER_OUTPUT: RSS: Main: 138772480 11:12:46 INFO - 2015-11-25 11:12:46,887 DEBUG : BROWSER_OUTPUT: 11:12:49 INFO - 2015-11-25 11:12:49,342 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42506/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42506/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:12:49 INFO - 2015-11-25 11:12:49,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 138039296 11:12:49 INFO - 2015-11-25 11:12:49,944 DEBUG : BROWSER_OUTPUT: 11:12:52 INFO - 2015-11-25 11:12:52,531 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42506/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42506/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:12:53 INFO - 2015-11-25 11:12:53,125 DEBUG : BROWSER_OUTPUT: RSS: Main: 138911744 11:12:53 INFO - 2015-11-25 11:12:53,125 DEBUG : BROWSER_OUTPUT: 11:12:54 INFO - 2015-11-25 11:12:54,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42506/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42506/tests/kraken/driver.html?testName=ai-astar) 11:12:55 INFO - 2015-11-25 11:12:55,024 DEBUG : BROWSER_OUTPUT: RSS: Main: 138735616 11:12:55 INFO - 2015-11-25 11:12:55,025 DEBUG : BROWSER_OUTPUT: 11:12:55 INFO - 2015-11-25 11:12:55,026 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:12:55 INFO - 2015-11-25 11:12:55,026 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:12:55 INFO - 2015-11-25 11:12:55,026 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:12:55 INFO - 2015-11-25 11:12:55,026 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:12:55 INFO - 2015-11-25 11:12:55,027 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;106;111;110;111;123;111;111;110;110 11:12:55 INFO - 2015-11-25 11:12:55,027 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;127;150;166;125;152;147;126;162;126 11:12:55 INFO - 2015-11-25 11:12:55,027 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;161;163;163;161;162;160;170;164 11:12:55 INFO - 2015-11-25 11:12:55,027 DEBUG : BROWSER_OUTPUT: |3;audio-fft;76;76;71;73;72;72;74;71;151;72 11:12:55 INFO - 2015-11-25 11:12:55,027 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;93;132;92;92;97;136;94;93;130 11:12:55 INFO - 2015-11-25 11:12:55,027 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;111;110;110;111;110;110;111;110;110 11:12:55 INFO - 2015-11-25 11:12:55,027 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;146;147;146;146;146;148 11:12:55 INFO - 2015-11-25 11:12:55,027 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;95;96;95;96;96;96 11:12:55 INFO - 2015-11-25 11:12:55,027 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;63;62;62;62;62;62;68;60;61 11:12:55 INFO - 2015-11-25 11:12:55,027 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;72;70;70;70;71;71;70;70;71;70 11:12:55 INFO - 2015-11-25 11:12:55,027 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;83;86;85;85;92;85;93;85;85 11:12:55 INFO - 2015-11-25 11:12:55,027 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;115;118;123;116;122;127;124;117;123 11:12:55 INFO - 2015-11-25 11:12:55,027 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;149;151;157;149;151;147;149;158;145;148 11:12:55 INFO - 2015-11-25 11:12:55,027 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;69;69;66;67;65;68;68;65;66 11:12:55 INFO - 2015-11-25 11:12:55,027 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:12:55 INFO - 2015-11-25 11:12:55,028 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:12:55 INFO - 2015-11-25 11:12:55,028 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,736 11:12:55 INFO - 2015-11-25 11:12:55,028 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:12:55 INFO - 2015-11-25 11:12:55,028 DEBUG : BROWSER_OUTPUT: __startTimestamp1448478775024__endTimestamp 11:12:55 INFO - 2015-11-25 11:12:55,028 DEBUG : BROWSER_OUTPUT: 11:12:55 INFO - 2015-11-25 11:12:55,029 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:12:55 INFO - 2015-11-25 11:12:55,029 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:12:55 INFO - 2015-11-25 11:12:55,030 DEBUG : BROWSER_OUTPUT: 11:12:55 INFO - 2015-11-25 11:12:55,030 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.40 Median:111.00 stddev:4.35 (3.9%) stddev-sans-first:4.61 11:12:55 INFO - 2015-11-25 11:12:55,030 DEBUG : BROWSER_OUTPUT: Values: 111.0 106.0 111.0 110.0 111.0 123.0 111.0 111.0 110.0 110.0 11:12:55 INFO - 2015-11-25 11:12:55,030 DEBUG : BROWSER_OUTPUT: 11:12:55 INFO - 2015-11-25 11:12:55,031 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.00 Median:149.50 stddev:15.74 (10.5%) stddev-sans-first:16.55 11:12:55 INFO - 2015-11-25 11:12:55,031 DEBUG : BROWSER_OUTPUT: Values: 149.0 127.0 150.0 166.0 125.0 152.0 147.0 126.0 162.0 126.0 11:12:55 INFO - 2015-11-25 11:12:55,031 DEBUG : BROWSER_OUTPUT: 11:12:55 INFO - 2015-11-25 11:12:55,031 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:2.77 (1.7%) stddev-sans-first:2.92 11:12:55 INFO - 2015-11-25 11:12:55,031 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 161.0 163.0 163.0 161.0 162.0 160.0 170.0 164.0 11:12:55 INFO - 2015-11-25 11:12:55,032 DEBUG : BROWSER_OUTPUT: 11:12:55 INFO - 2015-11-25 11:12:55,032 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.80 Median:72.50 stddev:24.73 (34.1%) stddev-sans-first:26.17 11:12:55 INFO - 2015-11-25 11:12:55,032 DEBUG : BROWSER_OUTPUT: Values: 76.0 76.0 71.0 73.0 72.0 72.0 74.0 71.0 151.0 72.0 11:12:55 INFO - 2015-11-25 11:12:55,032 DEBUG : BROWSER_OUTPUT: 11:12:55 INFO - 2015-11-25 11:12:55,033 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.30 Median:93.00 stddev:18.99 (20.4%) stddev-sans-first:19.70 11:12:55 INFO - 2015-11-25 11:12:55,033 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 132.0 92.0 92.0 97.0 136.0 94.0 93.0 130.0 11:12:55 INFO - 2015-11-25 11:12:55,033 DEBUG : BROWSER_OUTPUT: 11:12:55 INFO - 2015-11-25 11:12:55,033 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.50 11:12:55 INFO - 2015-11-25 11:12:55,033 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 110.0 110.0 111.0 110.0 110.0 111.0 110.0 110.0 11:12:55 INFO - 2015-11-25 11:12:55,033 DEBUG : BROWSER_OUTPUT: 11:12:55 INFO - 2015-11-25 11:12:55,033 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 11:12:55 INFO - 2015-11-25 11:12:55,034 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 148.0 11:12:55 INFO - 2015-11-25 11:12:55,034 DEBUG : BROWSER_OUTPUT: 11:12:55 INFO - 2015-11-25 11:12:55,034 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:12:55 INFO - 2015-11-25 11:12:55,034 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 11:12:55 INFO - 2015-11-25 11:12:55,034 DEBUG : BROWSER_OUTPUT: 11:12:55 INFO - 2015-11-25 11:12:55,034 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.50 Median:62.00 stddev:2.12 (3.4%) stddev-sans-first:2.24 11:12:55 INFO - 2015-11-25 11:12:55,034 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 62.0 62.0 62.0 62.0 62.0 68.0 60.0 61.0 11:12:55 INFO - 2015-11-25 11:12:55,034 DEBUG : BROWSER_OUTPUT: 11:12:55 INFO - 2015-11-25 11:12:55,034 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:70.50 stddev:0.71 (1.0%) stddev-sans-first:0.50 11:12:55 INFO - 2015-11-25 11:12:55,035 DEBUG : BROWSER_OUTPUT: Values: 72.0 70.0 70.0 70.0 71.0 71.0 70.0 70.0 71.0 70.0 11:12:55 INFO - 2015-11-25 11:12:55,035 DEBUG : BROWSER_OUTPUT: 11:12:55 INFO - 2015-11-25 11:12:55,036 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:85.00 stddev:3.46 (4.1%) stddev-sans-first:3.47 11:12:55 INFO - 2015-11-25 11:12:55,036 DEBUG : BROWSER_OUTPUT: Values: 83.0 83.0 86.0 85.0 85.0 92.0 85.0 93.0 85.0 85.0 11:12:55 INFO - 2015-11-25 11:12:55,036 DEBUG : BROWSER_OUTPUT: 11:12:55 INFO - 2015-11-25 11:12:55,036 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.70 Median:122.50 stddev:3.95 (3.2%) stddev-sans-first:4.16 11:12:55 INFO - 2015-11-25 11:12:55,036 DEBUG : BROWSER_OUTPUT: Values: 122.0 115.0 118.0 123.0 116.0 122.0 127.0 124.0 117.0 123.0 11:12:55 INFO - 2015-11-25 11:12:55,036 DEBUG : BROWSER_OUTPUT: 11:12:55 INFO - 2015-11-25 11:12:55,036 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.40 Median:150.00 stddev:4.14 (2.8%) stddev-sans-first:4.36 11:12:55 INFO - 2015-11-25 11:12:55,036 DEBUG : BROWSER_OUTPUT: Values: 149.0 151.0 157.0 149.0 151.0 147.0 149.0 158.0 145.0 148.0 11:12:55 INFO - 2015-11-25 11:12:55,037 DEBUG : BROWSER_OUTPUT: 11:12:55 INFO - 2015-11-25 11:12:55,037 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.50 stddev:1.49 (2.2%) stddev-sans-first:1.58 11:12:55 INFO - 2015-11-25 11:12:55,037 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 69.0 66.0 67.0 65.0 68.0 68.0 65.0 66.0 11:12:55 INFO - 2015-11-25 11:12:55,037 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:12:55 INFO - 2015-11-25 11:12:55,037 DEBUG : BROWSER_OUTPUT: 11:12:55 INFO - 2015-11-25 11:12:55,945 INFO : Browser exited with error code: 0 11:12:55 INFO - 2015-11-25 11:12:55,995 INFO : Completed test kraken (00:00:59) 11:12:55 INFO - 2015-11-25 11:12:55,995 INFO : Starting test v8_7 11:12:55 INFO - 2015-11-25 11:12:55,995 DEBUG : operating with platform_type : linux_ 11:12:55 INFO - 2015-11-25 11:12:55,995 INFO : Initialising browser for v8_7 test... 11:12:56 INFO - 2015-11-25 11:12:56,001 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8shRg1/profile http://localhost:42506/getInfo.html 11:13:00 INFO - 2015-11-25 11:13:00,112 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:13:00 INFO - 2015-11-25 11:13:00,112 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:13:00 INFO - 2015-11-25 11:13:00,112 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:13:00 INFO - 2015-11-25 11:13:00,113 DEBUG : BROWSER_OUTPUT: __metrics 11:13:01 INFO - 2015-11-25 11:13:01,037 INFO : Browser initialized. 11:13:01 INFO - 2015-11-25 11:13:01,038 INFO : Running cycle 1/1 for v8_7 test... 11:13:01 INFO - 2015-11-25 11:13:01,038 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8shRg1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:13:12 INFO - 2015-11-25 11:13:12,835 DEBUG : BROWSER_OUTPUT: RSS: Main: 139165696 11:13:12 INFO - 2015-11-25 11:13:12,835 DEBUG : BROWSER_OUTPUT: 11:13:34 INFO - 2015-11-25 11:13:34,209 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42506/tests/v8_7/run.html (next: http://localhost:42506/tests/v8_7/run.html) 11:13:34 INFO - 2015-11-25 11:13:34,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 137277440 11:13:34 INFO - 2015-11-25 11:13:34,468 DEBUG : BROWSER_OUTPUT: 11:13:34 INFO - 2015-11-25 11:13:34,468 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:13:34 INFO - 2015-11-25 11:13:34,468 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:13:34 INFO - 2015-11-25 11:13:34,469 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:13:34 INFO - 2015-11-25 11:13:34,469 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:13:34 INFO - 2015-11-25 11:13:34,469 DEBUG : BROWSER_OUTPUT: |0;Richards;166.8335001668335 11:13:34 INFO - 2015-11-25 11:13:34,469 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.11576400521125 11:13:34 INFO - 2015-11-25 11:13:34,469 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.4857462269424 11:13:34 INFO - 2015-11-25 11:13:34,469 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5213.541666666667 11:13:34 INFO - 2015-11-25 11:13:34,469 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1062.6992561105208 11:13:34 INFO - 2015-11-25 11:13:34,469 DEBUG : BROWSER_OUTPUT: |5;Earley;696.3788300835655 11:13:34 INFO - 2015-11-25 11:13:34,470 DEBUG : BROWSER_OUTPUT: |6;Boyer;12207.317073170732 11:13:34 INFO - 2015-11-25 11:13:34,470 DEBUG : BROWSER_OUTPUT: |7;RegExp;24829.268292682926 11:13:34 INFO - 2015-11-25 11:13:34,470 DEBUG : BROWSER_OUTPUT: |8;Splay;710.2272727272727 11:13:34 INFO - 2015-11-25 11:13:34,470 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 11:13:34 INFO - 2015-11-25 11:13:34,470 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:13:34 INFO - 2015-11-25 11:13:34,470 DEBUG : BROWSER_OUTPUT: __startTimestamp1448478814461__endTimestamp 11:13:34 INFO - 2015-11-25 11:13:34,470 DEBUG : BROWSER_OUTPUT: 11:13:34 INFO - 2015-11-25 11:13:34,470 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:13:34 INFO - 2015-11-25 11:13:34,470 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:13:34 INFO - 2015-11-25 11:13:34,470 DEBUG : BROWSER_OUTPUT: 11:13:34 INFO - 2015-11-25 11:13:34,470 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.83 Median:166.83 stddev:0.00 (0.0%) 11:13:34 INFO - 2015-11-25 11:13:34,470 DEBUG : BROWSER_OUTPUT: Values: 166.8 11:13:34 INFO - 2015-11-25 11:13:34,470 DEBUG : BROWSER_OUTPUT: 11:13:34 INFO - 2015-11-25 11:13:34,470 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.12 Median:186.12 stddev:0.00 (0.0%) 11:13:34 INFO - 2015-11-25 11:13:34,470 DEBUG : BROWSER_OUTPUT: Values: 186.1 11:13:34 INFO - 2015-11-25 11:13:34,471 DEBUG : BROWSER_OUTPUT: 11:13:34 INFO - 2015-11-25 11:13:34,471 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.49 Median:279.49 stddev:0.00 (0.0%) 11:13:34 INFO - 2015-11-25 11:13:34,471 DEBUG : BROWSER_OUTPUT: Values: 279.5 11:13:34 INFO - 2015-11-25 11:13:34,471 DEBUG : BROWSER_OUTPUT: 11:13:34 INFO - 2015-11-25 11:13:34,471 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5213.54 Median:5213.54 stddev:0.00 (0.0%) 11:13:34 INFO - 2015-11-25 11:13:34,471 DEBUG : BROWSER_OUTPUT: Values: 5213.5 11:13:34 INFO - 2015-11-25 11:13:34,471 DEBUG : BROWSER_OUTPUT: 11:13:34 INFO - 2015-11-25 11:13:34,471 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1062.70 Median:1062.70 stddev:0.00 (0.0%) 11:13:34 INFO - 2015-11-25 11:13:34,471 DEBUG : BROWSER_OUTPUT: Values: 1062.7 11:13:34 INFO - 2015-11-25 11:13:34,471 DEBUG : BROWSER_OUTPUT: 11:13:34 INFO - 2015-11-25 11:13:34,471 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:696.38 Median:696.38 stddev:0.00 (0.0%) 11:13:34 INFO - 2015-11-25 11:13:34,471 DEBUG : BROWSER_OUTPUT: Values: 696.4 11:13:34 INFO - 2015-11-25 11:13:34,471 DEBUG : BROWSER_OUTPUT: 11:13:34 INFO - 2015-11-25 11:13:34,471 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 11:13:34 INFO - 2015-11-25 11:13:34,471 DEBUG : BROWSER_OUTPUT: Values: 12207.3 11:13:34 INFO - 2015-11-25 11:13:34,472 DEBUG : BROWSER_OUTPUT: 11:13:34 INFO - 2015-11-25 11:13:34,472 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24829.27 Median:24829.27 stddev:0.00 (0.0%) 11:13:34 INFO - 2015-11-25 11:13:34,472 DEBUG : BROWSER_OUTPUT: Values: 24829.3 11:13:34 INFO - 2015-11-25 11:13:34,472 DEBUG : BROWSER_OUTPUT: 11:13:34 INFO - 2015-11-25 11:13:34,472 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:710.23 Median:710.23 stddev:0.00 (0.0%) 11:13:34 INFO - 2015-11-25 11:13:34,472 DEBUG : BROWSER_OUTPUT: Values: 710.2 11:13:34 INFO - 2015-11-25 11:13:34,472 DEBUG : BROWSER_OUTPUT: 11:13:34 INFO - 2015-11-25 11:13:34,472 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 11:13:34 INFO - 2015-11-25 11:13:34,472 DEBUG : BROWSER_OUTPUT: Values: 4840.6 11:13:34 INFO - 2015-11-25 11:13:34,472 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:13:34 INFO - 2015-11-25 11:13:34,472 DEBUG : BROWSER_OUTPUT: 11:13:35 INFO - 2015-11-25 11:13:35,257 INFO : Browser exited with error code: 0 11:13:35 INFO - 2015-11-25 11:13:35,272 INFO : Completed test v8_7 (00:00:39) 11:13:35 INFO - 2015-11-25 11:13:35,488 INFO : Completed test suite (00:20:09) 11:13:35 INFO - 2015-11-25 11:13:35,489 DEBUG : Working with test: dromaeo_css 11:13:35 INFO - 2015-11-25 11:13:35,489 DEBUG : Generating results file: dromaeo_css 11:13:35 INFO - 2015-11-25 11:13:35,490 DEBUG : Working with test: kraken 11:13:35 INFO - 2015-11-25 11:13:35,490 DEBUG : Generating results file: kraken 11:13:35 INFO - 2015-11-25 11:13:35,490 INFO : javascript benchmark 11:13:35 INFO - 2015-11-25 11:13:35,491 DEBUG : Working with test: v8_7 11:13:35 INFO - 2015-11-25 11:13:35,491 DEBUG : Generating results file: v8_7 11:13:35 INFO - 2015-11-25 11:13:35,491 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:13:35 INFO - 2015-11-25 11:13:35,540 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 11:13:35 INFO - 2015-11-25 11:13:35,540 DEBUG : process_Request line: dromaeo_css 7118.93 graph.html#tests=[[72,64,43]] 11:13:35 INFO - 2015-11-25 11:13:35,540 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:13:35 INFO - 2015-11-25 11:13:35,569 DEBUG : process_Request line: kraken 1513.00 graph.html#tests=[[232,64,43]] 11:13:35 INFO - 2015-11-25 11:13:35,569 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:13:35 INFO - 2015-11-25 11:13:35,598 DEBUG : process_Request line: v8_7 21145.07 graph.html#tests=[[230,64,43]] 11:13:35 INFO - 2015-11-25 11:13:35,599 INFO : javascript benchmark 11:13:35 INFO - 2015-11-25 11:13:35,603 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3241.0600925731537, 3246.977202181313, 3275.88534401296, 3280.6227283862363, 3303.8513266902996, 5289.206619007151, 5413.052715774744, 5420.105682562383, 5434.239206511087, 5445.292112025441, 5376.973115134429, 5393.4336894626085, 5447.373552041517, 5470.8085217017415, 5566.86082847929, 5004.949950500494, 5062.063518249117, 5138.922916156261, 5144.6655967362185, 5168.948310516903, 4803.159447096744, 5094.5160209780015, 5243.108671525831, 5247.973760131194, 5290.444503327153, 4955.132851750929, 5046.520580544842, 5076.593872490229, 5147.022065807503, 5158.896822063556, 4929.408470983469, 4988.127077761377, 5022.84931452057, 5057.039162559139, 5064.696118232918, 4951.836318465158, 5006.69959802413, 5018.172001619729, 5021.246812978083, 5062.519060689228, 5173.896522069575, 5319.707416092114, 5335.893282134374, 5375.22059301403, 5379.65032272901, 5860.17957485948, 5884.735186916556, 5961.433663801932, 5965.4929331006915, 6003.249593800775, 5991.700414979234, 6048.848778780522, 6078.848028799272, 6099.298580663191, 6108.572399932006, 5346.973265133688, 5577.498025177753, 5676.290463692038, 5677.630953987978, 5694.259746233005, 5984.581079324493, 6009.45914867664, 6030.728617212236, 6046.062860256668, 6097.298810636745, 5895.764169433174, 5912.46787789101, 5923.7926672566255, 5942.435468630473, 5954.970225148846, 5784.132380143013, 5908.261467316585, 5936.762529498858, 5947.226860508193, 6045.637261764308, 5940.138679891392, 5988.9401105989255, 6001.819945401645, 6011.188489553854, 6018.548608854266, 5972.522198224132, 5982.820515384546, 5988.341282458926, 5988.550858685616, 5990.760369585168, 4406.889827754268, 4488.236999710057, 4538.682292239511, 4555.088982203572, 4598.540145985375, 4000.19996000801, 4011.6389524942897, 4028.798560071985, 4057.168280502549, 4104.199681062224, 5665.8300250991715, 5666.688332141772, 5666.688332141772, 5674.602777805514, 5688.914666280009, 5818.5636077294375, 5957.6127551709, 5967.104934259895, 5991.400859914061, 6042.093685947055, 5544.362398324163, 5553.250311208016, 5564.33228012641, 5635.6618602883955, 5692.0323544997445, 5187.792488300502, 5193.428722840485, 5194.091034069098, 5204.0632686116105, 5217.399999000164, 5980.641161530409, 6173.135760993465, 6178.320384757673, 6178.752849885954, 6192.195014648157, 5864.9413505866105, 5867.5305975521005, 5868.882622347614, 5917.378675239038, 5963.28440587115, 6121.112438696453, 6139.3553676863285, 6147.477464415575, 6167.321594624498, 6181.81454556364, 5775.537956963349, 5873.2658417697785, 5896.64620122794, 5948.196993405835, 5955.583109182316, 6000.459958603747, 6043.063325184427, 6050.273967123973, 6092.208012958287, 6126.172966649624, 5884.411558844081, 5884.911726324194, 5885.646861188171, 5892.882142357043, 5894.056950888009, 5703.600747947769, 5752.424757524214, 5865.266841644794, 5878.412158784087, 5923.170756094064, 5686.43135686428, 5758.452946970031, 5764.538836892954, 5765.8558536036935, 5775.249217601685, 5865.4134586541, 5875.001249787461, 5880.941190588211, 5926.1999630049395, 5930.9110363343725, 5593.440655934374, 5727.11229759388, 5744.080947048452, 5758.89800222924, 5790.363060063474], "unit": "ms", "name": "dojo.html", "value": 5486.0209721871815}, {"lowerIsBetter": false, "replicates": [550.9063459211934, 596.6211455725614, 604.4227762486822, 606.1634943777588, 609.5489337889962, 36918.0, 37483.0, 37623.623763762385, 37749.24501509968, 37757.811210943975, 41759.37360939589, 42158.367624485654, 42247.0, 42318.0, 42390.36414453778, 8713.30293576514, 8804.339674524404, 8825.382223244376, 8838.823223535557, 8900.332475064364, 8602.35482338824, 8667.609957551926, 8706.825863482727, 8716.0, 8721.345899057564, 8673.089325620813, 8701.738947831574, 8752.168543988311, 8757.51833649149, 8769.342299327544, 8640.697575584856, 8714.694985675535, 8726.432781869189, 8747.868781968276, 8778.912210877874, 8544.273736732384, 8605.569721513899, 8645.0, 8663.39356245063, 8689.869651955225, 39906.800465997774, 40235.19529609421, 40311.19377612461, 40352.0, 40485.59514404848, 3240.821754803485, 3264.6735326467165, 3354.1446931032674, 3401.1667141550233, 3426.623071462137, 29753.55369669435, 30067.248318791986, 30312.075578705484, 30840.53739193914, 31051.223719407197, 3809.5619003814363, 3868.303705333039, 3891.8054097295303, 3929.390944403622, 3995.98002009991, 259808.0, 260003.0, 260335.0, 261864.9999999981, 262833.0, 43123.35314970278, 43750.343744843856, 57889.552761180465, 58093.12860307099, 58220.708896455246, 41465.79267103645, 41688.0, 41767.37348939768, 41792.164156716695, 41876.790616046725, 15350.0, 15521.301541430663, 15564.92217538905, 15569.0, 15577.688446231012, 11404.087672986141, 11589.420528973518, 11598.0, 11650.184487085991, 11650.30098194111, 14447.566573002827, 14551.927240363942, 14586.34361453737, 14597.0, 14619.707605847823, 5524.861878452991, 5564.33228012641, 5569.8500079782925, 5639.8590035249445, 5656.830295091154, 943.8725772020827, 969.4183489906, 996.4121168510613, 1050.76883085721, 1080.9028835731738, 28527.0, 28808.0, 28882.559224211283, 29335.55996660052, 29400.411991760044, 1033.5555711044324, 1042.635077722791, 1103.189155970361, 1110.4725255503572, 1158.0966845860241, 15258.361373896729, 15381.307841147176, 15663.451779187673, 15772.76340854888, 15850.365985360457, 352910.0, 355561.0, 356574.0, 356745.0, 356961.0, 55688.16467752987, 55764.442355576735, 56044.0, 56154.15768763472, 56159.71920140455, 1376.2224343246035, 1414.9717005660034, 1416.6529200345776, 1418.432626949208, 1425.8716715495448, 28138.43723125567, 29127.0, 29132.126036218946, 29137.56293655639, 29340.0, 46966.53033469622, 47464.52535474601, 47511.0, 47581.524184759095, 47719.28421073756, 303753.0, 308298.0, 308915.0, 309123.0, 309882.0, 28632.14103576896, 29133.0, 32710.34579308448, 33591.83204083964, 33684.0, 39069.41395879121, 39378.80310598543, 40073.39889901712, 40106.79946600365, 40461.1907761849, 35932.820335898155, 36266.8186659065, 37036.81481592575, 37303.81348093242, 38022.809885950395, 36733.08167295732, 36931.63068369282, 37002.62997369992, 37173.070673233386, 37301.62698372982, 41796.373054404816, 41823.58176418197, 42138.57861421347, 42263.78868105763, 42640.14719705527, 31774.36451271008, 31790.0, 35278.647213528566, 35499.645003550664, 38357.232855343296, 25472.0, 25564.872175639004, 26126.34684132836, 26220.475590488466, 26722.331941700835], "unit": "ms", "name": "ext.html", "value": 18222.82407285782}, {"lowerIsBetter": false, "replicates": [360.864675746595, 361.88419705694173, 363.0470016207455, 365.27857481474075, 366.8037599884063, 16785.41251056213, 17331.30674773009, 17790.288388464447, 17985.280588776448, 18437.539061523436, 11281.153913456483, 11296.378699171562, 11369.431528423587, 11436.19946603738, 11447.885521144786, 4868.415790105192, 4879.51204879511, 4993.575546078588, 4997.275395067713, 5008.674436161656, 4942.110420124376, 4980.551750342468, 4981.701097934136, 4984.177610694249, 4984.302197692308, 4987.251912213179, 5034.270030845525, 5630.239917611131, 5812.767489300423, 5827.0, 5830.183774271605, 5866.237389139427, 5866.266716660418, 5877.85305367365, 6023.247094113236, 5372.516473517363, 5380.515753582157, 5382.946170538284, 5385.3268341457315, 5404.405515393303, 12837.358132093357, 18119.637607247914, 21492.89253553738, 21611.02750376237, 21856.125754969784, 2116.841236907238, 2135.135270215565, 2150.537634408594, 2165.4802847316532, 2211.1266049910196, 9777.0, 9949.353292035994, 11830.290182589073, 13416.46334146633, 13563.864361356358, 1826.4611939477886, 1853.481025312901, 1877.4086162858655, 1885.6982882738696, 1905.9332923347615, 62274.68862655703, 63420.0, 66179.3382066178, 67139.0, 68053.0, 10232.181425485944, 10374.429406382722, 10448.164146868232, 10565.36607803519, 10586.682399528027, 13941.721165576631, 13941.790873136912, 13950.651233719036, 13966.86033139676, 13972.672596103353, 7569.205233450519, 7816.68733250675, 7932.325752311002, 7950.403719720928, 7982.600869956479, 7852.136265010844, 7900.249476299742, 7901.525908445396, 7906.683732650629, 7949.880751788728, 4530.501644819067, 4567.634589232854, 4593.448786145617, 4613.308003799457, 4631.814727410866, 1830.4417152768267, 1837.200817644329, 1923.8460923126117, 1964.950876228077, 1965.1549833571416, 884.7743825324501, 918.9816203675889, 925.5834874306589, 961.7835986902891, 1092.1099304067159, 17288.481345559652, 17486.825131748774, 17710.91144544269, 17856.28574857017, 17913.37303194382, 942.222666300305, 942.3686130292721, 966.3284017607696, 969.4377261188494, 970.7864269860619, 10046.296759226783, 10175.491225438698, 10233.692989210336, 10349.379037257788, 10351.120154786777, 536780.0, 537307.0, 539020.0, 549702.0, 550724.0, 81986.0, 82218.58890705628, 82272.0, 82349.0, 83571.5821420889, 1112.6217086190572, 1149.494222542079, 1152.4525850221078, 1154.9307041577533, 1160.6169963911889, 15934.0, 16038.358465661242, 16086.919565402099, 16142.273597687898, 16384.262708178398, 34633.134171645914, 34682.82658586691, 34828.477572836935, 35911.82044089867, 36286.63713362833, 46992.29511557261, 48125.0, 48191.5180848187, 49089.509104908495, 49167.754161228964, 9973.401595904268, 10242.897571024194, 10325.225608079274, 10327.535260913428, 10342.32774869631, 16909.577260568585, 17791.644167116843, 18288.359907403177, 18289.634207315514, 18344.72482912784, 9413.246940244628, 9671.564779584794, 9754.804903902024, 10637.468126593794, 14959.476418325306, 8987.685431009882, 9179.541022948959, 10228.590856365661, 10407.895921040692, 10413.531391087268, 10324.741881453023, 10580.735481613021, 10648.201384896318, 10732.0, 10898.0, 15226.0, 15400.0, 15516.37934482608, 15823.762643560585, 15879.603009924382, 15744.60638484047, 15889.284982176061, 16383.508494745176, 16422.17889105564, 16425.342986280415], "unit": "ms", "name": "jquery.html", "value": 8944.046920443812}, {"lowerIsBetter": false, "replicates": [1482.6812235369393, 1560.9843901560985, 1611.6615510742743, 1716.8626509879202, 1836.4674244469113, 7814.0, 7930.841383172333, 7995.84008319834, 8022.839543209139, 8140.470869393485, 8034.156413576578, 8104.513729176254, 8110.553919534424, 8146.877796833052, 8186.590670466483, 2289.713785776774, 2314.2710046335433, 2324.7675232476786, 2326.581215381231, 2344.3318654183477, 2304.1820153845397, 2332.242021343062, 2338.0764597983784, 2341.7658234176615, 2343.4024323797407, 2292.541491701658, 2316.8262380321544, 2341.3327201747506, 2342.6603142544404, 2346.5189636124637, 2284.1776960294446, 2310.5378924215142, 2348.7416384197722, 2352.5882970480097, 2353.364591560269, 2303.8041766449874, 2314.9421264468524, 2316.096722278313, 2319.5476882008015, 2334.0897050150456, 7857.0, 7947.483413578099, 7957.403194760416, 7961.562114083723, 7963.084245311806, 4788.80844766209, 4861.368022157097, 4870.707757534524, 4894.486078961693, 4903.632227582945, 3066.3713938642527, 3113.2683819302674, 3155.0850253426706, 3171.0, 3189.888353907602, 963.3882484622245, 970.4129001953787, 974.6491263145263, 987.6641941739842, 995.049727510226, 10727.731806704816, 10730.839037414446, 10754.193435492369, 10775.084117849992, 10809.83785243222, 4269.7224680395675, 4327.069680018811, 4340.30555111187, 4379.64962802975, 4396.164728701537, 8638.697645582375, 8712.477251364939, 8724.69463568772, 8741.213290803858, 8744.256738177326, 4841.491643377394, 4854.393200849894, 4855.830045948375, 4859.319695242669, 4862.3922009748785, 4390.8024138913825, 4405.911881762347, 4435.1351486459835, 4435.290353543418, 4455.68810183284, 3563.492142579564, 3569.9286014280087, 3584.856605735741, 3598.8560457581925, 3616.8914932552066, 1089.4716062709579, 1090.5201711247025, 1106.4080716816466, 1109.2567979453786, 1132.2074547816562, 1079.4764539198482, 1089.6458650938318, 1130.9208355415042, 1265.5760320292804, 1366.3987845348015, 7436.144843342977, 7458.105027396748, 7525.285097915689, 7558.622068896533, 7561.621918904033, 1160.1171089841737, 1162.7848847963153, 1166.6150170443734, 1172.472387425645, 1178.4107946026986, 5856.6486010838635, 5865.090910908731, 5883.852648733541, 5895.528357731371, 5910.615809972338, 9112.088791120967, 9396.671116511026, 9528.95235523818, 9562.61749530011, 9623.663171788954, 9335.766605834908, 9337.859932101024, 9399.436033837992, 9404.764880878032, 9495.14543691071, 7067.505274630829, 7221.53060051095, 7222.891656625155, 7229.349358557755, 7378.889316660255, 7309.195988441161, 7347.963260183665, 7416.6291685414435, 7431.479796414199, 7441.590712510864, 8296.668133274601, 8387.53868537212, 8402.95798521028, 8455.66177352899, 8520.10538893432, 8446.155384461505, 8599.054104048424, 8621.913780862362, 8626.56867156627, 8653.17794809492, 7012.123484564429, 7066.823329416806, 7088.787336379917, 7089.680964356513, 7091.0, 7525.247475252431, 7653.846923061396, 7679.3856491481665, 7692.42306826979, 7735.574543400167, 6318.0, 7171.713131474683, 7207.603581803051, 7312.0128782613665, 7434.405247580073, 6463.224413070461, 6660.400563949268, 7042.542234754725, 7120.145582530129, 7195.928040719526, 6756.729730810909, 6825.761098361533, 6845.383915447634, 6868.381845633717, 6971.58170509771, 6531.804045878631, 6540.149780528501, 6551.115599394021, 6558.344165583403, 6559.0, 6590.5716128451495, 6614.933850661432, 6616.966915165393, 6617.933820661924, 6697.196336439463], "unit": "ms", "name": "mootools.html", "value": 4550.889421012544}, {"lowerIsBetter": false, "replicates": [333.65300087908577, 335.83711899728627, 338.6917904706717, 346.75900249326696, 347.7583079759567, 6160.383961603838, 6205.81382558524, 6243.875122497553, 6263.906041409371, 6354.904676429857, 6168.62988220707, 6211.285702144255, 6215.160953271307, 6216.502679785618, 6223.471004964572, 4735.692180008297, 4747.881302967419, 4749.881252968669, 4764.857054288377, 4774.904501909959, 4746.477887432379, 4762.499937506564, 4764.404449443819, 4766.451858036336, 4770.7376094314795, 4600.263957766758, 4621.9306710399205, 4658.138244424792, 4681.812727490897, 4684.929726054112, 4688.765561721901, 4707.5057119002695, 4714.646401519865, 4716.740579268139, 4720.645951553647, 4093.099518106012, 4106.240345536085, 4107.589241075869, 4111.650509706678, 4121.113960498477, 5924.58527903047, 5955.136505206764, 5962.046072628359, 5963.701814909237, 5963.731632076524, 5451.454854514556, 5520.254765606672, 5527.143292789624, 5539.750711218005, 5559.722013899289, 6634.369734875179, 6636.070950066995, 6661.533692641517, 6663.0, 6664.366885145903, 4553.2714765637675, 4567.977160114211, 4573.062522182944, 4580.679352445331, 4597.60920321773, 6746.797596072126, 6826.419754320888, 6908.171019477695, 6917.688704008332, 6950.270221626707, 4650.395448591661, 4656.4412270527755, 4661.254199328091, 4663.230566956414, 4667.649926255476, 4688.601468875116, 4707.586999425389, 4718.0328032753205, 4719.646026548023, 4732.053589282157, 5512.228288039678, 5512.834614961557, 5513.145462453326, 5519.31008623922, 5528.369131106253, 6433.195850518685, 6615.239247486505, 6697.162854643169, 6731.596104233761, 6747.561408508432, 1653.9503814885572, 1665.050920975057, 1666.5500314914905, 1669.9165041747865, 1673.3557580331417, 1101.1466113761899, 1107.8504401905639, 1110.6168371911679, 1126.4086354663866, 1131.3268605179906, 6488.967555162194, 6496.610203387811, 6497.0, 6519.771807986698, 6530.346965303432, 6944.687489063004, 6949.3745562899585, 6951.443884489228, 6970.756023539253, 6973.651317434108, 6370.458511026522, 6496.382843629847, 6498.642574658439, 6539.215294164731, 6551.050097735897, 3767.416050512175, 3767.811609419518, 3781.3760729479327, 3784.2053168834304, 3788.962110378861, 7152.17749958751, 7165.0, 7202.783916482514, 7219.819504512324, 7225.458090643223, 7009.299070093052, 7070.71717131309, 7165.390941770008, 7165.6417179140835, 7177.995080688708, 7129.180144283474, 7159.319864612749, 7188.209296977328, 7204.56772593646, 7227.566346019255, 6985.0, 6994.720211191699, 7000.649967501707, 7012.948057791372, 7013.824654383681, 6707.228668703162, 6859.759908403182, 6886.139232595926, 6892.483063770337, 6899.896501552581, 7140.8214794628475, 7198.064251647253, 7201.243869393638, 7213.3868621167785, 7213.6753846076, 4669.673122881366, 4705.294205869147, 4706.0823139487475, 4714.269288260325, 4717.080169366941, 6850.246472887879, 6948.305169483214, 6948.33990770876, 6973.476989225727, 6995.825104372431, 6738.292479289604, 6746.190457145174, 6749.831254218684, 6750.088738020305, 6752.831179220362, 6606.504512161511, 6739.59562426256, 6755.966220169064, 6787.457003439812, 6811.557248778813, 6585.440237579859, 6608.867822643617, 6610.305917878553, 6614.570052946543, 6628.668566571556, 6777.762778302736, 6810.5913645181445, 6820.829479263058, 6830.7609233676585, 6834.897476537756, 6493.220813502221, 6592.110065141336, 6636.303188165173, 6649.434798042221, 6653.0], "unit": "ms", "name": "prototype.html", "value": 5023.625503321833}, {"lowerIsBetter": false, "replicates": [853.1596377568096, 863.7970077031898, 863.8047979260765, 872.1104473437094, 872.1975782280306, 12421.31682757448, 12605.558805441811, 13942.860571394283, 14103.647408814784, 14118.505852295171, 14004.509842155527, 14281.0, 14303.856961430383, 14345.42618295267, 14384.71230575388, 833.9708110216144, 845.0577605969331, 847.7711018025129, 850.90640029597, 851.4976164063202, 832.2925513313695, 839.7186942374312, 841.1378337204384, 843.9451435656694, 845.1970627903486, 881.0616693221731, 884.2528063786123, 885.0441523154977, 888.6356593796545, 890.812929284851, 861.6984055580559, 885.406777459104, 885.9512726800024, 886.0784783824814, 887.9422837515541, 640.311664960165, 641.0128402260514, 643.4948565376204, 645.3804347826093, 646.7283740828863, 13475.66310842227, 13661.0, 13725.313734313344, 13737.519186828513, 14029.719405611933, 12534.74930501385, 12618.936905315415, 12712.555060572835, 12744.80882786759, 12842.614721558368, 10676.507991920835, 10765.300255483447, 10907.0, 11029.393383363911, 11358.545658173663, 3550.3609350316933, 3595.658412450813, 3624.3838547446735, 3638.3632864248916, 3720.293144302601, 44407.55592444067, 50947.0, 51276.74361628168, 51366.22950655743, 51729.22406163911, 10122.139618132542, 10165.085142337077, 10205.591776329013, 10264.692059238234, 10310.32982856112, 17818.376356827448, 18041.909790451227, 18062.729059064124, 18137.36519221821, 18146.727799083023, 7228.204897461275, 7294.416446684359, 7437.0, 7620.085589729157, 7658.425618078666, 4374.759388233678, 4399.560043995639, 4417.160739459492, 4420.292753159479, 4496.595306422438, 3056.2359410147465, 3093.829839358857, 3093.9535906961414, 3098.6746391629003, 3099.070278916316, 555.0757987950018, 556.5603173492976, 562.6455333140177, 563.5998441106779, 565.7284503438373, 627.6233467965449, 651.7002178997619, 656.5310959705736, 686.1337162916858, 717.867194568996, 8275.710350137837, 8318.168183181633, 8398.118197589165, 8524.147585241426, 8556.871646925301, 553.6788662575697, 557.2504980800817, 600.9849753756191, 616.5930485879298, 663.5885750834514, 3981.7810020449156, 4081.77550234734, 4186.267403204427, 4236.724612900151, 4237.957620423818, 52767.73616131895, 60995.0, 61248.387516125156, 61343.693281533306, 61406.38593614007, 53175.734121329144, 53657.1951420729, 53835.461645383046, 54490.18264726032, 54706.45293547093, 47834.0, 47927.5207247923, 48484.27273590899, 49548.0, 49725.50274497209, 8454.619542120743, 8665.696700615448, 8893.110688931056, 8914.420562663407, 8981.82036359256, 33886.83056584701, 35150.472742908365, 35540.64459355477, 36052.27895442129, 36107.458388123676, 44939.0, 47340.52659473361, 47623.0, 47642.0, 47938.5206147948, 10154.238432117769, 10270.07569318765, 10330.793384132425, 10334.328268662513, 10610.204234682584, 11507.0, 11658.0, 11709.180357374902, 11960.401979901144, 12076.637700868989, 10394.376337419779, 10407.824505253042, 10491.580336786443, 10780.72666829716, 11300.694845401784, 10682.0, 10818.984877975681, 10886.129109671048, 11194.832077519006, 11654.242474239147, 9524.904750952403, 9799.069088436587, 9880.35777674449, 9919.107280344804, 10203.948980255349, 9436.292278079309, 9505.762355941157, 9564.970598047195, 9574.47340396285, 9822.263330250116, 8810.515421651871, 9312.906870931203, 9385.953070234606, 9401.341906066784, 9582.760430989281], "unit": "ms", "name": "yui.html", "value": 6366.948107864876}], "name": "dromaeo_css", "value": 7118.928173029778}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 111.0, 110.0, 111.0, 123.0, 111.0, 111.0, 110.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [149.0, 127.0, 150.0, 166.0, 125.0, 152.0, 147.0, 126.0, 162.0, 126.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.0}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 161.0, 163.0, 163.0, 161.0, 162.0, 160.0, 170.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 162.9}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 71.0, 73.0, 72.0, 72.0, 74.0, 71.0, 151.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 132.0, 92.0, 92.0, 97.0, 136.0, 94.0, 93.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 105.3}, {"lowerIsBetter": true, "replicates": [109.0, 111.0, 110.0, 110.0, 111.0, 110.0, 110.0, 111.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0, 68.0, 60.0, 61.0], "unit": "ms", "name": "json-parse-financial", "value": 62.5}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 70.0, 70.0, 71.0, 71.0, 70.0, 70.0, 71.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.5}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 86.0, 85.0, 85.0, 92.0, 85.0, 93.0, 85.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [122.0, 115.0, 118.0, 123.0, 116.0, 122.0, 127.0, 124.0, 117.0, 123.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.7}, {"lowerIsBetter": true, "replicates": [149.0, 151.0, 157.0, 149.0, 151.0, 147.0, 149.0, 158.0, 145.0, 148.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 150.4}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 69.0, 66.0, 67.0, 65.0, 68.0, 68.0, 65.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1513.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.8335001668335], "unit": "score", "name": "Richards", "value": 211.6001880000001}, {"lowerIsBetter": false, "replicates": [186.11576400521125], "unit": "score", "name": "DeltaBlue", "value": 355.2520139999999}, {"lowerIsBetter": false, "replicates": [279.4857462269424], "unit": "score", "name": "Encrypt", "value": 952.3956179999999}, {"lowerIsBetter": false, "replicates": [5213.541666666667], "unit": "score", "name": "Decrypt", "value": 51.05569630369634}, {"lowerIsBetter": false, "replicates": [1062.6992561105208], "unit": "score", "name": "RayTrace", "value": 696.3296489999998}, {"lowerIsBetter": false, "replicates": [696.3788300835655], "unit": "score", "name": "Earley", "value": 957.0408679999998}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [24829.268292682926], "unit": "score", "name": "RegExp", "value": 36.68996561886052}, {"lowerIsBetter": false, "replicates": [710.2272727272727], "unit": "score", "name": "Splay", "value": 114.73932799999996}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21145.06528187782}]} 11:13:35 INFO - RETURN: dromaeo_css: 7118.93 11:13:35 INFO - RETURN: kraken: 1513.00 11:13:35 INFO - RETURN: v8_7: 21145.07 11:13:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21145.07"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1513.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "7118.93"}}} 11:13:35 INFO - Return code: 0 11:13:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:13:35 INFO - # TBPL SUCCESS # 11:13:35 INFO - Running post-action listener: _resource_record_post_action 11:13:35 INFO - Running post-run listener: _resource_record_post_run 11:13:36 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 36864; Write bytes: 273977344; Read time: 64; Write time: 131216 11:13:36 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 1347584; Read time: 0; Write time: 72 11:13:36 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 36864; Write bytes: 272629760; Read time: 64; Write time: 131144 11:13:36 INFO - Running post-run listener: _upload_blobber_files 11:13:36 INFO - Blob upload gear active. 11:13:36 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:13:36 INFO - Copying logs to upload dir... 11:13:36 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1257.341170 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-11-25 11:13:36.869956) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 11:13:36.873410) ========= 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=6587686cb2da90a5f91b3170000001be-1448475139.858636-186839823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009916 build_url: 'https://queue.taskcluster.net/v1/task/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 11:13:36.924020) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 11:13:36.924381) ========= 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=6587686cb2da90a5f91b3170000001be-1448475139.858636-186839823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004617 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 11:13:36.974129) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 11:13:36.974473) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 11:13:36.974785) ========= ========= Total master_lag: 0.22 =========