builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1448477559.59 results: success (0) buildid: 20151125083151 builduid: 1798f140ff5f4eccb2c778dcc7718b4b revision: f516533b96a46764f288d336415e5a8aa3468e21 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:39.590031) ========= 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:39.590403) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:39.590683) ========= 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=256b35f542ca8bede9e27f1f00000291-1448477442.706514-598726958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006487 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:39.612756) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:39.613035) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:39.632766) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:39.633052) ========= 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=256b35f542ca8bede9e27f1f00000291-1448477442.706514-598726958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019689 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:39.678429) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:39.678688) ========= 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:39.679090) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:39.679359) ========= 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=256b35f542ca8bede9e27f1f00000291-1448477442.706514-598726958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-25 10:52:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.8M=0s 2015-11-25 10:52:39 (38.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179225 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:39.870043) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:39.870317) ========= 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=256b35f542ca8bede9e27f1f00000291-1448477442.706514-598726958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.093233 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:39.974440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:39.974813) ========= 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=256b35f542ca8bede9e27f1f00000291-1448477442.706514-598726958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-25 10:52:40,009 truncating revision to first 12 chars 2015-11-25 10:52:40,009 Setting DEBUG logging. 2015-11-25 10:52:40,009 attempt 1/10 2015-11-25 10:52:40,009 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:40,261 unpacking tar archive at: fx-team-f516533b96a4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.554184 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:40.541567) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:40.541897) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:40.550661) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 10:52:40.550924) ========= 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:40.551294) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 9 secs) (at 2015-11-25 10:52:40.551573) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=256b35f542ca8bede9e27f1f00000291-1448477442.706514-598726958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:52:40 INFO - MultiFileLogger online at 20151125 10:52:40 in /builds/slave/test-pgo 10:52:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:52:40 INFO - {'append_to_log': False, 10:52:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:52:40 INFO - 'blob_upload_branch': 'Fx-Team', 10:52:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:52:40 INFO - 'branch': 'Fx-Team', 10:52:40 INFO - 'buildbot_json_path': 'buildprops.json', 10:52:40 INFO - 'config_files': ('talos/linux_config.py',), 10:52:40 INFO - 'default_actions': ('clobber', 10:52:40 INFO - 'read-buildbot-config', 10:52:40 INFO - 'download-and-extract', 10:52:40 INFO - 'populate-webroot', 10:52:40 INFO - 'create-virtualenv', 10:52:40 INFO - 'install', 10:52:40 INFO - 'run-tests'), 10:52:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:52:40 INFO - 'download_minidump_stackwalk': True, 10:52:40 INFO - 'download_symbols': 'ondemand', 10:52:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:52:40 INFO - 'tooltool.py': '/tools/tooltool.py', 10:52:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:52:40 INFO - '/tools/misc-python/virtualenv.py')}, 10:52:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:52:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:52:40 INFO - 'installer_path': 'installer.exe', 10:52:40 INFO - 'log_level': 'info', 10:52:40 INFO - 'log_name': 'talos', 10:52:40 INFO - 'log_to_console': True, 10:52:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:52:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:52:40 INFO - 'opt_config_files': (), 10:52:40 INFO - 'pip_index': False, 10:52:40 INFO - 'sps_profile': False, 10:52:40 INFO - 'sps_profile_interval': 0, 10:52:40 INFO - 'suite': 'dromaeojs', 10:52:40 INFO - 'system_bits': '64', 10:52:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:52:40 INFO - 'title': 'talos-linux64-ix-013', 10:52:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:52:40 INFO - 'use_talos_json': True, 10:52:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:52:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:52:40 INFO - 'work_dir': 'build'} 10:52:40 INFO - ##### 10:52:40 INFO - ##### Running clobber 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: clobber 10:52:40 INFO - rmtree: /builds/slave/test-pgo/build 10:52:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:52:43 INFO - Running post-action listener: _resource_record_post_action 10:52:43 INFO - ##### 10:52:43 INFO - ##### Running read-buildbot-config step. 10:52:43 INFO - ##### 10:52:43 INFO - Running pre-action listener: _resource_record_pre_action 10:52:43 INFO - Running main action method: read_buildbot_config 10:52:43 INFO - Using buildbot properties: 10:52:43 INFO - { 10:52:43 INFO - "properties": { 10:52:43 INFO - "buildnumber": 802, 10:52:43 INFO - "product": "firefox", 10:52:43 INFO - "script_repo_revision": "production", 10:52:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:52:43 INFO - "repository": "", 10:52:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 10:52:43 INFO - "buildid": "20151125083151", 10:52:43 INFO - "slavename": "talos-linux64-ix-013", 10:52:43 INFO - "pgo_build": "True", 10:52:43 INFO - "basedir": "/builds/slave/test-pgo", 10:52:43 INFO - "project": "", 10:52:43 INFO - "platform": "ubuntu64_hw", 10:52:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:52:43 INFO - "slavebuilddir": "test", 10:52:43 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:52:43 INFO - "branch": "fx-team", 10:52:43 INFO - "repo_path": "integration/fx-team", 10:52:43 INFO - "stage_platform": "linux64-pgo", 10:52:43 INFO - "builduid": "1798f140ff5f4eccb2c778dcc7718b4b", 10:52:43 INFO - "revision": "f516533b96a46764f288d336415e5a8aa3468e21" 10:52:43 INFO - }, 10:52:43 INFO - "sourcestamp": { 10:52:43 INFO - "repository": "", 10:52:43 INFO - "hasPatch": false, 10:52:43 INFO - "project": "", 10:52:43 INFO - "branch": "fx-team-linux64-pgo-talos", 10:52:43 INFO - "changes": [ 10:52:43 INFO - { 10:52:43 INFO - "category": null, 10:52:43 INFO - "files": [ 10:52:43 INFO - { 10:52:43 INFO - "url": null, 10:52:43 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:43 INFO - } 10:52:43 INFO - ], 10:52:43 INFO - "repository": "", 10:52:43 INFO - "rev": "f516533b96a46764f288d336415e5a8aa3468e21", 10:52:43 INFO - "who": "sendchange", 10:52:43 INFO - "when": 1448477513, 10:52:43 INFO - "number": 6706918, 10:52:43 INFO - "comments": "", 10:52:43 INFO - "project": "", 10:52:43 INFO - "at": "Wed 25 Nov 2015 10:51:53", 10:52:43 INFO - "branch": "fx-team-linux64-pgo-talos", 10:52:43 INFO - "revlink": "", 10:52:43 INFO - "properties": [ 10:52:43 INFO - [ 10:52:43 INFO - "buildid", 10:52:43 INFO - "20151125083151", 10:52:43 INFO - "Change" 10:52:43 INFO - ], 10:52:43 INFO - [ 10:52:43 INFO - "builduid", 10:52:43 INFO - "1798f140ff5f4eccb2c778dcc7718b4b", 10:52:43 INFO - "Change" 10:52:43 INFO - ], 10:52:43 INFO - [ 10:52:43 INFO - "pgo_build", 10:52:43 INFO - "True", 10:52:43 INFO - "Change" 10:52:43 INFO - ] 10:52:43 INFO - ], 10:52:43 INFO - "revision": "f516533b96a46764f288d336415e5a8aa3468e21" 10:52:43 INFO - } 10:52:43 INFO - ], 10:52:43 INFO - "revision": "f516533b96a46764f288d336415e5a8aa3468e21" 10:52:43 INFO - } 10:52:43 INFO - } 10:52:43 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:43 INFO - Running post-action listener: _resource_record_post_action 10:52:43 INFO - ##### 10:52:43 INFO - ##### Running download-and-extract step. 10:52:43 INFO - ##### 10:52:43 INFO - Running pre-action listener: _resource_record_pre_action 10:52:43 INFO - Running main action method: download_and_extract 10:52:43 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:43 INFO - https://queue.taskcluster.net/v1/task/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:52:43 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:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aDWjIoIrTay8dnyc3mY_dw/artifacts/public/build/test_packages.json 10:52:43 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:43 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:48 INFO - Downloaded 1302 bytes. 10:52:48 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:52:48 INFO - Using the following test package requirements: 10:52:48 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:52:48 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:52:48 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:48 INFO - u'jsshell-linux-x86_64.zip'], 10:52:48 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:52:48 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:52:48 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:52:48 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:52:48 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:52:48 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:52:48 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:52:48 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 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.common.tests.zip 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.common.tests.zip 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.common.tests.zip 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.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:52:48 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:53 INFO - Downloaded 22754332 bytes. 10:52:53 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:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:52:53 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:54 INFO - Return code: 0 10:52:54 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: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 - 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:54 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:54 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:54 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:54 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:56 INFO - Downloaded 22754332 bytes. 10:52:56 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:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:52:56 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:58 INFO - Return code: 0 10:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:58 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:58 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:58 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:58 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:58 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:53:02 INFO - Downloaded 11131717 bytes. 10:53:02 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:53:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:53:02 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:53:03 INFO - Return code: 0 10:53:03 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:03 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:53:03 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:53:03 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:53:03 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:53:03 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:53:04 INFO - Downloaded 58387706 bytes. 10:53:04 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:53:04 INFO - mkdir: /builds/slave/test-pgo/properties 10:53:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:53:04 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:53:04 INFO - Contents: 10:53:04 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:53:04 INFO - Running post-action listener: _resource_record_post_action 10:53:04 INFO - Running post-action listener: set_extra_try_arguments 10:53:04 INFO - ##### 10:53:04 INFO - ##### Running populate-webroot step. 10:53:04 INFO - ##### 10:53:04 INFO - Running pre-action listener: _resource_record_pre_action 10:53:04 INFO - Running main action method: populate_webroot 10:53:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:53:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:53:04 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 10:53:04 INFO - '../fennec_ids.txt'], 10:53:04 INFO - 'tests': ['tcheck2']}, 10:53:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:53:04 INFO - '--tppagecycles', 10:53:04 INFO - '7'], 10:53:04 INFO - 'tests': ['tsvgm']}}, 10:53:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:53:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:53:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:53:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:53:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:53:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:53:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:04 INFO - 'talos_options': ['--e10s'], 10:53:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:04 INFO - 'tests': ['damp', 'tps']}, 10:53:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:04 INFO - 'talos_options': ['--e10s'], 10:53:04 INFO - 'tests': ['damp', 'tps']}, 10:53:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:53:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:53:04 INFO - 'other': {'tests': ['a11yr', 10:53:04 INFO - 'ts_paint', 10:53:04 INFO - 'tpaint', 10:53:04 INFO - 'sessionrestore', 10:53:04 INFO - 'sessionrestore_no_auto_restore']}, 10:53:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:53:04 INFO - 'tests': ['a11yr', 10:53:04 INFO - 'ts_paint', 10:53:04 INFO - 'tpaint', 10:53:04 INFO - 'sessionrestore', 10:53:04 INFO - 'sessionrestore_no_auto_restore']}, 10:53:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:53:04 INFO - 'tests': ['a11yr', 10:53:04 INFO - 'ts_paint', 10:53:04 INFO - 'tpaint', 10:53:04 INFO - 'sessionrestore', 10:53:04 INFO - 'sessionrestore_no_auto_restore']}, 10:53:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:53:04 INFO - 'tests': ['a11yr', 10:53:04 INFO - 'ts_paint', 10:53:04 INFO - 'tpaint', 10:53:04 INFO - 'sessionrestore', 10:53:04 INFO - 'sessionrestore_no_auto_restore']}, 10:53:04 INFO - 'other_l64': {'tests': ['a11yr', 10:53:04 INFO - 'ts_paint', 10:53:04 INFO - 'tpaint', 10:53:04 INFO - 'sessionrestore', 10:53:04 INFO - 'sessionrestore_no_auto_restore']}, 10:53:04 INFO - 'other_nol64': {'tests': ['a11yr', 10:53:04 INFO - 'ts_paint', 10:53:04 INFO - 'tpaint', 10:53:04 INFO - 'sessionrestore', 10:53:04 INFO - 'sessionrestore_no_auto_restore']}, 10:53:04 INFO - 'svgr': {'tests': ['tsvgx', 10:53:04 INFO - 'tsvgr_opacity', 10:53:04 INFO - 'tart', 10:53:04 INFO - 'tscrollx', 10:53:04 INFO - 'cart']}, 10:53:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:53:04 INFO - 'tests': ['tsvgx', 10:53:04 INFO - 'tsvgr_opacity', 10:53:04 INFO - 'tart', 10:53:04 INFO - 'tscrollx', 10:53:04 INFO - 'cart']}, 10:53:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:04 INFO - 'tests': ['tp5o']}, 10:53:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:04 INFO - 'talos_options': ['--e10s'], 10:53:04 INFO - 'tests': ['tp5o']}, 10:53:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:04 INFO - 'talos_options': ['--xperf_path', 10:53:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:04 INFO - 'tests': ['tp5n']}, 10:53:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:04 INFO - 'talos_options': ['--e10s', 10:53:04 INFO - '--xperf_path', 10:53:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:04 INFO - 'tests': ['tp5n']}}, 10:53:04 INFO - 'talos.zip': {'path': '', 10:53:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:53:04 INFO - Running post-action listener: _resource_record_post_action 10:53:04 INFO - ##### 10:53:04 INFO - ##### Running create-virtualenv step. 10:53:04 INFO - ##### 10:53:04 INFO - Running pre-action listener: _resource_record_pre_action 10:53:04 INFO - Running main action method: create_virtualenv 10:53:04 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:53:04 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:53:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:53:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:53:04 INFO - Using real prefix '/usr' 10:53:04 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:53:05 INFO - Installing distribute.............................................................................................................................................................................................done. 10:53:07 INFO - Installing pip.................done. 10:53:07 INFO - Return code: 0 10:53:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:07 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 0x17c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d640>, '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 0x1a7e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e9d0>, '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': '256b35f542ca8bede9e27f1f00000291-1448477442.706514-598726958', '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:07 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:53:07 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:53:07 INFO - Using env: {'DISPLAY': ':0', 10:53:07 INFO - 'HOME': '/home/cltbld', 10:53:07 INFO - 'LANG': 'en_US.UTF-8', 10:53:07 INFO - 'LANGUAGE': 'en_US:en', 10:53:07 INFO - 'LOGNAME': 'cltbld', 10:53:07 INFO - 'MAIL': '/var/mail/cltbld', 10:53:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:07 INFO - 'MOZ_NO_REMOTE': '1', 10:53:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:07 INFO - 'NO_EM_RESTART': '1', 10:53:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:07 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:07 INFO - 'SHELL': '/bin/bash', 10:53:07 INFO - 'SHLVL': '1', 10:53:07 INFO - 'TERM': 'linux', 10:53:07 INFO - 'TMOUT': '86400', 10:53:07 INFO - 'USER': 'cltbld', 10:53:07 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1448477442.706514-598726958', 10:53:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:07 INFO - '_': '/tools/buildbot/bin/python'} 10:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:07 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:53:07 INFO - Cleaning up... 10:53:07 INFO - Return code: 0 10:53:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:07 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 0x17c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d640>, '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 0x1a7e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e9d0>, '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': '256b35f542ca8bede9e27f1f00000291-1448477442.706514-598726958', '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:07 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:53:07 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:53:07 INFO - Using env: {'DISPLAY': ':0', 10:53:07 INFO - 'HOME': '/home/cltbld', 10:53:07 INFO - 'LANG': 'en_US.UTF-8', 10:53:07 INFO - 'LANGUAGE': 'en_US:en', 10:53:07 INFO - 'LOGNAME': 'cltbld', 10:53:07 INFO - 'MAIL': '/var/mail/cltbld', 10:53:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:07 INFO - 'MOZ_NO_REMOTE': '1', 10:53:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:07 INFO - 'NO_EM_RESTART': '1', 10:53:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:07 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:07 INFO - 'SHELL': '/bin/bash', 10:53:07 INFO - 'SHLVL': '1', 10:53:07 INFO - 'TERM': 'linux', 10:53:07 INFO - 'TMOUT': '86400', 10:53:07 INFO - 'USER': 'cltbld', 10:53:07 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1448477442.706514-598726958', 10:53:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:07 INFO - '_': '/tools/buildbot/bin/python'} 10:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:07 INFO - Downloading/unpacking psutil>=0.7.1 10:53:07 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:07 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 - 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:07 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:07 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:07 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:09 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:53:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:53:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:53:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:53:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:53:09 INFO - Installing collected packages: psutil 10:53:09 INFO - Running setup.py install for psutil 10:53:09 INFO - building 'psutil._psutil_linux' extension 10:53:09 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:53:09 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:53:09 INFO - building 'psutil._psutil_posix' extension 10:53:09 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:53:09 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:53:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:53:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:53:09 INFO - Successfully installed psutil 10:53:09 INFO - Cleaning up... 10:53:09 INFO - Return code: 0 10:53:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:53:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d640>, '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 0x1a7e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e9d0>, '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': '256b35f542ca8bede9e27f1f00000291-1448477442.706514-598726958', '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:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:53:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:53:09 INFO - Using env: {'DISPLAY': ':0', 10:53:09 INFO - 'HOME': '/home/cltbld', 10:53:09 INFO - 'LANG': 'en_US.UTF-8', 10:53:09 INFO - 'LANGUAGE': 'en_US:en', 10:53:09 INFO - 'LOGNAME': 'cltbld', 10:53:09 INFO - 'MAIL': '/var/mail/cltbld', 10:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:09 INFO - 'MOZ_NO_REMOTE': '1', 10:53:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:09 INFO - 'NO_EM_RESTART': '1', 10:53:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:09 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:09 INFO - 'SHELL': '/bin/bash', 10:53:09 INFO - 'SHLVL': '1', 10:53:09 INFO - 'TERM': 'linux', 10:53:09 INFO - 'TMOUT': '86400', 10:53:09 INFO - 'USER': 'cltbld', 10:53:09 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1448477442.706514-598726958', 10:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:09 INFO - '_': '/tools/buildbot/bin/python'} 10:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 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:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:53:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:53:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:53:11 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:53:11 INFO - Installing collected packages: mozsystemmonitor 10:53:11 INFO - Running setup.py install for mozsystemmonitor 10:53:11 INFO - Successfully installed mozsystemmonitor 10:53:11 INFO - Cleaning up... 10:53:11 INFO - Return code: 0 10:53:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:53:11 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:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:11 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:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:11 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 0x17c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d640>, '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 0x1a7e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e9d0>, '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': '256b35f542ca8bede9e27f1f00000291-1448477442.706514-598726958', '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:11 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:53:11 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:53:11 INFO - Using env: {'DISPLAY': ':0', 10:53:11 INFO - 'HOME': '/home/cltbld', 10:53:11 INFO - 'LANG': 'en_US.UTF-8', 10:53:11 INFO - 'LANGUAGE': 'en_US:en', 10:53:11 INFO - 'LOGNAME': 'cltbld', 10:53:11 INFO - 'MAIL': '/var/mail/cltbld', 10:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:11 INFO - 'MOZ_NO_REMOTE': '1', 10:53:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:11 INFO - 'NO_EM_RESTART': '1', 10:53:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:11 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:11 INFO - 'SHELL': '/bin/bash', 10:53:11 INFO - 'SHLVL': '1', 10:53:11 INFO - 'TERM': 'linux', 10:53:11 INFO - 'TMOUT': '86400', 10:53:11 INFO - 'USER': 'cltbld', 10:53:11 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1448477442.706514-598726958', 10:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:11 INFO - '_': '/tools/buildbot/bin/python'} 10:53:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:12 INFO - Downloading/unpacking blobuploader==1.2.4 10:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:13 INFO - Downloading blobuploader-1.2.4.tar.gz 10:53:13 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:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:53:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:53:13 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:13 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:13 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:13 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:13 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:13 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:14 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:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:53:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:53:14 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:14 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:14 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:14 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:14 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:14 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:14 INFO - Downloading docopt-0.6.1.tar.gz 10:53:14 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:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:53:14 INFO - Installing collected packages: blobuploader, requests, docopt 10:53:14 INFO - Running setup.py install for blobuploader 10:53:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:53:14 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:53:14 INFO - Running setup.py install for requests 10:53:14 INFO - Running setup.py install for docopt 10:53:16 INFO - Successfully installed blobuploader requests docopt 10:53:16 INFO - Cleaning up... 10:53:16 INFO - Return code: 0 10:53:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:53:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:16 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 0x17c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d640>, '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 0x1a7e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e9d0>, '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': '256b35f542ca8bede9e27f1f00000291-1448477442.706514-598726958', '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:16 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:16 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:16 INFO - Using env: {'DISPLAY': ':0', 10:53:16 INFO - 'HOME': '/home/cltbld', 10:53:16 INFO - 'LANG': 'en_US.UTF-8', 10:53:16 INFO - 'LANGUAGE': 'en_US:en', 10:53:16 INFO - 'LOGNAME': 'cltbld', 10:53:16 INFO - 'MAIL': '/var/mail/cltbld', 10:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:16 INFO - 'MOZ_NO_REMOTE': '1', 10:53:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:16 INFO - 'NO_EM_RESTART': '1', 10:53:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:16 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:16 INFO - 'SHELL': '/bin/bash', 10:53:16 INFO - 'SHLVL': '1', 10:53:16 INFO - 'TERM': 'linux', 10:53:16 INFO - 'TMOUT': '86400', 10:53:16 INFO - 'USER': 'cltbld', 10:53:16 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1448477442.706514-598726958', 10:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:16 INFO - '_': '/tools/buildbot/bin/python'} 10:53:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:53:16 INFO - Running setup.py (path:/tmp/pip-5l2qjm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:53:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:53:16 INFO - Running setup.py (path:/tmp/pip-UH9h6L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:53:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:53:16 INFO - Running setup.py (path:/tmp/pip-115TG3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:53:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:53:16 INFO - Running setup.py (path:/tmp/pip-1_6M4d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:53:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:53:16 INFO - Running setup.py (path:/tmp/pip-iRDYtw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:53:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:53:17 INFO - Running setup.py (path:/tmp/pip-knk_Aq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:53:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:53:17 INFO - Running setup.py (path:/tmp/pip-Ub7mQ2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:53:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:53:17 INFO - Running setup.py (path:/tmp/pip-XFZ0sp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:53:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:53:17 INFO - Running setup.py (path:/tmp/pip-PNPaLx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:53:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:53:17 INFO - Running setup.py (path:/tmp/pip-US38E3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:53:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:53:17 INFO - Running setup.py (path:/tmp/pip-iCWJdm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:53:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:53:17 INFO - Running setup.py (path:/tmp/pip-DGkJJm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:53:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:53:17 INFO - Running setup.py (path:/tmp/pip-cE3vSo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:53:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:53:17 INFO - Running setup.py (path:/tmp/pip-V6BALL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:53:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:53:17 INFO - Running setup.py (path:/tmp/pip-_RRhgT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:53:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:53:17 INFO - Running setup.py (path:/tmp/pip-FbY1wO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:53:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:53:17 INFO - Running setup.py (path:/tmp/pip-UD8R6v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:53:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:53:17 INFO - Running setup.py install for manifestparser 10:53:18 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:53:18 INFO - Running setup.py install for mozcrash 10:53:18 INFO - Running setup.py install for mozdebug 10:53:18 INFO - Running setup.py install for mozdevice 10:53:18 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:53:18 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:53:18 INFO - Running setup.py install for mozfile 10:53:18 INFO - Running setup.py install for mozhttpd 10:53:18 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:53:18 INFO - Running setup.py install for mozinfo 10:53:18 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:53:18 INFO - Running setup.py install for mozInstall 10:53:18 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:53:18 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:53:18 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:53:18 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:53:18 INFO - Running setup.py install for mozleak 10:53:18 INFO - Running setup.py install for mozlog 10:53:18 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:53:18 INFO - Running setup.py install for moznetwork 10:53:19 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:53:19 INFO - Running setup.py install for mozprocess 10:53:19 INFO - Running setup.py install for mozprofile 10:53:19 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:53:19 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:53:19 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:53:19 INFO - Running setup.py install for mozrunner 10:53:19 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:53:19 INFO - Running setup.py install for mozscreenshot 10:53:19 INFO - Running setup.py install for moztest 10:53:19 INFO - Running setup.py install for mozversion 10:53:19 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:53:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:53:19 INFO - Cleaning up... 10:53:19 INFO - Return code: 0 10:53:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:19 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 0x17c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d640>, '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 0x1a7e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e9d0>, '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': '256b35f542ca8bede9e27f1f00000291-1448477442.706514-598726958', '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:19 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:19 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:19 INFO - Using env: {'DISPLAY': ':0', 10:53:19 INFO - 'HOME': '/home/cltbld', 10:53:19 INFO - 'LANG': 'en_US.UTF-8', 10:53:19 INFO - 'LANGUAGE': 'en_US:en', 10:53:19 INFO - 'LOGNAME': 'cltbld', 10:53:19 INFO - 'MAIL': '/var/mail/cltbld', 10:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:19 INFO - 'MOZ_NO_REMOTE': '1', 10:53:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:19 INFO - 'NO_EM_RESTART': '1', 10:53:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:19 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:19 INFO - 'SHELL': '/bin/bash', 10:53:19 INFO - 'SHLVL': '1', 10:53:19 INFO - 'TERM': 'linux', 10:53:19 INFO - 'TMOUT': '86400', 10:53:19 INFO - 'USER': 'cltbld', 10:53:19 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1448477442.706514-598726958', 10:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:19 INFO - '_': '/tools/buildbot/bin/python'} 10:53:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:53:19 INFO - Running setup.py (path:/tmp/pip-F4j7li-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:53:19 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:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:53:19 INFO - Running setup.py (path:/tmp/pip-hF84Af-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:53:20 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:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:53:20 INFO - Running setup.py (path:/tmp/pip-rId_cr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:53:20 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:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:53:20 INFO - Running setup.py (path:/tmp/pip-JpYMG4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:53:20 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:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:53:20 INFO - Running setup.py (path:/tmp/pip-v3465E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:53:20 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:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:53:20 INFO - Running setup.py (path:/tmp/pip-FrETZ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:53:20 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:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:53:20 INFO - Running setup.py (path:/tmp/pip-FV7PLM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:53:20 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:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:53:20 INFO - Running setup.py (path:/tmp/pip-pEVQv9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:53:20 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:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:53:20 INFO - Running setup.py (path:/tmp/pip-X0wjqQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:53:20 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:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:53:20 INFO - Running setup.py (path:/tmp/pip-lcT9SM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:53:20 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:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:53:20 INFO - Running setup.py (path:/tmp/pip-bTp9fj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:53:20 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:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:53:20 INFO - Running setup.py (path:/tmp/pip-rXXrLa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:53:20 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:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:53:20 INFO - Running setup.py (path:/tmp/pip-c6EsbD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:53:20 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:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:53:20 INFO - Running setup.py (path:/tmp/pip-xW5yGx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:53:20 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:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:53:20 INFO - Running setup.py (path:/tmp/pip-yaoEGl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:53:20 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:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:53:20 INFO - Running setup.py (path:/tmp/pip-Ujq482-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:53:21 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:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:53:21 INFO - Running setup.py (path:/tmp/pip-3mlD2s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:53:21 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:21 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:21 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:21 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:21 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:21 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:21 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:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:22 INFO - Downloading blessings-1.5.1.tar.gz 10:53:22 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:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:53:22 INFO - Installing collected packages: blessings 10:53:22 INFO - Running setup.py install for blessings 10:53:22 INFO - Successfully installed blessings 10:53:22 INFO - Cleaning up... 10:53:23 INFO - Return code: 0 10:53:23 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:53:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:53:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:53:23 INFO - Reading from file tmpfile_stdout 10:53:23 INFO - Current package versions: 10:53:23 INFO - argparse == 1.2.1 10:53:23 INFO - blessings == 1.5.1 10:53:23 INFO - blobuploader == 1.2.4 10:53:23 INFO - docopt == 0.6.1 10:53:23 INFO - manifestparser == 1.1 10:53:23 INFO - mozInstall == 1.12 10:53:23 INFO - mozcrash == 0.16 10:53:23 INFO - mozdebug == 0.1 10:53:23 INFO - mozdevice == 0.47 10:53:23 INFO - mozfile == 1.2 10:53:23 INFO - mozhttpd == 0.7 10:53:23 INFO - mozinfo == 0.9 10:53:23 INFO - mozleak == 0.1 10:53:23 INFO - mozlog == 3.1 10:53:23 INFO - moznetwork == 0.27 10:53:23 INFO - mozprocess == 0.22 10:53:23 INFO - mozprofile == 0.27 10:53:23 INFO - mozrunner == 6.11 10:53:23 INFO - mozscreenshot == 0.1 10:53:23 INFO - mozsystemmonitor == 0.0 10:53:23 INFO - moztest == 0.7 10:53:23 INFO - mozversion == 1.4 10:53:23 INFO - psutil == 3.1.1 10:53:23 INFO - requests == 1.2.3 10:53:23 INFO - wsgiref == 0.1.2 10:53:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:53:23 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:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:23 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:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:23 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 0x17c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d640>, '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 0x1a7e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e9d0>, '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': '256b35f542ca8bede9e27f1f00000291-1448477442.706514-598726958', '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:23 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:23 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:23 INFO - Using env: {'DISPLAY': ':0', 10:53:23 INFO - 'HOME': '/home/cltbld', 10:53:23 INFO - 'LANG': 'en_US.UTF-8', 10:53:23 INFO - 'LANGUAGE': 'en_US:en', 10:53:23 INFO - 'LOGNAME': 'cltbld', 10:53:23 INFO - 'MAIL': '/var/mail/cltbld', 10:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:23 INFO - 'MOZ_NO_REMOTE': '1', 10:53:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:23 INFO - 'NO_EM_RESTART': '1', 10:53:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:23 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:23 INFO - 'SHELL': '/bin/bash', 10:53:23 INFO - 'SHLVL': '1', 10:53:23 INFO - 'TERM': 'linux', 10:53:23 INFO - 'TMOUT': '86400', 10:53:23 INFO - 'USER': 'cltbld', 10:53:23 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1448477442.706514-598726958', 10:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:23 INFO - '_': '/tools/buildbot/bin/python'} 10:53:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:23 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:23 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:23 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:23 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:23 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:23 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:23 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:23 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:23 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:23 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:23 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:23 INFO - Cleaning up... 10:53:23 INFO - Return code: 0 10:53:23 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:53:23 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:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:23 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:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:23 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 0x17c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d640>, '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 0x1a7e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e9d0>, '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': '256b35f542ca8bede9e27f1f00000291-1448477442.706514-598726958', '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:23 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:23 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:23 INFO - Using env: {'DISPLAY': ':0', 10:53:23 INFO - 'HOME': '/home/cltbld', 10:53:23 INFO - 'LANG': 'en_US.UTF-8', 10:53:23 INFO - 'LANGUAGE': 'en_US:en', 10:53:23 INFO - 'LOGNAME': 'cltbld', 10:53:23 INFO - 'MAIL': '/var/mail/cltbld', 10:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:23 INFO - 'MOZ_NO_REMOTE': '1', 10:53:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:23 INFO - 'NO_EM_RESTART': '1', 10:53:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:23 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:23 INFO - 'SHELL': '/bin/bash', 10:53:23 INFO - 'SHLVL': '1', 10:53:23 INFO - 'TERM': 'linux', 10:53:23 INFO - 'TMOUT': '86400', 10:53:23 INFO - 'USER': 'cltbld', 10:53:23 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1448477442.706514-598726958', 10:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:23 INFO - '_': '/tools/buildbot/bin/python'} 10:53:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:23 INFO - Downloading/unpacking jsonschema 10:53:23 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:23 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:23 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:23 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:23 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:23 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:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:53:25 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:25 INFO - Downloading/unpacking functools32 (from jsonschema) 10:53:25 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:25 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:25 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:25 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:25 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:25 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:25 INFO - Downloading functools32-3.2.3-2.tar.gz 10:53:25 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:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:53:25 INFO - warning: no files found matching '*.txt' 10:53:25 INFO - no previously-included directories found matching 'build' 10:53:25 INFO - no previously-included directories found matching 'dist' 10:53:25 INFO - no previously-included directories found matching '.git*' 10:53:25 INFO - Installing collected packages: jsonschema, functools32 10:53:25 INFO - Running setup.py install for functools32 10:53:25 INFO - warning: no files found matching '*.txt' 10:53:25 INFO - no previously-included directories found matching 'build' 10:53:25 INFO - no previously-included directories found matching 'dist' 10:53:25 INFO - no previously-included directories found matching '.git*' 10:53:25 INFO - Successfully installed jsonschema functools32 10:53:25 INFO - Cleaning up... 10:53:25 INFO - Return code: 0 10:53:25 INFO - Running post-action listener: _resource_record_post_action 10:53:25 INFO - Running post-action listener: _start_resource_monitoring 10:53:25 INFO - Starting resource monitoring. 10:53:25 INFO - ##### 10:53:25 INFO - ##### Running install step. 10:53:25 INFO - ##### 10:53:25 INFO - Running pre-action listener: _resource_record_pre_action 10:53:25 INFO - Running main action method: install 10:53:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:53:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:53:26 INFO - Reading from file tmpfile_stdout 10:53:26 INFO - Detecting whether we're running mozinstall >=1.0... 10:53:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:53:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:53:26 INFO - Reading from file tmpfile_stdout 10:53:26 INFO - Output received: 10:53:26 INFO - Usage: mozinstall [options] installer 10:53:26 INFO - Options: 10:53:26 INFO - -h, --help show this help message and exit 10:53:26 INFO - -d DEST, --destination=DEST 10:53:26 INFO - Directory to install application into. [default: 10:53:26 INFO - "/builds/slave/test-pgo"] 10:53:26 INFO - --app=APP Application being installed. [default: firefox] 10:53:26 INFO - mkdir: /builds/slave/test-pgo/build/application 10:53:26 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:26 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:40 INFO - Reading from file tmpfile_stdout 10:53:40 INFO - Output received: 10:53:40 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:53:40 INFO - Running post-action listener: _resource_record_post_action 10:53:40 INFO - ##### 10:53:40 INFO - ##### Running run-tests step. 10:53:40 INFO - ##### 10:53:40 INFO - Running pre-action listener: _resource_record_pre_action 10:53:40 INFO - Running main action method: run_tests 10:53:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:53:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:53:40 INFO - Python 2.7.3 10:53:40 INFO - Return code: 0 10:53:40 INFO - grabbing minidump binary from tooltool 10:53: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:53:40 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 0x1a7d640>, '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 0x1a7e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:53:40 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:40 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:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:53:40 INFO - Return code: 0 10:53:40 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:53:40 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:53:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:53:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:53:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:53:40 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', '--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-013', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 10:53:40 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 --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-013 --webServer localhost 10:53:40 INFO - Using env: {'DISPLAY': ':0', 10:53:40 INFO - 'HOME': '/home/cltbld', 10:53:40 INFO - 'LANG': 'en_US.UTF-8', 10:53:40 INFO - 'LANGUAGE': 'en_US:en', 10:53:40 INFO - 'LOGNAME': 'cltbld', 10:53:40 INFO - 'MAIL': '/var/mail/cltbld', 10:53:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:53:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:53:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:40 INFO - 'MOZ_NO_REMOTE': '1', 10:53:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:53:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:40 INFO - 'NO_EM_RESTART': '1', 10:53:40 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:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:40 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:40 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:53:40 INFO - 'SHELL': '/bin/bash', 10:53:40 INFO - 'SHLVL': '1', 10:53:40 INFO - 'TERM': 'linux', 10:53:40 INFO - 'TMOUT': '86400', 10:53:40 INFO - 'USER': 'cltbld', 10:53:40 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1448477442.706514-598726958', 10:53:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:40 INFO - '_': '/tools/buildbot/bin/python'} 10:53:40 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', '--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-013', '--webServer', 'localhost'] with output_timeout 3600 10:53:40 INFO - mozversion INFO | application_buildid: 20151125083151 10:53:40 INFO - mozversion INFO | application_changeset: f516533b96a46764f288d336415e5a8aa3468e21 10:53:40 INFO - mozversion INFO | application_display_name: Nightly 10:53:40 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:53:40 INFO - mozversion INFO | application_name: Firefox 10:53:40 INFO - mozversion INFO | application_remotingname: firefox 10:53:40 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:53:40 INFO - mozversion INFO | application_vendor: Mozilla 10:53:40 INFO - mozversion INFO | application_version: 45.0a1 10:53:40 INFO - mozversion INFO | platform_buildid: 20151125083151 10:53:40 INFO - mozversion INFO | platform_changeset: f516533b96a46764f288d336415e5a8aa3468e21 10:53:40 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:53:40 INFO - mozversion INFO | platform_version: 45.0a1 10:53:40 INFO - 2015-11-25 10:53:40,935 DEBUG : using testdate: 1448477620 10:53:40 INFO - 2015-11-25 10:53:40,935 DEBUG : actual date: 1448477620 10:53:40 INFO - 2015-11-25 10:53:40,944 INFO : starting webserver on 'localhost:43730' 10:53:40 INFO - 2015-11-25 10:53:40,944 INFO : Starting test suite talos-linux64-ix-013 10:53:40 INFO - 2015-11-25 10:53:40,944 INFO : Starting test dromaeo_css 10:53:40 INFO - 2015-11-25 10:53:40,944 DEBUG : operating with platform_type : linux_ 10:53:40 INFO - 2015-11-25 10:53:40,945 INFO : Initialising browser for dromaeo_css test... 10:53:40 INFO - 2015-11-25 10:53:40,952 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxa9Jer/profile http://localhost:43730/getInfo.html 10:54:52 INFO - 2015-11-25 10:54:52,367 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:54:52 INFO - 2015-11-25 10:54:52,368 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:54:52 INFO - 2015-11-25 10:54:52,368 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:54:52 INFO - 2015-11-25 10:54:52,368 DEBUG : BROWSER_OUTPUT: __metrics 10:54:53 INFO - 2015-11-25 10:54:53,260 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:55:01 INFO - 2015-11-25 10:55:01,365 INFO : Browser initialized. 10:55:01 INFO - 2015-11-25 10:55:01,366 INFO : Running cycle 1/1 for dromaeo_css test... 10:55:01 INFO - 2015-11-25 10:55:01,366 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxa9Jer/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:55:13 INFO - 2015-11-25 10:55:13,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 140865536 10:55:13 INFO - 2015-11-25 10:55:13,166 DEBUG : BROWSER_OUTPUT: 10:56:04 INFO - 2015-11-25 10:56:04,063 DEBUG : BROWSER_OUTPUT: 1448477764061 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:58:18 INFO - 2015-11-25 10:58:18,161 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43730/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43730/tests/dromaeo/cssquery-ext.html) 10:58:19 INFO - 2015-11-25 10:58:19,407 DEBUG : BROWSER_OUTPUT: RSS: Main: 263802880 10:58:19 INFO - 2015-11-25 10:58:19,408 DEBUG : BROWSER_OUTPUT: 11:01:21 INFO - 2015-11-25 11:01:21,844 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43730/tests/dromaeo/cssquery-ext.html (next: http://localhost:43730/tests/dromaeo/cssquery-jquery.html) 11:01:22 INFO - 2015-11-25 11:01:22,426 DEBUG : BROWSER_OUTPUT: RSS: Main: 229175296 11:01:22 INFO - 2015-11-25 11:01:22,426 DEBUG : BROWSER_OUTPUT: 11:04:24 INFO - 2015-11-25 11:04:24,292 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43730/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43730/tests/dromaeo/cssquery-mootools.html) 11:04:24 INFO - 2015-11-25 11:04:24,858 DEBUG : BROWSER_OUTPUT: RSS: Main: 224108544 11:04:24 INFO - 2015-11-25 11:04:24,858 DEBUG : BROWSER_OUTPUT: 11:07:26 INFO - 2015-11-25 11:07:26,693 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43730/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43730/tests/dromaeo/cssquery-prototype.html) 11:07:27 INFO - 2015-11-25 11:07:27,284 DEBUG : BROWSER_OUTPUT: RSS: Main: 199876608 11:07:27 INFO - 2015-11-25 11:07:27,284 DEBUG : BROWSER_OUTPUT: 11:10:29 INFO - 2015-11-25 11:10:29,933 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43730/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43730/tests/dromaeo/cssquery-yui.html) 11:10:30 INFO - 2015-11-25 11:10:30,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 201572352 11:10:30 INFO - 2015-11-25 11:10:30,506 DEBUG : BROWSER_OUTPUT: 11:13:33 INFO - 2015-11-25 11:13:33,005 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43730/tests/dromaeo/cssquery-yui.html (next: http://localhost:43730/tests/dromaeo/cssquery-dojo.html) 11:13:33 INFO - 2015-11-25 11:13:33,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 255918080 11:13:33 INFO - 2015-11-25 11:13:33,255 DEBUG : BROWSER_OUTPUT: 11:13:33 INFO - 2015-11-25 11:13:33,255 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:13:33 INFO - 2015-11-25 11:13:33,255 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:13:33 INFO - 2015-11-25 11:13:33,255 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:13:33 INFO - 2015-11-25 11:13:33,256 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:13:33 INFO - 2015-11-25 11:13:33,259 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3209.8555564999574;3241.8541165647543;3278.442664746994;3283.950740738889;3296.3572103439833;5284.577233821295;5353.116735738608;5429.7285135743205;5480.780768769245;5499.560035197184;5369.275147855038;5439.292891924044;5441.891162176754;5482.369527504338;5581.748821303041;4992.700437973734;5034.270030845525;5034.622403319748;5063.189889617662;5069.112905241586;4933.876653083666;5122.206058060988;5149.356330458692;5156.3296771419855;5211.166213405856;4925.556699896991;4970.378702662168;4985.102681517325;5015.0972824891505;5057.519535644108;4936.062148191868;4936.259561065833;4952.975235123801;4969.13040217964;4996.075725990703;4884.902301953941;4905.411350637911;4929.531694489017;4936.975315123437;4997.475265097149;5133.794648214067;5257.211418287249;5281.234221037967;5383.057964856134;5402.432744561843;5910.1430292607765;5921.467067963904;5926.822195334147;5929.940700592982;5941.584089113764;5838.678872662002;5951.434613711691;5960.105984102376;5977.880442391128;5982.461578457916;5442.0476416627325;5445.863853403657;5518.586106042023;5585.804496842591;5631.774729010794;6011.879762404727;6017.578769486182;6018.879622407528;6065.6663883486835;6068.726907289182;5658.122990936329;5845.298564172326;5845.795397161079;5848.356680765112;5890.263717035371;5824.271966004249;5826.82519524415;5858.326292476419;5882.205902203234;5934.673592952429;5880.588358814842;5937.732802023919;5938.049912014057;5951.672658003765;5953.851153721192;5717.256756621696;5814.79648212319;5925.318588362307;5936.257967754031;5938.851528711817;4501.099780043939;4561.110583436264;4580.358749775034;4583.083383323282;4595.2188128018315;4039.939400908989;4049.5950404959267;4058.3912413138264;4079.918401631951;4092.0588264699286;5432.619716619799;5611.859703507445;5631.549476041907;5631.8592035199445;5632.3804381518;5790.218320526675;5853.560982926298;5864.325602555676;5942.227510423617;5985.670788106696;5600.383957764642;5616.410276920946;5636.915446268309;5646.576506761927;5654.37801841797;5050.090983622909;5197.350331208599;5207.192885102815;5207.192885102815;5254.395744489356;5988.580799344091;6021;6097.409717157628;6113.689499947685;6122.84634471468;5980.162777211281;6073.908891366545;6073.969630151821;6075.817725468243;6078.149059131637;5839.299284085937;5882.323532793784;6184.567080304336;6194.4115309045565;6198.81403557894;5758.510526605285;5798.449147330997;5851.912221316598;5891.1752354671235;5892.027815410581;5849.64902105858;5992.67040312787;6013.30846952606;6017.699115044318;6021.036634138517;5633.0423827948525;5835;5856.94143058564;5858.5898987070495;5885.234919460443;5650.773969041193;5780.710964451677;5834.854128646818;5879.647221166572;5910.940890591039;5664.320281566238;5668.858278542904;5674.06377947634;5682.9147562785765;5683.7442315095095;5642.88714225705;5700.2304688868135;5751.827445176651;5759.596828221985;5825.300963884361;5661.971690141523;5747.885042299215;5756.625819321731;5790.507806836466;5804.94195058044 11:13:33 INFO - 2015-11-25 11:13:33,260 DEBUG : BROWSER_OUTPUT: |1;ext.html;554.3189488044804;575.2033433694334;586.8151532267339;601.0323379359232;621.7761605821903;30685.539716904237;39069.21861562774;39094.60905390949;39114.608853911486;39125.41311880324;41988.160236795244;42377.36433953493;42453;42482.36276455856;42487.15025699484;7570.6971721131085;7705.73029943952;8759.080296568849;8923.10768923109;8929.55352232389;10238.641647542338;10431.895681043206;10442.425666588335;10444.477776111202;10451.16390688743;10448.16414686827;10579.788404231911;10584.735381615445;10584.894151058468;10591.629292974747;7721.112072111723;7920.0495940486935;10239.744006399826;10413.583456661763;10486.475676216234;9929.156021738161;10057.849132263022;10061;10062.19502439803;10064.446455444948;33065.338693226244;36482;37091.629083709086;37108.515659373596;37119.25761484755;2801.271669365959;3289.671032896691;3754;3873.3996230584303;3952.664023558001;30209.244768880955;30234.84882575573;30831.84584077088;30911.536326955113;31413.842930785428;3628.7459877808565;3707.477895998812;3741.7567858089137;3781.867634632802;3789.77261364319;261798;262864;263591;264144;264475.9999999981;57725.11374431261;58016.8396632065;58082.54793630108;58157;58161;60701.69649151726;60821;60881;60918;60922.69538652367;16062.598435039217;16315.59211019734;16348;16351.42770003068;16355.182240887909;11794.29234245948;11846.703832404259;11846.88153118475;11848.289102653696;11857;18112.051415113023;19394.612107757766;19418.5145371364;19420.126094325788;19431.514212144808;7068.409607838195;7215.113954418274;7286.672099755524;7304.2695730427595;7358.8528229435115;976.5263847034183;1019.8215312320315;1021.39737554843;1041.1722680469045;1060.4591658254346;24973.87513062423;26252.949882004887;27042.32394190161;27321.863390683317;27707;1025.348903446302;1072.6245813965206;1086.2070688397514;1091.80102300261;1158.988410115905;14131.929340353232;14559.563213103624;14694.11835289886;14739.484118055816;14759.704805903822;323642;328319;328407;328587;329778;49086.509134908905;49563.752181239586;51391.74304128456;52138;52228.47771522236;1324.291504045331;1360.5782207515701;1362.3869258833565;1374.6425929258464;1380.8412032615977;24508.544552129486;26328;27117.72882271152;28068.85965570159;28508.714912850606;44336.77831610821;44754.55245447504;44754.77622611996;44850.551494484636;44852.32721509114;218219;221109;221423;221677;221950;30353;31266.374672506878;31395.84302078475;31554.368912622078;31575;43332;43566;43686.126277474905;44243.11513769771;44698.3295250565;36471;36759.26481470409;36998.8150059248;39017.609823901395;40632;35080.878393201936;35797.46303805393;36311.45532816957;36561.63438365582;36816.26367472689;35296.11759706028;35755;35774.8211258942;35837.283254335285;36118.27763444664;29873.850630746707;32308;32552.51171232386;32818.67181328252;33569;23949.760502394754;24052.36976165217;24071;24156.51686966216;24488 11:13:33 INFO - 2015-11-25 11:13:33,262 DEBUG : BROWSER_OUTPUT: |2;jquery.html;345.89104432103886;358.9443636236381;361.44698611124977;361.72147446466204;363.07053941908725;14036.368363423644;14188.148711077343;16725.414610488635;16966.066866322348;17628.823711762896;10928.125749940005;11227.157963152755;16653;17893.642127157447;17906.552336191602;4749.382580264561;4907.190313598252;4907.901841963158;4908.0429316283335;4915.483874193212;3733.906652333686;3847.057470919615;4963.652544321899;4989.925151122736;5354.41101478837;5460.262864513299;5493.038718224295;5496.615236933416;5503.972480137593;5511.9724401377935;5295.735213239342;5426.375966763833;5449.3188351456065;5455.18172274158;5467.343918729738;5176.534111929906;5227.6079294052715;5229.137192363255;5250.921236181461;5268.367795864482;12380.380980950917;13197.20816750998;13285.800712989312;13300.268485233308;13300.800487992688;2010.9844528513154;2057.5781964697203;2059.9279025234046;2179.0194412514434;2229.2866282789514;9559.713208603753;9720.95139524305;9841.704748857546;12849.935750321281;13009.869901300961;1824.9817501824944;1845.0036980030902;1845.1604519943394;1861.8882867028021;1880.7931127575955;62171.68914155445;65168.348316516705;66031.66984165048;66099.66950165266;67219;9670.613175472903;9783.315167938319;9891.10527154006;9906.900930990741;9935.503224838729;12863.035272354424;12871.48514059446;12897.677558060936;12898.742025159632;12903.290319032543;7302.2697730226555;7348.742794002291;7350.63246837656;7445.813854653568;7461.179270280265;7259.709611615582;7296.051513303237;7323.12122545298;7328.3404493595835;7366.337029667356;3984.86052988144;4048.8582899598373;4052.8378864845668;4076.694247931417;4076.8369265229057;1572.8112626484667;1651.3724784581782;1677.6812405642888;1690.9492715218564;1751.8773685841868;424.14111424365905;424.7027081043282;428.8563331284055;438.91221755648996;929.8512238041881;9725.124738773544;9816.312858099864;11042.613508527164;11094.167937404727;11193.552257909592;421.68584404618144;432.55014784623637;439.29054576858783;458.6399676254191;459.99080018399445;4554.863354099382;5736.397678243808;5818.359980402152;5998.220231369894;6006.309274433409;498659;527327;534308;539367;554747;78313.60843195747;82445.58777206075;82521;82690.58654706688;84680.15319846846;1109.8113320735495;1120.4845770945456;1127.2278489235064;1135.1940122513108;1137.766757814646;15121.86586006076;15299.541013769605;15462.613434664223;15466.458673946358;15617.843821561639;35555.82222088873;35932.46101308535;36088.45867312045;36132.63867361293;36333.45499817452;44924.77537612422;45351.546484536055;45752.771236143606;46295;46347.53652463432;9363.85954210701;9443.244540436886;9448.385854919408;9545;9569.712908612753;11360.829587556358;11402.82895756581;11519.13606479534;11530.423478826193;11546.538138474367;13941.233232171922;14082.366293517021;14199.64500887486;14485.710285794436;14788.334524946618;13742.862571374559;13921.373538191008;14157.504487342894;14384.42462301538;14395.712085758018;14504.782428263374;14514.419423222953;14623.707525849637;14664.780028299798;15140.167290799112;9047.457152570867;9071.866016747907;9078.500682462529;9265.814683706423;9473.289503287418;10031.147352475122;12487.687807804878;13958.441662333798;14239.430422783387;14302.856971430569 11:13:33 INFO - 2015-11-25 11:13:33,263 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1335.5659410691528;1696.8642508599314;1740.7649967254424;1759.0940665557237;1773.618671985523;6914.44684425246;7767.33977611903;7790.805229869256;7823.530588164707;7847.293743563078;7576.507527010741;7804.2585954334245;7834.138244793068;7837.725679601215;7839.568823714693;2258.8870556472193;2297.5519773644146;2297.8621282723007;2299.5975704251773;2300.1029598456616;2278.931632051033;2317.281642690763;2341.0869760793303;2349.718033835942;2349.9295021149305;2262.864228146308;2283.8858057097077;2296.322584837477;2300.49389134391;2317.8493397929083;2232.3191426614876;2281.0761641535123;2301.551197516485;2306.792388685018;2307.873066981307;2307.9884600577057;2320.2227253869974;2325.9184479217247;2328.1734984080745;2329.1032952313312;6762.154730658668;6982.895256571155;7809.414293927978;7891.644875980594;7906.52560846351;4271.444712187426;4297.828086876521;4667.253239481701;4762.214234651278;4772.093302272592;3096.2568983444035;3123.515855042472;3137.0902438293097;3140.356226973465;3251.089694885436;990.1929927109455;998.1964518562554;1005.5173516712019;1025.2874252394588;1094.6332978452228;10516.631917882914;10675.733106672318;10687.03816656497;10699.572017119306;10713.785724285548;4134.813933373005;4200.432941552913;4268.87193384199;4277.978610106929;4279.186954478639;8218.301444377175;8238.340932725368;8244.422890397735;8248.958755206186;8259.42184047123;4691.296305554194;4699.459562150328;4703.0593881223895;4704.458987216445;4735.005648813719;4279.272523670983;4281.785910704452;4297.226499230106;4323.610875021263;4337.652987760972;3478.599961004517;3531.205478767257;3543.7342199335153;3564.108972756811;3574.070741607201;1091.1325496230515;1104.9337039777638;1111.7943180511631;1119.7480566872389;1120.4509790202742;1302.7329397473495;1307.6992291772945;1316.4734106357535;1348.871857173567;1363.1820907455647;7045.8238544035785;7223.602701851343;7277.3086556777025;7287.890681639779;7302.6713797878165;462.06431975249717;471.56851480894596;473.6258355898801;474.62978876476404;478.5573344656179;5558.305211848519;5716.485516303469;5767.826965191051;5793.102069179284;5795.681237531892;8575.442596231225;9189.770255743526;9333.673321433716;9334.486603236886;9356.157945784777;9047.773805654911;9163.77090572741;9198.67804626835;9227.76930576741;9309.53452327381;7075;7221.277872212841;7237.421006319481;7245.8550828983125;7281.854362912712;7103.964480177566;7159.427245820218;7185;7188.245234250328;7195.46034047459;8037.156098609796;8074.475159114639;8086.43394962347;8179.509229446252;8287.50274983503;8238.546879921661;8378.162183781573;8434.367422443218;8463.703770368254;8497.490150590984;7222.674979625825;7284.198738138694;7289.380402665621;7290.234525374759;7291.34377905991;7482.064741907262;7551.773446796605;7605.619719013916;7646.541207527566;7675.731349402968;7116.039334689751;7174.426045916419;7176.641167941686;7281.417486600953;7355.926440735524;6999.650017499002;7003.3346832050875;7077.115360579927;7163.570185788869;7250.89123663156;7147.356737893615;7178.102737157856;7195.388391986739;7202.207757146814;7206.927930720625;6534.934650653433;6537.8692426152165;6578.473722102316;6650.700718467584;6677.599344039373;6560.147180866456;6568.343165683394;6575.934240657532;6594.769183078569;6613.867722645617 11:13:33 INFO - 2015-11-25 11:13:33,267 DEBUG : BROWSER_OUTPUT: |4;prototype.html;337.2698108594892;340.5130663151695;340.53006850546245;342.2316898562726;347.7391956032974;5955.315138759033;6038.547108966829;6156.907646385308;6162.691865406734;6166;5864.208331875196;5999.250093738283;6061.515078793697;6067.9696601516935;6073.301570319414;4657.813687452514;4693.624510039197;4694.225452800284;4710.646701497384;4710.97644511777;4436.090601426716;4507.391502147201;4537.024539723959;4544.091181763644;4704.176769065417;4507.684462087655;4555.863324100283;4622.86131416058;4666.603338716213;4671.906561868761;4641.327007583882;4642.7910744016435;4658.58072773452;4666.160091183586;4668.579827815496;4096.32410652242;4101.876943691694;4107.815148318333;4119.032027473541;4121.29937910556;5665.405132461074;5760.135979603051;5768.826935191909;5782.421757824226;5786.594938354317;5443.265159203496;5457.945420545783;5464.890702185974;5469.042917489423;5474.7262636868;6181.3818618138275;6469.385408386196;6472.288048314682;6472.644004579746;6484.6433446160445;4431.379606855043;4471.418715566988;4477.977610111961;4487.596116349544;4503.324501324795;6612.371824676648;6702.463802895757;6703.564268322543;6716.865662686719;6716.865662686768;4605.585497305258;4621.168189725814;4625.838095666635;4626.83806066786;4635.605973492224;4516.751578663205;4646.744429056367;4659.6505262105475;4689.320048592935;4699.459562150328;5378.273933019071;5380.650257733235;5386.245925570423;5388.865278367994;5392.595555333366;6544.476441884638;6555.147830781968;6569.146011018537;6569.146011018537;6572.638504882278;1620.3599578166793;1643.802743670767;1645.045873393429;1645.2020769926576;1647.3822316631263;1069.5133714160038;1086.2721976275914;1087.4345340423095;1106.5131342209402;1112.7551938573502;6189.6286222826775;6264.812055638338;6282.842928926813;6283.057541368831;6283.59156654816;6678.232003319583;6679.298673639295;6687.732490700415;6687.866242675216;6690.59856408617;6233.846738353419;6265.561410701298;6267.2792628847355;6272.623642581369;6273.560850740404;3648.087978005499;3681.7606855554304;3685.594584595692;3686.2811751708696;3687.6681098701247;6942.097527321517;6963.651817409211;6992.16094068715;7019.3682568569075;7020.122484689414;6763.266200715992;6912.585244885222;6938.375546200866;6938.757143499954;6957.61733104674;6975.476839237078;6979.4765392595755;6987.720491180397;6993.0908981832035;6998.230194678683;6386.93613063882;6548.214214294315;6647.434968027772;6780.762673306411;6790.966045169743;6619.205695316593;6665.666716664245;6691.59850408977;6695.163104611924;6712.194536655633;6944.062551555476;6947.513674042971;6953.304669533006;6958.652067396712;6966.12923384577;4556.635469162526;4579.473360563445;4604.194266003503;4680.180968330596;4685.461171965268;6609.438197753245;6680.5991640501725;6683.665816709048;6696.397324240842;6702.731890724316;6517.608943463408;6524.869502609827;6532.05285233648;6532.150820393318;6534.313897040933;6422.42198202164;6520.315366886409;6523.151990241238;6572.901406479003;6585.769498067544;6416.294207637249;6424.967875160594;6448.45188158993;6457.709403076967;6465.806025819233;6611.471082313499;6612.5040621952585;6613.66931653425;6619.635920024252;6622.271550129578;6278.340774218824;6444.8388790280615;6462.709178086903;6464.450521705519;6469.417752402118 11:13:33 INFO - 2015-11-25 11:13:33,267 DEBUG : BROWSER_OUTPUT: |5;yui.html;822.169608695218;834.8038211020407;847.262881293275;848.6011574559955;858.3948316436905;13569.864301356984;13576.321183940789;13943;13943.721125577482;13947.651308717288;13203.141795783267;13498.527551535673;13517.391717372717;13522.391492382842;13522.594322170326;704;838.4508147163602;856.25933567464;857.0315543435909;857.8927634045745;705.5696025424512;712.3837880233586;843.7932706486889;854.9487030778142;860.2129051917519;886.7251152142824;886.8669699545055;895.5432729308067;895.9686410975618;896.3277541843618;721.2571051816637;726.2664708644254;886.9866951995725;888.1074520107284;889.6797153024905;536.4608568388784;536.8577327008346;537.9515843574057;648.0506058624092;657.2572992518424;13254.53609123676;13457.528986485426;13466.461341546326;13476.326183690777;13512.189268643913;12382.442790074378;12908.741825163444;12952.611421657271;12981.675458113528;13275.601731948056;10239.948800256025;10474.895251047468;10498.160147188206;10576.206784491116;10583.947080264626;3517.26137511123;3589.174489867345;3590.8025058621765;3623.9637603624155;3689.114612493009;47972.520274797156;48128.75935620334;48162.27756583654;48205.75897120527;48223;10486.947565262277;10516.421596812248;10519.368837869752;10639.574417023232;10666.36001839892;19179.61640767205;19189.32837350686;19200.039998000324;19235.018572121342;19275;7527.962360188164;7530.359919406802;7581.734639287599;7594.392448604099;7602.277783610548;4220.894477638084;4336.674749393808;4338.522762496123;4396.912061758747;4453.1316393303;2846.7722582193373;2855.1006432973545;2862.0269108502794;2876.3240638449947;2883.5818806272973;507.3404574053715;510.22445882258756;510.4283202812873;517.7928828468642;521.2181727408887;560.8653923058437;583.151514546334;643.080395035095;648.8053583924898;651.7230177174682;8139.918600813916;8216.630251638571;8234.258916697527;8596.656133754705;8622.525761083201;538.8652836790802;594.8156071617813;663.7776344924505;669.9162604674416;676.9570779346867;3744.927190260203;3758.9248215035545;4034.576369481221;4165.083681590046;4208.179405016053;56506.15240771392;56615.43384566101;56672;56745.14882276769;56751;48839;49788.25317620239;50696;51418;51481;47161.52838471571;47217.76391118091;47822;47913;48400;8259.339252859876;8599.742007739778;8732.607032683418;8780.473171609723;8942.105789421006;34603.307933840675;35125.29749405049;35329;35410.645893540735;36329.27341453103;45777.31334029925;46394;46632.30051549162;47248.763756181;47378.52621473741;9721.270904682318;9738.367006144577;10168.491575421347;10243.180545556486;10489.108425783588;11301.6791836123;11414.429278536207;11695.473703683525;11825.704357391134;11883.524659013543;10817.188710846875;11337.149713771336;11411.885881141083;11503.367314797431;11647.475863586329;10520.263581549218;10768.246222764332;10787.406692631981;10896.019358257794;11468.713282168013;10473.738156546147;10582.153427725609;10711.785764284516;10916.563337466412;10919.727006824893;9266.675666351646;9311.833519019587;9367.765805854908;9641.469719165514;9683.806323873343;8721.258693010912;8801.471911685063;9187.219086377732;9251.583678734338;9454.574544145393 11:13:33 INFO - 2015-11-25 11:13:33,267 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:13:33 INFO - 2015-11-25 11:13:33,267 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:13:33 INFO - 2015-11-25 11:13:33,267 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1037 11:13:33 INFO - 2015-11-25 11:13:33,267 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:13:33 INFO - 2015-11-25 11:13:33,267 DEBUG : BROWSER_OUTPUT: __startTimestamp1448478813254__endTimestamp 11:13:33 INFO - 2015-11-25 11:13:33,267 DEBUG : BROWSER_OUTPUT: 11:13:33 INFO - 2015-11-25 11:13:33,268 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:13:33 INFO - 2015-11-25 11:13:33,268 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:13:33 INFO - 2015-11-25 11:13:33,268 DEBUG : BROWSER_OUTPUT: 11:13:33 INFO - 2015-11-25 11:13:33,268 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5487.23 Median:5674.06 stddev:617.42 (10.9%) stddev-sans-first:592.90 11:13:33 INFO - 2015-11-25 11:13:33,268 DEBUG : BROWSER_OUTPUT: Values: 3209.9 3241.9 3278.4 3284.0 3296.4 5284.6 5353.1 5429.7 5480.8 5499.6 5369.3 5439.3 5441.9 5482.4 5581.7 4992.7 5034.3 5034.6 5063.2 5069.1 4933.9 5122.2 5149.4 5156.3 5211.2 4925.6 4970.4 4985.1 5015.1 5057.5 4936.1 4936.3 4953.0 4969.1 4996.1 4884.9 4905.4 4929.5 4937.0 4997.5 5133.8 5257.2 5281.2 5383.1 5402.4 5910.1 5921.5 5926.8 5929.9 5941.6 5838.7 5951.4 5960.1 5977.9 5982.5 5442.0 5445.9 5518.6 5585.8 5631.8 6011.9 6017.6 6018.9 6065.7 6068.7 5658.1 5845.3 5845.8 5848.4 5890.3 5824.3 5826.8 5858.3 5882.2 5934.7 5880.6 5937.7 5938.0 5951.7 5953.9 5717.3 5814.8 5925.3 5936.3 5938.9 4501.1 4561.1 4580.4 4583.1 4595.2 4039.9 4049.6 4058.4 4079.9 4092.1 5432.6 5611.9 5631.5 5631.9 5632.4 5790.2 5853.6 5864.3 5942.2 5985.7 5600.4 5616.4 5636.9 5646.6 5654.4 5050.1 5197.4 5207.2 5207.2 5254.4 5988.6 6021.0 6097.4 6113.7 6122.8 5980.2 6073.9 6074.0 6075.8 6078.1 5839.3 5882.3 6184.6 6194.4 6198.8 5758.5 5798.4 5851.9 5891.2 5892.0 5849.6 5992.7 6013.3 6017.7 6021.0 5633.0 5835.0 5856.9 5858.6 5885.2 5650.8 5780.7 5834.9 5879.6 5910.9 5664.3 5668.9 5674.1 5682.9 5683.7 5642.9 5700.2 5751.8 5759.6 5825.3 5662.0 5747.9 5756.6 5790.5 5804.9 11:13:33 INFO - 2015-11-25 11:13:33,268 DEBUG : BROWSER_OUTPUT: 11:13:33 INFO - 2015-11-25 11:13:33,268 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44366.78 Median:178097.26 stddev:71569.63 (40.2%) stddev-sans-first:71694.80 11:13:33 INFO - 2015-11-25 11:13:33,268 DEBUG : BROWSER_OUTPUT: Values: 554.3 575.2 586.8 601.0 621.8 30685.5 39069.2 39094.6 39114.6 39125.4 41988.2 42377.4 42453.0 42482.4 42487.2 7570.7 7705.7 8759.1 8923.1 8929.6 10238.6 10431.9 10442.4 10444.5 10451.2 10448.2 10579.8 10584.7 10584.9 10591.6 7721.1 7920.0 10239.7 10413.6 10486.5 9929.2 10057.8 10061.0 10062.2 10064.4 33065.3 36482.0 37091.6 37108.5 37119.3 2801.3 3289.7 3754.0 3873.4 3952.7 30209.2 30234.8 30831.8 30911.5 31413.8 3628.7 3707.5 3741.8 3781.9 3789.8 261798.0 262864.0 263591.0 264144.0 264476.0 57725.1 58016.8 58082.5 58157.0 58161.0 60701.7 60821.0 60881.0 60918.0 60922.7 16062.6 16315.6 16348.0 16351.4 16355.2 11794.3 11846.7 11846.9 11848.3 11857.0 18112.1 19394.6 19418.5 19420.1 19431.5 7068.4 7215.1 7286.7 7304.3 7358.9 976.5 1019.8 1021.4 1041.2 1060.5 24973.9 26252.9 27042.3 27321.9 27707.0 1025.3 1072.6 1086.2 1091.8 1159.0 14131.9 14559.6 14694.1 14739.5 14759.7 323642.0 328319.0 328407.0 328587.0 329778.0 49086.5 49563.8 51391.7 52138.0 52228.5 1324.3 1360.6 1362.4 1374.6 1380.8 24508.5 26328.0 27117.7 28068.9 28508.7 44336.8 44754.6 44754.8 44850.6 44852.3 218219.0 221109.0 221423.0 221677.0 221950.0 30353.0 31266.4 31395.8 31554.4 31575.0 43332.0 43566.0 43686.1 44243.1 44698.3 36471.0 36759.3 36998.8 39017.6 40632.0 35080.9 35797.5 36311.5 36561.6 36816.3 35296.1 35755.0 35774.8 35837.3 36118.3 29873.9 32308.0 32552.5 32818.7 33569.0 23949.8 24052.4 24071.0 24156.5 24488.0 11:13:33 INFO - 2015-11-25 11:13:33,268 DEBUG : BROWSER_OUTPUT: 11:13:33 INFO - 2015-11-25 11:13:33,268 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28000.02 Median:4076.77 stddev:87029.80 (2134.8%) stddev-sans-first:87249.17 11:13:33 INFO - 2015-11-25 11:13:33,270 DEBUG : BROWSER_OUTPUT: Values: 345.9 358.9 361.4 361.7 363.1 14036.4 14188.1 16725.4 16966.1 17628.8 10928.1 11227.2 16653.0 17893.6 17906.6 4749.4 4907.2 4907.9 4908.0 4915.5 3733.9 3847.1 4963.7 4989.9 5354.4 5460.3 5493.0 5496.6 5504.0 5512.0 5295.7 5426.4 5449.3 5455.2 5467.3 5176.5 5227.6 5229.1 5250.9 5268.4 12380.4 13197.2 13285.8 13300.3 13300.8 2011.0 2057.6 2059.9 2179.0 2229.3 9559.7 9721.0 9841.7 12849.9 13009.9 1825.0 1845.0 1845.2 1861.9 1880.8 62171.7 65168.3 66031.7 66099.7 67219.0 9670.6 9783.3 9891.1 9906.9 9935.5 12863.0 12871.5 12897.7 12898.7 12903.3 7302.3 7348.7 7350.6 7445.8 7461.2 7259.7 7296.1 7323.1 7328.3 7366.3 3984.9 4048.9 4052.8 4076.7 4076.8 1572.8 1651.4 1677.7 1690.9 1751.9 424.1 424.7 428.9 438.9 929.9 9725.1 9816.3 11042.6 11094.2 11193.6 421.7 432.6 439.3 458.6 460.0 4554.9 5736.4 5818.4 5998.2 6006.3 498659.0 527327.0 534308.0 539367.0 554747.0 78313.6 82445.6 82521.0 82690.6 84680.2 1109.8 1120.5 1127.2 1135.2 1137.8 15121.9 15299.5 15462.6 15466.5 15617.8 35555.8 35932.5 36088.5 36132.6 36333.5 44924.8 45351.5 45752.8 46295.0 46347.5 9363.9 9443.2 9448.4 9545.0 9569.7 11360.8 11402.8 11519.1 11530.4 11546.5 13941.2 14082.4 14199.6 14485.7 14788.3 13742.9 13921.4 14157.5 14384.4 14395.7 14504.8 14514.4 14623.7 14664.8 15140.2 9047.5 9071.9 9078.5 9265.8 9473.3 10031.1 12487.7 13958.4 14239.4 14302.9 11:13:33 INFO - 2015-11-25 11:13:33,270 DEBUG : BROWSER_OUTPUT: 11:13:33 INFO - 2015-11-25 11:13:33,270 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5420.63 Median:6564.25 stddev:2792.98 (42.5%) stddev-sans-first:2783.93 11:13:33 INFO - 2015-11-25 11:13:33,270 DEBUG : BROWSER_OUTPUT: Values: 1335.6 1696.9 1740.8 1759.1 1773.6 6914.4 7767.3 7790.8 7823.5 7847.3 7576.5 7804.3 7834.1 7837.7 7839.6 2258.9 2297.6 2297.9 2299.6 2300.1 2278.9 2317.3 2341.1 2349.7 2349.9 2262.9 2283.9 2296.3 2300.5 2317.8 2232.3 2281.1 2301.6 2306.8 2307.9 2308.0 2320.2 2325.9 2328.2 2329.1 6762.2 6982.9 7809.4 7891.6 7906.5 4271.4 4297.8 4667.3 4762.2 4772.1 3096.3 3123.5 3137.1 3140.4 3251.1 990.2 998.2 1005.5 1025.3 1094.6 10516.6 10675.7 10687.0 10699.6 10713.8 4134.8 4200.4 4268.9 4278.0 4279.2 8218.3 8238.3 8244.4 8249.0 8259.4 4691.3 4699.5 4703.1 4704.5 4735.0 4279.3 4281.8 4297.2 4323.6 4337.7 3478.6 3531.2 3543.7 3564.1 3574.1 1091.1 1104.9 1111.8 1119.7 1120.5 1302.7 1307.7 1316.5 1348.9 1363.2 7045.8 7223.6 7277.3 7287.9 7302.7 462.1 471.6 473.6 474.6 478.6 5558.3 5716.5 5767.8 5793.1 5795.7 8575.4 9189.8 9333.7 9334.5 9356.2 9047.8 9163.8 9198.7 9227.8 9309.5 7075.0 7221.3 7237.4 7245.9 7281.9 7104.0 7159.4 7185.0 7188.2 7195.5 8037.2 8074.5 8086.4 8179.5 8287.5 8238.5 8378.2 8434.4 8463.7 8497.5 7222.7 7284.2 7289.4 7290.2 7291.3 7482.1 7551.8 7605.6 7646.5 7675.7 7116.0 7174.4 7176.6 7281.4 7355.9 6999.7 7003.3 7077.1 7163.6 7250.9 7147.4 7178.1 7195.4 7202.2 7206.9 6534.9 6537.9 6578.5 6650.7 6677.6 6560.1 6568.3 6575.9 6594.8 6613.9 11:13:33 INFO - 2015-11-25 11:13:33,270 DEBUG : BROWSER_OUTPUT: 11:13:33 INFO - 2015-11-25 11:13:33,270 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5434.90 Median:6185.51 stddev:1644.51 (26.6%) stddev-sans-first:1603.99 11:13:33 INFO - 2015-11-25 11:13:33,271 DEBUG : BROWSER_OUTPUT: Values: 337.3 340.5 340.5 342.2 347.7 5955.3 6038.5 6156.9 6162.7 6166.0 5864.2 5999.3 6061.5 6068.0 6073.3 4657.8 4693.6 4694.2 4710.6 4711.0 4436.1 4507.4 4537.0 4544.1 4704.2 4507.7 4555.9 4622.9 4666.6 4671.9 4641.3 4642.8 4658.6 4666.2 4668.6 4096.3 4101.9 4107.8 4119.0 4121.3 5665.4 5760.1 5768.8 5782.4 5786.6 5443.3 5457.9 5464.9 5469.0 5474.7 6181.4 6469.4 6472.3 6472.6 6484.6 4431.4 4471.4 4478.0 4487.6 4503.3 6612.4 6702.5 6703.6 6716.9 6716.9 4605.6 4621.2 4625.8 4626.8 4635.6 4516.8 4646.7 4659.7 4689.3 4699.5 5378.3 5380.7 5386.2 5388.9 5392.6 6544.5 6555.1 6569.1 6569.1 6572.6 1620.4 1643.8 1645.0 1645.2 1647.4 1069.5 1086.3 1087.4 1106.5 1112.8 6189.6 6264.8 6282.8 6283.1 6283.6 6678.2 6679.3 6687.7 6687.9 6690.6 6233.8 6265.6 6267.3 6272.6 6273.6 3648.1 3681.8 3685.6 3686.3 3687.7 6942.1 6963.7 6992.2 7019.4 7020.1 6763.3 6912.6 6938.4 6938.8 6957.6 6975.5 6979.5 6987.7 6993.1 6998.2 6386.9 6548.2 6647.4 6780.8 6791.0 6619.2 6665.7 6691.6 6695.2 6712.2 6944.1 6947.5 6953.3 6958.7 6966.1 4556.6 4579.5 4604.2 4680.2 4685.5 6609.4 6680.6 6683.7 6696.4 6702.7 6517.6 6524.9 6532.1 6532.2 6534.3 6422.4 6520.3 6523.2 6572.9 6585.8 6416.3 6425.0 6448.5 6457.7 6465.8 6611.5 6612.5 6613.7 6619.6 6622.3 6278.3 6444.8 6462.7 6464.5 6469.4 11:13:33 INFO - 2015-11-25 11:13:33,271 DEBUG : BROWSER_OUTPUT: 11:13:33 INFO - 2015-11-25 11:13:33,272 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13831.20 Median:47867.50 stddev:16061.87 (33.6%) stddev-sans-first:16077.22 11:13:33 INFO - 2015-11-25 11:13:33,272 DEBUG : BROWSER_OUTPUT: Values: 822.2 834.8 847.3 848.6 858.4 13569.9 13576.3 13943.0 13943.7 13947.7 13203.1 13498.5 13517.4 13522.4 13522.6 704.0 838.5 856.3 857.0 857.9 705.6 712.4 843.8 854.9 860.2 886.7 886.9 895.5 896.0 896.3 721.3 726.3 887.0 888.1 889.7 536.5 536.9 538.0 648.1 657.3 13254.5 13457.5 13466.5 13476.3 13512.2 12382.4 12908.7 12952.6 12981.7 13275.6 10239.9 10474.9 10498.2 10576.2 10583.9 3517.3 3589.2 3590.8 3624.0 3689.1 47972.5 48128.8 48162.3 48205.8 48223.0 10486.9 10516.4 10519.4 10639.6 10666.4 19179.6 19189.3 19200.0 19235.0 19275.0 7528.0 7530.4 7581.7 7594.4 7602.3 4220.9 4336.7 4338.5 4396.9 4453.1 2846.8 2855.1 2862.0 2876.3 2883.6 507.3 510.2 510.4 517.8 521.2 560.9 583.2 643.1 648.8 651.7 8139.9 8216.6 8234.3 8596.7 8622.5 538.9 594.8 663.8 669.9 677.0 3744.9 3758.9 4034.6 4165.1 4208.2 56506.2 56615.4 56672.0 56745.1 56751.0 48839.0 49788.3 50696.0 51418.0 51481.0 47161.5 47217.8 47822.0 47913.0 48400.0 8259.3 8599.7 8732.6 8780.5 8942.1 34603.3 35125.3 35329.0 35410.6 36329.3 45777.3 46394.0 46632.3 47248.8 47378.5 9721.3 9738.4 10168.5 10243.2 10489.1 11301.7 11414.4 11695.5 11825.7 11883.5 10817.2 11337.1 11411.9 11503.4 11647.5 10520.3 10768.2 10787.4 10896.0 11468.7 10473.7 10582.2 10711.8 10916.6 10919.7 9266.7 9311.8 9367.8 9641.5 9683.8 8721.3 8801.5 9187.2 9251.6 9454.6 11:13:33 INFO - 2015-11-25 11:13:33,272 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:13:33 INFO - 2015-11-25 11:13:33,272 DEBUG : BROWSER_OUTPUT: 11:13:34 INFO - 2015-11-25 11:13:34,973 INFO : Browser exited with error code: 0 11:13:34 INFO - 2015-11-25 11:13:34,990 INFO : Completed test dromaeo_css (00:19:54) 11:13:34 INFO - 2015-11-25 11:13:34,990 INFO : Starting test kraken 11:13:34 INFO - 2015-11-25 11:13:34,990 DEBUG : operating with platform_type : linux_ 11:13:34 INFO - 2015-11-25 11:13:34,990 INFO : Initialising browser for kraken test... 11:13:34 INFO - 2015-11-25 11:13:34,996 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWwbDf3/profile http://localhost:43730/getInfo.html 11:13:49 INFO - 2015-11-25 11:13:49,292 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:13:49 INFO - 2015-11-25 11:13:49,292 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:13:49 INFO - 2015-11-25 11:13:49,292 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:13:49 INFO - 2015-11-25 11:13:49,292 DEBUG : BROWSER_OUTPUT: __metrics 11:13:50 INFO - 2015-11-25 11:13:50,136 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:13:57 INFO - 2015-11-25 11:13:57,213 INFO : Browser initialized. 11:13:57 INFO - 2015-11-25 11:13:57,214 INFO : Running cycle 1/1 for kraken test... 11:13:57 INFO - 2015-11-25 11:13:57,214 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWwbDf3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:14:08 INFO - 2015-11-25 11:14:08,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 141418496 11:14:08 INFO - 2015-11-25 11:14:08,868 DEBUG : BROWSER_OUTPUT: 11:14:11 INFO - 2015-11-25 11:14:11,306 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43730/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43730/tests/kraken/driver.html?testName=audio-beat-detection) 11:14:11 INFO - 2015-11-25 11:14:11,908 DEBUG : BROWSER_OUTPUT: RSS: Main: 178253824 11:14:11 INFO - 2015-11-25 11:14:11,908 DEBUG : BROWSER_OUTPUT: 11:14:14 INFO - 2015-11-25 11:14:14,516 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43730/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43730/tests/kraken/driver.html?testName=audio-dft) 11:14:15 INFO - 2015-11-25 11:14:15,082 DEBUG : BROWSER_OUTPUT: RSS: Main: 165572608 11:14:15 INFO - 2015-11-25 11:14:15,082 DEBUG : BROWSER_OUTPUT: 11:14:17 INFO - 2015-11-25 11:14:17,904 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43730/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43730/tests/kraken/driver.html?testName=audio-fft) 11:14:18 INFO - 2015-11-25 11:14:18,465 DEBUG : BROWSER_OUTPUT: RSS: Main: 149618688 11:14:18 INFO - 2015-11-25 11:14:18,465 DEBUG : BROWSER_OUTPUT: 11:14:20 INFO - 2015-11-25 11:14:20,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43730/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43730/tests/kraken/driver.html?testName=audio-oscillator) 11:14:21 INFO - 2015-11-25 11:14:21,018 DEBUG : BROWSER_OUTPUT: RSS: Main: 153202688 11:14:21 INFO - 2015-11-25 11:14:21,019 DEBUG : BROWSER_OUTPUT: 11:14:23 INFO - 2015-11-25 11:14:23,195 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43730/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43730/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:14:23 INFO - 2015-11-25 11:14:23,762 DEBUG : BROWSER_OUTPUT: RSS: Main: 155418624 11:14:23 INFO - 2015-11-25 11:14:23,762 DEBUG : BROWSER_OUTPUT: 11:14:26 INFO - 2015-11-25 11:14:26,640 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43730/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43730/tests/kraken/driver.html?testName=imaging-darkroom) 11:14:27 INFO - 2015-11-25 11:14:27,206 DEBUG : BROWSER_OUTPUT: RSS: Main: 155848704 11:14:27 INFO - 2015-11-25 11:14:27,206 DEBUG : BROWSER_OUTPUT: 11:14:31 INFO - 2015-11-25 11:14:31,012 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43730/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43730/tests/kraken/driver.html?testName=imaging-desaturate) 11:14:31 INFO - 2015-11-25 11:14:31,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 153935872 11:14:31 INFO - 2015-11-25 11:14:31,639 DEBUG : BROWSER_OUTPUT: 11:14:34 INFO - 2015-11-25 11:14:34,397 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43730/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43730/tests/kraken/driver.html?testName=json-parse-financial) 11:14:34 INFO - 2015-11-25 11:14:34,966 DEBUG : BROWSER_OUTPUT: RSS: Main: 153272320 11:14:34 INFO - 2015-11-25 11:14:34,966 DEBUG : BROWSER_OUTPUT: 11:14:36 INFO - 2015-11-25 11:14:36,517 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43730/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43730/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:14:37 INFO - 2015-11-25 11:14:37,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 164458496 11:14:37 INFO - 2015-11-25 11:14:37,091 DEBUG : BROWSER_OUTPUT: 11:14:38 INFO - 2015-11-25 11:14:38,885 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43730/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43730/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:14:39 INFO - 2015-11-25 11:14:39,487 DEBUG : BROWSER_OUTPUT: RSS: Main: 163577856 11:14:39 INFO - 2015-11-25 11:14:39,487 DEBUG : BROWSER_OUTPUT: 11:14:41 INFO - 2015-11-25 11:14:41,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43730/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43730/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:14:42 INFO - 2015-11-25 11:14:42,123 DEBUG : BROWSER_OUTPUT: RSS: Main: 167419904 11:14:42 INFO - 2015-11-25 11:14:42,124 DEBUG : BROWSER_OUTPUT: 11:14:44 INFO - 2015-11-25 11:14:44,485 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43730/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43730/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:14:45 INFO - 2015-11-25 11:14:45,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 179990528 11:14:45 INFO - 2015-11-25 11:14:45,067 DEBUG : BROWSER_OUTPUT: 11:14:47 INFO - 2015-11-25 11:14:47,585 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43730/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43730/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:14:48 INFO - 2015-11-25 11:14:48,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 176340992 11:14:48 INFO - 2015-11-25 11:14:48,159 DEBUG : BROWSER_OUTPUT: 11:14:49 INFO - 2015-11-25 11:14:49,792 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43730/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43730/tests/kraken/driver.html?testName=ai-astar) 11:14:50 INFO - 2015-11-25 11:14:50,050 DEBUG : BROWSER_OUTPUT: RSS: Main: 234467328 11:14:50 INFO - 2015-11-25 11:14:50,050 DEBUG : BROWSER_OUTPUT: 11:14:50 INFO - 2015-11-25 11:14:50,050 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:14:50 INFO - 2015-11-25 11:14:50,050 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:14:50 INFO - 2015-11-25 11:14:50,050 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:14:50 INFO - 2015-11-25 11:14:50,051 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:14:50 INFO - 2015-11-25 11:14:50,051 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;110;104;110;110;110;97;109;110;108 11:14:50 INFO - 2015-11-25 11:14:50,051 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;147;123;159;159;128;159;151;131;172;124 11:14:50 INFO - 2015-11-25 11:14:50,051 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;160;160;161;159;162;161;160 11:14:50 INFO - 2015-11-25 11:14:50,051 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;71;84;94;72;72;73;125;88;72 11:14:50 INFO - 2015-11-25 11:14:50,051 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;135;92;94;93;140;92;93;142 11:14:50 INFO - 2015-11-25 11:14:50,052 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;109;110;110;109;109;110 11:14:50 INFO - 2015-11-25 11:14:50,052 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;147;146;146;145;146;146;146;145;145 11:14:50 INFO - 2015-11-25 11:14:50,052 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;95 11:14:50 INFO - 2015-11-25 11:14:50,052 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;59;57;57;57;59;58;60;56;57 11:14:50 INFO - 2015-11-25 11:14:50,052 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;70;70;69;70;70;70;69;71;70 11:14:50 INFO - 2015-11-25 11:14:50,052 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;92;84;85;85;84;85;84;99;97 11:14:50 INFO - 2015-11-25 11:14:50,053 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;114;120;122;115;115;122;120;120;121 11:14:50 INFO - 2015-11-25 11:14:50,053 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;149;145;152;155;135;145;146;146;136 11:14:50 INFO - 2015-11-25 11:14:50,053 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;65;66;66;66;66;65;64;63;64 11:14:50 INFO - 2015-11-25 11:14:50,053 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:14:50 INFO - 2015-11-25 11:14:50,053 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:14:50 INFO - 2015-11-25 11:14:50,053 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,918 11:14:50 INFO - 2015-11-25 11:14:50,053 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:14:50 INFO - 2015-11-25 11:14:50,053 DEBUG : BROWSER_OUTPUT: __startTimestamp1448478890044__endTimestamp 11:14:50 INFO - 2015-11-25 11:14:50,053 DEBUG : BROWSER_OUTPUT: 11:14:50 INFO - 2015-11-25 11:14:50,054 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:14:50 INFO - 2015-11-25 11:14:50,054 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:14:50 INFO - 2015-11-25 11:14:50,054 DEBUG : BROWSER_OUTPUT: 11:14:50 INFO - 2015-11-25 11:14:50,054 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.80 Median:110.00 stddev:4.24 (3.9%) stddev-sans-first:4.42 11:14:50 INFO - 2015-11-25 11:14:50,054 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 104.0 110.0 110.0 110.0 97.0 109.0 110.0 108.0 11:14:50 INFO - 2015-11-25 11:14:50,054 DEBUG : BROWSER_OUTPUT: 11:14:50 INFO - 2015-11-25 11:14:50,054 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.30 Median:155.00 stddev:17.53 (11.3%) stddev-sans-first:18.58 11:14:50 INFO - 2015-11-25 11:14:50,054 DEBUG : BROWSER_OUTPUT: Values: 147.0 123.0 159.0 159.0 128.0 159.0 151.0 131.0 172.0 124.0 11:14:50 INFO - 2015-11-25 11:14:50,054 DEBUG : BROWSER_OUTPUT: 11:14:50 INFO - 2015-11-25 11:14:50,054 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 11:14:50 INFO - 2015-11-25 11:14:50,054 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 160.0 160.0 161.0 159.0 162.0 161.0 160.0 11:14:50 INFO - 2015-11-25 11:14:50,054 DEBUG : BROWSER_OUTPUT: 11:14:50 INFO - 2015-11-25 11:14:50,055 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.10 Median:72.50 stddev:17.25 (23.8%) stddev-sans-first:17.73 11:14:50 INFO - 2015-11-25 11:14:50,055 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 84.0 94.0 72.0 72.0 73.0 125.0 88.0 72.0 11:14:50 INFO - 2015-11-25 11:14:50,055 DEBUG : BROWSER_OUTPUT: 11:14:50 INFO - 2015-11-25 11:14:50,055 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.90 Median:93.00 stddev:22.23 (23.9%) stddev-sans-first:23.08 11:14:50 INFO - 2015-11-25 11:14:50,055 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 135.0 92.0 94.0 93.0 140.0 92.0 93.0 142.0 11:14:50 INFO - 2015-11-25 11:14:50,055 DEBUG : BROWSER_OUTPUT: 11:14:50 INFO - 2015-11-25 11:14:50,055 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 11:14:50 INFO - 2015-11-25 11:14:50,055 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 109.0 110.0 110.0 109.0 109.0 110.0 11:14:50 INFO - 2015-11-25 11:14:50,055 DEBUG : BROWSER_OUTPUT: 11:14:50 INFO - 2015-11-25 11:14:50,055 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 11:14:50 INFO - 2015-11-25 11:14:50,055 DEBUG : BROWSER_OUTPUT: Values: 145.0 147.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 145.0 11:14:50 INFO - 2015-11-25 11:14:50,056 DEBUG : BROWSER_OUTPUT: 11:14:50 INFO - 2015-11-25 11:14:50,056 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:14:50 INFO - 2015-11-25 11:14:50,056 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 11:14:50 INFO - 2015-11-25 11:14:50,056 DEBUG : BROWSER_OUTPUT: 11:14:50 INFO - 2015-11-25 11:14:50,056 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.90 Median:58.50 stddev:1.29 (2.2%) stddev-sans-first:1.30 11:14:50 INFO - 2015-11-25 11:14:50,056 DEBUG : BROWSER_OUTPUT: Values: 59.0 59.0 57.0 57.0 57.0 59.0 58.0 60.0 56.0 57.0 11:14:50 INFO - 2015-11-25 11:14:50,056 DEBUG : BROWSER_OUTPUT: 11:14:50 INFO - 2015-11-25 11:14:50,056 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 11:14:50 INFO - 2015-11-25 11:14:50,056 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 70.0 69.0 70.0 70.0 70.0 69.0 71.0 70.0 11:14:50 INFO - 2015-11-25 11:14:50,056 DEBUG : BROWSER_OUTPUT: 11:14:50 INFO - 2015-11-25 11:14:50,056 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:85.00 stddev:6.04 (7.1%) stddev-sans-first:6.04 11:14:50 INFO - 2015-11-25 11:14:50,057 DEBUG : BROWSER_OUTPUT: Values: 82.0 92.0 84.0 85.0 85.0 84.0 85.0 84.0 99.0 97.0 11:14:50 INFO - 2015-11-25 11:14:50,057 DEBUG : BROWSER_OUTPUT: 11:14:50 INFO - 2015-11-25 11:14:50,057 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.60 Median:120.00 stddev:3.06 (2.6%) stddev-sans-first:3.19 11:14:50 INFO - 2015-11-25 11:14:50,057 DEBUG : BROWSER_OUTPUT: Values: 117.0 114.0 120.0 122.0 115.0 115.0 122.0 120.0 120.0 121.0 11:14:50 INFO - 2015-11-25 11:14:50,057 DEBUG : BROWSER_OUTPUT: 11:14:50 INFO - 2015-11-25 11:14:50,057 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.60 Median:146.00 stddev:6.75 (4.6%) stddev-sans-first:6.58 11:14:50 INFO - 2015-11-25 11:14:50,057 DEBUG : BROWSER_OUTPUT: Values: 137.0 149.0 145.0 152.0 155.0 135.0 145.0 146.0 146.0 136.0 11:14:50 INFO - 2015-11-25 11:14:50,057 DEBUG : BROWSER_OUTPUT: 11:14:50 INFO - 2015-11-25 11:14:50,057 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:66.00 stddev:1.10 (1.7%) stddev-sans-first:1.12 11:14:50 INFO - 2015-11-25 11:14:50,057 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 66.0 66.0 66.0 66.0 65.0 64.0 63.0 64.0 11:14:50 INFO - 2015-11-25 11:14:50,057 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:14:50 INFO - 2015-11-25 11:14:50,057 DEBUG : BROWSER_OUTPUT: 11:14:51 INFO - 2015-11-25 11:14:51,893 INFO : Browser exited with error code: 0 11:14:51 INFO - 2015-11-25 11:14:51,942 INFO : Completed test kraken (00:01:16) 11:14:51 INFO - 2015-11-25 11:14:51,942 INFO : Starting test v8_7 11:14:51 INFO - 2015-11-25 11:14:51,942 DEBUG : operating with platform_type : linux_ 11:14:51 INFO - 2015-11-25 11:14:51,942 INFO : Initialising browser for v8_7 test... 11:14:51 INFO - 2015-11-25 11:14:51,948 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfOjse1/profile http://localhost:43730/getInfo.html 11:15:05 INFO - 2015-11-25 11:15:05,620 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:15:05 INFO - 2015-11-25 11:15:05,620 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:15:05 INFO - 2015-11-25 11:15:05,620 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:15:05 INFO - 2015-11-25 11:15:05,620 DEBUG : BROWSER_OUTPUT: __metrics 11:15:06 INFO - 2015-11-25 11:15:06,153 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:15:12 INFO - 2015-11-25 11:15:12,817 INFO : Browser initialized. 11:15:12 INFO - 2015-11-25 11:15:12,818 INFO : Running cycle 1/1 for v8_7 test... 11:15:12 INFO - 2015-11-25 11:15:12,818 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfOjse1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:15:24 INFO - 2015-11-25 11:15:24,490 DEBUG : BROWSER_OUTPUT: RSS: Main: 139202560 11:15:24 INFO - 2015-11-25 11:15:24,491 DEBUG : BROWSER_OUTPUT: 11:15:46 INFO - 2015-11-25 11:15:46,028 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43730/tests/v8_7/run.html (next: http://localhost:43730/tests/v8_7/run.html) 11:15:46 INFO - 2015-11-25 11:15:46,279 DEBUG : BROWSER_OUTPUT: RSS: Main: 615325696 11:15:46 INFO - 2015-11-25 11:15:46,279 DEBUG : BROWSER_OUTPUT: 11:15:46 INFO - 2015-11-25 11:15:46,280 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:15:46 INFO - 2015-11-25 11:15:46,280 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:15:46 INFO - 2015-11-25 11:15:46,280 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:15:46 INFO - 2015-11-25 11:15:46,280 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:15:46 INFO - 2015-11-25 11:15:46,280 DEBUG : BROWSER_OUTPUT: |0;Richards;165.97510373443984 11:15:46 INFO - 2015-11-25 11:15:46,280 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.9317738791423 11:15:46 INFO - 2015-11-25 11:15:46,280 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.80542986425337 11:15:46 INFO - 2015-11-25 11:15:46,281 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5128.205128205128 11:15:46 INFO - 2015-11-25 11:15:46,281 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1109.8779134295228 11:15:46 INFO - 2015-11-25 11:15:46,281 DEBUG : BROWSER_OUTPUT: |5;Earley;791.1392405063291 11:15:46 INFO - 2015-11-25 11:15:46,281 DEBUG : BROWSER_OUTPUT: |6;Boyer;12195.121951219513 11:15:46 INFO - 2015-11-25 11:15:46,281 DEBUG : BROWSER_OUTPUT: |7;RegExp;25871.79487179487 11:15:46 INFO - 2015-11-25 11:15:46,282 DEBUG : BROWSER_OUTPUT: |8;Splay;636.7088607594936 11:15:46 INFO - 2015-11-25 11:15:46,282 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4931.0344827586205 11:15:46 INFO - 2015-11-25 11:15:46,282 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:15:46 INFO - 2015-11-25 11:15:46,282 DEBUG : BROWSER_OUTPUT: __startTimestamp1448478946278__endTimestamp 11:15:46 INFO - 2015-11-25 11:15:46,282 DEBUG : BROWSER_OUTPUT: 11:15:46 INFO - 2015-11-25 11:15:46,282 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:15:46 INFO - 2015-11-25 11:15:46,283 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:15:46 INFO - 2015-11-25 11:15:46,283 DEBUG : BROWSER_OUTPUT: 11:15:46 INFO - 2015-11-25 11:15:46,283 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.98 Median:165.98 stddev:0.00 (0.0%) 11:15:46 INFO - 2015-11-25 11:15:46,283 DEBUG : BROWSER_OUTPUT: Values: 166.0 11:15:46 INFO - 2015-11-25 11:15:46,283 DEBUG : BROWSER_OUTPUT: 11:15:46 INFO - 2015-11-25 11:15:46,284 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.93 Median:194.93 stddev:0.00 (0.0%) 11:15:46 INFO - 2015-11-25 11:15:46,284 DEBUG : BROWSER_OUTPUT: Values: 194.9 11:15:46 INFO - 2015-11-25 11:15:46,284 DEBUG : BROWSER_OUTPUT: 11:15:46 INFO - 2015-11-25 11:15:46,284 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.81 Median:282.81 stddev:0.00 (0.0%) 11:15:46 INFO - 2015-11-25 11:15:46,284 DEBUG : BROWSER_OUTPUT: Values: 282.8 11:15:46 INFO - 2015-11-25 11:15:46,284 DEBUG : BROWSER_OUTPUT: 11:15:46 INFO - 2015-11-25 11:15:46,285 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5128.21 Median:5128.21 stddev:0.00 (0.0%) 11:15:46 INFO - 2015-11-25 11:15:46,285 DEBUG : BROWSER_OUTPUT: Values: 5128.2 11:15:46 INFO - 2015-11-25 11:15:46,285 DEBUG : BROWSER_OUTPUT: 11:15:46 INFO - 2015-11-25 11:15:46,285 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1109.88 Median:1109.88 stddev:0.00 (0.0%) 11:15:46 INFO - 2015-11-25 11:15:46,285 DEBUG : BROWSER_OUTPUT: Values: 1109.9 11:15:46 INFO - 2015-11-25 11:15:46,285 DEBUG : BROWSER_OUTPUT: 11:15:46 INFO - 2015-11-25 11:15:46,285 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:791.14 Median:791.14 stddev:0.00 (0.0%) 11:15:46 INFO - 2015-11-25 11:15:46,286 DEBUG : BROWSER_OUTPUT: Values: 791.1 11:15:46 INFO - 2015-11-25 11:15:46,286 DEBUG : BROWSER_OUTPUT: 11:15:46 INFO - 2015-11-25 11:15:46,286 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 11:15:46 INFO - 2015-11-25 11:15:46,286 DEBUG : BROWSER_OUTPUT: Values: 12195.1 11:15:46 INFO - 2015-11-25 11:15:46,286 DEBUG : BROWSER_OUTPUT: 11:15:46 INFO - 2015-11-25 11:15:46,286 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25871.79 Median:25871.79 stddev:0.00 (0.0%) 11:15:46 INFO - 2015-11-25 11:15:46,286 DEBUG : BROWSER_OUTPUT: Values: 25871.8 11:15:46 INFO - 2015-11-25 11:15:46,286 DEBUG : BROWSER_OUTPUT: 11:15:46 INFO - 2015-11-25 11:15:46,286 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:636.71 Median:636.71 stddev:0.00 (0.0%) 11:15:46 INFO - 2015-11-25 11:15:46,287 DEBUG : BROWSER_OUTPUT: Values: 636.7 11:15:46 INFO - 2015-11-25 11:15:46,287 DEBUG : BROWSER_OUTPUT: 11:15:46 INFO - 2015-11-25 11:15:46,287 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4931.03 Median:4931.03 stddev:0.00 (0.0%) 11:15:46 INFO - 2015-11-25 11:15:46,288 DEBUG : BROWSER_OUTPUT: Values: 4931.0 11:15:46 INFO - 2015-11-25 11:15:46,288 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:15:46 INFO - 2015-11-25 11:15:46,288 DEBUG : BROWSER_OUTPUT: 11:15:47 INFO - 2015-11-25 11:15:47,953 INFO : Browser exited with error code: 0 11:15:47 INFO - 2015-11-25 11:15:47,970 INFO : Completed test v8_7 (00:00:56) 11:15:48 INFO - 2015-11-25 11:15:48,339 INFO : Completed test suite (00:22:07) 11:15:48 INFO - 2015-11-25 11:15:48,339 DEBUG : Working with test: dromaeo_css 11:15:48 INFO - 2015-11-25 11:15:48,339 DEBUG : Generating results file: dromaeo_css 11:15:48 INFO - 2015-11-25 11:15:48,340 DEBUG : Working with test: kraken 11:15:48 INFO - 2015-11-25 11:15:48,340 DEBUG : Generating results file: kraken 11:15:48 INFO - 2015-11-25 11:15:48,340 INFO : javascript benchmark 11:15:48 INFO - 2015-11-25 11:15:48,341 DEBUG : Working with test: v8_7 11:15:48 INFO - 2015-11-25 11:15:48,341 DEBUG : Generating results file: v8_7 11:15:48 INFO - 2015-11-25 11:15:48,341 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:15:48 INFO - 2015-11-25 11:15:48,484 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 11:15:48 INFO - 2015-11-25 11:15:48,484 DEBUG : process_Request line: dromaeo_css 6907.32 graph.html#tests=[[72,64,35]] 11:15:48 INFO - 2015-11-25 11:15:48,484 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:15:48 INFO - 2015-11-25 11:15:48,523 DEBUG : process_Request line: kraken 1496.90 graph.html#tests=[[232,64,35]] 11:15:48 INFO - 2015-11-25 11:15:48,523 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:15:48 INFO - 2015-11-25 11:15:48,562 DEBUG : process_Request line: v8_7 20815.08 graph.html#tests=[[230,64,35]] 11:15:48 INFO - 2015-11-25 11:15:48,563 INFO : javascript benchmark 11:15:48 INFO - 2015-11-25 11:15:48,566 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3209.8555564999574, 3241.8541165647543, 3278.442664746994, 3283.950740738889, 3296.3572103439833, 5284.577233821295, 5353.116735738608, 5429.7285135743205, 5480.780768769245, 5499.560035197184, 5369.275147855038, 5439.292891924044, 5441.891162176754, 5482.369527504338, 5581.748821303041, 4992.700437973734, 5034.270030845525, 5034.622403319748, 5063.189889617662, 5069.112905241586, 4933.876653083666, 5122.206058060988, 5149.356330458692, 5156.3296771419855, 5211.166213405856, 4925.556699896991, 4970.378702662168, 4985.102681517325, 5015.0972824891505, 5057.519535644108, 4936.062148191868, 4936.259561065833, 4952.975235123801, 4969.13040217964, 4996.075725990703, 4884.902301953941, 4905.411350637911, 4929.531694489017, 4936.975315123437, 4997.475265097149, 5133.794648214067, 5257.211418287249, 5281.234221037967, 5383.057964856134, 5402.432744561843, 5910.1430292607765, 5921.467067963904, 5926.822195334147, 5929.940700592982, 5941.584089113764, 5838.678872662002, 5951.434613711691, 5960.105984102376, 5977.880442391128, 5982.461578457916, 5442.0476416627325, 5445.863853403657, 5518.586106042023, 5585.804496842591, 5631.774729010794, 6011.879762404727, 6017.578769486182, 6018.879622407528, 6065.6663883486835, 6068.726907289182, 5658.122990936329, 5845.298564172326, 5845.795397161079, 5848.356680765112, 5890.263717035371, 5824.271966004249, 5826.82519524415, 5858.326292476419, 5882.205902203234, 5934.673592952429, 5880.588358814842, 5937.732802023919, 5938.049912014057, 5951.672658003765, 5953.851153721192, 5717.256756621696, 5814.79648212319, 5925.318588362307, 5936.257967754031, 5938.851528711817, 4501.099780043939, 4561.110583436264, 4580.358749775034, 4583.083383323282, 4595.2188128018315, 4039.939400908989, 4049.5950404959267, 4058.3912413138264, 4079.918401631951, 4092.0588264699286, 5432.619716619799, 5611.859703507445, 5631.549476041907, 5631.8592035199445, 5632.3804381518, 5790.218320526675, 5853.560982926298, 5864.325602555676, 5942.227510423617, 5985.670788106696, 5600.383957764642, 5616.410276920946, 5636.915446268309, 5646.576506761927, 5654.37801841797, 5050.090983622909, 5197.350331208599, 5207.192885102815, 5207.192885102815, 5254.395744489356, 5988.580799344091, 6021.0, 6097.409717157628, 6113.689499947685, 6122.84634471468, 5980.162777211281, 6073.908891366545, 6073.969630151821, 6075.817725468243, 6078.149059131637, 5839.299284085937, 5882.323532793784, 6184.567080304336, 6194.4115309045565, 6198.81403557894, 5758.510526605285, 5798.449147330997, 5851.912221316598, 5891.1752354671235, 5892.027815410581, 5849.64902105858, 5992.67040312787, 6013.30846952606, 6017.699115044318, 6021.036634138517, 5633.0423827948525, 5835.0, 5856.94143058564, 5858.5898987070495, 5885.234919460443, 5650.773969041193, 5780.710964451677, 5834.854128646818, 5879.647221166572, 5910.940890591039, 5664.320281566238, 5668.858278542904, 5674.06377947634, 5682.9147562785765, 5683.7442315095095, 5642.88714225705, 5700.2304688868135, 5751.827445176651, 5759.596828221985, 5825.300963884361, 5661.971690141523, 5747.885042299215, 5756.625819321731, 5790.507806836466, 5804.94195058044], "unit": "ms", "name": "dojo.html", "value": 5446.60969934801}, {"lowerIsBetter": false, "replicates": [554.3189488044804, 575.2033433694334, 586.8151532267339, 601.0323379359232, 621.7761605821903, 30685.539716904237, 39069.21861562774, 39094.60905390949, 39114.608853911486, 39125.41311880324, 41988.160236795244, 42377.36433953493, 42453.0, 42482.36276455856, 42487.15025699484, 7570.6971721131085, 7705.73029943952, 8759.080296568849, 8923.10768923109, 8929.55352232389, 10238.641647542338, 10431.895681043206, 10442.425666588335, 10444.477776111202, 10451.16390688743, 10448.16414686827, 10579.788404231911, 10584.735381615445, 10584.894151058468, 10591.629292974747, 7721.112072111723, 7920.0495940486935, 10239.744006399826, 10413.583456661763, 10486.475676216234, 9929.156021738161, 10057.849132263022, 10061.0, 10062.19502439803, 10064.446455444948, 33065.338693226244, 36482.0, 37091.629083709086, 37108.515659373596, 37119.25761484755, 2801.271669365959, 3289.671032896691, 3754.0, 3873.3996230584303, 3952.664023558001, 30209.244768880955, 30234.84882575573, 30831.84584077088, 30911.536326955113, 31413.842930785428, 3628.7459877808565, 3707.477895998812, 3741.7567858089137, 3781.867634632802, 3789.77261364319, 261798.0, 262864.0, 263591.0, 264144.0, 264475.9999999981, 57725.11374431261, 58016.8396632065, 58082.54793630108, 58157.0, 58161.0, 60701.69649151726, 60821.0, 60881.0, 60918.0, 60922.69538652367, 16062.598435039217, 16315.59211019734, 16348.0, 16351.42770003068, 16355.182240887909, 11794.29234245948, 11846.703832404259, 11846.88153118475, 11848.289102653696, 11857.0, 18112.051415113023, 19394.612107757766, 19418.5145371364, 19420.126094325788, 19431.514212144808, 7068.409607838195, 7215.113954418274, 7286.672099755524, 7304.2695730427595, 7358.8528229435115, 976.5263847034183, 1019.8215312320315, 1021.39737554843, 1041.1722680469045, 1060.4591658254346, 24973.87513062423, 26252.949882004887, 27042.32394190161, 27321.863390683317, 27707.0, 1025.348903446302, 1072.6245813965206, 1086.2070688397514, 1091.80102300261, 1158.988410115905, 14131.929340353232, 14559.563213103624, 14694.11835289886, 14739.484118055816, 14759.704805903822, 323642.0, 328319.0, 328407.0, 328587.0, 329778.0, 49086.509134908905, 49563.752181239586, 51391.74304128456, 52138.0, 52228.47771522236, 1324.291504045331, 1360.5782207515701, 1362.3869258833565, 1374.6425929258464, 1380.8412032615977, 24508.544552129486, 26328.0, 27117.72882271152, 28068.85965570159, 28508.714912850606, 44336.77831610821, 44754.55245447504, 44754.77622611996, 44850.551494484636, 44852.32721509114, 218219.0, 221109.0, 221423.0, 221677.0, 221950.0, 30353.0, 31266.374672506878, 31395.84302078475, 31554.368912622078, 31575.0, 43332.0, 43566.0, 43686.126277474905, 44243.11513769771, 44698.3295250565, 36471.0, 36759.26481470409, 36998.8150059248, 39017.609823901395, 40632.0, 35080.878393201936, 35797.46303805393, 36311.45532816957, 36561.63438365582, 36816.26367472689, 35296.11759706028, 35755.0, 35774.8211258942, 35837.283254335285, 36118.27763444664, 29873.850630746707, 32308.0, 32552.51171232386, 32818.67181328252, 33569.0, 23949.760502394754, 24052.36976165217, 24071.0, 24156.51686966216, 24488.0], "unit": "ms", "name": "ext.html", "value": 18483.454422374976}, {"lowerIsBetter": false, "replicates": [345.89104432103886, 358.9443636236381, 361.44698611124977, 361.72147446466204, 363.07053941908725, 14036.368363423644, 14188.148711077343, 16725.414610488635, 16966.066866322348, 17628.823711762896, 10928.125749940005, 11227.157963152755, 16653.0, 17893.642127157447, 17906.552336191602, 4749.382580264561, 4907.190313598252, 4907.901841963158, 4908.0429316283335, 4915.483874193212, 3733.906652333686, 3847.057470919615, 4963.652544321899, 4989.925151122736, 5354.41101478837, 5460.262864513299, 5493.038718224295, 5496.615236933416, 5503.972480137593, 5511.9724401377935, 5295.735213239342, 5426.375966763833, 5449.3188351456065, 5455.18172274158, 5467.343918729738, 5176.534111929906, 5227.6079294052715, 5229.137192363255, 5250.921236181461, 5268.367795864482, 12380.380980950917, 13197.20816750998, 13285.800712989312, 13300.268485233308, 13300.800487992688, 2010.9844528513154, 2057.5781964697203, 2059.9279025234046, 2179.0194412514434, 2229.2866282789514, 9559.713208603753, 9720.95139524305, 9841.704748857546, 12849.935750321281, 13009.869901300961, 1824.9817501824944, 1845.0036980030902, 1845.1604519943394, 1861.8882867028021, 1880.7931127575955, 62171.68914155445, 65168.348316516705, 66031.66984165048, 66099.66950165266, 67219.0, 9670.613175472903, 9783.315167938319, 9891.10527154006, 9906.900930990741, 9935.503224838729, 12863.035272354424, 12871.48514059446, 12897.677558060936, 12898.742025159632, 12903.290319032543, 7302.2697730226555, 7348.742794002291, 7350.63246837656, 7445.813854653568, 7461.179270280265, 7259.709611615582, 7296.051513303237, 7323.12122545298, 7328.3404493595835, 7366.337029667356, 3984.86052988144, 4048.8582899598373, 4052.8378864845668, 4076.694247931417, 4076.8369265229057, 1572.8112626484667, 1651.3724784581782, 1677.6812405642888, 1690.9492715218564, 1751.8773685841868, 424.14111424365905, 424.7027081043282, 428.8563331284055, 438.91221755648996, 929.8512238041881, 9725.124738773544, 9816.312858099864, 11042.613508527164, 11094.167937404727, 11193.552257909592, 421.68584404618144, 432.55014784623637, 439.29054576858783, 458.6399676254191, 459.99080018399445, 4554.863354099382, 5736.397678243808, 5818.359980402152, 5998.220231369894, 6006.309274433409, 498659.0, 527327.0, 534308.0, 539367.0, 554747.0, 78313.60843195747, 82445.58777206075, 82521.0, 82690.58654706688, 84680.15319846846, 1109.8113320735495, 1120.4845770945456, 1127.2278489235064, 1135.1940122513108, 1137.766757814646, 15121.86586006076, 15299.541013769605, 15462.613434664223, 15466.458673946358, 15617.843821561639, 35555.82222088873, 35932.46101308535, 36088.45867312045, 36132.63867361293, 36333.45499817452, 44924.77537612422, 45351.546484536055, 45752.771236143606, 46295.0, 46347.53652463432, 9363.85954210701, 9443.244540436886, 9448.385854919408, 9545.0, 9569.712908612753, 11360.829587556358, 11402.82895756581, 11519.13606479534, 11530.423478826193, 11546.538138474367, 13941.233232171922, 14082.366293517021, 14199.64500887486, 14485.710285794436, 14788.334524946618, 13742.862571374559, 13921.373538191008, 14157.504487342894, 14384.42462301538, 14395.712085758018, 14504.782428263374, 14514.419423222953, 14623.707525849637, 14664.780028299798, 15140.167290799112, 9047.457152570867, 9071.866016747907, 9078.500682462529, 9265.814683706423, 9473.289503287418, 10031.147352475122, 12487.687807804878, 13958.441662333798, 14239.430422783387, 14302.856971430569], "unit": "ms", "name": "jquery.html", "value": 8008.788691425873}, {"lowerIsBetter": false, "replicates": [1335.5659410691528, 1696.8642508599314, 1740.7649967254424, 1759.0940665557237, 1773.618671985523, 6914.44684425246, 7767.33977611903, 7790.805229869256, 7823.530588164707, 7847.293743563078, 7576.507527010741, 7804.2585954334245, 7834.138244793068, 7837.725679601215, 7839.568823714693, 2258.8870556472193, 2297.5519773644146, 2297.8621282723007, 2299.5975704251773, 2300.1029598456616, 2278.931632051033, 2317.281642690763, 2341.0869760793303, 2349.718033835942, 2349.9295021149305, 2262.864228146308, 2283.8858057097077, 2296.322584837477, 2300.49389134391, 2317.8493397929083, 2232.3191426614876, 2281.0761641535123, 2301.551197516485, 2306.792388685018, 2307.873066981307, 2307.9884600577057, 2320.2227253869974, 2325.9184479217247, 2328.1734984080745, 2329.1032952313312, 6762.154730658668, 6982.895256571155, 7809.414293927978, 7891.644875980594, 7906.52560846351, 4271.444712187426, 4297.828086876521, 4667.253239481701, 4762.214234651278, 4772.093302272592, 3096.2568983444035, 3123.515855042472, 3137.0902438293097, 3140.356226973465, 3251.089694885436, 990.1929927109455, 998.1964518562554, 1005.5173516712019, 1025.2874252394588, 1094.6332978452228, 10516.631917882914, 10675.733106672318, 10687.03816656497, 10699.572017119306, 10713.785724285548, 4134.813933373005, 4200.432941552913, 4268.87193384199, 4277.978610106929, 4279.186954478639, 8218.301444377175, 8238.340932725368, 8244.422890397735, 8248.958755206186, 8259.42184047123, 4691.296305554194, 4699.459562150328, 4703.0593881223895, 4704.458987216445, 4735.005648813719, 4279.272523670983, 4281.785910704452, 4297.226499230106, 4323.610875021263, 4337.652987760972, 3478.599961004517, 3531.205478767257, 3543.7342199335153, 3564.108972756811, 3574.070741607201, 1091.1325496230515, 1104.9337039777638, 1111.7943180511631, 1119.7480566872389, 1120.4509790202742, 1302.7329397473495, 1307.6992291772945, 1316.4734106357535, 1348.871857173567, 1363.1820907455647, 7045.8238544035785, 7223.602701851343, 7277.3086556777025, 7287.890681639779, 7302.6713797878165, 462.06431975249717, 471.56851480894596, 473.6258355898801, 474.62978876476404, 478.5573344656179, 5558.305211848519, 5716.485516303469, 5767.826965191051, 5793.102069179284, 5795.681237531892, 8575.442596231225, 9189.770255743526, 9333.673321433716, 9334.486603236886, 9356.157945784777, 9047.773805654911, 9163.77090572741, 9198.67804626835, 9227.76930576741, 9309.53452327381, 7075.0, 7221.277872212841, 7237.421006319481, 7245.8550828983125, 7281.854362912712, 7103.964480177566, 7159.427245820218, 7185.0, 7188.245234250328, 7195.46034047459, 8037.156098609796, 8074.475159114639, 8086.43394962347, 8179.509229446252, 8287.50274983503, 8238.546879921661, 8378.162183781573, 8434.367422443218, 8463.703770368254, 8497.490150590984, 7222.674979625825, 7284.198738138694, 7289.380402665621, 7290.234525374759, 7291.34377905991, 7482.064741907262, 7551.773446796605, 7605.619719013916, 7646.541207527566, 7675.731349402968, 7116.039334689751, 7174.426045916419, 7176.641167941686, 7281.417486600953, 7355.926440735524, 6999.650017499002, 7003.3346832050875, 7077.115360579927, 7163.570185788869, 7250.89123663156, 7147.356737893615, 7178.102737157856, 7195.388391986739, 7202.207757146814, 7206.927930720625, 6534.934650653433, 6537.8692426152165, 6578.473722102316, 6650.700718467584, 6677.599344039373, 6560.147180866456, 6568.343165683394, 6575.934240657532, 6594.769183078569, 6613.867722645617], "unit": "ms", "name": "mootools.html", "value": 4396.353961468286}, {"lowerIsBetter": false, "replicates": [337.2698108594892, 340.5130663151695, 340.53006850546245, 342.2316898562726, 347.7391956032974, 5955.315138759033, 6038.547108966829, 6156.907646385308, 6162.691865406734, 6166.0, 5864.208331875196, 5999.250093738283, 6061.515078793697, 6067.9696601516935, 6073.301570319414, 4657.813687452514, 4693.624510039197, 4694.225452800284, 4710.646701497384, 4710.97644511777, 4436.090601426716, 4507.391502147201, 4537.024539723959, 4544.091181763644, 4704.176769065417, 4507.684462087655, 4555.863324100283, 4622.86131416058, 4666.603338716213, 4671.906561868761, 4641.327007583882, 4642.7910744016435, 4658.58072773452, 4666.160091183586, 4668.579827815496, 4096.32410652242, 4101.876943691694, 4107.815148318333, 4119.032027473541, 4121.29937910556, 5665.405132461074, 5760.135979603051, 5768.826935191909, 5782.421757824226, 5786.594938354317, 5443.265159203496, 5457.945420545783, 5464.890702185974, 5469.042917489423, 5474.7262636868, 6181.3818618138275, 6469.385408386196, 6472.288048314682, 6472.644004579746, 6484.6433446160445, 4431.379606855043, 4471.418715566988, 4477.977610111961, 4487.596116349544, 4503.324501324795, 6612.371824676648, 6702.463802895757, 6703.564268322543, 6716.865662686719, 6716.865662686768, 4605.585497305258, 4621.168189725814, 4625.838095666635, 4626.83806066786, 4635.605973492224, 4516.751578663205, 4646.744429056367, 4659.6505262105475, 4689.320048592935, 4699.459562150328, 5378.273933019071, 5380.650257733235, 5386.245925570423, 5388.865278367994, 5392.595555333366, 6544.476441884638, 6555.147830781968, 6569.146011018537, 6569.146011018537, 6572.638504882278, 1620.3599578166793, 1643.802743670767, 1645.045873393429, 1645.2020769926576, 1647.3822316631263, 1069.5133714160038, 1086.2721976275914, 1087.4345340423095, 1106.5131342209402, 1112.7551938573502, 6189.6286222826775, 6264.812055638338, 6282.842928926813, 6283.057541368831, 6283.59156654816, 6678.232003319583, 6679.298673639295, 6687.732490700415, 6687.866242675216, 6690.59856408617, 6233.846738353419, 6265.561410701298, 6267.2792628847355, 6272.623642581369, 6273.560850740404, 3648.087978005499, 3681.7606855554304, 3685.594584595692, 3686.2811751708696, 3687.6681098701247, 6942.097527321517, 6963.651817409211, 6992.16094068715, 7019.3682568569075, 7020.122484689414, 6763.266200715992, 6912.585244885222, 6938.375546200866, 6938.757143499954, 6957.61733104674, 6975.476839237078, 6979.4765392595755, 6987.720491180397, 6993.0908981832035, 6998.230194678683, 6386.93613063882, 6548.214214294315, 6647.434968027772, 6780.762673306411, 6790.966045169743, 6619.205695316593, 6665.666716664245, 6691.59850408977, 6695.163104611924, 6712.194536655633, 6944.062551555476, 6947.513674042971, 6953.304669533006, 6958.652067396712, 6966.12923384577, 4556.635469162526, 4579.473360563445, 4604.194266003503, 4680.180968330596, 4685.461171965268, 6609.438197753245, 6680.5991640501725, 6683.665816709048, 6696.397324240842, 6702.731890724316, 6517.608943463408, 6524.869502609827, 6532.05285233648, 6532.150820393318, 6534.313897040933, 6422.42198202164, 6520.315366886409, 6523.151990241238, 6572.901406479003, 6585.769498067544, 6416.294207637249, 6424.967875160594, 6448.45188158993, 6457.709403076967, 6465.806025819233, 6611.471082313499, 6612.5040621952585, 6613.66931653425, 6619.635920024252, 6622.271550129578, 6278.340774218824, 6444.8388790280615, 6462.709178086903, 6464.450521705519, 6469.417752402118], "unit": "ms", "name": "prototype.html", "value": 4898.7396000937915}, {"lowerIsBetter": false, "replicates": [822.169608695218, 834.8038211020407, 847.262881293275, 848.6011574559955, 858.3948316436905, 13569.864301356984, 13576.321183940789, 13943.0, 13943.721125577482, 13947.651308717288, 13203.141795783267, 13498.527551535673, 13517.391717372717, 13522.391492382842, 13522.594322170326, 704.0, 838.4508147163602, 856.25933567464, 857.0315543435909, 857.8927634045745, 705.5696025424512, 712.3837880233586, 843.7932706486889, 854.9487030778142, 860.2129051917519, 886.7251152142824, 886.8669699545055, 895.5432729308067, 895.9686410975618, 896.3277541843618, 721.2571051816637, 726.2664708644254, 886.9866951995725, 888.1074520107284, 889.6797153024905, 536.4608568388784, 536.8577327008346, 537.9515843574057, 648.0506058624092, 657.2572992518424, 13254.53609123676, 13457.528986485426, 13466.461341546326, 13476.326183690777, 13512.189268643913, 12382.442790074378, 12908.741825163444, 12952.611421657271, 12981.675458113528, 13275.601731948056, 10239.948800256025, 10474.895251047468, 10498.160147188206, 10576.206784491116, 10583.947080264626, 3517.26137511123, 3589.174489867345, 3590.8025058621765, 3623.9637603624155, 3689.114612493009, 47972.520274797156, 48128.75935620334, 48162.27756583654, 48205.75897120527, 48223.0, 10486.947565262277, 10516.421596812248, 10519.368837869752, 10639.574417023232, 10666.36001839892, 19179.61640767205, 19189.32837350686, 19200.039998000324, 19235.018572121342, 19275.0, 7527.962360188164, 7530.359919406802, 7581.734639287599, 7594.392448604099, 7602.277783610548, 4220.894477638084, 4336.674749393808, 4338.522762496123, 4396.912061758747, 4453.1316393303, 2846.7722582193373, 2855.1006432973545, 2862.0269108502794, 2876.3240638449947, 2883.5818806272973, 507.3404574053715, 510.22445882258756, 510.4283202812873, 517.7928828468642, 521.2181727408887, 560.8653923058437, 583.151514546334, 643.080395035095, 648.8053583924898, 651.7230177174682, 8139.918600813916, 8216.630251638571, 8234.258916697527, 8596.656133754705, 8622.525761083201, 538.8652836790802, 594.8156071617813, 663.7776344924505, 669.9162604674416, 676.9570779346867, 3744.927190260203, 3758.9248215035545, 4034.576369481221, 4165.083681590046, 4208.179405016053, 56506.15240771392, 56615.43384566101, 56672.0, 56745.14882276769, 56751.0, 48839.0, 49788.25317620239, 50696.0, 51418.0, 51481.0, 47161.52838471571, 47217.76391118091, 47822.0, 47913.0, 48400.0, 8259.339252859876, 8599.742007739778, 8732.607032683418, 8780.473171609723, 8942.105789421006, 34603.307933840675, 35125.29749405049, 35329.0, 35410.645893540735, 36329.27341453103, 45777.31334029925, 46394.0, 46632.30051549162, 47248.763756181, 47378.52621473741, 9721.270904682318, 9738.367006144577, 10168.491575421347, 10243.180545556486, 10489.108425783588, 11301.6791836123, 11414.429278536207, 11695.473703683525, 11825.704357391134, 11883.524659013543, 10817.188710846875, 11337.149713771336, 11411.885881141083, 11503.367314797431, 11647.475863586329, 10520.263581549218, 10768.246222764332, 10787.406692631981, 10896.019358257794, 11468.713282168013, 10473.738156546147, 10582.153427725609, 10711.785764284516, 10916.563337466412, 10919.727006824893, 9266.675666351646, 9311.833519019587, 9367.765805854908, 9641.469719165514, 9683.806323873343, 8721.258693010912, 8801.471911685063, 9187.219086377732, 9251.583678734338, 9454.574544145393], "unit": "ms", "name": "yui.html", "value": 6254.1289587277915}], "name": "dromaeo_css", "value": 6907.3191915958205}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 104.0, 110.0, 110.0, 110.0, 97.0, 109.0, 110.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 107.8}, {"lowerIsBetter": true, "replicates": [147.0, 123.0, 159.0, 159.0, 128.0, 159.0, 151.0, 131.0, 172.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 145.3}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 160.0, 160.0, 161.0, 159.0, 162.0, 161.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 84.0, 94.0, 72.0, 72.0, 73.0, 125.0, 88.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 82.1}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 135.0, 92.0, 94.0, 93.0, 140.0, 92.0, 93.0, 142.0], "unit": "ms", "name": "audio-oscillator", "value": 106.9}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 57.0, 57.0, 57.0, 59.0, 58.0, 60.0, 56.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 57.9}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 69.0, 70.0, 70.0, 70.0, 69.0, 71.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.9}, {"lowerIsBetter": true, "replicates": [82.0, 92.0, 84.0, 85.0, 85.0, 84.0, 85.0, 84.0, 99.0, 97.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.7}, {"lowerIsBetter": true, "replicates": [117.0, 114.0, 120.0, 122.0, 115.0, 115.0, 122.0, 120.0, 120.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.6}, {"lowerIsBetter": true, "replicates": [137.0, 149.0, 145.0, 152.0, 155.0, 135.0, 145.0, 146.0, 146.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.6}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 64.0, 63.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.1}], "name": "kraken", "value": 1496.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.97510373443984], "unit": "score", "name": "Richards", "value": 212.69455}, {"lowerIsBetter": false, "replicates": [194.9317738791423], "unit": "score", "name": "DeltaBlue", "value": 339.18533999999994}, {"lowerIsBetter": false, "replicates": [282.80542986425337], "unit": "score", "name": "Encrypt", "value": 941.2160160000003}, {"lowerIsBetter": false, "replicates": [5128.205128205128], "unit": "score", "name": "Decrypt", "value": 51.90529499999997}, {"lowerIsBetter": false, "replicates": [1109.8779134295228], "unit": "score", "name": "RayTrace", "value": 666.7300889999998}, {"lowerIsBetter": false, "replicates": [791.1392405063291], "unit": "score", "name": "Earley", "value": 842.4092320000002}, {"lowerIsBetter": false, "replicates": [12195.121951219513], "unit": "score", "name": "Boyer", "value": 54.64996600000001}, {"lowerIsBetter": false, "replicates": [25871.79487179487], "unit": "score", "name": "RegExp", "value": 35.21151139742318}, {"lowerIsBetter": false, "replicates": [636.7088607594936], "unit": "score", "name": "Splay", "value": 127.98785288270379}, {"lowerIsBetter": false, "replicates": [4931.0344827586205], "unit": "score", "name": "NavierStokes", "value": 300.95104895104873}], "name": "v8_7", "value": 20815.077931709005}]} 11:15:48 INFO - RETURN: dromaeo_css: 6907.32 11:15:48 INFO - RETURN: kraken: 1496.90 11:15:48 INFO - RETURN: v8_7: 20815.08 11:15:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20815.08"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1496.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6907.32"}}} 11:15:48 INFO - Return code: 0 11:15:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:15:48 INFO - # TBPL SUCCESS # 11:15:48 INFO - Running post-action listener: _resource_record_post_action 11:15:48 INFO - Running post-run listener: _resource_record_post_run 11:15:49 INFO - Total resource usage - Wall time: 1342s; CPU: 14.0%; Read bytes: 20480; Write bytes: 507928576; Read time: 3812; Write time: 7448848 11:15:49 INFO - install - Wall time: 15s; CPU: 25.0%; Read bytes: 0; Write bytes: 67227648; Read time: 0; Write time: 271664 11:15:49 INFO - run-tests - Wall time: 1328s; CPU: 13.0%; Read bytes: 20480; Write bytes: 440700928; Read time: 3812; Write time: 7177184 11:15:49 INFO - Running post-run listener: _upload_blobber_files 11:15:49 INFO - Blob upload gear active. 11:15:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:15:49 INFO - Copying logs to upload dir... 11:15:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1389.294068 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 9 secs) (at 2015-11-25 11:15:49.866165) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 11:15:49.872606) ========= 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=256b35f542ca8bede9e27f1f00000291-1448477442.706514-598726958 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.009975 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:15:49.924645) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 11:15:49.925037) ========= 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=256b35f542ca8bede9e27f1f00000291-1448477442.706514-598726958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 11:15:49.975086) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 11:15:49.975428) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 11:15:49.975744) ========= ========= Total master_lag: 0.18 =========