builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-044 starttime: 1453528814.13 results: success (0) buildid: 20160122193307 builduid: 74112e7b856b448cbafce44de131548f revision: c49f59a5b8288c9cbb782b8beedb9b12b7171c67 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 22:00:14.130646) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 22:00:14.131184) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 22:00:14.131531) ========= 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=574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006460 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 22:00:14.205738) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 22:00:14.206086) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 22:00:14.321800) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 22:00:14.322096) ========= 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=574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004632 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 22:00:14.381057) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 22:00:14.381388) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 22:00:14.381776) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 22:00:14.382127) ========= 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=574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-22 22:00:14-- 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% 221M=0s 2016-01-22 22:00:15 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.225422 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 22:00:14.621989) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 22:00:14.622330) ========= 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=574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017301 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 22:00:14.672866) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 22:00:14.673383) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c49f59a5b8288c9cbb782b8beedb9b12b7171c67 --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/mozilla-inbound --rev c49f59a5b8288c9cbb782b8beedb9b12b7171c67 --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=574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-22 22:00:15,166 truncating revision to first 12 chars 2016-01-22 22:00:15,166 Setting DEBUG logging. 2016-01-22 22:00:15,166 attempt 1/10 2016-01-22 22:00:15,166 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c49f59a5b828?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-22 22:00:15,397 unpacking tar archive at: mozilla-inbound-c49f59a5b828/testing/mozharness/ program finished with exit code 0 elapsedTime=0.496069 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 22:00:15.187142) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 22:00:15.187537) ========= echo c49f59a5b8288c9cbb782b8beedb9b12b7171c67 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c49f59a5b8288c9cbb782b8beedb9b12b7171c67'] 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=574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c49f59a5b8288c9cbb782b8beedb9b12b7171c67 program finished with exit code 0 elapsedTime=0.004631 script_repo_revision: 'c49f59a5b8288c9cbb782b8beedb9b12b7171c67' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 22:00:15.239038) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 22:00:15.239375) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 22:00:15.270916) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-22 22:00:15.271241) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:00:15 INFO - MultiFileLogger online at 20160122 22:00:15 in /builds/slave/test-pgo 22:00:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:00:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:00:15 INFO - {'append_to_log': False, 22:00:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:00:15 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:00:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:00:15 INFO - 'branch': 'Mozilla-Inbound', 22:00:15 INFO - 'buildbot_json_path': 'buildprops.json', 22:00:15 INFO - 'config_files': ('talos/linux_config.py',), 22:00:15 INFO - 'default_actions': ('clobber', 22:00:15 INFO - 'read-buildbot-config', 22:00:15 INFO - 'download-and-extract', 22:00:15 INFO - 'populate-webroot', 22:00:15 INFO - 'create-virtualenv', 22:00:15 INFO - 'install', 22:00:15 INFO - 'run-tests'), 22:00:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:00:15 INFO - 'download_minidump_stackwalk': True, 22:00:15 INFO - 'download_symbols': 'ondemand', 22:00:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:00:15 INFO - 'tooltool.py': '/tools/tooltool.py', 22:00:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:00:15 INFO - '/tools/misc-python/virtualenv.py')}, 22:00:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:00:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:00:15 INFO - 'installer_path': 'installer.exe', 22:00:15 INFO - 'log_level': 'info', 22:00:15 INFO - 'log_name': 'talos', 22:00:15 INFO - 'log_to_console': True, 22:00:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:00:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:00:15 INFO - 'opt_config_files': (), 22:00:15 INFO - 'pip_index': False, 22:00:15 INFO - 'sps_profile': False, 22:00:15 INFO - 'sps_profile_interval': 0, 22:00:15 INFO - 'suite': 'dromaeojs-e10s', 22:00:15 INFO - 'system_bits': '32', 22:00:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:00:15 INFO - 'title': 'talos-linux64-ix-044', 22:00:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:00:15 INFO - 'use_talos_json': True, 22:00:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:00:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:00:15 INFO - 'work_dir': 'build'} 22:00:15 INFO - ##### 22:00:15 INFO - ##### Running clobber step. 22:00:15 INFO - ##### 22:00:15 INFO - Running pre-action listener: _resource_record_pre_action 22:00:15 INFO - Running main action method: clobber 22:00:15 INFO - rmtree: /builds/slave/test-pgo/build 22:00:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:00:16 INFO - Running post-action listener: _resource_record_post_action 22:00:16 INFO - ##### 22:00:16 INFO - ##### Running read-buildbot-config step. 22:00:16 INFO - ##### 22:00:16 INFO - Running pre-action listener: _resource_record_pre_action 22:00:16 INFO - Running main action method: read_buildbot_config 22:00:16 INFO - Using buildbot properties: 22:00:16 INFO - { 22:00:16 INFO - "project": "", 22:00:16 INFO - "product": "firefox", 22:00:16 INFO - "script_repo_revision": "production", 22:00:16 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 22:00:16 INFO - "repository": "", 22:00:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 22:00:16 INFO - "buildid": "20160122193307", 22:00:16 INFO - "pgo_build": "True", 22:00:16 INFO - "basedir": "/builds/slave/test-pgo", 22:00:16 INFO - "buildnumber": 332, 22:00:16 INFO - "slavename": "talos-linux64-ix-044", 22:00:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:00:16 INFO - "platform": "ubuntu64_hw", 22:00:16 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:00:16 INFO - "branch": "mozilla-inbound", 22:00:16 INFO - "repo_path": "integration/mozilla-inbound", 22:00:16 INFO - "revision": "c49f59a5b8288c9cbb782b8beedb9b12b7171c67", 22:00:16 INFO - "stage_platform": "linux64-pgo", 22:00:16 INFO - "builduid": "74112e7b856b448cbafce44de131548f", 22:00:16 INFO - "slavebuilddir": "test" 22:00:16 INFO - } 22:00:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:00:16 INFO - Running post-action listener: _resource_record_post_action 22:00:16 INFO - ##### 22:00:16 INFO - ##### Running download-and-extract step. 22:00:16 INFO - ##### 22:00:16 INFO - Running pre-action listener: _resource_record_pre_action 22:00:16 INFO - Running main action method: download_and_extract 22:00:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:00: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')]} 22:00:16 INFO - https://queue.taskcluster.net/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:00:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/test_packages.json 22:00:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/test_packages.json 22:00:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:00:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:00:26 INFO - Downloaded 1448 bytes. 22:00:26 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:00:26 INFO - Using the following test package requirements: 22:00:26 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:00:26 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:00:26 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:00:26 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:26 INFO - u'jsshell-linux-x86_64.zip'], 22:00:26 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:00:26 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:00:26 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:00:26 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:00:26 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:00:26 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:00:26 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:00:26 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:26 INFO - https://queue.taskcluster.net/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:00:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:00:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:00:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:00:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:00:31 INFO - Downloaded 22490737 bytes. 22:00:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:00:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:00:32 INFO - Return code: 0 22:00:32 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:00:32 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')]} 22:00:32 INFO - https://queue.taskcluster.net/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:00:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:00:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:00:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:00:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:00:35 INFO - Downloaded 22490737 bytes. 22:00:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:00:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:00:36 INFO - Return code: 0 22:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:36 INFO - https://queue.taskcluster.net/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:00:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:00:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:00:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:00:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:00:37 INFO - Downloaded 10706572 bytes. 22:00:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:00:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 22:00:37 INFO - Return code: 0 22:00:37 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')]} 22:00:37 INFO - https://queue.taskcluster.net/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:00:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:00:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:00:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:00:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:00:38 INFO - Downloaded 55968903 bytes. 22:00:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:00:38 INFO - mkdir: /builds/slave/test-pgo/properties 22:00:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:00:38 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:00:38 INFO - Contents: 22:00:38 INFO - build_url:https://queue.taskcluster.net/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:00:38 INFO - Running post-action listener: _resource_record_post_action 22:00:38 INFO - Running post-action listener: set_extra_try_arguments 22:00:38 INFO - ##### 22:00:38 INFO - ##### Running populate-webroot step. 22:00:38 INFO - ##### 22:00:38 INFO - Running pre-action listener: _resource_record_pre_action 22:00:38 INFO - Running main action method: populate_webroot 22:00:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:00:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:00:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:00:38 INFO - '--tppagecycles', 22:00:38 INFO - '7'], 22:00:38 INFO - 'tests': ['tsvgm']}}, 22:00:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:00:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:00:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:00:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:00:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:00:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:00:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:00:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:38 INFO - 'talos_options': ['--e10s'], 22:00:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:00:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:38 INFO - 'tests': ['damp', 'tps']}, 22:00:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:38 INFO - 'talos_options': ['--e10s'], 22:00:38 INFO - 'tests': ['damp', 'tps']}, 22:00:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:00:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:00:38 INFO - 'other': {'tests': ['a11yr', 22:00:38 INFO - 'ts_paint', 22:00:38 INFO - 'tpaint', 22:00:38 INFO - 'sessionrestore', 22:00:38 INFO - 'sessionrestore_no_auto_restore']}, 22:00:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:00:38 INFO - 'tests': ['a11yr', 22:00:38 INFO - 'ts_paint', 22:00:38 INFO - 'tpaint', 22:00:38 INFO - 'sessionrestore', 22:00:38 INFO - 'sessionrestore_no_auto_restore']}, 22:00:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:00:38 INFO - 'tests': ['a11yr', 22:00:38 INFO - 'ts_paint', 22:00:38 INFO - 'tpaint', 22:00:38 INFO - 'sessionrestore', 22:00:38 INFO - 'sessionrestore_no_auto_restore']}, 22:00:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:00:38 INFO - 'tests': ['a11yr', 22:00:38 INFO - 'ts_paint', 22:00:38 INFO - 'tpaint', 22:00:38 INFO - 'sessionrestore', 22:00:38 INFO - 'sessionrestore_no_auto_restore']}, 22:00:38 INFO - 'other_l64': {'tests': ['a11yr', 22:00:38 INFO - 'ts_paint', 22:00:38 INFO - 'tpaint', 22:00:38 INFO - 'sessionrestore', 22:00:38 INFO - 'sessionrestore_no_auto_restore']}, 22:00:38 INFO - 'other_nol64': {'tests': ['a11yr', 22:00:38 INFO - 'ts_paint', 22:00:38 INFO - 'tpaint', 22:00:38 INFO - 'sessionrestore', 22:00:38 INFO - 'sessionrestore_no_auto_restore']}, 22:00:38 INFO - 'svgr': {'tests': ['tsvgx', 22:00:38 INFO - 'tsvgr_opacity', 22:00:38 INFO - 'tart', 22:00:38 INFO - 'tscrollx', 22:00:38 INFO - 'cart']}, 22:00:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:00:38 INFO - 'tests': ['tsvgx', 22:00:38 INFO - 'tsvgr_opacity', 22:00:38 INFO - 'tart', 22:00:38 INFO - 'tscrollx', 22:00:38 INFO - 'cart']}, 22:00:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:38 INFO - 'tests': ['tp5o']}, 22:00:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:38 INFO - 'talos_options': ['--e10s'], 22:00:38 INFO - 'tests': ['tp5o']}, 22:00:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:38 INFO - 'talos_options': ['--xperf_path', 22:00:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:00:38 INFO - 'tests': ['tp5n']}, 22:00:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:38 INFO - 'talos_options': ['--e10s', 22:00:38 INFO - '--xperf_path', 22:00:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:00:38 INFO - 'tests': ['tp5n']}}, 22:00:38 INFO - 'talos.zip': {'path': '', 22:00:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:00:38 INFO - Running post-action listener: _resource_record_post_action 22:00:38 INFO - ##### 22:00:38 INFO - ##### Running create-virtualenv step. 22:00:38 INFO - ##### 22:00:38 INFO - Running pre-action listener: _resource_record_pre_action 22:00:38 INFO - Running main action method: create_virtualenv 22:00:38 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:00:38 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 22:00:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:00:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:00:38 INFO - Using real prefix '/usr' 22:00:38 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:00:39 INFO - Installing distribute.............................................................................................................................................................................................done. 22:00:41 INFO - Installing pip.................done. 22:00:41 INFO - Return code: 0 22:00:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f0548c41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe517f0>, '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 0xdbd2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbd760>, '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': '574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975', '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 22:00:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 22:00:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 22:00:41 INFO - Using env: {'DISPLAY': ':0', 22:00:41 INFO - 'HOME': '/home/cltbld', 22:00:41 INFO - 'LANG': 'en_US.UTF-8', 22:00:41 INFO - 'LANGUAGE': 'en_US:en', 22:00:41 INFO - 'LOGNAME': 'cltbld', 22:00:41 INFO - 'MAIL': '/var/mail/cltbld', 22:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:41 INFO - 'MOZ_NO_REMOTE': '1', 22:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:41 INFO - 'NO_EM_RESTART': '1', 22:00:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:41 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:41 INFO - 'SHELL': '/bin/bash', 22:00:41 INFO - 'SHLVL': '1', 22:00:41 INFO - 'TERM': 'linux', 22:00:41 INFO - 'TMOUT': '86400', 22:00:41 INFO - 'USER': 'cltbld', 22:00:41 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975', 22:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:41 INFO - '_': '/tools/buildbot/bin/python'} 22:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:41 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 22:00:41 INFO - Cleaning up... 22:00:41 INFO - Return code: 0 22:00:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f0548c41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe517f0>, '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 0xdbd2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbd760>, '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': '574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975', '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 22:00:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 22:00:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 22:00:41 INFO - Using env: {'DISPLAY': ':0', 22:00:41 INFO - 'HOME': '/home/cltbld', 22:00:41 INFO - 'LANG': 'en_US.UTF-8', 22:00:41 INFO - 'LANGUAGE': 'en_US:en', 22:00:41 INFO - 'LOGNAME': 'cltbld', 22:00:41 INFO - 'MAIL': '/var/mail/cltbld', 22:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:41 INFO - 'MOZ_NO_REMOTE': '1', 22:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:41 INFO - 'NO_EM_RESTART': '1', 22:00:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:41 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:41 INFO - 'SHELL': '/bin/bash', 22:00:41 INFO - 'SHLVL': '1', 22:00:41 INFO - 'TERM': 'linux', 22:00:41 INFO - 'TMOUT': '86400', 22:00:41 INFO - 'USER': 'cltbld', 22:00:41 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975', 22:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:41 INFO - '_': '/tools/buildbot/bin/python'} 22:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:41 INFO - Downloading/unpacking psutil>=0.7.1 22:00:41 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 22:00:41 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 22:00:41 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 22:00:41 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 22:00:41 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 22:00:41 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 22:00:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:00:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:00:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:00:43 INFO - Installing collected packages: psutil 22:00:43 INFO - Running setup.py install for psutil 22:00:43 INFO - building 'psutil._psutil_linux' extension 22:00:43 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 22:00:43 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 22:00:43 INFO - building 'psutil._psutil_posix' extension 22:00:43 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 22:00:44 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 22:00:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:00:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:00:44 INFO - Successfully installed psutil 22:00:44 INFO - Cleaning up... 22:00:44 INFO - Return code: 0 22:00:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f0548c41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe517f0>, '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 0xdbd2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbd760>, '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': '574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975', '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 22:00:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 22:00:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 22:00:44 INFO - Using env: {'DISPLAY': ':0', 22:00:44 INFO - 'HOME': '/home/cltbld', 22:00:44 INFO - 'LANG': 'en_US.UTF-8', 22:00:44 INFO - 'LANGUAGE': 'en_US:en', 22:00:44 INFO - 'LOGNAME': 'cltbld', 22:00:44 INFO - 'MAIL': '/var/mail/cltbld', 22:00:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:44 INFO - 'MOZ_NO_REMOTE': '1', 22:00:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:44 INFO - 'NO_EM_RESTART': '1', 22:00:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:44 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:44 INFO - 'SHELL': '/bin/bash', 22:00:44 INFO - 'SHLVL': '1', 22:00:44 INFO - 'TERM': 'linux', 22:00:44 INFO - 'TMOUT': '86400', 22:00:44 INFO - 'USER': 'cltbld', 22:00:44 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975', 22:00:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:44 INFO - '_': '/tools/buildbot/bin/python'} 22:00:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:00:44 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 22:00:44 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 22:00:44 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 22:00:44 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 22:00:44 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 22:00:44 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 22:00:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:00:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:00:46 INFO - Installing collected packages: mozsystemmonitor 22:00:46 INFO - Running setup.py install for mozsystemmonitor 22:00:46 INFO - Successfully installed mozsystemmonitor 22:00:46 INFO - Cleaning up... 22:00:46 INFO - Return code: 0 22:00:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f0548c41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe517f0>, '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 0xdbd2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbd760>, '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': '574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975', '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 22:00:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 22:00:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 22:00:46 INFO - Using env: {'DISPLAY': ':0', 22:00:46 INFO - 'HOME': '/home/cltbld', 22:00:46 INFO - 'LANG': 'en_US.UTF-8', 22:00:46 INFO - 'LANGUAGE': 'en_US:en', 22:00:46 INFO - 'LOGNAME': 'cltbld', 22:00:46 INFO - 'MAIL': '/var/mail/cltbld', 22:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:46 INFO - 'MOZ_NO_REMOTE': '1', 22:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:46 INFO - 'NO_EM_RESTART': '1', 22:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:46 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:46 INFO - 'SHELL': '/bin/bash', 22:00:46 INFO - 'SHLVL': '1', 22:00:46 INFO - 'TERM': 'linux', 22:00:46 INFO - 'TMOUT': '86400', 22:00:46 INFO - 'USER': 'cltbld', 22:00:46 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975', 22:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:46 INFO - '_': '/tools/buildbot/bin/python'} 22:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:46 INFO - Downloading/unpacking blobuploader==1.2.4 22:00:46 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 22:00:46 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 22:00:46 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 22:00:46 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 22:00:46 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 22:00:46 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 22:00:48 INFO - Downloading blobuploader-1.2.4.tar.gz 22:00:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:00:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:00:48 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 22:00:48 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 22:00:48 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 22:00:48 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 22:00:48 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 22:00:48 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 22:00:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:00:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:00:48 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 22:00:48 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 22:00:48 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 22:00:48 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 22:00:48 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 22:00:48 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 22:00:49 INFO - Downloading docopt-0.6.1.tar.gz 22:00:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:00:49 INFO - Installing collected packages: blobuploader, requests, docopt 22:00:49 INFO - Running setup.py install for blobuploader 22:00:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:00:49 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:00:49 INFO - Running setup.py install for requests 22:00:49 INFO - Running setup.py install for docopt 22:00:49 INFO - Successfully installed blobuploader requests docopt 22:00:49 INFO - Cleaning up... 22:00:49 INFO - Return code: 0 22:00:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:00:49 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')]} 22:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:49 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')]} 22:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f0548c41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe517f0>, '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 0xdbd2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbd760>, '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': '574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975', '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 22:00:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 22:00:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 22:00:49 INFO - Using env: {'DISPLAY': ':0', 22:00:49 INFO - 'HOME': '/home/cltbld', 22:00:49 INFO - 'LANG': 'en_US.UTF-8', 22:00:49 INFO - 'LANGUAGE': 'en_US:en', 22:00:49 INFO - 'LOGNAME': 'cltbld', 22:00:49 INFO - 'MAIL': '/var/mail/cltbld', 22:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:49 INFO - 'MOZ_NO_REMOTE': '1', 22:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:49 INFO - 'NO_EM_RESTART': '1', 22:00:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:49 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:49 INFO - 'SHELL': '/bin/bash', 22:00:49 INFO - 'SHLVL': '1', 22:00:49 INFO - 'TERM': 'linux', 22:00:49 INFO - 'TMOUT': '86400', 22:00:49 INFO - 'USER': 'cltbld', 22:00:49 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975', 22:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:49 INFO - '_': '/tools/buildbot/bin/python'} 22:00:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:00:49 INFO - Running setup.py (path:/tmp/pip-ysUerC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:00:50 INFO - Running setup.py (path:/tmp/pip-TJDwHF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:00:50 INFO - Running setup.py (path:/tmp/pip-pZ81Ny-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:00:50 INFO - Running setup.py (path:/tmp/pip-7R3K5I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:00:50 INFO - Running setup.py (path:/tmp/pip-dWppMp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:00:50 INFO - Running setup.py (path:/tmp/pip-asPvAc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:00:50 INFO - Running setup.py (path:/tmp/pip-VzuLKJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:00:50 INFO - Running setup.py (path:/tmp/pip-MkhFjR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:00:50 INFO - Running setup.py (path:/tmp/pip-0R9rst-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:00:50 INFO - Running setup.py (path:/tmp/pip-1XxXJB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:00:50 INFO - Running setup.py (path:/tmp/pip-gyKrpH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:00:50 INFO - Running setup.py (path:/tmp/pip-bgmS0Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:00:50 INFO - Running setup.py (path:/tmp/pip-HNIsIP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:00:50 INFO - Running setup.py (path:/tmp/pip-YHPkid-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:00:50 INFO - Running setup.py (path:/tmp/pip-vujvBW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:00:51 INFO - Running setup.py (path:/tmp/pip-BFRgi0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:00:51 INFO - Running setup.py (path:/tmp/pip-bwhpnB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:00:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:00:51 INFO - Running setup.py install for manifestparser 22:00:51 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:00:51 INFO - Running setup.py install for mozcrash 22:00:51 INFO - Running setup.py install for mozdebug 22:00:51 INFO - Running setup.py install for mozdevice 22:00:51 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:00:51 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:00:51 INFO - Running setup.py install for mozfile 22:00:51 INFO - Running setup.py install for mozhttpd 22:00:51 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:00:51 INFO - Running setup.py install for mozinfo 22:00:51 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:00:51 INFO - Running setup.py install for mozInstall 22:00:51 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:00:51 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:00:51 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:00:51 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:00:51 INFO - Running setup.py install for mozleak 22:00:52 INFO - Running setup.py install for mozlog 22:00:52 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:00:52 INFO - Running setup.py install for moznetwork 22:00:52 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:00:52 INFO - Running setup.py install for mozprocess 22:00:52 INFO - Running setup.py install for mozprofile 22:00:52 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:00:52 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:00:52 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:00:52 INFO - Running setup.py install for mozrunner 22:00:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:00:52 INFO - Running setup.py install for mozscreenshot 22:00:52 INFO - Running setup.py install for moztest 22:00:52 INFO - Running setup.py install for mozversion 22:00:52 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:00:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:00:52 INFO - Cleaning up... 22:00:52 INFO - Return code: 0 22:00:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f0548c41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe517f0>, '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 0xdbd2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbd760>, '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': '574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975', '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 22:00:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 22:00:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 22:00:52 INFO - Using env: {'DISPLAY': ':0', 22:00:52 INFO - 'HOME': '/home/cltbld', 22:00:52 INFO - 'LANG': 'en_US.UTF-8', 22:00:52 INFO - 'LANGUAGE': 'en_US:en', 22:00:52 INFO - 'LOGNAME': 'cltbld', 22:00:52 INFO - 'MAIL': '/var/mail/cltbld', 22:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:52 INFO - 'MOZ_NO_REMOTE': '1', 22:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:52 INFO - 'NO_EM_RESTART': '1', 22:00:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:52 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:52 INFO - 'SHELL': '/bin/bash', 22:00:52 INFO - 'SHLVL': '1', 22:00:52 INFO - 'TERM': 'linux', 22:00:52 INFO - 'TMOUT': '86400', 22:00:52 INFO - 'USER': 'cltbld', 22:00:52 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975', 22:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:52 INFO - '_': '/tools/buildbot/bin/python'} 22:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:00:53 INFO - Running setup.py (path:/tmp/pip-RJVs0u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:00:53 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)) 22:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:00:53 INFO - Running setup.py (path:/tmp/pip-e0D5dc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:00:53 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)) 22:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:00:53 INFO - Running setup.py (path:/tmp/pip-or6RdU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:00:53 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)) 22:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:00:53 INFO - Running setup.py (path:/tmp/pip-4oiRtW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 22:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:00:53 INFO - Running setup.py (path:/tmp/pip-BFXa5q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:00:53 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)) 22:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:00:53 INFO - Running setup.py (path:/tmp/pip-5rfHqI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:00:53 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)) 22:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:00:53 INFO - Running setup.py (path:/tmp/pip-VUHgWo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:00:53 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)) 22:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:00:53 INFO - Running setup.py (path:/tmp/pip-1Q65OA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:00:53 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)) 22:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:00:53 INFO - Running setup.py (path:/tmp/pip-8g_FH8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:00:53 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)) 22:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:00:53 INFO - Running setup.py (path:/tmp/pip-CWmoHb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:00:53 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)) 22:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:00:53 INFO - Running setup.py (path:/tmp/pip-Eh6XnN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:00:53 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)) 22:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:00:53 INFO - Running setup.py (path:/tmp/pip-qrdJHG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:00:54 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)) 22:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:00:54 INFO - Running setup.py (path:/tmp/pip-MA74p1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 22:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:00:54 INFO - Running setup.py (path:/tmp/pip-JgjenP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:00:54 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)) 22:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:00:54 INFO - Running setup.py (path:/tmp/pip-sxlmX5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:00:54 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)) 22:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:00:54 INFO - Running setup.py (path:/tmp/pip-VQqN7V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:00:54 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)) 22:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:00:54 INFO - Running setup.py (path:/tmp/pip-j1G36J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:00:54 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)) 22:00:54 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)) 22:00:54 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)) 22:00:54 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)) 22:00:54 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:00:54 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:00:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:56 INFO - Downloading blessings-1.6.tar.gz 22:00:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:00:56 INFO - Installing collected packages: blessings 22:00:56 INFO - Running setup.py install for blessings 22:00:56 INFO - Successfully installed blessings 22:00:56 INFO - Cleaning up... 22:00:56 INFO - Return code: 0 22:00:56 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:00:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:00:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:00:56 INFO - Reading from file tmpfile_stdout 22:00:56 INFO - Current package versions: 22:00:56 INFO - argparse == 1.2.1 22:00:56 INFO - blessings == 1.6 22:00:56 INFO - blobuploader == 1.2.4 22:00:56 INFO - docopt == 0.6.1 22:00:56 INFO - manifestparser == 1.1 22:00:56 INFO - mozInstall == 1.12 22:00:56 INFO - mozcrash == 0.16 22:00:56 INFO - mozdebug == 0.1 22:00:56 INFO - mozdevice == 0.48 22:00:56 INFO - mozfile == 1.2 22:00:56 INFO - mozhttpd == 0.7 22:00:56 INFO - mozinfo == 0.9 22:00:56 INFO - mozleak == 0.1 22:00:56 INFO - mozlog == 3.1 22:00:56 INFO - moznetwork == 0.27 22:00:56 INFO - mozprocess == 0.22 22:00:56 INFO - mozprofile == 0.28 22:00:56 INFO - mozrunner == 6.11 22:00:56 INFO - mozscreenshot == 0.1 22:00:56 INFO - mozsystemmonitor == 0.0 22:00:56 INFO - moztest == 0.7 22:00:56 INFO - mozversion == 1.4 22:00:56 INFO - psutil == 3.1.1 22:00:56 INFO - requests == 1.2.3 22:00:56 INFO - wsgiref == 0.1.2 22:00:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f0548c41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe517f0>, '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 0xdbd2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbd760>, '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': '574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975', '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 22:00:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 22:00:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 22:00:56 INFO - Using env: {'DISPLAY': ':0', 22:00:56 INFO - 'HOME': '/home/cltbld', 22:00:56 INFO - 'LANG': 'en_US.UTF-8', 22:00:56 INFO - 'LANGUAGE': 'en_US:en', 22:00:56 INFO - 'LOGNAME': 'cltbld', 22:00:56 INFO - 'MAIL': '/var/mail/cltbld', 22:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:56 INFO - 'MOZ_NO_REMOTE': '1', 22:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:56 INFO - 'NO_EM_RESTART': '1', 22:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:56 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:56 INFO - 'SHELL': '/bin/bash', 22:00:56 INFO - 'SHLVL': '1', 22:00:56 INFO - 'TERM': 'linux', 22:00:56 INFO - 'TMOUT': '86400', 22:00:56 INFO - 'USER': 'cltbld', 22:00:56 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975', 22:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:56 INFO - '_': '/tools/buildbot/bin/python'} 22:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.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 1)) 22:00:56 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 2)) 22:00:56 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 3)) 22:00:56 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 4)) 22:00:56 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 5)) 22:00:56 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 6)) 22:00:56 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 7)) 22:00:56 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 8)) 22:00:56 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 9)) 22:00:56 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.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:00:56 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 4)) 22:00:56 INFO - Cleaning up... 22:00:56 INFO - Return code: 0 22:00:56 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f0548c41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe517f0>, '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 0xdbd2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbd760>, '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': '574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975', '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 22:00:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 22:00:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 22:00:56 INFO - Using env: {'DISPLAY': ':0', 22:00:56 INFO - 'HOME': '/home/cltbld', 22:00:56 INFO - 'LANG': 'en_US.UTF-8', 22:00:56 INFO - 'LANGUAGE': 'en_US:en', 22:00:56 INFO - 'LOGNAME': 'cltbld', 22:00:56 INFO - 'MAIL': '/var/mail/cltbld', 22:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:56 INFO - 'MOZ_NO_REMOTE': '1', 22:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:56 INFO - 'NO_EM_RESTART': '1', 22:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:56 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:56 INFO - 'SHELL': '/bin/bash', 22:00:56 INFO - 'SHLVL': '1', 22:00:56 INFO - 'TERM': 'linux', 22:00:56 INFO - 'TMOUT': '86400', 22:00:56 INFO - 'USER': 'cltbld', 22:00:56 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975', 22:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:56 INFO - '_': '/tools/buildbot/bin/python'} 22:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:56 INFO - Downloading/unpacking jsonschema 22:00:56 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 22:00:56 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 22:00:56 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 22:00:56 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 22:00:56 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 22:00:56 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 22:00:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:00:58 INFO - Downloading/unpacking functools32 (from jsonschema) 22:00:58 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 22:00:58 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 22:00:58 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 22:00:58 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 22:00:58 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 22:00:58 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 22:00:58 INFO - Downloading functools32-3.2.3-2.tar.gz 22:00:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:00:59 INFO - warning: no files found matching '*.txt' 22:00:59 INFO - no previously-included directories found matching 'build' 22:00:59 INFO - no previously-included directories found matching 'dist' 22:00:59 INFO - no previously-included directories found matching '.git*' 22:00:59 INFO - Installing collected packages: jsonschema, functools32 22:00:59 INFO - Running setup.py install for functools32 22:00:59 INFO - warning: no files found matching '*.txt' 22:00:59 INFO - no previously-included directories found matching 'build' 22:00:59 INFO - no previously-included directories found matching 'dist' 22:00:59 INFO - no previously-included directories found matching '.git*' 22:00:59 INFO - Successfully installed jsonschema functools32 22:00:59 INFO - Cleaning up... 22:00:59 INFO - Return code: 0 22:00:59 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:00:59 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')]} 22:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:59 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')]} 22:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0548c41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe517f0>, '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 0xdbd2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbd760>, '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': '574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975', '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 22:00:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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', 'flake8'] in /builds/slave/test-pgo/build 22:00:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 flake8 22:00:59 INFO - Using env: {'DISPLAY': ':0', 22:00:59 INFO - 'HOME': '/home/cltbld', 22:00:59 INFO - 'LANG': 'en_US.UTF-8', 22:00:59 INFO - 'LANGUAGE': 'en_US:en', 22:00:59 INFO - 'LOGNAME': 'cltbld', 22:00:59 INFO - 'MAIL': '/var/mail/cltbld', 22:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:59 INFO - 'MOZ_NO_REMOTE': '1', 22:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:59 INFO - 'NO_EM_RESTART': '1', 22:00:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:59 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:59 INFO - 'SHELL': '/bin/bash', 22:00:59 INFO - 'SHLVL': '1', 22:00:59 INFO - 'TERM': 'linux', 22:00:59 INFO - 'TMOUT': '86400', 22:00:59 INFO - 'USER': 'cltbld', 22:00:59 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975', 22:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:59 INFO - '_': '/tools/buildbot/bin/python'} 22:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:59 INFO - Downloading/unpacking flake8 22:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:01:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:01:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:01:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:01:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:01:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:01:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:01:01 INFO - no previously-included directories found matching 'docs/_build' 22:01:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:01:01 INFO - Running setup.py install for pep8 22:01:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:01:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:01:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:01:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:01:01 INFO - no previously-included directories found matching 'docs/_build' 22:01:02 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:01:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:01:02 INFO - Cleaning up... 22:01:02 INFO - Return code: 0 22:01:02 INFO - Running post-action listener: _resource_record_post_action 22:01:02 INFO - Running post-action listener: _start_resource_monitoring 22:01:02 INFO - Starting resource monitoring. 22:01:02 INFO - ##### 22:01:02 INFO - ##### Running install step. 22:01:02 INFO - ##### 22:01:02 INFO - Running pre-action listener: _resource_record_pre_action 22:01:02 INFO - Running main action method: install 22:01:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:01:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:01:02 INFO - Reading from file tmpfile_stdout 22:01:02 INFO - Detecting whether we're running mozinstall >=1.0... 22:01:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:01:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:01:02 INFO - Reading from file tmpfile_stdout 22:01:02 INFO - Output received: 22:01:02 INFO - Usage: mozinstall [options] installer 22:01:02 INFO - Options: 22:01:02 INFO - -h, --help show this help message and exit 22:01:02 INFO - -d DEST, --destination=DEST 22:01:02 INFO - Directory to install application into. [default: 22:01:02 INFO - "/builds/slave/test-pgo"] 22:01:02 INFO - --app=APP Application being installed. [default: firefox] 22:01:02 INFO - mkdir: /builds/slave/test-pgo/build/application 22:01:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:01:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:01:18 INFO - Reading from file tmpfile_stdout 22:01:18 INFO - Output received: 22:01:18 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:01:18 INFO - Running post-action listener: _resource_record_post_action 22:01:18 INFO - ##### 22:01:18 INFO - ##### Running run-tests step. 22:01:18 INFO - ##### 22:01:18 INFO - Running pre-action listener: _resource_record_pre_action 22:01:18 INFO - Running main action method: run_tests 22:01:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:01:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:01:18 INFO - Python 2.7.3 22:01:18 INFO - Return code: 0 22:01:18 INFO - grabbing minidump binary from tooltool 22:01:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:18 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 0xe517f0>, '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 0xdbd2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbd760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:01:18 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 22:01:18 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 22:01:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:01:18 INFO - Return code: 0 22:01:18 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:01:18 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:01:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:01:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:01:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:01:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:01:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:01:19 INFO - Return code: 0 22:01:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 22:01:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:01:19 INFO - Using env: {'DISPLAY': ':0', 22:01:19 INFO - 'HOME': '/home/cltbld', 22:01:19 INFO - 'LANG': 'en_US.UTF-8', 22:01:19 INFO - 'LANGUAGE': 'en_US:en', 22:01:19 INFO - 'LOGNAME': 'cltbld', 22:01:19 INFO - 'MAIL': '/var/mail/cltbld', 22:01:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:01:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:01:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:19 INFO - 'MOZ_NO_REMOTE': '1', 22:01:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:01:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:19 INFO - 'NO_EM_RESTART': '1', 22:01:19 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:19 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:19 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:01:19 INFO - 'SHELL': '/bin/bash', 22:01:19 INFO - 'SHLVL': '1', 22:01:19 INFO - 'TERM': 'linux', 22:01:19 INFO - 'TMOUT': '86400', 22:01:19 INFO - 'USER': 'cltbld', 22:01:19 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975', 22:01:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:19 INFO - '_': '/tools/buildbot/bin/python'} 22:01:19 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:01:19 INFO - mozversion application_buildid: 20160122193307 22:01:19 INFO - mozversion application_changeset: c49f59a5b8288c9cbb782b8beedb9b12b7171c67 22:01:19 INFO - mozversion application_display_name: Nightly 22:01:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:01:19 INFO - mozversion application_name: Firefox 22:01:19 INFO - mozversion application_remotingname: firefox 22:01:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:01:19 INFO - mozversion application_vendor: Mozilla 22:01:19 INFO - mozversion application_version: 46.0a1 22:01:19 INFO - mozversion platform_buildid: 20160122193307 22:01:19 INFO - mozversion platform_changeset: c49f59a5b8288c9cbb782b8beedb9b12b7171c67 22:01:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:01:19 INFO - mozversion platform_version: 46.0a1 22:01:19 INFO - using testdate: 1453528879 22:01:19 INFO - actual date: 1453528879 22:01:19 INFO - starting webserver on 'localhost:42900' 22:01:19 INFO - SUITE-START | Running 3 tests 22:01:19 INFO - TEST-START | dromaeo_css 22:01:19 INFO - operating with platform_type : linux_ 22:01:19 INFO - Initialising browser for dromaeo_css test... 22:01:19 INFO - TEST-INFO | started process 25878 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpz_0Bda/profile http://localhost:42900/getInfo.html) 22:01:23 INFO - PROCESS | 25878 | 22:01:23 INFO - PROCESS | 25878 | (process:25959): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:01:24 INFO - PROCESS | 25878 | __metrics Screen width/height:1600/1200 22:01:24 INFO - PROCESS | 25878 | colorDepth:24 22:01:24 INFO - PROCESS | 25878 | Browser inner width/height: 1024/697 22:01:24 INFO - PROCESS | 25878 | __metrics 22:01:24 INFO - PROCESS | 25878 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:01:25 INFO - TEST-INFO | 25878: exit 0 22:01:25 INFO - Browser initialized. 22:01:25 INFO - Running cycle 1/1 for dromaeo_css test... 22:01:25 INFO - TEST-INFO | started process 26008 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpz_0Bda/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:01:26 INFO - PROCESS | 26008 | 22:01:26 INFO - PROCESS | 26008 | (process:26065): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:01:37 INFO - PROCESS | 26008 | RSS: Main: 150286336 22:01:37 INFO - PROCESS | 26008 | 22:02:27 INFO - PROCESS | 26008 | 1453528947043 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] 22:04:35 INFO - PROCESS | 26008 | Cycle 1(1): loaded http://localhost:42900/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42900/tests/dromaeo/cssquery-ext.html) 22:04:36 INFO - PROCESS | 26008 | RSS: Main: 160317440 22:04:36 INFO - PROCESS | 26008 | 22:07:38 INFO - PROCESS | 26008 | Cycle 1(1): loaded http://localhost:42900/tests/dromaeo/cssquery-ext.html (next: http://localhost:42900/tests/dromaeo/cssquery-jquery.html) 22:07:39 INFO - PROCESS | 26008 | RSS: Main: 155693056 22:07:39 INFO - PROCESS | 26008 | 22:10:41 INFO - PROCESS | 26008 | Cycle 1(1): loaded http://localhost:42900/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42900/tests/dromaeo/cssquery-mootools.html) 22:10:41 INFO - PROCESS | 26008 | RSS: Main: 156676096 22:10:41 INFO - PROCESS | 26008 | 22:13:43 INFO - PROCESS | 26008 | Cycle 1(1): loaded http://localhost:42900/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42900/tests/dromaeo/cssquery-prototype.html) 22:13:44 INFO - PROCESS | 26008 | RSS: Main: 154103808 22:13:44 INFO - PROCESS | 26008 | 22:16:46 INFO - PROCESS | 26008 | Cycle 1(1): loaded http://localhost:42900/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42900/tests/dromaeo/cssquery-yui.html) 22:16:47 INFO - PROCESS | 26008 | RSS: Main: 154599424 22:16:47 INFO - PROCESS | 26008 | 22:19:49 INFO - PROCESS | 26008 | Cycle 1(1): loaded http://localhost:42900/tests/dromaeo/cssquery-yui.html (next: http://localhost:42900/tests/dromaeo/cssquery-dojo.html) 22:19:49 INFO - PROCESS | 26008 | RSS: Main: 158248960 22:19:49 INFO - PROCESS | 26008 | 22:19:49 INFO - PROCESS | 26008 | __start_tp_report 22:19:49 INFO - PROCESS | 26008 | _x_x_mozilla_page_load 22:19:49 INFO - PROCESS | 26008 | _x_x_mozilla_page_load_details 22:19:49 INFO - PROCESS | 26008 | |i|pagename|runs| 22:19:49 INFO - PROCESS | 26008 | |0;dojo.html;3110.4867696830024;3156.33716919447;3167.5882135322418;3192.9999999999995;3204.823734694594;5149.845504634863;5186.585073194149;5206.114960456722;5208.114620514521;5223.294855194547;5276.076686579842;5279.973600131994;5297.708626025567;5313.3092697949305;5323;4813.49458306878;4823.638227132961;4837.346958160639;4916.729579873106;4947.936193718349;4913.091078150535;4934.80260789568;4966.180580204262;4985.052839960396;4991.900161996758;4790.257510085925;4818.855434336958;4845.466998630148;4908.558229759339;4927;4835.202191638411;4854.563089321978;4856.223004319328;4861.368022157097;4897.3878265216845;4732.384789977281;4825.469198388175;4837.32277481153;4853.223484242504;4887.8778030549165;5158.329417175743;5194.610404219661;5195.064888320101;5196.168613021899;5219.086659834514;5714.200011998323;5739.684317362543;5742.253507044099;5763.827085187451;5765.394633563499;5676.602637815355;5763.221965034709;5792.942070579283;5793.913091303634;5821.53427725781;5326.387465441485;5346.331708536433;5348.598855085923;5350.491703288181;5366.597505187126;5785.334686511105;5818.5345172386105;5825.679587622722;5833.970830145822;5836.824895253064;5426.620136590401;5477.3427188737605;5549.500544950893;5621.80323688669;5636.070048441961;5686.061799802987;5720.513756330675;5722.828315150552;5723.227364305849;5735.799247026334;5650.463205995424;5653.180288858092;5661.518770904437;5671.2060311556415;5681.289838770153;5413.539849112791;5556.499915007668;5655.943440565624;5670.886582268414;5719.370869204384;4363.585459381354;4375.234333991539;4379.0585024219945;4392.1874453226255;4394.824207031683;3936.724429289922;3947.4670919426085;3948.309045916953;3955.6835453163676;4016.2369149861433;5294.523492885582;5331.866703332447;5347.25138480613;5354.089804733205;5358.5981051421295;5721.056025755704;5725.341585717612;5731.713414329267;5772.134179872969;5779.3642699303045;5233.084210263189;5254.632175747661;5264;5265.183896496049;5279;4782.33047373368;4808.759562021885;4824.855254342376;4850.563449289581;4857.465678775332;5898.528117750569;5930.377310382434;5932.0508718604815;5933.851653708605;5985.9401405986255;5526.115821468546;5535.308086489189;5541.833744987657;5605.075162598126;5616.550675945996;5789.942100579109;5830.096335068071;5832;5878.735456904364;5913.379095194942;5591.804286849941;5618.073017951992;5632.5775566831835;5635.323761148688;5686.317641883001;5686.687232202103;5702.486776190163;5709.20071190042;5713.428657134254;5717.742701578522;5390.811321603882;5461.371942226695;5467;5558.555315574664;5577.8047768327915;5520.420355862577;5566.832995010156;5577.442255774552;5582.0231459495235;5606.215129881738;5417.214503896992;5445.428230035947;5456.945430545644;5475.972620136874;5477.561795056466;5497.5601951842955;5522.392536820867;5542.140968149944;5604.047311957059;5631.577631677723;5417.83746487606;5445.074337362737;5466.726663666721;5487.5609951203005;5505.366882808528 22:19:49 INFO - PROCESS | 26008 | |1;ext.html;549.727884697075;555.4195865320739;563.6449037106622;567.7133047810855;578.5400606517818;35569.644303556954;36380.81809590952;36413.81793091037;36468.088297792565;36472.63527364729;41305;42941.7852910735;42991.35512967308;43015.3547696784;43243.78378108113;8552.486850788942;8714.738557843275;8733.257673097794;8745.038045814956;8748.781280467976;8547.358948078889;8634.050254472035;8686.782830429227;8688.174623410798;8700.26047785939;8665.09016553259;8781.912180878173;8787.560621968907;8789.340799440035;8794.208521233088;8456.577171141449;8470.068292487822;8511.574421278974;8702.30381569473;8705.912940870638;8490;8610;8639.568021598958;8647.308215342757;8657.26413254874;38788.22423551513;38849.80575097135;39003.21993560141;39055.804720976215;39431;3084.8920287790042;3113.143885431502;3125.6405513366026;3130;3133.3106716522557;29099;29554.556681649792;29579;29580.260493487618;30825;3883.1457079442475;3974.5826688197903;3988.840446382141;4054.5945405459515;4106.384042393635;253089;253905;255504;255901;257945;42402.78798605987;42957.35563966543;42979.57020429818;54810;55409.16886246709;40487;40510.594894051275;40620.593794062275;40669;40684.79657601693;12236.143469957196;12391.93804030992;12395.132340736242;12395.75208495825;12424.37878106091;9825.361351512129;9890.950545247228;9936.80758308993;10002.049805268487;10027.548760305805;14109.506167284097;14128;14267.571972840831;14316.85683143176;14382.35279412429;5689.6586204827845;5717.742701578356;5805.535557155417;5851.795187168429;5869.266341707286;960.3661583355092;984.6602921991902;999.9500024998721;1001.234055947201;1091.9563217471211;27033.23365400461;27570.724292757215;27577.896884124813;27938.580921286197;30239.395212095635;998.4608311511847;1001.519270750044;1003.5427950709735;1032.0402026115635;1096.5997410944947;13594;13629.386677599334;13749.725005499835;13897.930510347383;13948.372323245276;383877;388394;388564;388820;389722;52710.472895270555;52743.736281319114;52780;52825.207621885704;53341.733291333294;1309.3191540398939;1326.9601911942657;1328.130074801007;1328.9069765116542;1339.9531016414378;25672.61491077598;26168.60747088757;26263;26676.19971400861;26779.196624101307;39989;40722.77831665055;41133.794331028155;41475.37786933138;41510.79244603758;306678;307393;307894;308384;309064;32151.356972859943;42974.355384668626;43299.567004329554;43749.34375984299;43966.56033439624;38660.420093698056;38996.41505377365;39244.60755392409;39552.40671389874;39664.60335396609;34929.65070349366;35009.12477188091;35439.82280088583;35528.64471355253;35761.64238357583;36185.63814361928;36188.63811361853;36314.4552831713;36560.45159322665;36703.632963670025;35359.46960795538;35609;35788.82105589456;35826.64173358233;35949.820250899626;30414.84792576023;32074.83962580172;32419.513707293936;33140;33163.17092072718;24239.272821815375;24682.753172468765;24714.629280561167;24947.376315592257;25026 22:19:49 INFO - PROCESS | 26008 | |2;jquery.html;367.1225770408722;368.13121034358915;369.44583125312033;369.5343866727922;370.60530534980245;15362;16256;16522;17081.402150924703;17191;10378.377297362164;10563.313384630013;10737.40944248066;10843.891561084387;10906.291091079074;4883.365162528867;5044.974775126119;5053.696778193302;5062.772175252123;5402.297701298826;5313.946860531384;5362.8123015694455;5373;5375.381831089436;5382.515573598375;5089.898202035975;5159.535641792257;5296.285001524802;5306.389765176996;5343.519083282504;5215.869603259911;5225.399079105913;5257.684538927677;5269.947300526984;5553.139263414178;5301.443348448396;5330.413654498002;5348.545373643245;5352.705601191933;5356.491133342326;11918.404079795975;12595.622131336075;12660.303683297416;12689.048321375842;12693.809592856114;1958.2460752610205;2012.4365177750253;2050.046728271346;2079.511314841011;2133.434639820449;9022.413543119676;9477.383970041925;9609.711708648752;11472.25430347033;12217.205881617667;1732.7314266288745;1789.6957517221974;1794.0760508338217;1817.3366721146817;1825.9087045647664;52384.73807630975;52591.47408525904;53166.734166329305;55256;55522.16716749252;10006;10181.440020798778;10199.337043092175;10200.183985281159;10230.23273254509;13324.73350532984;13353.799693004612;13359.064865459519;13375.732485350432;13410.798838017437;6744.0895479109695;6770.898436523456;6783.932160678429;6790.083338749206;6847.452203823682;6257.2491301044165;6260.311365749764;6274.592151510137;6278.623282603058;6308.842278943063;4436.467623885154;4456.175607512556;4509.7970591323465;4511.481179664315;4548.476925153584;1810.5473631592101;1834.7247912813184;1856.4430670798977;1882.4352694191687;1900.3918746001423;916;929.702495201529;975.9414435133915;978.4911845840123;1003.6437064842022;15384.923075384551;15588;15642.843571564366;15737.44918927832;16001.679966400607;867.6095756909416;877.4647465046316;905.1220316293185;925.6760133953062;931.1340453378423;8866.512341821133;9303.116203960613;9305.348625596278;9622.182114520345;9800;145561;146208;146230;146698;147140.26429867998;66891;66898.66550667313;69473;69507;70686.87100983453;1078.6224821312635;1102.4983632447218;1102.7518808268076;1103.194667892443;1113;15223.771643425136;15444.30500627497;15477.226138693246;15490.9225453872;15790.9210453947;31924;32605.836970814995;32813.343733124726;33443.66556334503;33878.15304617404;40206.798966004986;41799;42515.7874210627;43843.780781097164;44964;7075.540089894141;7122.109736282965;7213.819654508469;7322.597257150908;7613.885791713239;10409.219308551737;10658;11177.552897883994;11221.831672525082;11237.3257604544;9351.485668288038;9545.47499887485;9749.025097490194;9958.900410995797;10261.179105671677;9232.630694772133;9264.629414823601;9868.358556693793;9966.40201587907;10395.740106497398;8865.867011994696;9440.197583205505;9453.716388508356;9533.761655958657;9611.951940240255;7168.247334029852;7336.7432139874845;7376.7418140364825;7385.335319821242;7398.889016664862;8112.148224436349;9579.521023948635;9582.425054496753;9767.730195074595;9772.413655180711 22:19:49 INFO - PROCESS | 26008 | |3;mootools.html;1374.24416570886;1386.6117487103609;1494.1931357067185;1701.310969057532;1717.235830055625;7601.8479630407355;7799.688012479501;7806;7833.843323133534;8029.317508011812;7930.484518506308;7962.681492740284;8032.879506807388;8050.758477245678;8061.153578874222;2320.141547627372;2342.145117032288;2343.9179628713;2344.074090734159;2347.190219374313;2363.7518060603647;2370.0282884017556;2397.3407312988893;2405.1341517053847;2405.9518809623796;2173.619616567102;2223.0996446439217;2224.5884511365366;2291.0721157931066;2308.7691230876944;2326.6626339180893;2334.7198336199594;2341.894614742332;2351.8941647625898;2352.223766157164;2317.73346065203;2329.79031887131;2334.5914464968732;2337.836351455399;2340.1107579119994;7659.119201291867;7736.149023607399;7738.148803631596;7744.961275193645;7750.689972401097;4705.4588722296685;4796.160671882441;4835.226363781813;4842.104210721028;4873.512648735134;3063.6936306369184;3093.257618171645;3172.873085076594;3181.109289398972;3187.729043031345;974.6539978307741;991.2466525440645;993.0665174735725;1004.6684594084007;1023.8157131716288;10463.895361046369;10493.317934334244;10507.474626268657;10515.05364517197;10581.629642962536;4181.142865712522;4186.832526698898;4191.889149375418;4212.283911735012;4383.846565370197;8472.703455379033;8588.957055214809;8619.698310559226;8628.180322869317;8637.395382323177;4633.166030114544;4646.070785842845;4648.325992731103;4651.09303685778;4666.836660716926;4246;4250.06498570314;4253.234417804825;4289.463817022872;4293.377460268243;3498.5626796650417;3513.9297214055578;3515.0333658243676;3520.2607452435277;3544.379733546619;1052.1004541117234;1101.4492753623188;1114.9777004459866;1117.173291764105;1118.3457677258896;860.9883387020226;1043.7338478687886;1045.529511719714;1132.1395739238237;1340.088739657023;6994.265602111806;7001.649917504104;7014.158301003912;7035.085438892911;7036.577805331696;1146.1747541769912;1158.5481662151767;1189.3102000839492;1192.4753108632174;1213.5449206547544;5745.195672605755;5806.303243610793;5809.82570522885;5810.738516766755;5827.4172582741385;9063.864042039375;9070.18368346852;9246;9329.906700932905;9371.531423428802;9088.363814533051;9136.725898223063;9184.035676253898;9216.21662158724;9254.213391861633;7290.4896657233485;7304.671289791866;7350.779476615817;7416.888746668804;7431.145418276968;7019.982102595197;7029.226785053538;7050.2597227292445;7084.397826184832;7094.184168820445;7959;8294.875576866472;8366.707165249187;8386.32909367237;8654.134586541295;8402.915970840213;8614.569271536273;8616.310695144499;8621.13788621158;8699.956500217459;6801.2858649841055;6943.861122777617;7021.824454388681;7032.964835175791;7058.54119482232;7419.703211871681;7449.180590135189;7476.140243871807;7486.213947535431;7502.399808015455;6470.902936456051;6986.54587451814;7102.3962963148715;7152.356287933902;7224.855502890018;6784.050232967487;6814.727410903508;6819.352161544645;6822.351876571718;6902.378785909293;6614.636195009129;6623.437007854386;6629.867402651824;6644.302348253557;6650.83372915681;6273.780417685359;6299.779507717208;6339.778107766206;6339.809805705836;6360.9045864313;6355.1420558224045;6379.585326953733;6413.134226879311;6494.577852439576;6530.151080359523 22:19:49 INFO - PROCESS | 26008 | |4;prototype.html;351.8909138167168;353.87614334982777;354.15003990422997;356.5863598226057;362.1905042230614;6167.907481387782;6262.530310226734;6280.842978925529;6332.3351048139975;6343.23881134264;6070.817875463743;6234.84412889678;6258.968705156479;6266.655333956631;6268.780592679257;4791.928121078186;4795.520447955194;4801.327814106028;4822.421309442854;4831.613470922335;4809.7835597398025;4814.711117332954;4833.468318484964;4836.733979631119;4836.854894353175;4677.181493238687;4780.450248221447;4790.281457781326;4793.784279707422;4801.927971080437;4807.278908163768;4809.374781278429;4815.398075240595;4817.662763606531;4821.493743156953;4232.830686772525;4240.554741752133;4243.66050715945;4251.744895306291;4254.489461264668;5940.960331941893;5950.851228719273;5965.4631083202285;5972.432618901197;5976.9402305977255;5468.2891224141;5535.640183388067;5596.908602822451;5613.298337707786;5613.635113717636;6591.406773390418;6595.175603049619;6599.142111525471;6616.437602803768;6625.436837868739;4675.766211689436;4676.368690226844;4695.225287827504;4696.3894693689945;4701.083288758693;6672.132622759011;6904.758333458355;6964.651767411659;6975.895361569581;6984.546004509691;4678.532146785295;4698.083873644607;4719.598834099072;4727.527247275245;4728.196206644879;4784.880377990508;4786.856394308176;4788.090262850047;4789.137955168103;4793.712377257306;5524.8342549723575;5532.197831314437;5533.723313834292;5543.695096769636;5551.72241387929;6466.482681385478;6644.767433139817;6660.067590537328;6687.966560167168;6749.730010799513;1641.253229780447;1668.4660908509404;1684.8399402056784;1685.7977042754949;1688.991555042217;1089.8474213609943;1115.3865374044406;1115.966521004371;1134.7673726885969;1145.2269717940358;6178.505719542426;6238.500919926395;6278.434940855345;6294.087357333161;6326.145970294044;6863.347981941708;6872.793816185523;6873.487832676803;6894.620795856175;6897.689603967833;5974.970125149346;6096.786612468542;6119.388061193934;6119.755209791559;6120.938790612126;3668.229671768905;3671.742977991515;3684.3552378333684;3684.631536846294;3688.2807852469045;6895.34494223048;6929.5842249465195;6954.3045695431065;6988.545744526589;7000.649967501605;6762.763303284361;6876.828079298058;6876.931230687629;6961.40828029613;6964.373206411447;6879.036934829128;7059.270478732743;7080.822979425556;7090.468214883905;7117.466190035768;6701.229358623626;6703.4302084321425;6747.763828265987;6769;6771.322867713189;6662.133922590032;6673.866522669422;6679.8664026718225;6687.063811066552;6694.297098804555;7298.708051678086;7308.30571095745;7325.597092159983;7346;7364.668589913574;4672.906541869075;4717.551832576037;4722.38608980844;4738.526147385234;4757.09615173116;6740.022696708852;6857.897131542931;6979.232284448605;6994.055802466602;6997.860042799217;6708.262091170065;6729.327067293428;6742.898856517058;6744.359285867835;6750.35871592198;6645.6677166140535;6655.73377064912;6689.163854518185;6692.297308782508;6719.328067193242;6405.8718825624155;6552.443042341454;6581.506387021088;6583.539152259296;6600.8349791255605;6724.125863637696;6726.091977582963;6744.494162937897;6745.156855393076;6747.696353664195;6536.411722944958;6538.1500404947055;6570.47436205112;6575.80272591823;6606.471482281502 22:19:49 INFO - PROCESS | 26008 | |5;yui.html;729.5258082246536;750.8535835512075;759.7682706774439;798.7483942558092;811.4360519438992;11826.881731182686;11912.583059592916;11946.223495472788;11993.04055675546;12079.637610871678;10386.740331491717;11261.943690281558;11267.661970140909;11279.37963412012;11320.490577923993;769.4190885881166;782.8434313137367;783.2402569507568;784.2667106255641;785.6268272570512;772.6561680052379;776.4487214077983;780.1145699630931;783.3967844759532;787.4015748031509;833.291702053253;834.1450013735908;834.1491678487939;837.1252041616495;842.3724325377602;828.3994104274414;829.8008477965245;831.4969443486694;831.7795784117213;833.5248908122372;612.5436549770405;617.0990354083044;617.941295576924;618.0389494336305;619.8171539395889;11323;11337.716557086138;11382.715432114263;11411.94294028533;11428;11868.87245711656;11921.284722916653;12023.639290821202;12233.20484168535;12511.3744312784;9427.914431050103;9489.718887950108;9957.45234012129;9976.152027077707;10119.139873110795;3419.093940105874;3455.291665208626;3471.89584312471;3481.8927719548446;3610.5667319921513;43002.13995720099;43286.35070473914;43294.78352608217;43306.133877322594;43314.783426082984;8892.510911899908;9038.367314287936;9039.502827344428;9116.1339672731;9122.86315705265;17376.826231737774;17381.304747810198;17516.737248941277;17576.91211543934;17620.823791762174;6632.43624291931;6709.698063587052;6761.188657361148;6842.692078856463;6880.176753160416;3688.686461650736;3727.3290807654885;3733.5146430964346;3737.7944213068;3773;3049.1462390530687;3081.984590077035;3103.6120484939383;3110.377924415081;3118.1113382685826;558.8183840251853;578.0779656447959;586.7476984896535;589.286962775047;589.4694774702801;482.50784200115686;487.48813745567014;495.9380077490314;591.775125452334;656.6191608866845;7934.960325198337;8015.639296231683;8289.58552072394;8301.750947471586;8450.957745211235;511.2229411294811;516.7442116152529;576.8615532272308;606.2936678769273;614.50839328537;3750.7937063461773;3801.82891769871;3959.4456776051375;4011.4785077940264;4067.491563554556;53000.46999530032;54009.189862152096;54209;54502;54698.179527307126;47086.76456617695;48389.516104839204;48486.75756621194;49087;49291;42437.78781106075;43494.78252608717;43861;46054.309185362246;47520.76239618849;7918.445708800328;8335.583220839055;8351.33189344863;8361.122082181526;8389.748307550783;30444.84777576098;31481.37037259288;31693.36613267768;31697.04908852738;31836.204094897814;40218.9945251371;40601.39097913475;41379;41572;42960.35559466548;9944.651937182163;10146.340487868265;10147.18822494184;10178.796424071328;10218;11145.164112691742;11313.943430282796;11340.886591133984;11574.247673901169;12045.698857528632;10688.83966740484;10837.566497340018;11106.888931110909;11122.110231181648;11338.376389298668;10357.63748268807;10449.58201671955;10462.372257664565;11028.669139925814;11365.147613928822;9759.072888075621;10249.9487502562;10409.947950260503;11127.83308250393;11538.711532211426;8099.83800324002;8145.144759800372;8208.917910820815;8355.456895301786;8454.535000575028;8259.132791056853;8335.541545215072;8383.203595658402;8559.186877246651;8587.141285871612 22:19:49 INFO - PROCESS | 26008 | __end_tp_report 22:19:49 INFO - PROCESS | 26008 | __start_cc_report 22:19:49 INFO - PROCESS | 26008 | _x_x_mozilla_cycle_collect,306 22:19:49 INFO - PROCESS | 26008 | __end_cc_report 22:19:49 INFO - PROCESS | 26008 | __startTimestamp1453529989790__endTimestamp 22:19:49 INFO - PROCESS | 26008 | 22:19:49 INFO - PROCESS | 26008 | ------- Summary: start ------- 22:19:49 INFO - PROCESS | 26008 | Number of tests: 6 22:19:49 INFO - PROCESS | 26008 | 22:19:49 INFO - PROCESS | 26008 | [#0] dojo.html Cycles:165 Average:5277.92 Median:5456.95 stddev:579.62 (10.6%) stddev-sans-first:555.90 22:19:49 INFO - PROCESS | 26008 | Values: 3110.5 3156.3 3167.6 3193.0 3204.8 5149.8 5186.6 5206.1 5208.1 5223.3 5276.1 5280.0 5297.7 5313.3 5323.0 4813.5 4823.6 4837.3 4916.7 4947.9 4913.1 4934.8 4966.2 4985.1 4991.9 4790.3 4818.9 4845.5 4908.6 4927.0 4835.2 4854.6 4856.2 4861.4 4897.4 4732.4 4825.5 4837.3 4853.2 4887.9 5158.3 5194.6 5195.1 5196.2 5219.1 5714.2 5739.7 5742.3 5763.8 5765.4 5676.6 5763.2 5792.9 5793.9 5821.5 5326.4 5346.3 5348.6 5350.5 5366.6 5785.3 5818.5 5825.7 5834.0 5836.8 5426.6 5477.3 5549.5 5621.8 5636.1 5686.1 5720.5 5722.8 5723.2 5735.8 5650.5 5653.2 5661.5 5671.2 5681.3 5413.5 5556.5 5655.9 5670.9 5719.4 4363.6 4375.2 4379.1 4392.2 4394.8 3936.7 3947.5 3948.3 3955.7 4016.2 5294.5 5331.9 5347.3 5354.1 5358.6 5721.1 5725.3 5731.7 5772.1 5779.4 5233.1 5254.6 5264.0 5265.2 5279.0 4782.3 4808.8 4824.9 4850.6 4857.5 5898.5 5930.4 5932.1 5933.9 5985.9 5526.1 5535.3 5541.8 5605.1 5616.6 5789.9 5830.1 5832.0 5878.7 5913.4 5591.8 5618.1 5632.6 5635.3 5686.3 5686.7 5702.5 5709.2 5713.4 5717.7 5390.8 5461.4 5467.0 5558.6 5577.8 5520.4 5566.8 5577.4 5582.0 5606.2 5417.2 5445.4 5456.9 5476.0 5477.6 5497.6 5522.4 5542.1 5604.0 5631.6 5417.8 5445.1 5466.7 5487.6 5505.4 22:19:49 INFO - PROCESS | 26008 | 22:19:49 INFO - PROCESS | 26008 | [#1] ext.html Cycles:180 Average:46959.89 Median:38724.32 stddev:84616.31 (218.5%) stddev-sans-first:84781.94 22:19:49 INFO - PROCESS | 26008 | Values: 549.7 555.4 563.6 567.7 578.5 35569.6 36380.8 36413.8 36468.1 36472.6 41305.0 42941.8 42991.4 43015.4 43243.8 8552.5 8714.7 8733.3 8745.0 8748.8 8547.4 8634.1 8686.8 8688.2 8700.3 8665.1 8781.9 8787.6 8789.3 8794.2 8456.6 8470.1 8511.6 8702.3 8705.9 8490.0 8610.0 8639.6 8647.3 8657.3 38788.2 38849.8 39003.2 39055.8 39431.0 3084.9 3113.1 3125.6 3130.0 3133.3 29099.0 29554.6 29579.0 29580.3 30825.0 3883.1 3974.6 3988.8 4054.6 4106.4 253089.0 253905.0 255504.0 255901.0 257945.0 42402.8 42957.4 42979.6 54810.0 55409.2 40487.0 40510.6 40620.6 40669.0 40684.8 12236.1 12391.9 12395.1 12395.8 12424.4 9825.4 9891.0 9936.8 10002.0 10027.5 14109.5 14128.0 14267.6 14316.9 14382.4 5689.7 5717.7 5805.5 5851.8 5869.3 960.4 984.7 1000.0 1001.2 1092.0 27033.2 27570.7 27577.9 27938.6 30239.4 998.5 1001.5 1003.5 1032.0 1096.6 13594.0 13629.4 13749.7 13897.9 13948.4 383877.0 388394.0 388564.0 388820.0 389722.0 52710.5 52743.7 52780.0 52825.2 53341.7 1309.3 1327.0 1328.1 1328.9 1340.0 25672.6 26168.6 26263.0 26676.2 26779.2 39989.0 40722.8 41133.8 41475.4 41510.8 306678.0 307393.0 307894.0 308384.0 309064.0 32151.4 42974.4 43299.6 43749.3 43966.6 38660.4 38996.4 39244.6 39552.4 39664.6 34929.7 35009.1 35439.8 35528.6 35761.6 36185.6 36188.6 36314.5 36560.5 36703.6 35359.5 35609.0 35788.8 35826.6 35949.8 30414.8 32074.8 32419.5 33140.0 33163.2 24239.3 24682.8 24714.6 24947.4 25026.0 22:19:49 INFO - PROCESS | 26008 | 22:19:49 INFO - PROCESS | 26008 | [#2] jquery.html Cycles:180 Average:15979.63 Median:4964.17 stddev:26485.85 (533.5%) stddev-sans-first:26534.21 22:19:49 INFO - PROCESS | 26008 | Values: 367.1 368.1 369.4 369.5 370.6 15362.0 16256.0 16522.0 17081.4 17191.0 10378.4 10563.3 10737.4 10843.9 10906.3 4883.4 5045.0 5053.7 5062.8 5402.3 5313.9 5362.8 5373.0 5375.4 5382.5 5089.9 5159.5 5296.3 5306.4 5343.5 5215.9 5225.4 5257.7 5269.9 5553.1 5301.4 5330.4 5348.5 5352.7 5356.5 11918.4 12595.6 12660.3 12689.0 12693.8 1958.2 2012.4 2050.0 2079.5 2133.4 9022.4 9477.4 9609.7 11472.3 12217.2 1732.7 1789.7 1794.1 1817.3 1825.9 52384.7 52591.5 53166.7 55256.0 55522.2 10006.0 10181.4 10199.3 10200.2 10230.2 13324.7 13353.8 13359.1 13375.7 13410.8 6744.1 6770.9 6783.9 6790.1 6847.5 6257.2 6260.3 6274.6 6278.6 6308.8 4436.5 4456.2 4509.8 4511.5 4548.5 1810.5 1834.7 1856.4 1882.4 1900.4 916.0 929.7 975.9 978.5 1003.6 15384.9 15588.0 15642.8 15737.4 16001.7 867.6 877.5 905.1 925.7 931.1 8866.5 9303.1 9305.3 9622.2 9800.0 145561.0 146208.0 146230.0 146698.0 147140.3 66891.0 66898.7 69473.0 69507.0 70686.9 1078.6 1102.5 1102.8 1103.2 1113.0 15223.8 15444.3 15477.2 15490.9 15790.9 31924.0 32605.8 32813.3 33443.7 33878.2 40206.8 41799.0 42515.8 43843.8 44964.0 7075.5 7122.1 7213.8 7322.6 7613.9 10409.2 10658.0 11177.6 11221.8 11237.3 9351.5 9545.5 9749.0 9958.9 10261.2 9232.6 9264.6 9868.4 9966.4 10395.7 8865.9 9440.2 9453.7 9533.8 9612.0 7168.2 7336.7 7376.7 7385.3 7398.9 8112.1 9579.5 9582.4 9767.7 9772.4 22:19:49 INFO - PROCESS | 26008 | 22:19:49 INFO - PROCESS | 26008 | [#3] mootools.html Cycles:180 Average:5416.62 Median:6358.02 stddev:2771.09 (43.6%) stddev-sans-first:2762.20 22:19:49 INFO - PROCESS | 26008 | Values: 1374.2 1386.6 1494.2 1701.3 1717.2 7601.8 7799.7 7806.0 7833.8 8029.3 7930.5 7962.7 8032.9 8050.8 8061.2 2320.1 2342.1 2343.9 2344.1 2347.2 2363.8 2370.0 2397.3 2405.1 2406.0 2173.6 2223.1 2224.6 2291.1 2308.8 2326.7 2334.7 2341.9 2351.9 2352.2 2317.7 2329.8 2334.6 2337.8 2340.1 7659.1 7736.1 7738.1 7745.0 7750.7 4705.5 4796.2 4835.2 4842.1 4873.5 3063.7 3093.3 3172.9 3181.1 3187.7 974.7 991.2 993.1 1004.7 1023.8 10463.9 10493.3 10507.5 10515.1 10581.6 4181.1 4186.8 4191.9 4212.3 4383.8 8472.7 8589.0 8619.7 8628.2 8637.4 4633.2 4646.1 4648.3 4651.1 4666.8 4246.0 4250.1 4253.2 4289.5 4293.4 3498.6 3513.9 3515.0 3520.3 3544.4 1052.1 1101.4 1115.0 1117.2 1118.3 861.0 1043.7 1045.5 1132.1 1340.1 6994.3 7001.6 7014.2 7035.1 7036.6 1146.2 1158.5 1189.3 1192.5 1213.5 5745.2 5806.3 5809.8 5810.7 5827.4 9063.9 9070.2 9246.0 9329.9 9371.5 9088.4 9136.7 9184.0 9216.2 9254.2 7290.5 7304.7 7350.8 7416.9 7431.1 7020.0 7029.2 7050.3 7084.4 7094.2 7959.0 8294.9 8366.7 8386.3 8654.1 8402.9 8614.6 8616.3 8621.1 8700.0 6801.3 6943.9 7021.8 7033.0 7058.5 7419.7 7449.2 7476.1 7486.2 7502.4 6470.9 6986.5 7102.4 7152.4 7224.9 6784.1 6814.7 6819.4 6822.4 6902.4 6614.6 6623.4 6629.9 6644.3 6650.8 6273.8 6299.8 6339.8 6339.8 6360.9 6355.1 6379.6 6413.1 6494.6 6530.2 22:19:49 INFO - PROCESS | 26008 | 22:19:49 INFO - PROCESS | 26008 | [#4] prototype.html Cycles:180 Average:5554.22 Median:6260.75 stddev:1667.24 (26.6%) stddev-sans-first:1625.55 22:19:49 INFO - PROCESS | 26008 | Values: 351.9 353.9 354.2 356.6 362.2 6167.9 6262.5 6280.8 6332.3 6343.2 6070.8 6234.8 6259.0 6266.7 6268.8 4791.9 4795.5 4801.3 4822.4 4831.6 4809.8 4814.7 4833.5 4836.7 4836.9 4677.2 4780.5 4790.3 4793.8 4801.9 4807.3 4809.4 4815.4 4817.7 4821.5 4232.8 4240.6 4243.7 4251.7 4254.5 5941.0 5950.9 5965.5 5972.4 5976.9 5468.3 5535.6 5596.9 5613.3 5613.6 6591.4 6595.2 6599.1 6616.4 6625.4 4675.8 4676.4 4695.2 4696.4 4701.1 6672.1 6904.8 6964.7 6975.9 6984.5 4678.5 4698.1 4719.6 4727.5 4728.2 4784.9 4786.9 4788.1 4789.1 4793.7 5524.8 5532.2 5533.7 5543.7 5551.7 6466.5 6644.8 6660.1 6688.0 6749.7 1641.3 1668.5 1684.8 1685.8 1689.0 1089.8 1115.4 1116.0 1134.8 1145.2 6178.5 6238.5 6278.4 6294.1 6326.1 6863.3 6872.8 6873.5 6894.6 6897.7 5975.0 6096.8 6119.4 6119.8 6120.9 3668.2 3671.7 3684.4 3684.6 3688.3 6895.3 6929.6 6954.3 6988.5 7000.6 6762.8 6876.8 6876.9 6961.4 6964.4 6879.0 7059.3 7080.8 7090.5 7117.5 6701.2 6703.4 6747.8 6769.0 6771.3 6662.1 6673.9 6679.9 6687.1 6694.3 7298.7 7308.3 7325.6 7346.0 7364.7 4672.9 4717.6 4722.4 4738.5 4757.1 6740.0 6857.9 6979.2 6994.1 6997.9 6708.3 6729.3 6742.9 6744.4 6750.4 6645.7 6655.7 6689.2 6692.3 6719.3 6405.9 6552.4 6581.5 6583.5 6600.8 6724.1 6726.1 6744.5 6745.2 6747.7 6536.4 6538.2 6570.5 6575.8 6606.5 22:19:49 INFO - PROCESS | 26008 | 22:19:49 INFO - PROCESS | 26008 | [#5] yui.html Cycles:180 Average:12792.89 Median:24436.01 stddev:14890.56 (60.9%) stddev-sans-first:14904.78 22:19:49 INFO - PROCESS | 26008 | Values: 729.5 750.9 759.8 798.7 811.4 11826.9 11912.6 11946.2 11993.0 12079.6 10386.7 11261.9 11267.7 11279.4 11320.5 769.4 782.8 783.2 784.3 785.6 772.7 776.4 780.1 783.4 787.4 833.3 834.1 834.1 837.1 842.4 828.4 829.8 831.5 831.8 833.5 612.5 617.1 617.9 618.0 619.8 11323.0 11337.7 11382.7 11411.9 11428.0 11868.9 11921.3 12023.6 12233.2 12511.4 9427.9 9489.7 9957.5 9976.2 10119.1 3419.1 3455.3 3471.9 3481.9 3610.6 43002.1 43286.4 43294.8 43306.1 43314.8 8892.5 9038.4 9039.5 9116.1 9122.9 17376.8 17381.3 17516.7 17576.9 17620.8 6632.4 6709.7 6761.2 6842.7 6880.2 3688.7 3727.3 3733.5 3737.8 3773.0 3049.1 3082.0 3103.6 3110.4 3118.1 558.8 578.1 586.7 589.3 589.5 482.5 487.5 495.9 591.8 656.6 7935.0 8015.6 8289.6 8301.8 8451.0 511.2 516.7 576.9 606.3 614.5 3750.8 3801.8 3959.4 4011.5 4067.5 53000.5 54009.2 54209.0 54502.0 54698.2 47086.8 48389.5 48486.8 49087.0 49291.0 42437.8 43494.8 43861.0 46054.3 47520.8 7918.4 8335.6 8351.3 8361.1 8389.7 30444.8 31481.4 31693.4 31697.0 31836.2 40219.0 40601.4 41379.0 41572.0 42960.4 9944.7 10146.3 10147.2 10178.8 10218.0 11145.2 11313.9 11340.9 11574.2 12045.7 10688.8 10837.6 11106.9 11122.1 11338.4 10357.6 10449.6 10462.4 11028.7 11365.1 9759.1 10249.9 10409.9 11127.8 11538.7 8099.8 8145.1 8208.9 8355.5 8454.5 8259.1 8335.5 8383.2 8559.2 8587.1 22:19:49 INFO - PROCESS | 26008 | -------- Summary: end -------- 22:19:49 INFO - PROCESS | 26008 | 22:19:50 INFO - TEST-INFO | 26008: exit 0 22:19:50 INFO - TEST-OK | dromaeo_css | took 1110578ms 22:19:50 INFO - TEST-START | kraken 22:19:50 INFO - operating with platform_type : linux_ 22:19:50 INFO - Initialising browser for kraken test... 22:19:50 INFO - TEST-INFO | started process 26251 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjSjt3v/profile http://localhost:42900/getInfo.html) 22:19:54 INFO - PROCESS | 26251 | 22:19:54 INFO - PROCESS | 26251 | (process:26324): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:19:55 INFO - PROCESS | 26251 | __metrics Screen width/height:1600/1200 22:19:55 INFO - PROCESS | 26251 | colorDepth:24 22:19:55 INFO - PROCESS | 26251 | Browser inner width/height: 1024/697 22:19:55 INFO - PROCESS | 26251 | __metrics 22:19:55 INFO - PROCESS | 26251 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:19:56 INFO - TEST-INFO | 26251: exit 0 22:19:56 INFO - Browser initialized. 22:19:56 INFO - Running cycle 1/1 for kraken test... 22:19:56 INFO - TEST-INFO | started process 26373 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjSjt3v/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:19:57 INFO - PROCESS | 26373 | 22:19:57 INFO - PROCESS | 26373 | (process:26432): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:20:07 INFO - PROCESS | 26373 | RSS: Main: 152354816 22:20:07 INFO - PROCESS | 26373 | 22:20:10 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:42900/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42900/tests/kraken/driver.html?testName=audio-beat-detection) 22:20:10 INFO - PROCESS | 26373 | RSS: Main: 156332032 22:20:10 INFO - PROCESS | 26373 | 22:20:13 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:42900/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42900/tests/kraken/driver.html?testName=audio-dft) 22:20:14 INFO - PROCESS | 26373 | RSS: Main: 158900224 22:20:14 INFO - PROCESS | 26373 | 22:20:17 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:42900/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42900/tests/kraken/driver.html?testName=audio-fft) 22:20:17 INFO - PROCESS | 26373 | RSS: Main: 151539712 22:20:17 INFO - PROCESS | 26373 | 22:20:19 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:42900/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42900/tests/kraken/driver.html?testName=audio-oscillator) 22:20:20 INFO - PROCESS | 26373 | RSS: Main: 152064000 22:20:20 INFO - PROCESS | 26373 | 22:20:22 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:42900/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42900/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:20:23 INFO - PROCESS | 26373 | RSS: Main: 151519232 22:20:23 INFO - PROCESS | 26373 | 22:20:26 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:42900/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42900/tests/kraken/driver.html?testName=imaging-darkroom) 22:20:26 INFO - PROCESS | 26373 | RSS: Main: 151416832 22:20:26 INFO - PROCESS | 26373 | 22:20:30 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:42900/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42900/tests/kraken/driver.html?testName=imaging-desaturate) 22:20:30 INFO - PROCESS | 26373 | RSS: Main: 153399296 22:20:30 INFO - PROCESS | 26373 | 22:20:33 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:42900/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42900/tests/kraken/driver.html?testName=json-parse-financial) 22:20:34 INFO - PROCESS | 26373 | RSS: Main: 154210304 22:20:34 INFO - PROCESS | 26373 | 22:20:35 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:42900/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42900/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:20:36 INFO - PROCESS | 26373 | RSS: Main: 154763264 22:20:36 INFO - PROCESS | 26373 | 22:20:38 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:42900/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42900/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:20:38 INFO - PROCESS | 26373 | RSS: Main: 153960448 22:20:38 INFO - PROCESS | 26373 | 22:20:40 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:42900/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42900/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:20:41 INFO - PROCESS | 26373 | RSS: Main: 155058176 22:20:41 INFO - PROCESS | 26373 | 22:20:43 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:42900/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42900/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:20:44 INFO - PROCESS | 26373 | RSS: Main: 154759168 22:20:44 INFO - PROCESS | 26373 | 22:20:47 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:42900/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42900/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:20:47 INFO - PROCESS | 26373 | RSS: Main: 155799552 22:20:47 INFO - PROCESS | 26373 | 22:20:49 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:42900/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42900/tests/kraken/driver.html?testName=ai-astar) 22:20:49 INFO - PROCESS | 26373 | RSS: Main: 156037120 22:20:49 INFO - PROCESS | 26373 | 22:20:49 INFO - PROCESS | 26373 | __start_tp_report 22:20:49 INFO - PROCESS | 26373 | _x_x_mozilla_page_load 22:20:49 INFO - PROCESS | 26373 | _x_x_mozilla_page_load_details 22:20:49 INFO - PROCESS | 26373 | |i|pagename|runs| 22:20:49 INFO - PROCESS | 26373 | |0;ai-astar;111;106;111;112;113;127;111;114;111;113 22:20:49 INFO - PROCESS | 26373 | |1;audio-beat-detection;158;124;156;166;134;161;160;128;168;129 22:20:49 INFO - PROCESS | 26373 | |2;audio-dft;163;163;163;164;165;163;162;164;164;163 22:20:49 INFO - PROCESS | 26373 | |3;audio-fft;75;76;73;73;77;139;75;74;73;74 22:20:49 INFO - PROCESS | 26373 | |4;audio-oscillator;97;97;142;95;96;96;145;96;97;140 22:20:49 INFO - PROCESS | 26373 | |5;imaging-gaussian-blur;109;109;109;109;110;110;110;111;110;110 22:20:49 INFO - PROCESS | 26373 | |6;imaging-darkroom;147;147;148;148;147;147;147;148;147;145 22:20:49 INFO - PROCESS | 26373 | |7;imaging-desaturate;96;97;97;97;98;97;96;96;97;96 22:20:49 INFO - PROCESS | 26373 | |8;json-parse-financial;60;60;60;58;61;59;60;58;75;57 22:20:49 INFO - PROCESS | 26373 | |9;json-stringify-tinderbox;67;67;66;68;67;67;67;68;71;68 22:20:49 INFO - PROCESS | 26373 | |10;stanford-crypto-aes;80;81;88;84;84;83;83;84;87;92 22:20:49 INFO - PROCESS | 26373 | |11;stanford-crypto-ccm;128;119;117;114;115;124;126;125;116;118 22:20:49 INFO - PROCESS | 26373 | |12;stanford-crypto-pbkdf2;136;151;148;148;144;135;135;151;144;138 22:20:49 INFO - PROCESS | 26373 | |13;stanford-crypto-sha256-iterative;69;69;67;66;70;66;68;69;71;68 22:20:49 INFO - PROCESS | 26373 | __end_tp_report 22:20:49 INFO - PROCESS | 26373 | __start_cc_report 22:20:49 INFO - PROCESS | 26373 | _x_x_mozilla_cycle_collect,734 22:20:49 INFO - PROCESS | 26373 | __end_cc_report 22:20:49 INFO - PROCESS | 26373 | __startTimestamp1453530049602__endTimestamp 22:20:49 INFO - PROCESS | 26373 | 22:20:49 INFO - PROCESS | 26373 | ------- Summary: start ------- 22:20:49 INFO - PROCESS | 26373 | Number of tests: 14 22:20:49 INFO - PROCESS | 26373 | 22:20:49 INFO - PROCESS | 26373 | [#0] ai-astar Cycles:10 Average:112.90 Median:112.50 stddev:5.40 (4.8%) stddev-sans-first:5.69 22:20:49 INFO - PROCESS | 26373 | Values: 111.0 106.0 111.0 112.0 113.0 127.0 111.0 114.0 111.0 113.0 22:20:49 INFO - PROCESS | 26373 | 22:20:49 INFO - PROCESS | 26373 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:159.00 stddev:17.42 (11.0%) stddev-sans-first:18.13 22:20:49 INFO - PROCESS | 26373 | Values: 158.0 124.0 156.0 166.0 134.0 161.0 160.0 128.0 168.0 129.0 22:20:49 INFO - PROCESS | 26373 | 22:20:49 INFO - PROCESS | 26373 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:0.84 (0.5%) stddev-sans-first:0.88 22:20:49 INFO - PROCESS | 26373 | Values: 163.0 163.0 163.0 164.0 165.0 163.0 162.0 164.0 164.0 163.0 22:20:49 INFO - PROCESS | 26373 | 22:20:49 INFO - PROCESS | 26373 | [#3] audio-fft Cycles:10 Average:80.90 Median:74.50 stddev:20.46 (27.5%) stddev-sans-first:21.59 22:20:49 INFO - PROCESS | 26373 | Values: 75.0 76.0 73.0 73.0 77.0 139.0 75.0 74.0 73.0 74.0 22:20:49 INFO - PROCESS | 26373 | 22:20:49 INFO - PROCESS | 26373 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:96.00 stddev:22.28 (23.2%) stddev-sans-first:23.13 22:20:49 INFO - PROCESS | 26373 | Values: 97.0 97.0 142.0 95.0 96.0 96.0 145.0 96.0 97.0 140.0 22:20:49 INFO - PROCESS | 26373 | 22:20:49 INFO - PROCESS | 26373 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 22:20:49 INFO - PROCESS | 26373 | Values: 109.0 109.0 109.0 109.0 110.0 110.0 110.0 111.0 110.0 110.0 22:20:49 INFO - PROCESS | 26373 | 22:20:49 INFO - PROCESS | 26373 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 22:20:49 INFO - PROCESS | 26373 | Values: 147.0 147.0 148.0 148.0 147.0 147.0 147.0 148.0 147.0 145.0 22:20:49 INFO - PROCESS | 26373 | 22:20:49 INFO - PROCESS | 26373 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 22:20:49 INFO - PROCESS | 26373 | Values: 96.0 97.0 97.0 97.0 98.0 97.0 96.0 96.0 97.0 96.0 22:20:49 INFO - PROCESS | 26373 | 22:20:49 INFO - PROCESS | 26373 | [#8] json-parse-financial Cycles:10 Average:60.80 Median:60.00 stddev:5.14 (8.6%) stddev-sans-first:5.44 22:20:49 INFO - PROCESS | 26373 | Values: 60.0 60.0 60.0 58.0 61.0 59.0 60.0 58.0 75.0 57.0 22:20:49 INFO - PROCESS | 26373 | 22:20:49 INFO - PROCESS | 26373 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:67.50 stddev:1.35 (2.0%) stddev-sans-first:1.41 22:20:49 INFO - PROCESS | 26373 | Values: 67.0 67.0 66.0 68.0 67.0 67.0 67.0 68.0 71.0 68.0 22:20:49 INFO - PROCESS | 26373 | 22:20:49 INFO - PROCESS | 26373 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.00 stddev:3.53 (4.2%) stddev-sans-first:3.33 22:20:49 INFO - PROCESS | 26373 | Values: 80.0 81.0 88.0 84.0 84.0 83.0 83.0 84.0 87.0 92.0 22:20:49 INFO - PROCESS | 26373 | 22:20:49 INFO - PROCESS | 26373 | [#11] stanford-crypto-ccm Cycles:10 Average:120.20 Median:121.50 stddev:5.07 (4.2%) stddev-sans-first:4.53 22:20:49 INFO - PROCESS | 26373 | Values: 128.0 119.0 117.0 114.0 115.0 124.0 126.0 125.0 116.0 118.0 22:20:49 INFO - PROCESS | 26373 | 22:20:49 INFO - PROCESS | 26373 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.00 Median:146.00 stddev:6.51 (4.5%) stddev-sans-first:6.40 22:20:49 INFO - PROCESS | 26373 | Values: 136.0 151.0 148.0 148.0 144.0 135.0 135.0 151.0 144.0 138.0 22:20:49 INFO - PROCESS | 26373 | 22:20:49 INFO - PROCESS | 26373 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:69.00 stddev:1.64 (2.4%) stddev-sans-first:1.72 22:20:49 INFO - PROCESS | 26373 | Values: 69.0 69.0 67.0 66.0 70.0 66.0 68.0 69.0 71.0 68.0 22:20:49 INFO - PROCESS | 26373 | -------- Summary: end -------- 22:20:49 INFO - PROCESS | 26373 | 22:20:50 INFO - TEST-INFO | 26373: exit 0 22:20:50 INFO - TEST-OK | kraken | took 60082ms 22:20:50 INFO - TEST-START | v8_7 22:20:50 INFO - operating with platform_type : linux_ 22:20:50 INFO - Initialising browser for v8_7 test... 22:20:50 INFO - TEST-INFO | started process 26660 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuyo4NT/profile http://localhost:42900/getInfo.html) 22:20:54 INFO - PROCESS | 26660 | 22:20:54 INFO - PROCESS | 26660 | (process:26732): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:20:54 INFO - PROCESS | 26660 | __metrics Screen width/height:1600/1200 22:20:54 INFO - PROCESS | 26660 | colorDepth:24 22:20:54 INFO - PROCESS | 26660 | Browser inner width/height: 1024/697 22:20:54 INFO - PROCESS | 26660 | __metrics 22:20:55 INFO - PROCESS | 26660 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:20:55 INFO - TEST-INFO | 26660: exit 0 22:20:55 INFO - Browser initialized. 22:20:55 INFO - Running cycle 1/1 for v8_7 test... 22:20:55 INFO - TEST-INFO | started process 26781 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuyo4NT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:20:57 INFO - PROCESS | 26781 | 22:20:57 INFO - PROCESS | 26781 | (process:26839): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:21:07 INFO - PROCESS | 26781 | RSS: Main: 151592960 22:21:07 INFO - PROCESS | 26781 | 22:21:30 INFO - PROCESS | 26781 | Cycle 1(1): loaded http://localhost:42900/tests/v8_7/run.html (next: http://localhost:42900/tests/v8_7/run.html) 22:21:30 INFO - PROCESS | 26781 | RSS: Main: 151416832 22:21:30 INFO - PROCESS | 26781 | 22:21:30 INFO - PROCESS | 26781 | __start_tp_report 22:21:30 INFO - PROCESS | 26781 | _x_x_mozilla_page_load 22:21:30 INFO - PROCESS | 26781 | _x_x_mozilla_page_load_details 22:21:30 INFO - PROCESS | 26781 | |i|pagename|runs| 22:21:30 INFO - PROCESS | 26781 | |0;Richards;167.6727028839705 22:21:30 INFO - PROCESS | 26781 | |1;DeltaBlue;189.28639030853682 22:21:30 INFO - PROCESS | 26781 | |2;Encrypt;280.8988764044944 22:21:30 INFO - PROCESS | 26781 | |3;Decrypt;5273.684210526316 22:21:30 INFO - PROCESS | 26781 | |4;RayTrace;1078.7486515641856 22:21:30 INFO - PROCESS | 26781 | |5;Earley;786.331500392773 22:21:30 INFO - PROCESS | 26781 | |6;Boyer;12500 22:21:30 INFO - PROCESS | 26781 | |7;RegExp;40725.490196078434 22:21:30 INFO - PROCESS | 26781 | |8;Splay;580.7935595169638 22:21:30 INFO - PROCESS | 26781 | |9;NavierStokes;4826.923076923077 22:21:30 INFO - PROCESS | 26781 | __end_tp_report 22:21:30 INFO - PROCESS | 26781 | __startTimestamp1453530090590__endTimestamp 22:21:30 INFO - PROCESS | 26781 | 22:21:30 INFO - PROCESS | 26781 | ------- Summary: start ------- 22:21:30 INFO - PROCESS | 26781 | Number of tests: 10 22:21:30 INFO - PROCESS | 26781 | 22:21:30 INFO - PROCESS | 26781 | [#0] Richards Cycles:1 Average:167.67 Median:167.67 stddev:0.00 (0.0%) 22:21:30 INFO - PROCESS | 26781 | Values: 167.7 22:21:30 INFO - PROCESS | 26781 | 22:21:30 INFO - PROCESS | 26781 | [#1] DeltaBlue Cycles:1 Average:189.29 Median:189.29 stddev:0.00 (0.0%) 22:21:30 INFO - PROCESS | 26781 | Values: 189.3 22:21:30 INFO - PROCESS | 26781 | 22:21:30 INFO - PROCESS | 26781 | [#2] Encrypt Cycles:1 Average:280.90 Median:280.90 stddev:0.00 (0.0%) 22:21:30 INFO - PROCESS | 26781 | Values: 280.9 22:21:30 INFO - PROCESS | 26781 | 22:21:30 INFO - PROCESS | 26781 | [#3] Decrypt Cycles:1 Average:5273.68 Median:5273.68 stddev:0.00 (0.0%) 22:21:30 INFO - PROCESS | 26781 | Values: 5273.7 22:21:30 INFO - PROCESS | 26781 | 22:21:30 INFO - PROCESS | 26781 | [#4] RayTrace Cycles:1 Average:1078.75 Median:1078.75 stddev:0.00 (0.0%) 22:21:30 INFO - PROCESS | 26781 | Values: 1078.7 22:21:30 INFO - PROCESS | 26781 | 22:21:30 INFO - PROCESS | 26781 | [#5] Earley Cycles:1 Average:786.33 Median:786.33 stddev:0.00 (0.0%) 22:21:30 INFO - PROCESS | 26781 | Values: 786.3 22:21:30 INFO - PROCESS | 26781 | 22:21:30 INFO - PROCESS | 26781 | [#6] Boyer Cycles:1 Average:12500.00 Median:12500.00 stddev:0.00 (0.0%) 22:21:30 INFO - PROCESS | 26781 | Values: 12500.0 22:21:30 INFO - PROCESS | 26781 | 22:21:30 INFO - PROCESS | 26781 | [#7] RegExp Cycles:1 Average:40725.49 Median:40725.49 stddev:0.00 (0.0%) 22:21:30 INFO - PROCESS | 26781 | Values: 40725.5 22:21:30 INFO - PROCESS | 26781 | 22:21:30 INFO - PROCESS | 26781 | [#8] Splay Cycles:1 Average:580.79 Median:580.79 stddev:0.00 (0.0%) 22:21:30 INFO - PROCESS | 26781 | Values: 580.8 22:21:30 INFO - PROCESS | 26781 | 22:21:30 INFO - PROCESS | 26781 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 22:21:30 INFO - PROCESS | 26781 | Values: 4826.9 22:21:30 INFO - PROCESS | 26781 | -------- Summary: end -------- 22:21:30 INFO - PROCESS | 26781 | 22:21:31 INFO - TEST-INFO | 26781: exit 0 22:21:31 INFO - TEST-OK | v8_7 | took 41005ms 22:21:31 INFO - SUITE-END | took 1211s 22:21:31 INFO - Completed test suite (00:20:12) 22:21:31 INFO - Working with test: dromaeo_css 22:21:31 INFO - Generating results file: dromaeo_css 22:21:31 INFO - Working with test: kraken 22:21:31 INFO - Generating results file: kraken 22:21:31 INFO - javascript benchmark 22:21:31 INFO - Working with test: v8_7 22:21:31 INFO - Generating results file: v8_7 22:21:31 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:21:32 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 22:21:32 INFO - process_Request line: dromaeo_css 6718.82 graph.html#tests=[[72,63,43]] 22:21:32 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:21:32 INFO - process_Request line: kraken 1513.70 graph.html#tests=[[232,63,43]] 22:21:32 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:21:32 INFO - process_Request line: v8_7 20163.04 graph.html#tests=[[230,63,43]] 22:21:32 INFO - RETURN: dromaeo_css: 6718.82 22:21:32 INFO - RETURN: kraken: 1513.70 22:21:32 INFO - RETURN: v8_7: 20163.04 22:21:32 INFO - javascript benchmark 22:21:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3110.4867696830024, 3156.33716919447, 3167.5882135322418, 3192.9999999999995, 3204.823734694594, 5149.845504634863, 5186.585073194149, 5206.114960456722, 5208.114620514521, 5223.294855194547, 5276.076686579842, 5279.973600131994, 5297.708626025567, 5313.3092697949305, 5323.0, 4813.49458306878, 4823.638227132961, 4837.346958160639, 4916.729579873106, 4947.936193718349, 4913.091078150535, 4934.80260789568, 4966.180580204262, 4985.052839960396, 4991.900161996758, 4790.257510085925, 4818.855434336958, 4845.466998630148, 4908.558229759339, 4927.0, 4835.202191638411, 4854.563089321978, 4856.223004319328, 4861.368022157097, 4897.3878265216845, 4732.384789977281, 4825.469198388175, 4837.32277481153, 4853.223484242504, 4887.8778030549165, 5158.329417175743, 5194.610404219661, 5195.064888320101, 5196.168613021899, 5219.086659834514, 5714.200011998323, 5739.684317362543, 5742.253507044099, 5763.827085187451, 5765.394633563499, 5676.602637815355, 5763.221965034709, 5792.942070579283, 5793.913091303634, 5821.53427725781, 5326.387465441485, 5346.331708536433, 5348.598855085923, 5350.491703288181, 5366.597505187126, 5785.334686511105, 5818.5345172386105, 5825.679587622722, 5833.970830145822, 5836.824895253064, 5426.620136590401, 5477.3427188737605, 5549.500544950893, 5621.80323688669, 5636.070048441961, 5686.061799802987, 5720.513756330675, 5722.828315150552, 5723.227364305849, 5735.799247026334, 5650.463205995424, 5653.180288858092, 5661.518770904437, 5671.2060311556415, 5681.289838770153, 5413.539849112791, 5556.499915007668, 5655.943440565624, 5670.886582268414, 5719.370869204384, 4363.585459381354, 4375.234333991539, 4379.0585024219945, 4392.1874453226255, 4394.824207031683, 3936.724429289922, 3947.4670919426085, 3948.309045916953, 3955.6835453163676, 4016.2369149861433, 5294.523492885582, 5331.866703332447, 5347.25138480613, 5354.089804733205, 5358.5981051421295, 5721.056025755704, 5725.341585717612, 5731.713414329267, 5772.134179872969, 5779.3642699303045, 5233.084210263189, 5254.632175747661, 5264.0, 5265.183896496049, 5279.0, 4782.33047373368, 4808.759562021885, 4824.855254342376, 4850.563449289581, 4857.465678775332, 5898.528117750569, 5930.377310382434, 5932.0508718604815, 5933.851653708605, 5985.9401405986255, 5526.115821468546, 5535.308086489189, 5541.833744987657, 5605.075162598126, 5616.550675945996, 5789.942100579109, 5830.096335068071, 5832.0, 5878.735456904364, 5913.379095194942, 5591.804286849941, 5618.073017951992, 5632.5775566831835, 5635.323761148688, 5686.317641883001, 5686.687232202103, 5702.486776190163, 5709.20071190042, 5713.428657134254, 5717.742701578522, 5390.811321603882, 5461.371942226695, 5467.0, 5558.555315574664, 5577.8047768327915, 5520.420355862577, 5566.832995010156, 5577.442255774552, 5582.0231459495235, 5606.215129881738, 5417.214503896992, 5445.428230035947, 5456.945430545644, 5475.972620136874, 5477.561795056466, 5497.5601951842955, 5522.392536820867, 5542.140968149944, 5604.047311957059, 5631.577631677723, 5417.83746487606, 5445.074337362737, 5466.726663666721, 5487.5609951203005, 5505.366882808528], "unit": "score", "name": "dojo.html", "value": 5240.618296775943}, {"lowerIsBetter": false, "replicates": [549.727884697075, 555.4195865320739, 563.6449037106622, 567.7133047810855, 578.5400606517818, 35569.644303556954, 36380.81809590952, 36413.81793091037, 36468.088297792565, 36472.63527364729, 41305.0, 42941.7852910735, 42991.35512967308, 43015.3547696784, 43243.78378108113, 8552.486850788942, 8714.738557843275, 8733.257673097794, 8745.038045814956, 8748.781280467976, 8547.358948078889, 8634.050254472035, 8686.782830429227, 8688.174623410798, 8700.26047785939, 8665.09016553259, 8781.912180878173, 8787.560621968907, 8789.340799440035, 8794.208521233088, 8456.577171141449, 8470.068292487822, 8511.574421278974, 8702.30381569473, 8705.912940870638, 8490.0, 8610.0, 8639.568021598958, 8647.308215342757, 8657.26413254874, 38788.22423551513, 38849.80575097135, 39003.21993560141, 39055.804720976215, 39431.0, 3084.8920287790042, 3113.143885431502, 3125.6405513366026, 3130.0, 3133.3106716522557, 29099.0, 29554.556681649792, 29579.0, 29580.260493487618, 30825.0, 3883.1457079442475, 3974.5826688197903, 3988.840446382141, 4054.5945405459515, 4106.384042393635, 253089.0, 253905.0, 255504.0, 255901.0, 257945.0, 42402.78798605987, 42957.35563966543, 42979.57020429818, 54810.0, 55409.16886246709, 40487.0, 40510.594894051275, 40620.593794062275, 40669.0, 40684.79657601693, 12236.143469957196, 12391.93804030992, 12395.132340736242, 12395.75208495825, 12424.37878106091, 9825.361351512129, 9890.950545247228, 9936.80758308993, 10002.049805268487, 10027.548760305805, 14109.506167284097, 14128.0, 14267.571972840831, 14316.85683143176, 14382.35279412429, 5689.6586204827845, 5717.742701578356, 5805.535557155417, 5851.795187168429, 5869.266341707286, 960.3661583355092, 984.6602921991902, 999.9500024998721, 1001.234055947201, 1091.9563217471211, 27033.23365400461, 27570.724292757215, 27577.896884124813, 27938.580921286197, 30239.395212095635, 998.4608311511847, 1001.519270750044, 1003.5427950709735, 1032.0402026115635, 1096.5997410944947, 13594.0, 13629.386677599334, 13749.725005499835, 13897.930510347383, 13948.372323245276, 383877.0, 388394.0, 388564.0, 388820.0, 389722.0, 52710.472895270555, 52743.736281319114, 52780.0, 52825.207621885704, 53341.733291333294, 1309.3191540398939, 1326.9601911942657, 1328.130074801007, 1328.9069765116542, 1339.9531016414378, 25672.61491077598, 26168.60747088757, 26263.0, 26676.19971400861, 26779.196624101307, 39989.0, 40722.77831665055, 41133.794331028155, 41475.37786933138, 41510.79244603758, 306678.0, 307393.0, 307894.0, 308384.0, 309064.0, 32151.356972859943, 42974.355384668626, 43299.567004329554, 43749.34375984299, 43966.56033439624, 38660.420093698056, 38996.41505377365, 39244.60755392409, 39552.40671389874, 39664.60335396609, 34929.65070349366, 35009.12477188091, 35439.82280088583, 35528.64471355253, 35761.64238357583, 36185.63814361928, 36188.63811361853, 36314.4552831713, 36560.45159322665, 36703.632963670025, 35359.46960795538, 35609.0, 35788.82105589456, 35826.64173358233, 35949.820250899626, 30414.84792576023, 32074.83962580172, 32419.513707293936, 33140.0, 33163.17092072718, 24239.272821815375, 24682.753172468765, 24714.629280561167, 24947.376315592257, 25026.0], "unit": "score", "name": "ext.html", "value": 17578.303238666434}, {"lowerIsBetter": false, "replicates": [367.1225770408722, 368.13121034358915, 369.44583125312033, 369.5343866727922, 370.60530534980245, 15362.0, 16256.0, 16522.0, 17081.402150924703, 17191.0, 10378.377297362164, 10563.313384630013, 10737.40944248066, 10843.891561084387, 10906.291091079074, 4883.365162528867, 5044.974775126119, 5053.696778193302, 5062.772175252123, 5402.297701298826, 5313.946860531384, 5362.8123015694455, 5373.0, 5375.381831089436, 5382.515573598375, 5089.898202035975, 5159.535641792257, 5296.285001524802, 5306.389765176996, 5343.519083282504, 5215.869603259911, 5225.399079105913, 5257.684538927677, 5269.947300526984, 5553.139263414178, 5301.443348448396, 5330.413654498002, 5348.545373643245, 5352.705601191933, 5356.491133342326, 11918.404079795975, 12595.622131336075, 12660.303683297416, 12689.048321375842, 12693.809592856114, 1958.2460752610205, 2012.4365177750253, 2050.046728271346, 2079.511314841011, 2133.434639820449, 9022.413543119676, 9477.383970041925, 9609.711708648752, 11472.25430347033, 12217.205881617667, 1732.7314266288745, 1789.6957517221974, 1794.0760508338217, 1817.3366721146817, 1825.9087045647664, 52384.73807630975, 52591.47408525904, 53166.734166329305, 55256.0, 55522.16716749252, 10006.0, 10181.440020798778, 10199.337043092175, 10200.183985281159, 10230.23273254509, 13324.73350532984, 13353.799693004612, 13359.064865459519, 13375.732485350432, 13410.798838017437, 6744.0895479109695, 6770.898436523456, 6783.932160678429, 6790.083338749206, 6847.452203823682, 6257.2491301044165, 6260.311365749764, 6274.592151510137, 6278.623282603058, 6308.842278943063, 4436.467623885154, 4456.175607512556, 4509.7970591323465, 4511.481179664315, 4548.476925153584, 1810.5473631592101, 1834.7247912813184, 1856.4430670798977, 1882.4352694191687, 1900.3918746001423, 916.0, 929.702495201529, 975.9414435133915, 978.4911845840123, 1003.6437064842022, 15384.923075384551, 15588.0, 15642.843571564366, 15737.44918927832, 16001.679966400607, 867.6095756909416, 877.4647465046316, 905.1220316293185, 925.6760133953062, 931.1340453378423, 8866.512341821133, 9303.116203960613, 9305.348625596278, 9622.182114520345, 9800.0, 145561.0, 146208.0, 146230.0, 146698.0, 147140.26429867998, 66891.0, 66898.66550667313, 69473.0, 69507.0, 70686.87100983453, 1078.6224821312635, 1102.4983632447218, 1102.7518808268076, 1103.194667892443, 1113.0, 15223.771643425136, 15444.30500627497, 15477.226138693246, 15490.9225453872, 15790.9210453947, 31924.0, 32605.836970814995, 32813.343733124726, 33443.66556334503, 33878.15304617404, 40206.798966004986, 41799.0, 42515.7874210627, 43843.780781097164, 44964.0, 7075.540089894141, 7122.109736282965, 7213.819654508469, 7322.597257150908, 7613.885791713239, 10409.219308551737, 10658.0, 11177.552897883994, 11221.831672525082, 11237.3257604544, 9351.485668288038, 9545.47499887485, 9749.025097490194, 9958.900410995797, 10261.179105671677, 9232.630694772133, 9264.629414823601, 9868.358556693793, 9966.40201587907, 10395.740106497398, 8865.867011994696, 9440.197583205505, 9453.716388508356, 9533.761655958657, 9611.951940240255, 7168.247334029852, 7336.7432139874845, 7376.7418140364825, 7385.335319821242, 7398.889016664862, 8112.148224436349, 9579.521023948635, 9582.425054496753, 9767.730195074595, 9772.413655180711], "unit": "score", "name": "jquery.html", "value": 7589.860824963477}, {"lowerIsBetter": false, "replicates": [1374.24416570886, 1386.6117487103609, 1494.1931357067185, 1701.310969057532, 1717.235830055625, 7601.8479630407355, 7799.688012479501, 7806.0, 7833.843323133534, 8029.317508011812, 7930.484518506308, 7962.681492740284, 8032.879506807388, 8050.758477245678, 8061.153578874222, 2320.141547627372, 2342.145117032288, 2343.9179628713, 2344.074090734159, 2347.190219374313, 2363.7518060603647, 2370.0282884017556, 2397.3407312988893, 2405.1341517053847, 2405.9518809623796, 2173.619616567102, 2223.0996446439217, 2224.5884511365366, 2291.0721157931066, 2308.7691230876944, 2326.6626339180893, 2334.7198336199594, 2341.894614742332, 2351.8941647625898, 2352.223766157164, 2317.73346065203, 2329.79031887131, 2334.5914464968732, 2337.836351455399, 2340.1107579119994, 7659.119201291867, 7736.149023607399, 7738.148803631596, 7744.961275193645, 7750.689972401097, 4705.4588722296685, 4796.160671882441, 4835.226363781813, 4842.104210721028, 4873.512648735134, 3063.6936306369184, 3093.257618171645, 3172.873085076594, 3181.109289398972, 3187.729043031345, 974.6539978307741, 991.2466525440645, 993.0665174735725, 1004.6684594084007, 1023.8157131716288, 10463.895361046369, 10493.317934334244, 10507.474626268657, 10515.05364517197, 10581.629642962536, 4181.142865712522, 4186.832526698898, 4191.889149375418, 4212.283911735012, 4383.846565370197, 8472.703455379033, 8588.957055214809, 8619.698310559226, 8628.180322869317, 8637.395382323177, 4633.166030114544, 4646.070785842845, 4648.325992731103, 4651.09303685778, 4666.836660716926, 4246.0, 4250.06498570314, 4253.234417804825, 4289.463817022872, 4293.377460268243, 3498.5626796650417, 3513.9297214055578, 3515.0333658243676, 3520.2607452435277, 3544.379733546619, 1052.1004541117234, 1101.4492753623188, 1114.9777004459866, 1117.173291764105, 1118.3457677258896, 860.9883387020226, 1043.7338478687886, 1045.529511719714, 1132.1395739238237, 1340.088739657023, 6994.265602111806, 7001.649917504104, 7014.158301003912, 7035.085438892911, 7036.577805331696, 1146.1747541769912, 1158.5481662151767, 1189.3102000839492, 1192.4753108632174, 1213.5449206547544, 5745.195672605755, 5806.303243610793, 5809.82570522885, 5810.738516766755, 5827.4172582741385, 9063.864042039375, 9070.18368346852, 9246.0, 9329.906700932905, 9371.531423428802, 9088.363814533051, 9136.725898223063, 9184.035676253898, 9216.21662158724, 9254.213391861633, 7290.4896657233485, 7304.671289791866, 7350.779476615817, 7416.888746668804, 7431.145418276968, 7019.982102595197, 7029.226785053538, 7050.2597227292445, 7084.397826184832, 7094.184168820445, 7959.0, 8294.875576866472, 8366.707165249187, 8386.32909367237, 8654.134586541295, 8402.915970840213, 8614.569271536273, 8616.310695144499, 8621.13788621158, 8699.956500217459, 6801.2858649841055, 6943.861122777617, 7021.824454388681, 7032.964835175791, 7058.54119482232, 7419.703211871681, 7449.180590135189, 7476.140243871807, 7486.213947535431, 7502.399808015455, 6470.902936456051, 6986.54587451814, 7102.3962963148715, 7152.356287933902, 7224.855502890018, 6784.050232967487, 6814.727410903508, 6819.352161544645, 6822.351876571718, 6902.378785909293, 6614.636195009129, 6623.437007854386, 6629.867402651824, 6644.302348253557, 6650.83372915681, 6273.780417685359, 6299.779507717208, 6339.778107766206, 6339.809805705836, 6360.9045864313, 6355.1420558224045, 6379.585326953733, 6413.134226879311, 6494.577852439576, 6530.151080359523], "unit": "score", "name": "mootools.html", "value": 4464.78830895008}, {"lowerIsBetter": false, "replicates": [351.8909138167168, 353.87614334982777, 354.15003990422997, 356.5863598226057, 362.1905042230614, 6167.907481387782, 6262.530310226734, 6280.842978925529, 6332.3351048139975, 6343.23881134264, 6070.817875463743, 6234.84412889678, 6258.968705156479, 6266.655333956631, 6268.780592679257, 4791.928121078186, 4795.520447955194, 4801.327814106028, 4822.421309442854, 4831.613470922335, 4809.7835597398025, 4814.711117332954, 4833.468318484964, 4836.733979631119, 4836.854894353175, 4677.181493238687, 4780.450248221447, 4790.281457781326, 4793.784279707422, 4801.927971080437, 4807.278908163768, 4809.374781278429, 4815.398075240595, 4817.662763606531, 4821.493743156953, 4232.830686772525, 4240.554741752133, 4243.66050715945, 4251.744895306291, 4254.489461264668, 5940.960331941893, 5950.851228719273, 5965.4631083202285, 5972.432618901197, 5976.9402305977255, 5468.2891224141, 5535.640183388067, 5596.908602822451, 5613.298337707786, 5613.635113717636, 6591.406773390418, 6595.175603049619, 6599.142111525471, 6616.437602803768, 6625.436837868739, 4675.766211689436, 4676.368690226844, 4695.225287827504, 4696.3894693689945, 4701.083288758693, 6672.132622759011, 6904.758333458355, 6964.651767411659, 6975.895361569581, 6984.546004509691, 4678.532146785295, 4698.083873644607, 4719.598834099072, 4727.527247275245, 4728.196206644879, 4784.880377990508, 4786.856394308176, 4788.090262850047, 4789.137955168103, 4793.712377257306, 5524.8342549723575, 5532.197831314437, 5533.723313834292, 5543.695096769636, 5551.72241387929, 6466.482681385478, 6644.767433139817, 6660.067590537328, 6687.966560167168, 6749.730010799513, 1641.253229780447, 1668.4660908509404, 1684.8399402056784, 1685.7977042754949, 1688.991555042217, 1089.8474213609943, 1115.3865374044406, 1115.966521004371, 1134.7673726885969, 1145.2269717940358, 6178.505719542426, 6238.500919926395, 6278.434940855345, 6294.087357333161, 6326.145970294044, 6863.347981941708, 6872.793816185523, 6873.487832676803, 6894.620795856175, 6897.689603967833, 5974.970125149346, 6096.786612468542, 6119.388061193934, 6119.755209791559, 6120.938790612126, 3668.229671768905, 3671.742977991515, 3684.3552378333684, 3684.631536846294, 3688.2807852469045, 6895.34494223048, 6929.5842249465195, 6954.3045695431065, 6988.545744526589, 7000.649967501605, 6762.763303284361, 6876.828079298058, 6876.931230687629, 6961.40828029613, 6964.373206411447, 6879.036934829128, 7059.270478732743, 7080.822979425556, 7090.468214883905, 7117.466190035768, 6701.229358623626, 6703.4302084321425, 6747.763828265987, 6769.0, 6771.322867713189, 6662.133922590032, 6673.866522669422, 6679.8664026718225, 6687.063811066552, 6694.297098804555, 7298.708051678086, 7308.30571095745, 7325.597092159983, 7346.0, 7364.668589913574, 4672.906541869075, 4717.551832576037, 4722.38608980844, 4738.526147385234, 4757.09615173116, 6740.022696708852, 6857.897131542931, 6979.232284448605, 6994.055802466602, 6997.860042799217, 6708.262091170065, 6729.327067293428, 6742.898856517058, 6744.359285867835, 6750.35871592198, 6645.6677166140535, 6655.73377064912, 6689.163854518185, 6692.297308782508, 6719.328067193242, 6405.8718825624155, 6552.443042341454, 6581.506387021088, 6583.539152259296, 6600.8349791255605, 6724.125863637696, 6726.091977582963, 6744.494162937897, 6745.156855393076, 6747.696353664195, 6536.411722944958, 6538.1500404947055, 6570.47436205112, 6575.80272591823, 6606.471482281502], "unit": "score", "name": "prototype.html", "value": 5012.082724532344}, {"lowerIsBetter": false, "replicates": [729.5258082246536, 750.8535835512075, 759.7682706774439, 798.7483942558092, 811.4360519438992, 11826.881731182686, 11912.583059592916, 11946.223495472788, 11993.04055675546, 12079.637610871678, 10386.740331491717, 11261.943690281558, 11267.661970140909, 11279.37963412012, 11320.490577923993, 769.4190885881166, 782.8434313137367, 783.2402569507568, 784.2667106255641, 785.6268272570512, 772.6561680052379, 776.4487214077983, 780.1145699630931, 783.3967844759532, 787.4015748031509, 833.291702053253, 834.1450013735908, 834.1491678487939, 837.1252041616495, 842.3724325377602, 828.3994104274414, 829.8008477965245, 831.4969443486694, 831.7795784117213, 833.5248908122372, 612.5436549770405, 617.0990354083044, 617.941295576924, 618.0389494336305, 619.8171539395889, 11323.0, 11337.716557086138, 11382.715432114263, 11411.94294028533, 11428.0, 11868.87245711656, 11921.284722916653, 12023.639290821202, 12233.20484168535, 12511.3744312784, 9427.914431050103, 9489.718887950108, 9957.45234012129, 9976.152027077707, 10119.139873110795, 3419.093940105874, 3455.291665208626, 3471.89584312471, 3481.8927719548446, 3610.5667319921513, 43002.13995720099, 43286.35070473914, 43294.78352608217, 43306.133877322594, 43314.783426082984, 8892.510911899908, 9038.367314287936, 9039.502827344428, 9116.1339672731, 9122.86315705265, 17376.826231737774, 17381.304747810198, 17516.737248941277, 17576.91211543934, 17620.823791762174, 6632.43624291931, 6709.698063587052, 6761.188657361148, 6842.692078856463, 6880.176753160416, 3688.686461650736, 3727.3290807654885, 3733.5146430964346, 3737.7944213068, 3773.0, 3049.1462390530687, 3081.984590077035, 3103.6120484939383, 3110.377924415081, 3118.1113382685826, 558.8183840251853, 578.0779656447959, 586.7476984896535, 589.286962775047, 589.4694774702801, 482.50784200115686, 487.48813745567014, 495.9380077490314, 591.775125452334, 656.6191608866845, 7934.960325198337, 8015.639296231683, 8289.58552072394, 8301.750947471586, 8450.957745211235, 511.2229411294811, 516.7442116152529, 576.8615532272308, 606.2936678769273, 614.50839328537, 3750.7937063461773, 3801.82891769871, 3959.4456776051375, 4011.4785077940264, 4067.491563554556, 53000.46999530032, 54009.189862152096, 54209.0, 54502.0, 54698.179527307126, 47086.76456617695, 48389.516104839204, 48486.75756621194, 49087.0, 49291.0, 42437.78781106075, 43494.78252608717, 43861.0, 46054.309185362246, 47520.76239618849, 7918.445708800328, 8335.583220839055, 8351.33189344863, 8361.122082181526, 8389.748307550783, 30444.84777576098, 31481.37037259288, 31693.36613267768, 31697.04908852738, 31836.204094897814, 40218.9945251371, 40601.39097913475, 41379.0, 41572.0, 42960.35559466548, 9944.651937182163, 10146.340487868265, 10147.18822494184, 10178.796424071328, 10218.0, 11145.164112691742, 11313.943430282796, 11340.886591133984, 11574.247673901169, 12045.698857528632, 10688.83966740484, 10837.566497340018, 11106.888931110909, 11122.110231181648, 11338.376389298668, 10357.63748268807, 10449.58201671955, 10462.372257664565, 11028.669139925814, 11365.147613928822, 9759.072888075621, 10249.9487502562, 10409.947950260503, 11127.83308250393, 11538.711532211426, 8099.83800324002, 8145.144759800372, 8208.917910820815, 8355.456895301786, 8454.535000575028, 8259.132791056853, 8335.541545215072, 8383.203595658402, 8559.186877246651, 8587.141285871612], "unit": "score", "name": "yui.html", "value": 5879.085341155833}], "name": "dromaeo_css", "value": 6718.817089164684}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 111.0, 112.0, 113.0, 127.0, 111.0, 114.0, 111.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.9}, {"lowerIsBetter": true, "replicates": [158.0, 124.0, 156.0, 166.0, 134.0, 161.0, 160.0, 128.0, 168.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 148.4}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 163.0, 164.0, 165.0, 163.0, 162.0, 164.0, 164.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 73.0, 73.0, 77.0, 139.0, 75.0, 74.0, 73.0, 74.0], "unit": "score", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 142.0, 95.0, 96.0, 96.0, 145.0, 96.0, 97.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 97.0, 98.0, 97.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 60.0, 58.0, 61.0, 59.0, 60.0, 58.0, 75.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 60.8}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 68.0, 67.0, 67.0, 67.0, 68.0, 71.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 88.0, 84.0, 84.0, 83.0, 83.0, 84.0, 87.0, 92.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [128.0, 119.0, 117.0, 114.0, 115.0, 124.0, 126.0, 125.0, 116.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.2}, {"lowerIsBetter": true, "replicates": [136.0, 151.0, 148.0, 148.0, 144.0, 135.0, 135.0, 151.0, 144.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.0}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 67.0, 66.0, 70.0, 66.0, 68.0, 69.0, 71.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1513.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.6727028839705], "unit": "score", "name": "Richards", "value": 210.54112800000007}, {"lowerIsBetter": false, "replicates": [189.28639030853682], "unit": "score", "name": "DeltaBlue", "value": 349.30139399999996}, {"lowerIsBetter": false, "replicates": [280.8988764044944], "unit": "score", "name": "Encrypt", "value": 947.6043599999998}, {"lowerIsBetter": false, "replicates": [5273.684210526316], "unit": "score", "name": "Decrypt", "value": 50.47344311377245}, {"lowerIsBetter": false, "replicates": [1078.7486515641856], "unit": "score", "name": "RayTrace", "value": 685.9698030000003}, {"lowerIsBetter": false, "replicates": [786.331500392773], "unit": "score", "name": "Earley", "value": 847.5598391608395}, {"lowerIsBetter": false, "replicates": [12500.0], "unit": "score", "name": "Boyer", "value": 53.31704}, {"lowerIsBetter": false, "replicates": [40725.490196078434], "unit": "score", "name": "RegExp", "value": 22.368914299470404}, {"lowerIsBetter": false, "replicates": [580.7935595169638], "unit": "score", "name": "Splay", "value": 140.30975148514847}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20163.03869504417}]} 22:21:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20163.04"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1513.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6718.82"}}} 22:21:32 INFO - Return code: 0 22:21:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:21:32 INFO - # TBPL SUCCESS # 22:21:32 INFO - Running post-action listener: _resource_record_post_action 22:21:32 INFO - Running post-run listener: _resource_record_post_run 22:21:33 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549339136; Read time: 8; Write time: 447632 22:21:33 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236150784; Read time: 0; Write time: 281432 22:21:33 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 4096; Write bytes: 313188352; Read time: 8; Write time: 166200 22:21:33 INFO - Running post-run listener: _upload_blobber_files 22:21:33 INFO - Blob upload gear active. 22:21:33 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:21:33 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:21:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:21:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:21:33 INFO - (blobuploader) - INFO - Open directory for files ... 22:21:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:21:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:21:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:34 INFO - (blobuploader) - INFO - Done attempting. 22:21:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:21:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:21:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:35 INFO - (blobuploader) - INFO - Done attempting. 22:21:35 INFO - (blobuploader) - INFO - Iteration through files over. 22:21:35 INFO - Return code: 0 22:21:35 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:21:35 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:21:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d849f02dd00cfcab95c4ce035e3b0c63d430322b6f8423d4331c2c33a6d29f077788096c7fb9017b150bd3ed8826f19a8ab6f17954e477db20a57f7e702a99d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a5235e90d141ce14b722427005a126111e737e129f5daa6f8236f521ba479933f8bcf3b5215dab043a6ff3f8fc64bf65932656f29c0757e0a2a4f26e8e8f53a6"} 22:21:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:21:35 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:21:35 INFO - Contents: 22:21:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d849f02dd00cfcab95c4ce035e3b0c63d430322b6f8423d4331c2c33a6d29f077788096c7fb9017b150bd3ed8826f19a8ab6f17954e477db20a57f7e702a99d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a5235e90d141ce14b722427005a126111e737e129f5daa6f8236f521ba479933f8bcf3b5215dab043a6ff3f8fc64bf65932656f29c0757e0a2a4f26e8e8f53a6"} 22:21:35 INFO - Running post-run listener: copy_logs_to_upload_dir 22:21:35 INFO - Copying logs to upload dir... 22:21:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:21:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.844168 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-22 22:21:35.125228) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-22 22:21:35.128719) ========= 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=574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d849f02dd00cfcab95c4ce035e3b0c63d430322b6f8423d4331c2c33a6d29f077788096c7fb9017b150bd3ed8826f19a8ab6f17954e477db20a57f7e702a99d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a5235e90d141ce14b722427005a126111e737e129f5daa6f8236f521ba479933f8bcf3b5215dab043a6ff3f8fc64bf65932656f29c0757e0a2a4f26e8e8f53a6"} build_url:https://queue.taskcluster.net/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011075 build_url: 'https://queue.taskcluster.net/v1/task/FJdtlG-vSTaaiACdrffsgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d849f02dd00cfcab95c4ce035e3b0c63d430322b6f8423d4331c2c33a6d29f077788096c7fb9017b150bd3ed8826f19a8ab6f17954e477db20a57f7e702a99d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a5235e90d141ce14b722427005a126111e737e129f5daa6f8236f521ba479933f8bcf3b5215dab043a6ff3f8fc64bf65932656f29c0757e0a2a4f26e8e8f53a6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-22 22:21:35.158138) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 22:21:35.158924) ========= 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=574dc5aafe09851ec43d388c000001b6-1453527569.348954-1576973975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 22:21:35.243464) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 22:21:35.244261) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 22:21:35.244584) ========= ========= Total master_lag: 0.34 =========