builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-035 starttime: 1453787958.91 results: success (0) buildid: 20160125193227 builduid: 1f0d16596bdd41aeba1e4b0ed05f1ec5 revision: 08f0995ef87370f56d8148dcdec0e74d3ab313f6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:18.907227) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:18.907754) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:18.908041) ========= 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=ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006385 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:18.931020) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:18.931370) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:18.944655) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:18.944918) ========= 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=ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004648 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:18.994615) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:18.994920) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:18.995293) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:18.995577) ========= 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=ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 21:59:19-- 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% 220M=0s 2016-01-25 21:59:19 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151909 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:19.160401) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:19.160709) ========= 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=ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022156 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:19.210075) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-25 21:59:19.210429) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 08f0995ef87370f56d8148dcdec0e74d3ab313f6 --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 08f0995ef87370f56d8148dcdec0e74d3ab313f6 --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=ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 21:59:19,765 truncating revision to first 12 chars 2016-01-25 21:59:19,765 Setting DEBUG logging. 2016-01-25 21:59:19,765 attempt 1/10 2016-01-25 21:59:19,765 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/08f0995ef873?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 21:59:20,549 unpacking tar archive at: mozilla-inbound-08f0995ef873/testing/mozharness/ program finished with exit code 0 elapsedTime=1.068196 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-25 21:59:20.291842) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:20.292463) ========= echo 08f0995ef87370f56d8148dcdec0e74d3ab313f6 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'08f0995ef87370f56d8148dcdec0e74d3ab313f6'] 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=ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08f0995ef87370f56d8148dcdec0e74d3ab313f6 program finished with exit code 0 elapsedTime=0.004831 script_repo_revision: '08f0995ef87370f56d8148dcdec0e74d3ab313f6' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:20.343027) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:20.343356) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:20.353133) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-25 21:59:20.353415) ========= /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=ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:59:20 INFO - MultiFileLogger online at 20160125 21:59:20 in /builds/slave/test-pgo 21:59:20 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 21:59:20 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:59:21 INFO - {'append_to_log': False, 21:59:21 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:59:21 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:59:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:59:21 INFO - 'branch': 'Mozilla-Inbound', 21:59:21 INFO - 'buildbot_json_path': 'buildprops.json', 21:59:21 INFO - 'config_files': ('talos/linux_config.py',), 21:59:21 INFO - 'default_actions': ('clobber', 21:59:21 INFO - 'read-buildbot-config', 21:59:21 INFO - 'download-and-extract', 21:59:21 INFO - 'populate-webroot', 21:59:21 INFO - 'create-virtualenv', 21:59:21 INFO - 'install', 21:59:21 INFO - 'run-tests'), 21:59:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:59:21 INFO - 'download_minidump_stackwalk': True, 21:59:21 INFO - 'download_symbols': 'ondemand', 21:59:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:59:21 INFO - 'tooltool.py': '/tools/tooltool.py', 21:59:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:59:21 INFO - '/tools/misc-python/virtualenv.py')}, 21:59:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:59:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:59:21 INFO - 'installer_path': 'installer.exe', 21:59:21 INFO - 'log_level': 'info', 21:59:21 INFO - 'log_name': 'talos', 21:59:21 INFO - 'log_to_console': True, 21:59:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:59:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:59:21 INFO - 'opt_config_files': (), 21:59:21 INFO - 'pip_index': False, 21:59:21 INFO - 'sps_profile': False, 21:59:21 INFO - 'sps_profile_interval': 0, 21:59:21 INFO - 'suite': 'dromaeojs-e10s', 21:59:21 INFO - 'system_bits': '32', 21:59:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:59:21 INFO - 'title': 'talos-linux64-ix-035', 21:59:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:59:21 INFO - 'use_talos_json': True, 21:59:21 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:59:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:59:21 INFO - 'work_dir': 'build'} 21:59:21 INFO - ##### 21:59:21 INFO - ##### Running clobber step. 21:59:21 INFO - ##### 21:59:21 INFO - Running pre-action listener: _resource_record_pre_action 21:59:21 INFO - Running main action method: clobber 21:59:21 INFO - rmtree: /builds/slave/test-pgo/build 21:59:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:59:21 INFO - Running post-action listener: _resource_record_post_action 21:59:21 INFO - ##### 21:59:21 INFO - ##### Running read-buildbot-config step. 21:59:21 INFO - ##### 21:59:21 INFO - Running pre-action listener: _resource_record_pre_action 21:59:21 INFO - Running main action method: read_buildbot_config 21:59:21 INFO - Using buildbot properties: 21:59:21 INFO - { 21:59:21 INFO - "project": "", 21:59:21 INFO - "product": "firefox", 21:59:21 INFO - "script_repo_revision": "production", 21:59:21 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 21:59:21 INFO - "repository": "", 21:59:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 21:59:21 INFO - "buildid": "20160125193227", 21:59:21 INFO - "pgo_build": "True", 21:59:21 INFO - "basedir": "/builds/slave/test-pgo", 21:59:21 INFO - "buildnumber": 275, 21:59:21 INFO - "slavename": "talos-linux64-ix-035", 21:59:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:59:21 INFO - "platform": "ubuntu64_hw", 21:59:21 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:59:21 INFO - "branch": "mozilla-inbound", 21:59:21 INFO - "repo_path": "integration/mozilla-inbound", 21:59:21 INFO - "revision": "08f0995ef87370f56d8148dcdec0e74d3ab313f6", 21:59:21 INFO - "stage_platform": "linux64-pgo", 21:59:21 INFO - "builduid": "1f0d16596bdd41aeba1e4b0ed05f1ec5", 21:59:21 INFO - "slavebuilddir": "test" 21:59:21 INFO - } 21:59:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 21:59:21 INFO - Running post-action listener: _resource_record_post_action 21:59:21 INFO - ##### 21:59:21 INFO - ##### Running download-and-extract step. 21:59:21 INFO - ##### 21:59:21 INFO - Running pre-action listener: _resource_record_pre_action 21:59:21 INFO - Running main action method: download_and_extract 21:59:21 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:21 INFO - https://queue.taskcluster.net/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:59:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/test_packages.json 21:59:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/test_packages.json 21:59:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:59:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:59:26 INFO - Downloaded 1448 bytes. 21:59:26 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:59:26 INFO - Using the following test package requirements: 21:59:26 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:26 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:59:26 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:59:26 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:26 INFO - u'jsshell-linux-x86_64.zip'], 21:59:26 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:59:26 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:26 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:59:26 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:59:26 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:59:26 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:26 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:59:26 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:59: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')]} 21:59:26 INFO - https://queue.taskcluster.net/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:59:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:59:28 INFO - Downloaded 22501430 bytes. 21:59:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:59:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 21:59:29 INFO - Return code: 0 21:59:29 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:29 INFO - https://queue.taskcluster.net/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:59:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:59:37 INFO - Downloaded 22501430 bytes. 21:59:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:59:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 21:59:38 INFO - Return code: 0 21:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:38 INFO - https://queue.taskcluster.net/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:59:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:59:39 INFO - Downloaded 10706572 bytes. 21:59:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:59:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 21:59:39 INFO - Return code: 0 21:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:39 INFO - https://queue.taskcluster.net/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:59:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:59:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:59:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:59:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:59:41 INFO - Downloaded 55988105 bytes. 21:59:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:59:41 INFO - mkdir: /builds/slave/test-pgo/properties 21:59:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:59:41 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:59:41 INFO - Contents: 21:59:41 INFO - build_url:https://queue.taskcluster.net/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:59:41 INFO - Running post-action listener: _resource_record_post_action 21:59:41 INFO - Running post-action listener: set_extra_try_arguments 21:59:41 INFO - ##### 21:59:41 INFO - ##### Running populate-webroot step. 21:59:41 INFO - ##### 21:59:41 INFO - Running pre-action listener: _resource_record_pre_action 21:59:41 INFO - Running main action method: populate_webroot 21:59:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:59:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:59:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:59:41 INFO - '--tppagecycles', 21:59:41 INFO - '7'], 21:59:41 INFO - 'tests': ['tsvgm']}}, 21:59:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:59:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:59:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:59:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:59:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:59:41 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:59:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:41 INFO - 'talos_options': ['--e10s'], 21:59:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:41 INFO - 'tests': ['damp', 'tps']}, 21:59:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:41 INFO - 'talos_options': ['--e10s'], 21:59:41 INFO - 'tests': ['damp', 'tps']}, 21:59:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:59:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:59:41 INFO - 'other': {'tests': ['a11yr', 21:59:41 INFO - 'ts_paint', 21:59:41 INFO - 'tpaint', 21:59:41 INFO - 'sessionrestore', 21:59:41 INFO - 'sessionrestore_no_auto_restore']}, 21:59:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:59:41 INFO - 'tests': ['a11yr', 21:59:41 INFO - 'ts_paint', 21:59:41 INFO - 'tpaint', 21:59:41 INFO - 'sessionrestore', 21:59:41 INFO - 'sessionrestore_no_auto_restore']}, 21:59:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:59:41 INFO - 'tests': ['a11yr', 21:59:41 INFO - 'ts_paint', 21:59:41 INFO - 'tpaint', 21:59:41 INFO - 'sessionrestore', 21:59:41 INFO - 'sessionrestore_no_auto_restore']}, 21:59:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:59:41 INFO - 'tests': ['a11yr', 21:59:41 INFO - 'ts_paint', 21:59:41 INFO - 'tpaint', 21:59:41 INFO - 'sessionrestore', 21:59:41 INFO - 'sessionrestore_no_auto_restore']}, 21:59:41 INFO - 'other_l64': {'tests': ['a11yr', 21:59:41 INFO - 'ts_paint', 21:59:41 INFO - 'tpaint', 21:59:41 INFO - 'sessionrestore', 21:59:41 INFO - 'sessionrestore_no_auto_restore']}, 21:59:41 INFO - 'other_nol64': {'tests': ['a11yr', 21:59:41 INFO - 'ts_paint', 21:59:41 INFO - 'tpaint', 21:59:41 INFO - 'sessionrestore', 21:59:41 INFO - 'sessionrestore_no_auto_restore']}, 21:59:41 INFO - 'svgr': {'tests': ['tsvgx', 21:59:41 INFO - 'tsvgr_opacity', 21:59:41 INFO - 'tart', 21:59:41 INFO - 'tscrollx', 21:59:41 INFO - 'cart']}, 21:59:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:59:41 INFO - 'tests': ['tsvgx', 21:59:41 INFO - 'tsvgr_opacity', 21:59:41 INFO - 'tart', 21:59:41 INFO - 'tscrollx', 21:59:41 INFO - 'cart']}, 21:59:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:41 INFO - 'tests': ['tp5o']}, 21:59:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:41 INFO - 'talos_options': ['--e10s'], 21:59:41 INFO - 'tests': ['tp5o']}, 21:59:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:41 INFO - 'talos_options': ['--xperf_path', 21:59:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:41 INFO - 'tests': ['tp5n']}, 21:59:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:41 INFO - 'talos_options': ['--e10s', 21:59:41 INFO - '--xperf_path', 21:59:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:41 INFO - 'tests': ['tp5n']}}, 21:59:41 INFO - 'talos.zip': {'path': '', 21:59:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:59:41 INFO - Running post-action listener: _resource_record_post_action 21:59:41 INFO - ##### 21:59:41 INFO - ##### Running create-virtualenv step. 21:59:41 INFO - ##### 21:59:41 INFO - Running pre-action listener: _resource_record_pre_action 21:59:41 INFO - Running main action method: create_virtualenv 21:59:41 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:59:41 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 21:59:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:59:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:59:41 INFO - Using real prefix '/usr' 21:59:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:59:42 INFO - Installing distribute.............................................................................................................................................................................................done. 21:59:44 INFO - Installing pip.................done. 21:59:44 INFO - Return code: 0 21:59:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:59: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')]} 21:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5bea95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19647f0>, '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 0x18d02d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d0760>, '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': 'ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892', '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 21:59: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 21:59: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 pip>=1.5 21:59:44 INFO - Using env: {'DISPLAY': ':0', 21:59:44 INFO - 'HOME': '/home/cltbld', 21:59:44 INFO - 'LANG': 'en_US.UTF-8', 21:59:44 INFO - 'LANGUAGE': 'en_US:en', 21:59:44 INFO - 'LOGNAME': 'cltbld', 21:59:44 INFO - 'MAIL': '/var/mail/cltbld', 21:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:44 INFO - 'MOZ_NO_REMOTE': '1', 21:59:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:44 INFO - 'NO_EM_RESTART': '1', 21:59:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:44 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:44 INFO - 'SHELL': '/bin/bash', 21:59:44 INFO - 'SHLVL': '1', 21:59:44 INFO - 'TERM': 'linux', 21:59:44 INFO - 'TMOUT': '86400', 21:59:44 INFO - 'USER': 'cltbld', 21:59:44 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892', 21:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:44 INFO - '_': '/tools/buildbot/bin/python'} 21:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:59:44 INFO - Cleaning up... 21:59:44 INFO - Return code: 0 21:59:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:59: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')]} 21:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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', '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 0x7fa5bea95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19647f0>, '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 0x18d02d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d0760>, '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': 'ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892', '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 21:59: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 21:59: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 psutil>=0.7.1 21:59:44 INFO - Using env: {'DISPLAY': ':0', 21:59:44 INFO - 'HOME': '/home/cltbld', 21:59:44 INFO - 'LANG': 'en_US.UTF-8', 21:59:44 INFO - 'LANGUAGE': 'en_US:en', 21:59:44 INFO - 'LOGNAME': 'cltbld', 21:59:44 INFO - 'MAIL': '/var/mail/cltbld', 21:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:44 INFO - 'MOZ_NO_REMOTE': '1', 21:59:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:44 INFO - 'NO_EM_RESTART': '1', 21:59:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:44 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:44 INFO - 'SHELL': '/bin/bash', 21:59:44 INFO - 'SHLVL': '1', 21:59:44 INFO - 'TERM': 'linux', 21:59:44 INFO - 'TMOUT': '86400', 21:59:44 INFO - 'USER': 'cltbld', 21:59:44 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892', 21:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:44 INFO - '_': '/tools/buildbot/bin/python'} 21:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:44 INFO - Downloading/unpacking psutil>=0.7.1 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:59:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:46 INFO - Installing collected packages: psutil 21:59:46 INFO - Running setup.py install for psutil 21:59:46 INFO - building 'psutil._psutil_linux' extension 21:59:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:59:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:59:46 INFO - building 'psutil._psutil_posix' extension 21:59:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:59:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:59:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:46 INFO - Successfully installed psutil 21:59:46 INFO - Cleaning up... 21:59:46 INFO - Return code: 0 21:59:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:59: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')]} 21:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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', '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 0x7fa5bea95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19647f0>, '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 0x18d02d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d0760>, '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': 'ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892', '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 21:59: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 21:59: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 mozsystemmonitor==0.0.0 21:59:46 INFO - Using env: {'DISPLAY': ':0', 21:59:46 INFO - 'HOME': '/home/cltbld', 21:59:46 INFO - 'LANG': 'en_US.UTF-8', 21:59:46 INFO - 'LANGUAGE': 'en_US:en', 21:59:46 INFO - 'LOGNAME': 'cltbld', 21:59:46 INFO - 'MAIL': '/var/mail/cltbld', 21:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:46 INFO - 'MOZ_NO_REMOTE': '1', 21:59:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:46 INFO - 'NO_EM_RESTART': '1', 21:59:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:46 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:46 INFO - 'SHELL': '/bin/bash', 21:59:46 INFO - 'SHLVL': '1', 21:59:46 INFO - 'TERM': 'linux', 21:59:46 INFO - 'TMOUT': '86400', 21:59:46 INFO - 'USER': 'cltbld', 21:59:46 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892', 21:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:46 INFO - '_': '/tools/buildbot/bin/python'} 21:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:59:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:59:48 INFO - Installing collected packages: mozsystemmonitor 21:59:48 INFO - Running setup.py install for mozsystemmonitor 21:59:49 INFO - Successfully installed mozsystemmonitor 21:59:49 INFO - Cleaning up... 21:59:49 INFO - Return code: 0 21:59:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:59: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')]} 21:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:49 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 0x7fa5bea95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19647f0>, '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 0x18d02d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d0760>, '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': 'ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892', '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 21:59:49 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 21:59:49 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 21:59:49 INFO - Using env: {'DISPLAY': ':0', 21:59:49 INFO - 'HOME': '/home/cltbld', 21:59:49 INFO - 'LANG': 'en_US.UTF-8', 21:59:49 INFO - 'LANGUAGE': 'en_US:en', 21:59:49 INFO - 'LOGNAME': 'cltbld', 21:59:49 INFO - 'MAIL': '/var/mail/cltbld', 21:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:49 INFO - 'MOZ_NO_REMOTE': '1', 21:59:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:49 INFO - 'NO_EM_RESTART': '1', 21:59:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:49 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:49 INFO - 'SHELL': '/bin/bash', 21:59:49 INFO - 'SHLVL': '1', 21:59:49 INFO - 'TERM': 'linux', 21:59:49 INFO - 'TMOUT': '86400', 21:59:49 INFO - 'USER': 'cltbld', 21:59:49 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892', 21:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:49 INFO - '_': '/tools/buildbot/bin/python'} 21:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:49 INFO - Downloading/unpacking blobuploader==1.2.4 21:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:51 INFO - Downloading blobuploader-1.2.4.tar.gz 21:59:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:59:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:59:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:51 INFO - Downloading docopt-0.6.1.tar.gz 21:59:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:59:51 INFO - Installing collected packages: blobuploader, requests, docopt 21:59:51 INFO - Running setup.py install for blobuploader 21:59:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:59:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:59:51 INFO - Running setup.py install for requests 21:59:52 INFO - Running setup.py install for docopt 21:59:52 INFO - Successfully installed blobuploader requests docopt 21:59:52 INFO - Cleaning up... 21:59:52 INFO - Return code: 0 21:59:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:59: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')]} 21:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:52 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 0x7fa5bea95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19647f0>, '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 0x18d02d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d0760>, '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': 'ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892', '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 21:59:52 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 21:59:52 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 21:59:52 INFO - Using env: {'DISPLAY': ':0', 21:59:52 INFO - 'HOME': '/home/cltbld', 21:59:52 INFO - 'LANG': 'en_US.UTF-8', 21:59:52 INFO - 'LANGUAGE': 'en_US:en', 21:59:52 INFO - 'LOGNAME': 'cltbld', 21:59:52 INFO - 'MAIL': '/var/mail/cltbld', 21:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:52 INFO - 'MOZ_NO_REMOTE': '1', 21:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:52 INFO - 'NO_EM_RESTART': '1', 21:59:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:52 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:52 INFO - 'SHELL': '/bin/bash', 21:59:52 INFO - 'SHLVL': '1', 21:59:52 INFO - 'TERM': 'linux', 21:59:52 INFO - 'TMOUT': '86400', 21:59:52 INFO - 'USER': 'cltbld', 21:59:52 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892', 21:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:52 INFO - '_': '/tools/buildbot/bin/python'} 21:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:59:52 INFO - Running setup.py (path:/tmp/pip-1w0L0D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:59:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:59:52 INFO - Running setup.py (path:/tmp/pip-_G4ajU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:59:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:59:52 INFO - Running setup.py (path:/tmp/pip-H7CsgC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:59:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:59:52 INFO - Running setup.py (path:/tmp/pip-1XS2JO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:59:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:59:52 INFO - Running setup.py (path:/tmp/pip-fnSuev-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:59:53 INFO - Running setup.py (path:/tmp/pip-VTg3Dq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:59:53 INFO - Running setup.py (path:/tmp/pip-PUw2hX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:59:53 INFO - Running setup.py (path:/tmp/pip-1SFLZv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:59:53 INFO - Running setup.py (path:/tmp/pip-UNjc1N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:59:53 INFO - Running setup.py (path:/tmp/pip-LV1YIc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:59:53 INFO - Running setup.py (path:/tmp/pip-c0m_6D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:59:53 INFO - Running setup.py (path:/tmp/pip-Vqur49-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:59:53 INFO - Running setup.py (path:/tmp/pip-dwoQHG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:59:53 INFO - Running setup.py (path:/tmp/pip-E_kUjo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:59:53 INFO - Running setup.py (path:/tmp/pip-1dFsJk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:59:53 INFO - Running setup.py (path:/tmp/pip-vU6iVn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:59:53 INFO - Running setup.py (path:/tmp/pip-YPOhdX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:59:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:59:53 INFO - Running setup.py install for manifestparser 21:59:54 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:59:54 INFO - Running setup.py install for mozcrash 21:59:54 INFO - Running setup.py install for mozdebug 21:59:54 INFO - Running setup.py install for mozdevice 21:59:54 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:59:54 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:59:54 INFO - Running setup.py install for mozfile 21:59:54 INFO - Running setup.py install for mozhttpd 21:59:54 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:59:54 INFO - Running setup.py install for mozinfo 21:59:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:59:54 INFO - Running setup.py install for mozInstall 21:59:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:59:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:59:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:59:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:59:54 INFO - Running setup.py install for mozleak 21:59:54 INFO - Running setup.py install for mozlog 21:59:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:59:54 INFO - Running setup.py install for moznetwork 21:59:55 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:59:55 INFO - Running setup.py install for mozprocess 21:59:55 INFO - Running setup.py install for mozprofile 21:59:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:59:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:59:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:59:55 INFO - Running setup.py install for mozrunner 21:59:55 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:59:55 INFO - Running setup.py install for mozscreenshot 21:59:55 INFO - Running setup.py install for moztest 21:59:55 INFO - Running setup.py install for mozversion 21:59:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:59:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:59:55 INFO - Cleaning up... 21:59:55 INFO - Return code: 0 21:59:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:55 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 0x7fa5bea95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19647f0>, '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 0x18d02d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d0760>, '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': 'ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892', '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 21:59:55 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 21:59:55 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 21:59:55 INFO - Using env: {'DISPLAY': ':0', 21:59:55 INFO - 'HOME': '/home/cltbld', 21:59:55 INFO - 'LANG': 'en_US.UTF-8', 21:59:55 INFO - 'LANGUAGE': 'en_US:en', 21:59:55 INFO - 'LOGNAME': 'cltbld', 21:59:55 INFO - 'MAIL': '/var/mail/cltbld', 21:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:55 INFO - 'MOZ_NO_REMOTE': '1', 21:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:55 INFO - 'NO_EM_RESTART': '1', 21:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:55 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:55 INFO - 'SHELL': '/bin/bash', 21:59:55 INFO - 'SHLVL': '1', 21:59:55 INFO - 'TERM': 'linux', 21:59:55 INFO - 'TMOUT': '86400', 21:59:55 INFO - 'USER': 'cltbld', 21:59:55 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892', 21:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:55 INFO - '_': '/tools/buildbot/bin/python'} 21:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:59:55 INFO - Running setup.py (path:/tmp/pip-zSCWBe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:59:55 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)) 21:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:59:55 INFO - Running setup.py (path:/tmp/pip-khj7l9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:59:56 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)) 21:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:59:56 INFO - Running setup.py (path:/tmp/pip-UALjSD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:59:56 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)) 21:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:59:56 INFO - Running setup.py (path:/tmp/pip-w1fD7o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:59:56 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)) 21:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:59:56 INFO - Running setup.py (path:/tmp/pip-Au8TcB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:59:56 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)) 21:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:59:56 INFO - Running setup.py (path:/tmp/pip-BqPr_C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:59:56 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)) 21:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:59:56 INFO - Running setup.py (path:/tmp/pip-cigljp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:59:56 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)) 21:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:59:56 INFO - Running setup.py (path:/tmp/pip-lpC_iw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:59:56 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)) 21:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:59:56 INFO - Running setup.py (path:/tmp/pip-9ocoIs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:59:56 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)) 21:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:59:56 INFO - Running setup.py (path:/tmp/pip-Wub6nx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:59:56 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)) 21:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:59:56 INFO - Running setup.py (path:/tmp/pip-sdhOvK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:59:56 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)) 21:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:59:56 INFO - Running setup.py (path:/tmp/pip-wTigEX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:59:56 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)) 21:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:59:56 INFO - Running setup.py (path:/tmp/pip-Usn2jq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:59:56 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)) 21:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:59:56 INFO - Running setup.py (path:/tmp/pip-nXo5Ls-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:59:56 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)) 21:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:59:56 INFO - Running setup.py (path:/tmp/pip-CfCCrn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:59:57 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)) 21:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:59:57 INFO - Running setup.py (path:/tmp/pip-k6nGvL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:59:57 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)) 21:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:59:57 INFO - Running setup.py (path:/tmp/pip-10W2FP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:59:57 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)) 21:59:57 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)) 21:59:57 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)) 21:59:57 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)) 21:59:57 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)) 21:59:57 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)) 21:59:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:58 INFO - Downloading blessings-1.6.tar.gz 21:59:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:59:58 INFO - Installing collected packages: blessings 21:59:58 INFO - Running setup.py install for blessings 21:59:59 INFO - Successfully installed blessings 21:59:59 INFO - Cleaning up... 21:59:59 INFO - Return code: 0 21:59:59 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:59:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:59:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:59:59 INFO - Reading from file tmpfile_stdout 21:59:59 INFO - Current package versions: 21:59:59 INFO - argparse == 1.2.1 21:59:59 INFO - blessings == 1.6 21:59:59 INFO - blobuploader == 1.2.4 21:59:59 INFO - docopt == 0.6.1 21:59:59 INFO - manifestparser == 1.1 21:59:59 INFO - mozInstall == 1.12 21:59:59 INFO - mozcrash == 0.16 21:59:59 INFO - mozdebug == 0.1 21:59:59 INFO - mozdevice == 0.48 21:59:59 INFO - mozfile == 1.2 21:59:59 INFO - mozhttpd == 0.7 21:59:59 INFO - mozinfo == 0.9 21:59:59 INFO - mozleak == 0.1 21:59:59 INFO - mozlog == 3.1 21:59:59 INFO - moznetwork == 0.27 21:59:59 INFO - mozprocess == 0.22 21:59:59 INFO - mozprofile == 0.28 21:59:59 INFO - mozrunner == 6.11 21:59:59 INFO - mozscreenshot == 0.1 21:59:59 INFO - mozsystemmonitor == 0.0 21:59:59 INFO - moztest == 0.7 21:59:59 INFO - mozversion == 1.4 21:59:59 INFO - psutil == 3.1.1 21:59:59 INFO - requests == 1.2.3 21:59:59 INFO - wsgiref == 0.1.2 21:59:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:59: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')]} 21:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:59 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 0x7fa5bea95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19647f0>, '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 0x18d02d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d0760>, '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': 'ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892', '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 21:59:59 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 21:59:59 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 21:59:59 INFO - Using env: {'DISPLAY': ':0', 21:59:59 INFO - 'HOME': '/home/cltbld', 21:59:59 INFO - 'LANG': 'en_US.UTF-8', 21:59:59 INFO - 'LANGUAGE': 'en_US:en', 21:59:59 INFO - 'LOGNAME': 'cltbld', 21:59:59 INFO - 'MAIL': '/var/mail/cltbld', 21:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:59 INFO - 'MOZ_NO_REMOTE': '1', 21:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:59 INFO - 'NO_EM_RESTART': '1', 21:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:59 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:59 INFO - 'SHELL': '/bin/bash', 21:59:59 INFO - 'SHLVL': '1', 21:59:59 INFO - 'TERM': 'linux', 21:59:59 INFO - 'TMOUT': '86400', 21:59:59 INFO - 'USER': 'cltbld', 21:59:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892', 21:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:59 INFO - '_': '/tools/buildbot/bin/python'} 21:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:59 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)) 21:59:59 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)) 21:59:59 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)) 21:59:59 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)) 21:59:59 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)) 21:59:59 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)) 21:59:59 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)) 21:59:59 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)) 21:59:59 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)) 21:59:59 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)) 21:59:59 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)) 21:59:59 INFO - Cleaning up... 21:59:59 INFO - Return code: 0 21:59:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 21:59: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')]} 21:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5bea95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19647f0>, '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 0x18d02d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d0760>, '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': 'ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892', '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 21:59: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', 'jsonschema'] in /builds/slave/test-pgo/build 21:59: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 jsonschema 21:59:59 INFO - Using env: {'DISPLAY': ':0', 21:59:59 INFO - 'HOME': '/home/cltbld', 21:59:59 INFO - 'LANG': 'en_US.UTF-8', 21:59:59 INFO - 'LANGUAGE': 'en_US:en', 21:59:59 INFO - 'LOGNAME': 'cltbld', 21:59:59 INFO - 'MAIL': '/var/mail/cltbld', 21:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:59 INFO - 'MOZ_NO_REMOTE': '1', 21:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:59 INFO - 'NO_EM_RESTART': '1', 21:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:59 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:59 INFO - 'SHELL': '/bin/bash', 21:59:59 INFO - 'SHLVL': '1', 21:59:59 INFO - 'TERM': 'linux', 21:59:59 INFO - 'TMOUT': '86400', 21:59:59 INFO - 'USER': 'cltbld', 21:59:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892', 21:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:59 INFO - '_': '/tools/buildbot/bin/python'} 21:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:59 INFO - Downloading/unpacking jsonschema 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:00:01 INFO - Downloading/unpacking functools32 (from jsonschema) 22:00: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:00: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:00: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:00: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:00: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:00: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:00:01 INFO - Downloading functools32-3.2.3-2.tar.gz 22:00:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:00:01 INFO - warning: no files found matching '*.txt' 22:00:01 INFO - no previously-included directories found matching 'build' 22:00:01 INFO - no previously-included directories found matching 'dist' 22:00:01 INFO - no previously-included directories found matching '.git*' 22:00:01 INFO - Installing collected packages: jsonschema, functools32 22:00:01 INFO - Running setup.py install for functools32 22:00:01 INFO - warning: no files found matching '*.txt' 22:00:01 INFO - no previously-included directories found matching 'build' 22:00:01 INFO - no previously-included directories found matching 'dist' 22:00:01 INFO - no previously-included directories found matching '.git*' 22:00:01 INFO - Successfully installed jsonschema functools32 22:00:01 INFO - Cleaning up... 22:00:02 INFO - Return code: 0 22:00:02 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:02 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 0x7fa5bea95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19647f0>, '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 0x18d02d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d0760>, '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': 'ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892', '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:02 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:02 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:02 INFO - Using env: {'DISPLAY': ':0', 22:00:02 INFO - 'HOME': '/home/cltbld', 22:00:02 INFO - 'LANG': 'en_US.UTF-8', 22:00:02 INFO - 'LANGUAGE': 'en_US:en', 22:00:02 INFO - 'LOGNAME': 'cltbld', 22:00:02 INFO - 'MAIL': '/var/mail/cltbld', 22:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:02 INFO - 'MOZ_NO_REMOTE': '1', 22:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:02 INFO - 'NO_EM_RESTART': '1', 22:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:02 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:02 INFO - 'SHELL': '/bin/bash', 22:00:02 INFO - 'SHLVL': '1', 22:00:02 INFO - 'TERM': 'linux', 22:00:02 INFO - 'TMOUT': '86400', 22:00:02 INFO - 'USER': 'cltbld', 22:00:02 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892', 22:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:02 INFO - '_': '/tools/buildbot/bin/python'} 22:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:02 INFO - Downloading/unpacking flake8 22:00:02 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:02 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:02 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:02 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:02 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:02 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:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:00:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:00:04 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:04 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:04 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:04 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:04 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:04 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:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:00:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:00:04 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:04 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:04 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:04 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:04 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:04 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:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:00:04 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:04 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:04 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:04 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:04 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:04 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:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:00:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:00:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:00:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:00:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:00:04 INFO - no previously-included directories found matching 'docs/_build' 22:00:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:00:04 INFO - Running setup.py install for pep8 22:00:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:00:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:00:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:00:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:00:04 INFO - no previously-included directories found matching 'docs/_build' 22:00:04 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:00:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:00:04 INFO - Cleaning up... 22:00:04 INFO - Return code: 0 22:00:04 INFO - Running post-action listener: _resource_record_post_action 22:00:04 INFO - Running post-action listener: _start_resource_monitoring 22:00:04 INFO - Starting resource monitoring. 22:00:04 INFO - ##### 22:00:04 INFO - ##### Running install step. 22:00:04 INFO - ##### 22:00:04 INFO - Running pre-action listener: _resource_record_pre_action 22:00:04 INFO - Running main action method: install 22:00:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:00:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:00:05 INFO - Reading from file tmpfile_stdout 22:00:05 INFO - Detecting whether we're running mozinstall >=1.0... 22:00:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:00:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:00:05 INFO - Reading from file tmpfile_stdout 22:00:05 INFO - Output received: 22:00:05 INFO - Usage: mozinstall [options] installer 22:00:05 INFO - Options: 22:00:05 INFO - -h, --help show this help message and exit 22:00:05 INFO - -d DEST, --destination=DEST 22:00:05 INFO - Directory to install application into. [default: 22:00:05 INFO - "/builds/slave/test-pgo"] 22:00:05 INFO - --app=APP Application being installed. [default: firefox] 22:00:05 INFO - mkdir: /builds/slave/test-pgo/build/application 22:00:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:00:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:00:21 INFO - Reading from file tmpfile_stdout 22:00:21 INFO - Output received: 22:00:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:00:21 INFO - Running post-action listener: _resource_record_post_action 22:00:21 INFO - ##### 22:00:21 INFO - ##### Running run-tests step. 22:00:21 INFO - ##### 22:00:21 INFO - Running pre-action listener: _resource_record_pre_action 22:00:21 INFO - Running main action method: run_tests 22:00:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:00:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:00:21 INFO - Python 2.7.3 22:00:21 INFO - Return code: 0 22:00:21 INFO - grabbing minidump binary from tooltool 22:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:21 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 0x19647f0>, '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 0x18d02d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d0760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:00:21 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:00:21 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:00:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:00:21 INFO - Return code: 0 22:00:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:00:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:00:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:00:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:00:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:00:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:00:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:00:22 INFO - Return code: 0 22:00:22 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/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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:00:22 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/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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:00:22 INFO - Using env: {'DISPLAY': ':0', 22:00:22 INFO - 'HOME': '/home/cltbld', 22:00:22 INFO - 'LANG': 'en_US.UTF-8', 22:00:22 INFO - 'LANGUAGE': 'en_US:en', 22:00:22 INFO - 'LOGNAME': 'cltbld', 22:00:22 INFO - 'MAIL': '/var/mail/cltbld', 22:00:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:00:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:22 INFO - 'MOZ_NO_REMOTE': '1', 22:00:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:00:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:22 INFO - 'NO_EM_RESTART': '1', 22:00:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:22 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:00:22 INFO - 'SHELL': '/bin/bash', 22:00:22 INFO - 'SHLVL': '1', 22:00:22 INFO - 'TERM': 'linux', 22:00:22 INFO - 'TMOUT': '86400', 22:00:22 INFO - 'USER': 'cltbld', 22:00:22 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892', 22:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:22 INFO - '_': '/tools/buildbot/bin/python'} 22:00:22 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/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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:00:22 INFO - mozversion application_buildid: 20160125193227 22:00:22 INFO - mozversion application_changeset: 08f0995ef87370f56d8148dcdec0e74d3ab313f6 22:00:22 INFO - mozversion application_display_name: Nightly 22:00:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:00:22 INFO - mozversion application_name: Firefox 22:00:22 INFO - mozversion application_remotingname: firefox 22:00:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:00:22 INFO - mozversion application_vendor: Mozilla 22:00:22 INFO - mozversion application_version: 47.0a1 22:00:22 INFO - mozversion platform_buildid: 20160125193227 22:00:22 INFO - mozversion platform_changeset: 08f0995ef87370f56d8148dcdec0e74d3ab313f6 22:00:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:00:22 INFO - mozversion platform_version: 47.0a1 22:00:22 INFO - using testdate: 1453788022 22:00:22 INFO - actual date: 1453788022 22:00:22 INFO - starting webserver on 'localhost:54668' 22:00:22 INFO - SUITE-START | Running 3 tests 22:00:22 INFO - TEST-START | dromaeo_css 22:00:22 INFO - operating with platform_type : linux_ 22:00:22 INFO - Initialising browser for dromaeo_css test... 22:00:22 INFO - TEST-INFO | started process 22800 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9nB3U0/profile http://localhost:54668/getInfo.html) 22:00:26 INFO - PROCESS | 22800 | 22:00:26 INFO - PROCESS | 22800 | (process:22881): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:00:27 INFO - PROCESS | 22800 | __metrics Screen width/height:1600/1200 22:00:27 INFO - PROCESS | 22800 | colorDepth:24 22:00:27 INFO - PROCESS | 22800 | Browser inner width/height: 1024/697 22:00:27 INFO - PROCESS | 22800 | __metrics 22:00:27 INFO - PROCESS | 22800 | 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:00:28 INFO - TEST-INFO | 22800: exit 0 22:00:28 INFO - Browser initialized. 22:00:28 INFO - Running cycle 1/1 for dromaeo_css test... 22:00:28 INFO - TEST-INFO | started process 22930 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9nB3U0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:00:29 INFO - PROCESS | 22930 | 22:00:29 INFO - PROCESS | 22930 | (process:22989): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:00:39 INFO - PROCESS | 22930 | RSS: Main: 151740416 22:00:39 INFO - PROCESS | 22930 | 22:01:29 INFO - PROCESS | 22930 | 1453788089373 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:03:38 INFO - PROCESS | 22930 | Cycle 1(1): loaded http://localhost:54668/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54668/tests/dromaeo/cssquery-ext.html) 22:03:39 INFO - PROCESS | 22930 | RSS: Main: 161071104 22:03:39 INFO - PROCESS | 22930 | 22:06:41 INFO - PROCESS | 22930 | Cycle 1(1): loaded http://localhost:54668/tests/dromaeo/cssquery-ext.html (next: http://localhost:54668/tests/dromaeo/cssquery-jquery.html) 22:06:41 INFO - PROCESS | 22930 | RSS: Main: 155250688 22:06:41 INFO - PROCESS | 22930 | 22:09:43 INFO - PROCESS | 22930 | Cycle 1(1): loaded http://localhost:54668/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54668/tests/dromaeo/cssquery-mootools.html) 22:09:44 INFO - PROCESS | 22930 | RSS: Main: 156188672 22:09:44 INFO - PROCESS | 22930 | 22:12:45 INFO - PROCESS | 22930 | Cycle 1(1): loaded http://localhost:54668/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54668/tests/dromaeo/cssquery-prototype.html) 22:12:46 INFO - PROCESS | 22930 | RSS: Main: 154271744 22:12:46 INFO - PROCESS | 22930 | 22:15:48 INFO - PROCESS | 22930 | Cycle 1(1): loaded http://localhost:54668/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54668/tests/dromaeo/cssquery-yui.html) 22:15:49 INFO - PROCESS | 22930 | RSS: Main: 156569600 22:15:49 INFO - PROCESS | 22930 | 22:18:51 INFO - PROCESS | 22930 | Cycle 1(1): loaded http://localhost:54668/tests/dromaeo/cssquery-yui.html (next: http://localhost:54668/tests/dromaeo/cssquery-dojo.html) 22:18:51 INFO - PROCESS | 22930 | RSS: Main: 158142464 22:18:51 INFO - PROCESS | 22930 | 22:18:51 INFO - PROCESS | 22930 | __start_tp_report 22:18:51 INFO - PROCESS | 22930 | _x_x_mozilla_page_load 22:18:51 INFO - PROCESS | 22930 | _x_x_mozilla_page_load_details 22:18:51 INFO - PROCESS | 22930 | |i|pagename|runs| 22:18:51 INFO - PROCESS | 22930 | |0;dojo.html;3205.871765129395;3236.514522821575;3266.297745984613;3284.687954644309;3289.9999999999986;5183.818566350178;5371.57027437805;5418;5427.945720542793;5437.184422336652;5227.555657769094;5237.79048838046;5262.473752624735;5271.077561426745;5277.683338999663;4628.143793398232;4876.292937524066;5049.621278404116;5058.519440653132;5067.721275329855;4712.5523075307965;4964.180910149839;5000.824971126011;5022.849314520552;5038.017586570621;4752.59602933751;4797.784099715521;4812;4829.541193586604;4845.951540484585;4895.632827537949;4917.803287868481;4933.506649335073;4960.355153830015;4960.379952505937;4767.594754445876;4822.421309442854;4930.926036109461;4949.653524253304;4977.50224977503;5172.534471897509;5206.193040078794;5221.921671174935;5227.555657769094;5251.396089449686;5657.519110875581;5659.971700141514;5668.178114173422;5679.744411501492;5693.914591281134;5701.828945131652;5707.258056452676;5791.507721843648;5803.709814509258;5821.27234095738;5457.208704737831;5483.396826349099;5484.808031718871;5486.725663716878;5516.91724624131;5936.050231962865;5945.316288626776;5963.19496867926;5975.163477113208;5984.940150598525;5584.636998595079;5685.687287199161;5706.172604972256;5749.281339832521;5760.654360738369;5778.219940308089;5813.244278243801;5830.067189249699;5861.912071318934;5867.061270196748;5735.139729040594;5764.596478246566;5767.625104368202;5782.190493330937;5782.306123265235;5503.862403439946;5579.832605021856;5659.26429564154;5703.344115426779;5760.107183386582;4245.915081698348;4262.50981137167;4271.017665936852;4271.466066741657;4290.635295999812;3827.196288779332;3833.1950290438763;3840.1743625120735;3851.807409629507;3889.3388124018984;5283.867903302371;5362.1420572708175;5389.7035663038905;5435.918461223085;5466.1527463243265;5770.394108618619;5787.623804452697;5801.332846722681;5814.9709251454315;5845.09401042839;5225.320708307896;5412.269343638558;5421.512063914267;5437.483439073281;5437.972810135924;4891.3396691446915;4910.435299940481;4973.776180071905;4990.076835785391;5022.84931452057;5833.766649334064;5844;5846;5858.502027327725;5876.676782776988;5553.777848885999;5670.234518340137;5678.0915053591225;5707.343655479673;5717.113847353667;5990.610610310316;6000.399960003964;6017.699115044318;6067.180930574316;6088.543359248163;5689.402612725769;5742.1673857289625;5798.159266906359;5798.304203495608;5814.94185058144;5687.9431205687415;5741.282339707536;5869.35437101927;5897.439743224387;5899.587028908107;5664.575156863334;5713.457221563945;5719.5138413235345;5739.9139012915675;5773.076307790733;5514.145307477347;5576.804811831728;5584.190292407659;5605.215269862304;5611.859703507445;5280.6303558750515;5373.462653734595;5516.062269414129;5517.972410137923;5521.558275338044;5604.6356986797355;5708.257926469699;5712.0860662293835;5737;5744.281964754406;5590.664560126405;5597.468240517144;5604.299462567179;5607.495325420732;5619.971900140473 22:18:51 INFO - PROCESS | 22930 | |1;ext.html;508.9262057001735;535.1678140491535;538.122859738626;557.5539568345323;584.7282161299173;27938.58092128617;35494.99999999997;35526.111847203836;35956;35987.28025439489;38189.42715859264;38557;38559;38902.8054859726;38918.4162237566;8352.248297653196;8599.312055035582;8611.354148438892;8627.741167764978;8633.445979723647;8349.248567628912;8419.326453883705;8462.111478294783;8470.74587762365;8726.781830454225;8723.607437665289;8738;8772.517511536864;8793.516356600385;8824.911750882506;8661.263792577638;8728.563571821414;8758.211760941545;8779.165979231962;8782.780430489225;8483.575821208915;8562.571871406468;8623.051464338918;8624.525651089187;8632.438891472097;39373.40939885904;39495.21009579792;39678.60321396778;39732;39882.40176397356;2944.793864429491;2978.3894301668106;3045.1473587395567;3053.603031605877;3234.886778962725;27908;28959.855200724072;29112.563311550344;29608.851955740083;29611.407771844657;3832.291026160169;3851;3892.3772196448717;4018.357062869956;4111.8560850370395;209566;212852;212886;213197;213277;52988.73505632447;54002.729986350605;60042;60352.698236508535;60374;61999.38000619936;63539.68230158912;63929;64132;64137.67931160408;13515.662108447368;13567.660808479866;13577.11748736329;13650.658733531742;13655.86344136546;11438.656840294805;11500;11551.075913927034;11572.305661660159;11590.884091159149;19723.901380493007;19909.402717918485;19924.609046914462;20181.192752289742;20207.898960505103;7783.610819459004;8035.839283214303;8100.189981001853;8116.675332986614;8150.75547733569;970.427447805798;1046.199657262195;1134.8127558952845;1152.9769404611861;1155.185594156118;27623.171304860887;28604.570931436047;28627;32698.509522357184;32990;1010.2372708604956;1043.4886905416292;1088.1784252889017;1107.0147568663895;1115.70991542198;13545.59363219105;13665.385057672429;13721.794173087412;13780.310984450738;13816.171029738249;371949;374661;375986.1200693979;376226;376721;50436.24345634819;51336.486635133915;51341;51574;51599.742001290506;1352.4725357110735;1358.9116707413987;1363.1275983370651;1363.3455941148304;1368.9794653080212;25440.363990900376;26396.208113756617;26410;26679.599806003313;26721.19836404911;51751.2237316433;53047.204291936425;53386.46613533815;53406.73296633492;53571.19643205433;282399;285467;286249;286795;287626;40956.59043409528;41066.79466602648;41100;41108.79445602872;41755.1648967025;41800;42404.36393454162;42730.14539709126;43150.35274470822;43426.34860477032;34815.12962175966;35153.64846351504;35376.11559710925;35499.112522187155;35939.28121437504;36095.097622559646;37049.44425833561;37673.681421150126;38635.06824658812;38855;32267.838660807483;32986.17534561655;33306.83346583252;33309.50035749417;33577.16057098592;28177.718222817508;29667.40665186641;35338.646613533536;37314.44028339631;37949.62050379571;25088.62367064459;25131.24606261815;25567.616485752358;26573;27039.729602703723 22:18:51 INFO - PROCESS | 22930 | |2;jquery.html;363.27526584464;364.6226155928613;367.3406235806727;372.3465318366267;373.12502182382303;16181.83818161818;16594.419195328166;16864.15679216039;17314.913425432856;17613.207405666744;9641.276904232176;9938.602455901755;9977.451240181786;10405.687829365112;10582.312149710264;4841.612670986313;4875.515045573729;4974.1295273327205;4989.700617962916;5418.593605479585;5280.735963201843;5390.110631745777;5414.539764120054;5419.918701219485;5422.511973922346;5226.843194704146;5418.485243901823;5483.561315094803;5502.367227768817;5732.7133643317875;5383.16560933056;5590.552755779528;5600.775968961237;5622.240997465351;5740.339860916007;5045.84862454127;5047.924281135786;5078.5937125029905;5088.7964481420695;5110.5400513953555;11833.349165795878;12411.379431028503;17970.91014544919;19712.802871971384;19878.204871805112;2052.056054215063;2173.2610912289897;2174.70641463402;2233.955320893573;2335.590038543728;8756.912430875736;8823.77940551485;9062.954685226532;9082.909170908273;9260;1791.5610675384614;1806.205269681336;1811.1306572844976;1858.50749551369;1865.6082222733241;49761.75119124418;50480.24279635845;55363.72318138384;57007.42992570063;57212;9518.095780900803;9786.951065244628;9863.260255480867;9877;9921;12897.484100636057;12915.547955821501;12928.482860685655;12966.935165324301;12980.221186728637;7229.602371869492;7294.343509084208;7319.451041171933;7346.706131754777;7370.484066115428;7072.186698529735;7135.89296160558;7137;7219.350258476762;7234.457415693844;4278.358246263086;4297.269464191095;4361.171377438277;4363.5418281080665;4402;1736.3749050341867;1795.5870149865343;1818.4271954334342;1842.1249906294404;1848.5471059590218;863.3266052479077;893.660409044559;950.7623094226443;999.3504222255447;1060.1942523681903;15819.367225311089;16140.596485087966;16292.592685182728;16731.6653666926;16797.908135971367;936.6581197862731;943.1794338925179;944.6127087893931;991.0287917840412;1008.3546530220665;9487.76280592977;9529.38059026175;9534.808148981378;9542.284328675378;9621;473967;475717;475722;515654;527617;63479.04781428282;66725.33274667288;66984.3301566978;67135.66432167808;68451;1060.740118670915;1061.3260579531898;1062.0600768320091;1070.1652710885521;1081.7079388565044;14593.92703036478;14594.708105837612;14797.630059248604;14874.181919994504;15039.323230454436;30498.542521861746;31696;32222.677773221967;32299.35401292008;32901.83549082239;39536.802315988236;39872.601273988046;41366;41636.37545436881;41801.79099104485;6858.142732158481;6927.480438967198;7020.7893763187185;7126;7372.152202496782;10345.896541034494;11381.146414018816;11480;11481;11648.184627076023;9642.614295428104;9682.322237443594;9787.755306117404;10105.787305523385;10253.436061016715;9408.482533460725;9934.701958941243;10059.245556583432;10192.694219173436;10409.115225205942;9745.805083898424;9835.311528192959;9838.852417213604;10305.433201174008;10330.431826249327;7351.301626345488;7568.243175682388;7617;7623.809404764926;7682.923170768221;10070.19438444908;10389.740256493647;10483.423411712123;10510.684679459628;10604.416757078434 22:18:51 INFO - PROCESS | 22930 | |3;mootools.html;1458.9124652520845;1489.300028986376;1636.7872176617038;1762.0132725673616;1784.072282413145;7573.5834529100875;7651.885221721679;7741.3419859312025;7772.1450640429575;7793.688252469894;7790.220977902207;7820.804479887991;7892.921070789291;7900.130985591581;7906.169852165512;2239.9328020159423;2254.7745225477483;2257.695211146499;2265.546890621882;2267.0931627349028;2340.473393486469;2359.610664240407;2366.0535785685693;2373.145667559686;2375.7743014413604;2182.0617134632103;2234.4748983988748;2263.7396699379533;2265.8753768542806;2300.0914638717695;2283.0981762204;2294.8508346957396;2300.8504447210876;2307.8038366738847;2310.4570425949973;2306.5156317173414;2312.7571604981404;2313.595120853844;2315.710536182977;2327.6624889391114;7602.277783610548;7630.580318082503;7654.0815102187535;7682.4238182136005;7709.383249340095;4609.124266389409;4771.618270538349;4776.904461910743;4800.639952003578;4805.3753012108555;3008;3028.9394212115853;3133.6552979172275;3156.2425017995515;3161.2887100402227;954.575214029757;963.9903600963971;970.9951450242703;972.8297547929084;984.9901500985042;10215.387076775418;10304.845427318596;10306.123979461754;10308.484575771181;10321.690349289533;4134.772587507716;4187.685923555746;4238.830446782094;4255.5957184067465;4268.679849011337;8340.124286949784;8381.371397145238;8388.916110838814;8392.706255281037;8420.284275836622;4570.702904311275;4590.9540904591195;4606.378138951266;4613.938794077381;4623.653226007996;4219.556946520571;4241.766702831374;4254.42565253693;4260.957390426118;4295.37717031035;3437.7937323760652;3456.2914602506426;3462.376772181032;3470.045737422229;3500.2824420993634;1058.99470502647;1087.7770057138268;1094.3597995172754;1095.309954728516;1106.651404807483;1094.2121672395863;1099.961501347449;1126.487448211062;1238.2137342787396;1325.4830616059744;7049.541779784297;7078.893816592756;7101.502894797314;7112.110986126734;7172.497925145294;1111.216592302425;1127.5827943660734;1129.813580759182;1129.875833433157;1135.131624307389;5490.6431081979545;5518.420565840609;5554.777808887599;5558.944410555842;5619.185218143428;9303;9329.440233586007;9530.285228607881;9679.225661947028;9718.173955213886;9505.42967421957;9521.666741664147;9557.139857412867;9614.615415383447;9653.855192172123;7322.450816188807;7387.445941554405;7422.888656670154;7468.4025277977635;7504.962475187589;7062.576245425085;7093.1488221413765;7099.929000709927;7118.430525558047;7135.678894449658;8210.876836847332;8246.54643994586;8491.617877195418;8529.91470085316;8703.390762646553;8606.397552171538;8620.094890036708;8646.394752367274;8688.782780430287;8773.122687731176;6488.610683359014;6699.564528305645;6724.462043036643;6744.123263975652;6770.45836333102;7335.596542190017;7340.816479588053;7354.8896766549615;7374.815629609303;7381.483296169216;6535.281119076993;7086.574805511686;7239.384652304613;7241.131064272321;7361.595112268877;6450.774222902176;6543.083968244355;6609.173853268341;6719.62247739222;6829;6790.42281406086;6847.486438517031;6889.827754306182;6894.103766510522;6917.896231556631;6129.417705318166;6198.907016394667;6252.9374706254175;6255.40573645503;6268.059791031382;6382.074599183;6460.547761656639;6465.579737317247;6491.285958544462;6587.538872278895 22:18:51 INFO - PROCESS | 22930 | |4;prototype.html;338.4381926002835;342.31536926147703;348.23562280793635;351.73444049742443;352.62797748375453;6286.937130628692;6322.620642761438;6343.460805831498;6378.457831084357;6456.160699109109;6221.59559628625;6268.341824108471;6310.274318453379;6361.936380636193;6363.459105975986;4802.615790736751;4804.663673542854;4811.518848115195;4817.879553011186;4823.180059389894;4817.0847538967655;4821.855344339658;4827.131116399047;4827.927581086286;4841;4673.83641572545;4779.211430114045;4780.90438191236;4784.306275590037;4791.976040119795;4738.2892566115015;4767.69010014348;4770.689905156154;4772.355731976173;4783.115123702091;4190.895227619303;4192.559781222958;4195.832166713328;4198.244316023115;4201.243776120297;5934.347221805598;5960.672163031031;5972.522198224175;5973.761049558056;5990.161377407167;5368.892622147535;5479.863003424906;5480.780768769245;5482.5613950884235;5485.890282194374;6601.339866013408;6611;6619.304972977816;6623.867522649568;6630.171228596426;4464.084862603158;4501.144782491317;4504.288370419253;4505.842295519641;4514.525974772634;6850.520463567552;6922.342377474182;6969.337912898216;6989.755358562476;7044.577325360444;4626.306054091846;4662;4673.6728429009645;4675.018246168274;4681.29780532916;4707.246840505502;4709.152352576569;4725.983913458623;4729.597984171384;4731.219348807408;5463.7814487420055;5479.726013699299;5483.972580137153;5504.036793561191;5518.53092487135;6608.570442921291;6719.092922455504;6723.562968407038;6725.495587830932;6726.697298621574;1687.9493615191564;1709.2393884721428;1719.7678313427778;1721.0706218641794;1726.0420466641135;1142.8057230270874;1173.3957012138756;1181.1141643767176;1183.988160118388;1188.2989036468352;6152.753889844356;6202.224721909762;6204.100405441276;6235.781747638902;6246.531510136758;6670.332966703291;6675.332466753286;6685.699143538553;6699.229588597374;6708.127943367429;5977.222961015127;6136.9079463808075;6138.109974053827;6162.876742465126;6165.383461653799;3700.5744339400776;3703.703703703697;3705.814709264526;3706.4810926470313;3715.5727091384297;7052.788416347517;7079.469039822034;7088.539244949062;7089.326513981164;7101.715931362791;6766.627835469097;6903.240643529208;6928.099347084847;6931.202911665122;6952.200496942815;7053.612051337123;7064.823379415556;7076.787696369014;7085.185203701537;7094.361507464353;6780.660966951731;6800.795976120724;6802.455803535607;6802.455803535607;6803.115594972622;6556.8360790980605;6640.435562977201;6652.501062420241;6672.566283191577;6680.465562755066;7055.788326350218;7077.6461176941975;7079.575225486487;7079.610621415872;7101.538400003983;4688.5545873143365;4698.177818881751;4701.177293973473;4704.905901882012;4715.797471644709;6700.396964273239;6745.763898263537;6761.628110453776;6776.424003959719;6974.163100427981;6732.966335168293;6738.528303018742;6775.356341147583;6776.966115169393;6777.695003724745;6768.187817461936;6783.559068660521;6791.117154769849;6808.114945057111;6821.863562728817;6453.193350831146;6621.337866213533;6628.900566491603;6641.900371494528;6664.100346453167;6802.387785099365;6838.076859623887;6838.14523184602;6871.759488417882;6876.759313424006;6605.636689982097;6690.6320152390135;6691;6697.0958920547055;6705.731770729311 22:18:51 INFO - PROCESS | 22930 | |5;yui.html;663.5123184459421;681.4820736240456;696.8257935516122;823.3906908887421;831.0318478971997;11910.464029118688;11929.7614047719;12032.699182520442;12038.33789141597;12046.57836975706;11744.706382340446;11787.29276243426;11828.29030258185;11861.288322700644;13378.264195469244;779.7504798464507;794.4200733464575;795.6697970342301;796.3231253434564;796.4703472191015;760.1296515489761;760.7147319755092;760.7869796457001;760.9581473019009;784.207949970531;787.4369825574713;791.1574173505227;792.9801754956144;803.1606970715616;827.8758186272078;782.4288269563194;784.3685832904538;786.268770043859;792.3383974381399;818.5170749257936;572.4876235769005;574.287883025046;575.3584753000416;593.442164365495;597.9162917191596;11875.584354547549;11925.105617078754;12011.819822702666;12039.518419263219;12040;11863.466144023454;12171.14801963863;12333.568325108577;12636.557720479832;12956.222626642431;10001.299909006373;10022.248331375176;10081.747956301078;10292.382457052601;10327.638532651396;3513.2446523997464;3515.771474854126;3519.8416071276597;3545.0782796473104;3661.6155303692994;46350.76824615855;46469.07061858744;47118.52881471175;47274.527254727356;47858.76070619625;9202.953985230031;9308.8603670945;9330.113639204264;9387.389819661837;9456.338056336128;15965.44120955761;16037.117958512394;16075.919620401823;16097;16103;6811.897821532681;6902.309769023058;6904.689288982008;6918;7047.68285427157;3992.2334713609002;4037.4953130858644;4037.9394309085387;4043.2317859606583;4077.857274995361;3031.4846476098674;3068.3863227354173;3079.4303053935096;3088.845557722105;3091.7990330628436;563.357772139761;577.7573419163962;578.5662095463438;588.3821986913723;594.5392320951297;592.2508027345411;595.9303051023423;657.1063353838871;694.6318451220861;712.4905692429834;8261.876071858927;8310.878031465796;8329.383827146323;8476.745697629081;9121;529.6636635736335;559;563.5942121672389;576.0696475192534;713.7858642407257;3910.804459777;4022.8189731462153;4070.4504891839815;4138.586141385837;4152.294110001307;55552.72223638937;56985;61074;62015;62105.68947155235;50126.248106278435;50902.74548627233;51130;51169.48830511647;51468.48531514637;45090.77454612706;45562.03846749951;45753.77123114363;48828.755856220494;48890.02219955652;8332.33341332704;8465.111163327761;8591.44155629882;8644.481331119901;8776.91223087761;32722.50916236211;32919.83540082284;33826;34671.65328346684;35242.47136293009;39297;40876;41193.176136477705;42322.576774231864;43805.56194438015;9920.802823421784;10279.84580231312;10312.948435257777;10442.530086146293;10526.578936842441;11698;11804.291742495478;11824.82262766042;12020.485742360042;12278.386080696107;11041.282316649393;11149.10807135411;11174;11182.888171118184;11474.94262528682;10445.210613101544;10620.681379558626;10640.627578034731;10702.89297107019;11076.667699969013;11115.610953616584;11130.610428634958;11237.438128093727;11254.38100904458;11300.09599232076;8847.867281990646;9214.861777073214;9241.953790231006;9289.256859451092;9569.521523923637;8754.956225218833;8994.685186018458;9068.773280667772;9118.270538357048;9327.766805829637 22:18:51 INFO - PROCESS | 22930 | __end_tp_report 22:18:51 INFO - PROCESS | 22930 | __start_cc_report 22:18:51 INFO - PROCESS | 22930 | _x_x_mozilla_cycle_collect,328 22:18:51 INFO - PROCESS | 22930 | __end_cc_report 22:18:51 INFO - PROCESS | 22930 | __startTimestamp1453789131806__endTimestamp 22:18:51 INFO - PROCESS | 22930 | 22:18:51 INFO - PROCESS | 22930 | ------- Summary: start ------- 22:18:51 INFO - PROCESS | 22930 | Number of tests: 6 22:18:51 INFO - PROCESS | 22930 | 22:18:51 INFO - PROCESS | 22930 | [#0] dojo.html Cycles:165 Average:5341.42 Median:5553.78 stddev:610.06 (11.0%) stddev-sans-first:588.48 22:18:51 INFO - PROCESS | 22930 | Values: 3205.9 3236.5 3266.3 3284.7 3290.0 5183.8 5371.6 5418.0 5427.9 5437.2 5227.6 5237.8 5262.5 5271.1 5277.7 4628.1 4876.3 5049.6 5058.5 5067.7 4712.6 4964.2 5000.8 5022.8 5038.0 4752.6 4797.8 4812.0 4829.5 4846.0 4895.6 4917.8 4933.5 4960.4 4960.4 4767.6 4822.4 4930.9 4949.7 4977.5 5172.5 5206.2 5221.9 5227.6 5251.4 5657.5 5660.0 5668.2 5679.7 5693.9 5701.8 5707.3 5791.5 5803.7 5821.3 5457.2 5483.4 5484.8 5486.7 5516.9 5936.1 5945.3 5963.2 5975.2 5984.9 5584.6 5685.7 5706.2 5749.3 5760.7 5778.2 5813.2 5830.1 5861.9 5867.1 5735.1 5764.6 5767.6 5782.2 5782.3 5503.9 5579.8 5659.3 5703.3 5760.1 4245.9 4262.5 4271.0 4271.5 4290.6 3827.2 3833.2 3840.2 3851.8 3889.3 5283.9 5362.1 5389.7 5435.9 5466.2 5770.4 5787.6 5801.3 5815.0 5845.1 5225.3 5412.3 5421.5 5437.5 5438.0 4891.3 4910.4 4973.8 4990.1 5022.8 5833.8 5844.0 5846.0 5858.5 5876.7 5553.8 5670.2 5678.1 5707.3 5717.1 5990.6 6000.4 6017.7 6067.2 6088.5 5689.4 5742.2 5798.2 5798.3 5814.9 5687.9 5741.3 5869.4 5897.4 5899.6 5664.6 5713.5 5719.5 5739.9 5773.1 5514.1 5576.8 5584.2 5605.2 5611.9 5280.6 5373.5 5516.1 5518.0 5521.6 5604.6 5708.3 5712.1 5737.0 5744.3 5590.7 5597.5 5604.3 5607.5 5620.0 22:18:51 INFO - PROCESS | 22930 | 22:18:51 INFO - PROCESS | 22930 | [#1] ext.html Cycles:180 Average:46308.98 Median:205987.72 stddev:78428.48 (38.1%) stddev-sans-first:78573.11 22:18:51 INFO - PROCESS | 22930 | Values: 508.9 535.2 538.1 557.6 584.7 27938.6 35495.0 35526.1 35956.0 35987.3 38189.4 38557.0 38559.0 38902.8 38918.4 8352.2 8599.3 8611.4 8627.7 8633.4 8349.2 8419.3 8462.1 8470.7 8726.8 8723.6 8738.0 8772.5 8793.5 8824.9 8661.3 8728.6 8758.2 8779.2 8782.8 8483.6 8562.6 8623.1 8624.5 8632.4 39373.4 39495.2 39678.6 39732.0 39882.4 2944.8 2978.4 3045.1 3053.6 3234.9 27908.0 28959.9 29112.6 29608.9 29611.4 3832.3 3851.0 3892.4 4018.4 4111.9 209566.0 212852.0 212886.0 213197.0 213277.0 52988.7 54002.7 60042.0 60352.7 60374.0 61999.4 63539.7 63929.0 64132.0 64137.7 13515.7 13567.7 13577.1 13650.7 13655.9 11438.7 11500.0 11551.1 11572.3 11590.9 19723.9 19909.4 19924.6 20181.2 20207.9 7783.6 8035.8 8100.2 8116.7 8150.8 970.4 1046.2 1134.8 1153.0 1155.2 27623.2 28604.6 28627.0 32698.5 32990.0 1010.2 1043.5 1088.2 1107.0 1115.7 13545.6 13665.4 13721.8 13780.3 13816.2 371949.0 374661.0 375986.1 376226.0 376721.0 50436.2 51336.5 51341.0 51574.0 51599.7 1352.5 1358.9 1363.1 1363.3 1369.0 25440.4 26396.2 26410.0 26679.6 26721.2 51751.2 53047.2 53386.5 53406.7 53571.2 282399.0 285467.0 286249.0 286795.0 287626.0 40956.6 41066.8 41100.0 41108.8 41755.2 41800.0 42404.4 42730.1 43150.4 43426.3 34815.1 35153.6 35376.1 35499.1 35939.3 36095.1 37049.4 37673.7 38635.1 38855.0 32267.8 32986.2 33306.8 33309.5 33577.2 28177.7 29667.4 35338.6 37314.4 37949.6 25088.6 25131.2 25567.6 26573.0 27039.7 22:18:51 INFO - PROCESS | 22930 | 22:18:51 INFO - PROCESS | 22930 | [#2] jquery.html Cycles:180 Average:25654.54 Median:4924.82 stddev:80703.81 (1638.7%) stddev-sans-first:80907.86 22:18:51 INFO - PROCESS | 22930 | Values: 363.3 364.6 367.3 372.3 373.1 16181.8 16594.4 16864.2 17314.9 17613.2 9641.3 9938.6 9977.5 10405.7 10582.3 4841.6 4875.5 4974.1 4989.7 5418.6 5280.7 5390.1 5414.5 5419.9 5422.5 5226.8 5418.5 5483.6 5502.4 5732.7 5383.2 5590.6 5600.8 5622.2 5740.3 5045.8 5047.9 5078.6 5088.8 5110.5 11833.3 12411.4 17970.9 19712.8 19878.2 2052.1 2173.3 2174.7 2234.0 2335.6 8756.9 8823.8 9063.0 9082.9 9260.0 1791.6 1806.2 1811.1 1858.5 1865.6 49761.8 50480.2 55363.7 57007.4 57212.0 9518.1 9787.0 9863.3 9877.0 9921.0 12897.5 12915.5 12928.5 12966.9 12980.2 7229.6 7294.3 7319.5 7346.7 7370.5 7072.2 7135.9 7137.0 7219.4 7234.5 4278.4 4297.3 4361.2 4363.5 4402.0 1736.4 1795.6 1818.4 1842.1 1848.5 863.3 893.7 950.8 999.4 1060.2 15819.4 16140.6 16292.6 16731.7 16797.9 936.7 943.2 944.6 991.0 1008.4 9487.8 9529.4 9534.8 9542.3 9621.0 473967.0 475717.0 475722.0 515654.0 527617.0 63479.0 66725.3 66984.3 67135.7 68451.0 1060.7 1061.3 1062.1 1070.2 1081.7 14593.9 14594.7 14797.6 14874.2 15039.3 30498.5 31696.0 32222.7 32299.4 32901.8 39536.8 39872.6 41366.0 41636.4 41801.8 6858.1 6927.5 7020.8 7126.0 7372.2 10345.9 11381.1 11480.0 11481.0 11648.2 9642.6 9682.3 9787.8 10105.8 10253.4 9408.5 9934.7 10059.2 10192.7 10409.1 9745.8 9835.3 9838.9 10305.4 10330.4 7351.3 7568.2 7617.0 7623.8 7682.9 10070.2 10389.7 10483.4 10510.7 10604.4 22:18:51 INFO - PROCESS | 22930 | 22:18:51 INFO - PROCESS | 22930 | [#3] mootools.html Cycles:180 Average:5401.48 Median:6416.42 stddev:2781.81 (43.4%) stddev-sans-first:2773.83 22:18:51 INFO - PROCESS | 22930 | Values: 1458.9 1489.3 1636.8 1762.0 1784.1 7573.6 7651.9 7741.3 7772.1 7793.7 7790.2 7820.8 7892.9 7900.1 7906.2 2239.9 2254.8 2257.7 2265.5 2267.1 2340.5 2359.6 2366.1 2373.1 2375.8 2182.1 2234.5 2263.7 2265.9 2300.1 2283.1 2294.9 2300.9 2307.8 2310.5 2306.5 2312.8 2313.6 2315.7 2327.7 7602.3 7630.6 7654.1 7682.4 7709.4 4609.1 4771.6 4776.9 4800.6 4805.4 3008.0 3028.9 3133.7 3156.2 3161.3 954.6 964.0 971.0 972.8 985.0 10215.4 10304.8 10306.1 10308.5 10321.7 4134.8 4187.7 4238.8 4255.6 4268.7 8340.1 8381.4 8388.9 8392.7 8420.3 4570.7 4591.0 4606.4 4613.9 4623.7 4219.6 4241.8 4254.4 4261.0 4295.4 3437.8 3456.3 3462.4 3470.0 3500.3 1059.0 1087.8 1094.4 1095.3 1106.7 1094.2 1100.0 1126.5 1238.2 1325.5 7049.5 7078.9 7101.5 7112.1 7172.5 1111.2 1127.6 1129.8 1129.9 1135.1 5490.6 5518.4 5554.8 5558.9 5619.2 9303.0 9329.4 9530.3 9679.2 9718.2 9505.4 9521.7 9557.1 9614.6 9653.9 7322.5 7387.4 7422.9 7468.4 7505.0 7062.6 7093.1 7099.9 7118.4 7135.7 8210.9 8246.5 8491.6 8529.9 8703.4 8606.4 8620.1 8646.4 8688.8 8773.1 6488.6 6699.6 6724.5 6744.1 6770.5 7335.6 7340.8 7354.9 7374.8 7381.5 6535.3 7086.6 7239.4 7241.1 7361.6 6450.8 6543.1 6609.2 6719.6 6829.0 6790.4 6847.5 6889.8 6894.1 6917.9 6129.4 6198.9 6252.9 6255.4 6268.1 6382.1 6460.5 6465.6 6491.3 6587.5 22:18:51 INFO - PROCESS | 22930 | 22:18:51 INFO - PROCESS | 22930 | [#4] prototype.html Cycles:180 Average:5549.82 Median:6257.44 stddev:1670.56 (26.7%) stddev-sans-first:1628.81 22:18:51 INFO - PROCESS | 22930 | Values: 338.4 342.3 348.2 351.7 352.6 6286.9 6322.6 6343.5 6378.5 6456.2 6221.6 6268.3 6310.3 6361.9 6363.5 4802.6 4804.7 4811.5 4817.9 4823.2 4817.1 4821.9 4827.1 4827.9 4841.0 4673.8 4779.2 4780.9 4784.3 4792.0 4738.3 4767.7 4770.7 4772.4 4783.1 4190.9 4192.6 4195.8 4198.2 4201.2 5934.3 5960.7 5972.5 5973.8 5990.2 5368.9 5479.9 5480.8 5482.6 5485.9 6601.3 6611.0 6619.3 6623.9 6630.2 4464.1 4501.1 4504.3 4505.8 4514.5 6850.5 6922.3 6969.3 6989.8 7044.6 4626.3 4662.0 4673.7 4675.0 4681.3 4707.2 4709.2 4726.0 4729.6 4731.2 5463.8 5479.7 5484.0 5504.0 5518.5 6608.6 6719.1 6723.6 6725.5 6726.7 1687.9 1709.2 1719.8 1721.1 1726.0 1142.8 1173.4 1181.1 1184.0 1188.3 6152.8 6202.2 6204.1 6235.8 6246.5 6670.3 6675.3 6685.7 6699.2 6708.1 5977.2 6136.9 6138.1 6162.9 6165.4 3700.6 3703.7 3705.8 3706.5 3715.6 7052.8 7079.5 7088.5 7089.3 7101.7 6766.6 6903.2 6928.1 6931.2 6952.2 7053.6 7064.8 7076.8 7085.2 7094.4 6780.7 6800.8 6802.5 6802.5 6803.1 6556.8 6640.4 6652.5 6672.6 6680.5 7055.8 7077.6 7079.6 7079.6 7101.5 4688.6 4698.2 4701.2 4704.9 4715.8 6700.4 6745.8 6761.6 6776.4 6974.2 6733.0 6738.5 6775.4 6777.0 6777.7 6768.2 6783.6 6791.1 6808.1 6821.9 6453.2 6621.3 6628.9 6641.9 6664.1 6802.4 6838.1 6838.1 6871.8 6876.8 6605.6 6690.6 6691.0 6697.1 6705.7 22:18:51 INFO - PROCESS | 22930 | 22:18:51 INFO - PROCESS | 22930 | [#5] yui.html Cycles:180 Average:13398.57 Median:47566.64 stddev:15887.97 (33.4%) stddev-sans-first:15903.76 22:18:51 INFO - PROCESS | 22930 | Values: 663.5 681.5 696.8 823.4 831.0 11910.5 11929.8 12032.7 12038.3 12046.6 11744.7 11787.3 11828.3 11861.3 13378.3 779.8 794.4 795.7 796.3 796.5 760.1 760.7 760.8 761.0 784.2 787.4 791.2 793.0 803.2 827.9 782.4 784.4 786.3 792.3 818.5 572.5 574.3 575.4 593.4 597.9 11875.6 11925.1 12011.8 12039.5 12040.0 11863.5 12171.1 12333.6 12636.6 12956.2 10001.3 10022.2 10081.7 10292.4 10327.6 3513.2 3515.8 3519.8 3545.1 3661.6 46350.8 46469.1 47118.5 47274.5 47858.8 9203.0 9308.9 9330.1 9387.4 9456.3 15965.4 16037.1 16075.9 16097.0 16103.0 6811.9 6902.3 6904.7 6918.0 7047.7 3992.2 4037.5 4037.9 4043.2 4077.9 3031.5 3068.4 3079.4 3088.8 3091.8 563.4 577.8 578.6 588.4 594.5 592.3 595.9 657.1 694.6 712.5 8261.9 8310.9 8329.4 8476.7 9121.0 529.7 559.0 563.6 576.1 713.8 3910.8 4022.8 4070.5 4138.6 4152.3 55552.7 56985.0 61074.0 62015.0 62105.7 50126.2 50902.7 51130.0 51169.5 51468.5 45090.8 45562.0 45753.8 48828.8 48890.0 8332.3 8465.1 8591.4 8644.5 8776.9 32722.5 32919.8 33826.0 34671.7 35242.5 39297.0 40876.0 41193.2 42322.6 43805.6 9920.8 10279.8 10312.9 10442.5 10526.6 11698.0 11804.3 11824.8 12020.5 12278.4 11041.3 11149.1 11174.0 11182.9 11474.9 10445.2 10620.7 10640.6 10702.9 11076.7 11115.6 11130.6 11237.4 11254.4 11300.1 8847.9 9214.9 9242.0 9289.3 9569.5 8755.0 8994.7 9068.8 9118.3 9327.8 22:18:51 INFO - PROCESS | 22930 | -------- Summary: end -------- 22:18:51 INFO - PROCESS | 22930 | 22:18:52 INFO - TEST-INFO | 22930: exit 0 22:18:52 INFO - TEST-OK | dromaeo_css | took 1109816ms 22:18:52 INFO - TEST-START | kraken 22:18:52 INFO - operating with platform_type : linux_ 22:18:52 INFO - Initialising browser for kraken test... 22:18:52 INFO - TEST-INFO | started process 23176 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpficEAT/profile http://localhost:54668/getInfo.html) 22:18:55 INFO - PROCESS | 23176 | 22:18:55 INFO - PROCESS | 23176 | (process:23250): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:18:56 INFO - PROCESS | 23176 | __metrics Screen width/height:1600/1200 22:18:56 INFO - PROCESS | 23176 | colorDepth:24 22:18:56 INFO - PROCESS | 23176 | Browser inner width/height: 1024/697 22:18:56 INFO - PROCESS | 23176 | __metrics 22:18:56 INFO - PROCESS | 23176 | 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:18:57 INFO - TEST-INFO | 23176: exit 0 22:18:57 INFO - Browser initialized. 22:18:57 INFO - Running cycle 1/1 for kraken test... 22:18:57 INFO - TEST-INFO | started process 23299 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpficEAT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:18:58 INFO - PROCESS | 23299 | 22:18:58 INFO - PROCESS | 23299 | (process:23355): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:19:09 INFO - PROCESS | 23299 | RSS: Main: 152059904 22:19:09 INFO - PROCESS | 23299 | 22:19:11 INFO - PROCESS | 23299 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54668/tests/kraken/driver.html?testName=audio-beat-detection) 22:19:12 INFO - PROCESS | 23299 | RSS: Main: 154963968 22:19:12 INFO - PROCESS | 23299 | 22:19:15 INFO - PROCESS | 23299 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54668/tests/kraken/driver.html?testName=audio-dft) 22:19:15 INFO - PROCESS | 23299 | RSS: Main: 159244288 22:19:15 INFO - PROCESS | 23299 | 22:19:18 INFO - PROCESS | 23299 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54668/tests/kraken/driver.html?testName=audio-fft) 22:19:19 INFO - PROCESS | 23299 | RSS: Main: 152870912 22:19:19 INFO - PROCESS | 23299 | 22:19:21 INFO - PROCESS | 23299 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54668/tests/kraken/driver.html?testName=audio-oscillator) 22:19:22 INFO - PROCESS | 23299 | RSS: Main: 152981504 22:19:22 INFO - PROCESS | 23299 | 22:19:24 INFO - PROCESS | 23299 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54668/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:19:24 INFO - PROCESS | 23299 | RSS: Main: 153194496 22:19:24 INFO - PROCESS | 23299 | 22:19:27 INFO - PROCESS | 23299 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54668/tests/kraken/driver.html?testName=imaging-darkroom) 22:19:28 INFO - PROCESS | 23299 | RSS: Main: 152952832 22:19:28 INFO - PROCESS | 23299 | 22:19:31 INFO - PROCESS | 23299 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54668/tests/kraken/driver.html?testName=imaging-desaturate) 22:19:32 INFO - PROCESS | 23299 | RSS: Main: 154939392 22:19:32 INFO - PROCESS | 23299 | 22:19:35 INFO - PROCESS | 23299 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54668/tests/kraken/driver.html?testName=json-parse-financial) 22:19:35 INFO - PROCESS | 23299 | RSS: Main: 154836992 22:19:35 INFO - PROCESS | 23299 | 22:19:37 INFO - PROCESS | 23299 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54668/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:19:38 INFO - PROCESS | 23299 | RSS: Main: 153571328 22:19:38 INFO - PROCESS | 23299 | 22:19:39 INFO - PROCESS | 23299 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54668/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:19:40 INFO - PROCESS | 23299 | RSS: Main: 153423872 22:19:40 INFO - PROCESS | 23299 | 22:19:42 INFO - PROCESS | 23299 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54668/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:19:43 INFO - PROCESS | 23299 | RSS: Main: 154247168 22:19:43 INFO - PROCESS | 23299 | 22:19:45 INFO - PROCESS | 23299 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54668/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:19:46 INFO - PROCESS | 23299 | RSS: Main: 154722304 22:19:46 INFO - PROCESS | 23299 | 22:19:48 INFO - PROCESS | 23299 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54668/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:19:49 INFO - PROCESS | 23299 | RSS: Main: 153915392 22:19:49 INFO - PROCESS | 23299 | 22:19:51 INFO - PROCESS | 23299 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54668/tests/kraken/driver.html?testName=ai-astar) 22:19:51 INFO - PROCESS | 23299 | RSS: Main: 156286976 22:19:51 INFO - PROCESS | 23299 | 22:19:51 INFO - PROCESS | 23299 | __start_tp_report 22:19:51 INFO - PROCESS | 23299 | _x_x_mozilla_page_load 22:19:51 INFO - PROCESS | 23299 | _x_x_mozilla_page_load_details 22:19:51 INFO - PROCESS | 23299 | |i|pagename|runs| 22:19:51 INFO - PROCESS | 23299 | |0;ai-astar;112;111;113;113;113;123;113;113;112;113 22:19:51 INFO - PROCESS | 23299 | |1;audio-beat-detection;161;129;166;167;126;158;157;129;168;130 22:19:51 INFO - PROCESS | 23299 | |2;audio-dft;164;162;162;162;163;162;162;163;168;162 22:19:51 INFO - PROCESS | 23299 | |3;audio-fft;73;73;72;73;73;161;75;73;76;75 22:19:51 INFO - PROCESS | 23299 | |4;audio-oscillator;96;96;141;94;95;95;135;96;95;146 22:19:51 INFO - PROCESS | 23299 | |5;imaging-gaussian-blur;120;116;116;115;115;116;115;116;115;115 22:19:51 INFO - PROCESS | 23299 | |6;imaging-darkroom;146;148;147;146;149;146;151;147;147;146 22:19:51 INFO - PROCESS | 23299 | |7;imaging-desaturate;97;96;96;97;96;96;96;97;96;96 22:19:51 INFO - PROCESS | 23299 | |8;json-parse-financial;61;64;59;60;63;59;61;61;68;59 22:19:51 INFO - PROCESS | 23299 | |9;json-stringify-tinderbox;67;67;67;67;68;67;66;66;68;68 22:19:51 INFO - PROCESS | 23299 | |10;stanford-crypto-aes;84;84;85;93;85;93;86;91;85;86 22:19:51 INFO - PROCESS | 23299 | |11;stanford-crypto-ccm;119;115;115;123;118;119;129;122;116;118 22:19:51 INFO - PROCESS | 23299 | |12;stanford-crypto-pbkdf2;140;154;148;148;147;153;148;150;150;141 22:19:51 INFO - PROCESS | 23299 | |13;stanford-crypto-sha256-iterative;71;69;69;69;67;67;68;70;82;66 22:19:51 INFO - PROCESS | 23299 | __end_tp_report 22:19:51 INFO - PROCESS | 23299 | __start_cc_report 22:19:51 INFO - PROCESS | 23299 | _x_x_mozilla_cycle_collect,753 22:19:51 INFO - PROCESS | 23299 | __end_cc_report 22:19:51 INFO - PROCESS | 23299 | __startTimestamp1453789191322__endTimestamp 22:19:51 INFO - PROCESS | 23299 | 22:19:51 INFO - PROCESS | 23299 | ------- Summary: start ------- 22:19:51 INFO - PROCESS | 23299 | Number of tests: 14 22:19:51 INFO - PROCESS | 23299 | 22:19:51 INFO - PROCESS | 23299 | [#0] ai-astar Cycles:10 Average:113.60 Median:113.00 stddev:3.37 (3.0%) stddev-sans-first:3.53 22:19:51 INFO - PROCESS | 23299 | Values: 112.0 111.0 113.0 113.0 113.0 123.0 113.0 113.0 112.0 113.0 22:19:51 INFO - PROCESS | 23299 | 22:19:51 INFO - PROCESS | 23299 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:159.50 stddev:18.11 (11.4%) stddev-sans-first:18.69 22:19:51 INFO - PROCESS | 23299 | Values: 161.0 129.0 166.0 167.0 126.0 158.0 157.0 129.0 168.0 130.0 22:19:51 INFO - PROCESS | 23299 | 22:19:51 INFO - PROCESS | 23299 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.50 stddev:1.89 (1.2%) stddev-sans-first:1.96 22:19:51 INFO - PROCESS | 23299 | Values: 164.0 162.0 162.0 162.0 163.0 162.0 162.0 163.0 168.0 162.0 22:19:51 INFO - PROCESS | 23299 | 22:19:51 INFO - PROCESS | 23299 | [#3] audio-fft Cycles:10 Average:82.40 Median:73.00 stddev:27.65 (37.9%) stddev-sans-first:29.11 22:19:51 INFO - PROCESS | 23299 | Values: 73.0 73.0 72.0 73.0 73.0 161.0 75.0 73.0 76.0 75.0 22:19:51 INFO - PROCESS | 23299 | 22:19:51 INFO - PROCESS | 23299 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:95.00 stddev:22.08 (23.2%) stddev-sans-first:22.92 22:19:51 INFO - PROCESS | 23299 | Values: 96.0 96.0 141.0 94.0 95.0 95.0 135.0 96.0 95.0 146.0 22:19:51 INFO - PROCESS | 23299 | 22:19:51 INFO - PROCESS | 23299 | [#5] imaging-gaussian-blur Cycles:10 Average:115.90 Median:116.00 stddev:1.52 (1.3%) stddev-sans-first:0.53 22:19:51 INFO - PROCESS | 23299 | Values: 120.0 116.0 116.0 115.0 115.0 116.0 115.0 116.0 115.0 115.0 22:19:51 INFO - PROCESS | 23299 | 22:19:51 INFO - PROCESS | 23299 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:1.64 (1.1%) stddev-sans-first:1.67 22:19:51 INFO - PROCESS | 23299 | Values: 146.0 148.0 147.0 146.0 149.0 146.0 151.0 147.0 147.0 146.0 22:19:51 INFO - PROCESS | 23299 | 22:19:51 INFO - PROCESS | 23299 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 22:19:51 INFO - PROCESS | 23299 | Values: 97.0 96.0 96.0 97.0 96.0 96.0 96.0 97.0 96.0 96.0 22:19:51 INFO - PROCESS | 23299 | 22:19:51 INFO - PROCESS | 23299 | [#8] json-parse-financial Cycles:10 Average:61.50 Median:61.00 stddev:2.84 (4.7%) stddev-sans-first:3.00 22:19:51 INFO - PROCESS | 23299 | Values: 61.0 64.0 59.0 60.0 63.0 59.0 61.0 61.0 68.0 59.0 22:19:51 INFO - PROCESS | 23299 | 22:19:51 INFO - PROCESS | 23299 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 22:19:51 INFO - PROCESS | 23299 | Values: 67.0 67.0 67.0 67.0 68.0 67.0 66.0 66.0 68.0 68.0 22:19:51 INFO - PROCESS | 23299 | 22:19:51 INFO - PROCESS | 23299 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:86.00 stddev:3.65 (4.2%) stddev-sans-first:3.68 22:19:51 INFO - PROCESS | 23299 | Values: 84.0 84.0 85.0 93.0 85.0 93.0 86.0 91.0 85.0 86.0 22:19:51 INFO - PROCESS | 23299 | 22:19:51 INFO - PROCESS | 23299 | [#11] stanford-crypto-ccm Cycles:10 Average:119.40 Median:119.00 stddev:4.30 (3.6%) stddev-sans-first:4.56 22:19:51 INFO - PROCESS | 23299 | Values: 119.0 115.0 115.0 123.0 118.0 119.0 129.0 122.0 116.0 118.0 22:19:51 INFO - PROCESS | 23299 | 22:19:51 INFO - PROCESS | 23299 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:149.00 stddev:4.51 (3.0%) stddev-sans-first:3.77 22:19:51 INFO - PROCESS | 23299 | Values: 140.0 154.0 148.0 148.0 147.0 153.0 148.0 150.0 150.0 141.0 22:19:51 INFO - PROCESS | 23299 | 22:19:51 INFO - PROCESS | 23299 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:69.00 stddev:4.54 (6.6%) stddev-sans-first:4.80 22:19:51 INFO - PROCESS | 23299 | Values: 71.0 69.0 69.0 69.0 67.0 67.0 68.0 70.0 82.0 66.0 22:19:51 INFO - PROCESS | 23299 | -------- Summary: end -------- 22:19:51 INFO - PROCESS | 23299 | 22:19:52 INFO - TEST-INFO | 23299: exit 0 22:19:52 INFO - TEST-OK | kraken | took 59972ms 22:19:52 INFO - TEST-START | v8_7 22:19:52 INFO - operating with platform_type : linux_ 22:19:52 INFO - Initialising browser for v8_7 test... 22:19:52 INFO - TEST-INFO | started process 23584 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkZhS2y/profile http://localhost:54668/getInfo.html) 22:19:55 INFO - PROCESS | 23584 | 22:19:55 INFO - PROCESS | 23584 | (process:23659): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:19:56 INFO - PROCESS | 23584 | __metrics Screen width/height:1600/1200 22:19:56 INFO - PROCESS | 23584 | colorDepth:24 22:19:56 INFO - PROCESS | 23584 | Browser inner width/height: 1024/697 22:19:56 INFO - PROCESS | 23584 | __metrics 22:19:56 INFO - PROCESS | 23584 | 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:57 INFO - TEST-INFO | 23584: exit 0 22:19:57 INFO - Browser initialized. 22:19:57 INFO - Running cycle 1/1 for v8_7 test... 22:19:57 INFO - TEST-INFO | started process 23708 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkZhS2y/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:19:58 INFO - PROCESS | 23708 | 22:19:58 INFO - PROCESS | 23708 | (process:23769): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:20:09 INFO - PROCESS | 23708 | RSS: Main: 150704128 22:20:09 INFO - PROCESS | 23708 | 22:20:31 INFO - PROCESS | 23708 | Cycle 1(1): loaded http://localhost:54668/tests/v8_7/run.html (next: http://localhost:54668/tests/v8_7/run.html) 22:20:32 INFO - PROCESS | 23708 | RSS: Main: 151883776 22:20:32 INFO - PROCESS | 23708 | 22:20:32 INFO - PROCESS | 23708 | __start_tp_report 22:20:32 INFO - PROCESS | 23708 | _x_x_mozilla_page_load 22:20:32 INFO - PROCESS | 23708 | _x_x_mozilla_page_load_details 22:20:32 INFO - PROCESS | 23708 | |i|pagename|runs| 22:20:32 INFO - PROCESS | 23708 | |0;Richards;167.0843776106934 22:20:32 INFO - PROCESS | 23708 | |1;DeltaBlue;191.20458891013385 22:20:32 INFO - PROCESS | 23708 | |2;Encrypt;272.92576419213975 22:20:32 INFO - PROCESS | 23708 | |3;Decrypt;5306.878306878307 22:20:32 INFO - PROCESS | 23708 | |4;RayTrace;1102.5358324145534 22:20:32 INFO - PROCESS | 23708 | |5;Earley;690.6077348066299 22:20:32 INFO - PROCESS | 23708 | |6;Boyer;12358.024691358025 22:20:32 INFO - PROCESS | 23708 | |7;RegExp;41306.12244897959 22:20:32 INFO - PROCESS | 23708 | |8;Splay;606.151990349819 22:20:32 INFO - PROCESS | 23708 | |9;NavierStokes;4817.307692307692 22:20:32 INFO - PROCESS | 23708 | __end_tp_report 22:20:32 INFO - PROCESS | 23708 | __startTimestamp1453789232082__endTimestamp 22:20:32 INFO - PROCESS | 23708 | 22:20:32 INFO - PROCESS | 23708 | ------- Summary: start ------- 22:20:32 INFO - PROCESS | 23708 | Number of tests: 10 22:20:32 INFO - PROCESS | 23708 | 22:20:32 INFO - PROCESS | 23708 | [#0] Richards Cycles:1 Average:167.08 Median:167.08 stddev:0.00 (0.0%) 22:20:32 INFO - PROCESS | 23708 | Values: 167.1 22:20:32 INFO - PROCESS | 23708 | 22:20:32 INFO - PROCESS | 23708 | [#1] DeltaBlue Cycles:1 Average:191.20 Median:191.20 stddev:0.00 (0.0%) 22:20:32 INFO - PROCESS | 23708 | Values: 191.2 22:20:32 INFO - PROCESS | 23708 | 22:20:32 INFO - PROCESS | 23708 | [#2] Encrypt Cycles:1 Average:272.93 Median:272.93 stddev:0.00 (0.0%) 22:20:32 INFO - PROCESS | 23708 | Values: 272.9 22:20:32 INFO - PROCESS | 23708 | 22:20:32 INFO - PROCESS | 23708 | [#3] Decrypt Cycles:1 Average:5306.88 Median:5306.88 stddev:0.00 (0.0%) 22:20:32 INFO - PROCESS | 23708 | Values: 5306.9 22:20:32 INFO - PROCESS | 23708 | 22:20:32 INFO - PROCESS | 23708 | [#4] RayTrace Cycles:1 Average:1102.54 Median:1102.54 stddev:0.00 (0.0%) 22:20:32 INFO - PROCESS | 23708 | Values: 1102.5 22:20:32 INFO - PROCESS | 23708 | 22:20:32 INFO - PROCESS | 23708 | [#5] Earley Cycles:1 Average:690.61 Median:690.61 stddev:0.00 (0.0%) 22:20:32 INFO - PROCESS | 23708 | Values: 690.6 22:20:32 INFO - PROCESS | 23708 | 22:20:32 INFO - PROCESS | 23708 | [#6] Boyer Cycles:1 Average:12358.02 Median:12358.02 stddev:0.00 (0.0%) 22:20:32 INFO - PROCESS | 23708 | Values: 12358.0 22:20:32 INFO - PROCESS | 23708 | 22:20:32 INFO - PROCESS | 23708 | [#7] RegExp Cycles:1 Average:41306.12 Median:41306.12 stddev:0.00 (0.0%) 22:20:32 INFO - PROCESS | 23708 | Values: 41306.1 22:20:32 INFO - PROCESS | 23708 | 22:20:32 INFO - PROCESS | 23708 | [#8] Splay Cycles:1 Average:606.15 Median:606.15 stddev:0.00 (0.0%) 22:20:32 INFO - PROCESS | 23708 | Values: 606.2 22:20:32 INFO - PROCESS | 23708 | 22:20:32 INFO - PROCESS | 23708 | [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 22:20:32 INFO - PROCESS | 23708 | Values: 4817.3 22:20:32 INFO - PROCESS | 23708 | -------- Summary: end -------- 22:20:32 INFO - PROCESS | 23708 | 22:20:32 INFO - TEST-INFO | 23708: exit 0 22:20:32 INFO - TEST-OK | v8_7 | took 40489ms 22:20:32 INFO - SUITE-END | took 1210s 22:20:33 INFO - Completed test suite (00:20:10) 22:20:33 INFO - Working with test: dromaeo_css 22:20:33 INFO - Generating results file: dromaeo_css 22:20:33 INFO - Working with test: kraken 22:20:33 INFO - Generating results file: kraken 22:20:33 INFO - javascript benchmark 22:20:33 INFO - Working with test: v8_7 22:20:33 INFO - Generating results file: v8_7 22:20:33 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:20:33 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 22:20:33 INFO - process_Request line: dromaeo_css 6863.15 graph.html#tests=[[72,63,43]] 22:20:33 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:20:33 INFO - process_Request line: kraken 1529.40 graph.html#tests=[[232,63,43]] 22:20:33 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:20:33 INFO - process_Request line: v8_7 20328.18 graph.html#tests=[[230,63,43]] 22:20:33 INFO - RETURN: dromaeo_css: 6863.15 22:20:33 INFO - RETURN: kraken: 1529.40 22:20:33 INFO - RETURN: v8_7: 20328.18 22:20:33 INFO - javascript benchmark 22:20:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3205.871765129395, 3236.514522821575, 3266.297745984613, 3284.687954644309, 3289.9999999999986, 5183.818566350178, 5371.57027437805, 5418.0, 5427.945720542793, 5437.184422336652, 5227.555657769094, 5237.79048838046, 5262.473752624735, 5271.077561426745, 5277.683338999663, 4628.143793398232, 4876.292937524066, 5049.621278404116, 5058.519440653132, 5067.721275329855, 4712.5523075307965, 4964.180910149839, 5000.824971126011, 5022.849314520552, 5038.017586570621, 4752.59602933751, 4797.784099715521, 4812.0, 4829.541193586604, 4845.951540484585, 4895.632827537949, 4917.803287868481, 4933.506649335073, 4960.355153830015, 4960.379952505937, 4767.594754445876, 4822.421309442854, 4930.926036109461, 4949.653524253304, 4977.50224977503, 5172.534471897509, 5206.193040078794, 5221.921671174935, 5227.555657769094, 5251.396089449686, 5657.519110875581, 5659.971700141514, 5668.178114173422, 5679.744411501492, 5693.914591281134, 5701.828945131652, 5707.258056452676, 5791.507721843648, 5803.709814509258, 5821.27234095738, 5457.208704737831, 5483.396826349099, 5484.808031718871, 5486.725663716878, 5516.91724624131, 5936.050231962865, 5945.316288626776, 5963.19496867926, 5975.163477113208, 5984.940150598525, 5584.636998595079, 5685.687287199161, 5706.172604972256, 5749.281339832521, 5760.654360738369, 5778.219940308089, 5813.244278243801, 5830.067189249699, 5861.912071318934, 5867.061270196748, 5735.139729040594, 5764.596478246566, 5767.625104368202, 5782.190493330937, 5782.306123265235, 5503.862403439946, 5579.832605021856, 5659.26429564154, 5703.344115426779, 5760.107183386582, 4245.915081698348, 4262.50981137167, 4271.017665936852, 4271.466066741657, 4290.635295999812, 3827.196288779332, 3833.1950290438763, 3840.1743625120735, 3851.807409629507, 3889.3388124018984, 5283.867903302371, 5362.1420572708175, 5389.7035663038905, 5435.918461223085, 5466.1527463243265, 5770.394108618619, 5787.623804452697, 5801.332846722681, 5814.9709251454315, 5845.09401042839, 5225.320708307896, 5412.269343638558, 5421.512063914267, 5437.483439073281, 5437.972810135924, 4891.3396691446915, 4910.435299940481, 4973.776180071905, 4990.076835785391, 5022.84931452057, 5833.766649334064, 5844.0, 5846.0, 5858.502027327725, 5876.676782776988, 5553.777848885999, 5670.234518340137, 5678.0915053591225, 5707.343655479673, 5717.113847353667, 5990.610610310316, 6000.399960003964, 6017.699115044318, 6067.180930574316, 6088.543359248163, 5689.402612725769, 5742.1673857289625, 5798.159266906359, 5798.304203495608, 5814.94185058144, 5687.9431205687415, 5741.282339707536, 5869.35437101927, 5897.439743224387, 5899.587028908107, 5664.575156863334, 5713.457221563945, 5719.5138413235345, 5739.9139012915675, 5773.076307790733, 5514.145307477347, 5576.804811831728, 5584.190292407659, 5605.215269862304, 5611.859703507445, 5280.6303558750515, 5373.462653734595, 5516.062269414129, 5517.972410137923, 5521.558275338044, 5604.6356986797355, 5708.257926469699, 5712.0860662293835, 5737.0, 5744.281964754406, 5590.664560126405, 5597.468240517144, 5604.299462567179, 5607.495325420732, 5619.971900140473], "unit": "score", "name": "dojo.html", "value": 5301.0294397448}, {"lowerIsBetter": false, "replicates": [508.9262057001735, 535.1678140491535, 538.122859738626, 557.5539568345323, 584.7282161299173, 27938.58092128617, 35494.99999999997, 35526.111847203836, 35956.0, 35987.28025439489, 38189.42715859264, 38557.0, 38559.0, 38902.8054859726, 38918.4162237566, 8352.248297653196, 8599.312055035582, 8611.354148438892, 8627.741167764978, 8633.445979723647, 8349.248567628912, 8419.326453883705, 8462.111478294783, 8470.74587762365, 8726.781830454225, 8723.607437665289, 8738.0, 8772.517511536864, 8793.516356600385, 8824.911750882506, 8661.263792577638, 8728.563571821414, 8758.211760941545, 8779.165979231962, 8782.780430489225, 8483.575821208915, 8562.571871406468, 8623.051464338918, 8624.525651089187, 8632.438891472097, 39373.40939885904, 39495.21009579792, 39678.60321396778, 39732.0, 39882.40176397356, 2944.793864429491, 2978.3894301668106, 3045.1473587395567, 3053.603031605877, 3234.886778962725, 27908.0, 28959.855200724072, 29112.563311550344, 29608.851955740083, 29611.407771844657, 3832.291026160169, 3851.0, 3892.3772196448717, 4018.357062869956, 4111.8560850370395, 209566.0, 212852.0, 212886.0, 213197.0, 213277.0, 52988.73505632447, 54002.729986350605, 60042.0, 60352.698236508535, 60374.0, 61999.38000619936, 63539.68230158912, 63929.0, 64132.0, 64137.67931160408, 13515.662108447368, 13567.660808479866, 13577.11748736329, 13650.658733531742, 13655.86344136546, 11438.656840294805, 11500.0, 11551.075913927034, 11572.305661660159, 11590.884091159149, 19723.901380493007, 19909.402717918485, 19924.609046914462, 20181.192752289742, 20207.898960505103, 7783.610819459004, 8035.839283214303, 8100.189981001853, 8116.675332986614, 8150.75547733569, 970.427447805798, 1046.199657262195, 1134.8127558952845, 1152.9769404611861, 1155.185594156118, 27623.171304860887, 28604.570931436047, 28627.0, 32698.509522357184, 32990.0, 1010.2372708604956, 1043.4886905416292, 1088.1784252889017, 1107.0147568663895, 1115.70991542198, 13545.59363219105, 13665.385057672429, 13721.794173087412, 13780.310984450738, 13816.171029738249, 371949.0, 374661.0, 375986.1200693979, 376226.0, 376721.0, 50436.24345634819, 51336.486635133915, 51341.0, 51574.0, 51599.742001290506, 1352.4725357110735, 1358.9116707413987, 1363.1275983370651, 1363.3455941148304, 1368.9794653080212, 25440.363990900376, 26396.208113756617, 26410.0, 26679.599806003313, 26721.19836404911, 51751.2237316433, 53047.204291936425, 53386.46613533815, 53406.73296633492, 53571.19643205433, 282399.0, 285467.0, 286249.0, 286795.0, 287626.0, 40956.59043409528, 41066.79466602648, 41100.0, 41108.79445602872, 41755.1648967025, 41800.0, 42404.36393454162, 42730.14539709126, 43150.35274470822, 43426.34860477032, 34815.12962175966, 35153.64846351504, 35376.11559710925, 35499.112522187155, 35939.28121437504, 36095.097622559646, 37049.44425833561, 37673.681421150126, 38635.06824658812, 38855.0, 32267.838660807483, 32986.17534561655, 33306.83346583252, 33309.50035749417, 33577.16057098592, 28177.718222817508, 29667.40665186641, 35338.646613533536, 37314.44028339631, 37949.62050379571, 25088.62367064459, 25131.24606261815, 25567.616485752358, 26573.0, 27039.729602703723], "unit": "score", "name": "ext.html", "value": 18365.61017632061}, {"lowerIsBetter": false, "replicates": [363.27526584464, 364.6226155928613, 367.3406235806727, 372.3465318366267, 373.12502182382303, 16181.83818161818, 16594.419195328166, 16864.15679216039, 17314.913425432856, 17613.207405666744, 9641.276904232176, 9938.602455901755, 9977.451240181786, 10405.687829365112, 10582.312149710264, 4841.612670986313, 4875.515045573729, 4974.1295273327205, 4989.700617962916, 5418.593605479585, 5280.735963201843, 5390.110631745777, 5414.539764120054, 5419.918701219485, 5422.511973922346, 5226.843194704146, 5418.485243901823, 5483.561315094803, 5502.367227768817, 5732.7133643317875, 5383.16560933056, 5590.552755779528, 5600.775968961237, 5622.240997465351, 5740.339860916007, 5045.84862454127, 5047.924281135786, 5078.5937125029905, 5088.7964481420695, 5110.5400513953555, 11833.349165795878, 12411.379431028503, 17970.91014544919, 19712.802871971384, 19878.204871805112, 2052.056054215063, 2173.2610912289897, 2174.70641463402, 2233.955320893573, 2335.590038543728, 8756.912430875736, 8823.77940551485, 9062.954685226532, 9082.909170908273, 9260.0, 1791.5610675384614, 1806.205269681336, 1811.1306572844976, 1858.50749551369, 1865.6082222733241, 49761.75119124418, 50480.24279635845, 55363.72318138384, 57007.42992570063, 57212.0, 9518.095780900803, 9786.951065244628, 9863.260255480867, 9877.0, 9921.0, 12897.484100636057, 12915.547955821501, 12928.482860685655, 12966.935165324301, 12980.221186728637, 7229.602371869492, 7294.343509084208, 7319.451041171933, 7346.706131754777, 7370.484066115428, 7072.186698529735, 7135.89296160558, 7137.0, 7219.350258476762, 7234.457415693844, 4278.358246263086, 4297.269464191095, 4361.171377438277, 4363.5418281080665, 4402.0, 1736.3749050341867, 1795.5870149865343, 1818.4271954334342, 1842.1249906294404, 1848.5471059590218, 863.3266052479077, 893.660409044559, 950.7623094226443, 999.3504222255447, 1060.1942523681903, 15819.367225311089, 16140.596485087966, 16292.592685182728, 16731.6653666926, 16797.908135971367, 936.6581197862731, 943.1794338925179, 944.6127087893931, 991.0287917840412, 1008.3546530220665, 9487.76280592977, 9529.38059026175, 9534.808148981378, 9542.284328675378, 9621.0, 473967.0, 475717.0, 475722.0, 515654.0, 527617.0, 63479.04781428282, 66725.33274667288, 66984.3301566978, 67135.66432167808, 68451.0, 1060.740118670915, 1061.3260579531898, 1062.0600768320091, 1070.1652710885521, 1081.7079388565044, 14593.92703036478, 14594.708105837612, 14797.630059248604, 14874.181919994504, 15039.323230454436, 30498.542521861746, 31696.0, 32222.677773221967, 32299.35401292008, 32901.83549082239, 39536.802315988236, 39872.601273988046, 41366.0, 41636.37545436881, 41801.79099104485, 6858.142732158481, 6927.480438967198, 7020.7893763187185, 7126.0, 7372.152202496782, 10345.896541034494, 11381.146414018816, 11480.0, 11481.0, 11648.184627076023, 9642.614295428104, 9682.322237443594, 9787.755306117404, 10105.787305523385, 10253.436061016715, 9408.482533460725, 9934.701958941243, 10059.245556583432, 10192.694219173436, 10409.115225205942, 9745.805083898424, 9835.311528192959, 9838.852417213604, 10305.433201174008, 10330.431826249327, 7351.301626345488, 7568.243175682388, 7617.0, 7623.809404764926, 7682.923170768221, 10070.19438444908, 10389.740256493647, 10483.423411712123, 10510.684679459628, 10604.416757078434], "unit": "score", "name": "jquery.html", "value": 7955.325749871728}, {"lowerIsBetter": false, "replicates": [1458.9124652520845, 1489.300028986376, 1636.7872176617038, 1762.0132725673616, 1784.072282413145, 7573.5834529100875, 7651.885221721679, 7741.3419859312025, 7772.1450640429575, 7793.688252469894, 7790.220977902207, 7820.804479887991, 7892.921070789291, 7900.130985591581, 7906.169852165512, 2239.9328020159423, 2254.7745225477483, 2257.695211146499, 2265.546890621882, 2267.0931627349028, 2340.473393486469, 2359.610664240407, 2366.0535785685693, 2373.145667559686, 2375.7743014413604, 2182.0617134632103, 2234.4748983988748, 2263.7396699379533, 2265.8753768542806, 2300.0914638717695, 2283.0981762204, 2294.8508346957396, 2300.8504447210876, 2307.8038366738847, 2310.4570425949973, 2306.5156317173414, 2312.7571604981404, 2313.595120853844, 2315.710536182977, 2327.6624889391114, 7602.277783610548, 7630.580318082503, 7654.0815102187535, 7682.4238182136005, 7709.383249340095, 4609.124266389409, 4771.618270538349, 4776.904461910743, 4800.639952003578, 4805.3753012108555, 3008.0, 3028.9394212115853, 3133.6552979172275, 3156.2425017995515, 3161.2887100402227, 954.575214029757, 963.9903600963971, 970.9951450242703, 972.8297547929084, 984.9901500985042, 10215.387076775418, 10304.845427318596, 10306.123979461754, 10308.484575771181, 10321.690349289533, 4134.772587507716, 4187.685923555746, 4238.830446782094, 4255.5957184067465, 4268.679849011337, 8340.124286949784, 8381.371397145238, 8388.916110838814, 8392.706255281037, 8420.284275836622, 4570.702904311275, 4590.9540904591195, 4606.378138951266, 4613.938794077381, 4623.653226007996, 4219.556946520571, 4241.766702831374, 4254.42565253693, 4260.957390426118, 4295.37717031035, 3437.7937323760652, 3456.2914602506426, 3462.376772181032, 3470.045737422229, 3500.2824420993634, 1058.99470502647, 1087.7770057138268, 1094.3597995172754, 1095.309954728516, 1106.651404807483, 1094.2121672395863, 1099.961501347449, 1126.487448211062, 1238.2137342787396, 1325.4830616059744, 7049.541779784297, 7078.893816592756, 7101.502894797314, 7112.110986126734, 7172.497925145294, 1111.216592302425, 1127.5827943660734, 1129.813580759182, 1129.875833433157, 1135.131624307389, 5490.6431081979545, 5518.420565840609, 5554.777808887599, 5558.944410555842, 5619.185218143428, 9303.0, 9329.440233586007, 9530.285228607881, 9679.225661947028, 9718.173955213886, 9505.42967421957, 9521.666741664147, 9557.139857412867, 9614.615415383447, 9653.855192172123, 7322.450816188807, 7387.445941554405, 7422.888656670154, 7468.4025277977635, 7504.962475187589, 7062.576245425085, 7093.1488221413765, 7099.929000709927, 7118.430525558047, 7135.678894449658, 8210.876836847332, 8246.54643994586, 8491.617877195418, 8529.91470085316, 8703.390762646553, 8606.397552171538, 8620.094890036708, 8646.394752367274, 8688.782780430287, 8773.122687731176, 6488.610683359014, 6699.564528305645, 6724.462043036643, 6744.123263975652, 6770.45836333102, 7335.596542190017, 7340.816479588053, 7354.8896766549615, 7374.815629609303, 7381.483296169216, 6535.281119076993, 7086.574805511686, 7239.384652304613, 7241.131064272321, 7361.595112268877, 6450.774222902176, 6543.083968244355, 6609.173853268341, 6719.62247739222, 6829.0, 6790.42281406086, 6847.486438517031, 6889.827754306182, 6894.103766510522, 6917.896231556631, 6129.417705318166, 6198.907016394667, 6252.9374706254175, 6255.40573645503, 6268.059791031382, 6382.074599183, 6460.547761656639, 6465.579737317247, 6491.285958544462, 6587.538872278895], "unit": "score", "name": "mootools.html", "value": 4448.952901918605}, {"lowerIsBetter": false, "replicates": [338.4381926002835, 342.31536926147703, 348.23562280793635, 351.73444049742443, 352.62797748375453, 6286.937130628692, 6322.620642761438, 6343.460805831498, 6378.457831084357, 6456.160699109109, 6221.59559628625, 6268.341824108471, 6310.274318453379, 6361.936380636193, 6363.459105975986, 4802.615790736751, 4804.663673542854, 4811.518848115195, 4817.879553011186, 4823.180059389894, 4817.0847538967655, 4821.855344339658, 4827.131116399047, 4827.927581086286, 4841.0, 4673.83641572545, 4779.211430114045, 4780.90438191236, 4784.306275590037, 4791.976040119795, 4738.2892566115015, 4767.69010014348, 4770.689905156154, 4772.355731976173, 4783.115123702091, 4190.895227619303, 4192.559781222958, 4195.832166713328, 4198.244316023115, 4201.243776120297, 5934.347221805598, 5960.672163031031, 5972.522198224175, 5973.761049558056, 5990.161377407167, 5368.892622147535, 5479.863003424906, 5480.780768769245, 5482.5613950884235, 5485.890282194374, 6601.339866013408, 6611.0, 6619.304972977816, 6623.867522649568, 6630.171228596426, 4464.084862603158, 4501.144782491317, 4504.288370419253, 4505.842295519641, 4514.525974772634, 6850.520463567552, 6922.342377474182, 6969.337912898216, 6989.755358562476, 7044.577325360444, 4626.306054091846, 4662.0, 4673.6728429009645, 4675.018246168274, 4681.29780532916, 4707.246840505502, 4709.152352576569, 4725.983913458623, 4729.597984171384, 4731.219348807408, 5463.7814487420055, 5479.726013699299, 5483.972580137153, 5504.036793561191, 5518.53092487135, 6608.570442921291, 6719.092922455504, 6723.562968407038, 6725.495587830932, 6726.697298621574, 1687.9493615191564, 1709.2393884721428, 1719.7678313427778, 1721.0706218641794, 1726.0420466641135, 1142.8057230270874, 1173.3957012138756, 1181.1141643767176, 1183.988160118388, 1188.2989036468352, 6152.753889844356, 6202.224721909762, 6204.100405441276, 6235.781747638902, 6246.531510136758, 6670.332966703291, 6675.332466753286, 6685.699143538553, 6699.229588597374, 6708.127943367429, 5977.222961015127, 6136.9079463808075, 6138.109974053827, 6162.876742465126, 6165.383461653799, 3700.5744339400776, 3703.703703703697, 3705.814709264526, 3706.4810926470313, 3715.5727091384297, 7052.788416347517, 7079.469039822034, 7088.539244949062, 7089.326513981164, 7101.715931362791, 6766.627835469097, 6903.240643529208, 6928.099347084847, 6931.202911665122, 6952.200496942815, 7053.612051337123, 7064.823379415556, 7076.787696369014, 7085.185203701537, 7094.361507464353, 6780.660966951731, 6800.795976120724, 6802.455803535607, 6802.455803535607, 6803.115594972622, 6556.8360790980605, 6640.435562977201, 6652.501062420241, 6672.566283191577, 6680.465562755066, 7055.788326350218, 7077.6461176941975, 7079.575225486487, 7079.610621415872, 7101.538400003983, 4688.5545873143365, 4698.177818881751, 4701.177293973473, 4704.905901882012, 4715.797471644709, 6700.396964273239, 6745.763898263537, 6761.628110453776, 6776.424003959719, 6974.163100427981, 6732.966335168293, 6738.528303018742, 6775.356341147583, 6776.966115169393, 6777.695003724745, 6768.187817461936, 6783.559068660521, 6791.117154769849, 6808.114945057111, 6821.863562728817, 6453.193350831146, 6621.337866213533, 6628.900566491603, 6641.900371494528, 6664.100346453167, 6802.387785099365, 6838.076859623887, 6838.14523184602, 6871.759488417882, 6876.759313424006, 6605.636689982097, 6690.6320152390135, 6691.0, 6697.0958920547055, 6705.731770729311], "unit": "score", "name": "prototype.html", "value": 5009.433645889079}, {"lowerIsBetter": false, "replicates": [663.5123184459421, 681.4820736240456, 696.8257935516122, 823.3906908887421, 831.0318478971997, 11910.464029118688, 11929.7614047719, 12032.699182520442, 12038.33789141597, 12046.57836975706, 11744.706382340446, 11787.29276243426, 11828.29030258185, 11861.288322700644, 13378.264195469244, 779.7504798464507, 794.4200733464575, 795.6697970342301, 796.3231253434564, 796.4703472191015, 760.1296515489761, 760.7147319755092, 760.7869796457001, 760.9581473019009, 784.207949970531, 787.4369825574713, 791.1574173505227, 792.9801754956144, 803.1606970715616, 827.8758186272078, 782.4288269563194, 784.3685832904538, 786.268770043859, 792.3383974381399, 818.5170749257936, 572.4876235769005, 574.287883025046, 575.3584753000416, 593.442164365495, 597.9162917191596, 11875.584354547549, 11925.105617078754, 12011.819822702666, 12039.518419263219, 12040.0, 11863.466144023454, 12171.14801963863, 12333.568325108577, 12636.557720479832, 12956.222626642431, 10001.299909006373, 10022.248331375176, 10081.747956301078, 10292.382457052601, 10327.638532651396, 3513.2446523997464, 3515.771474854126, 3519.8416071276597, 3545.0782796473104, 3661.6155303692994, 46350.76824615855, 46469.07061858744, 47118.52881471175, 47274.527254727356, 47858.76070619625, 9202.953985230031, 9308.8603670945, 9330.113639204264, 9387.389819661837, 9456.338056336128, 15965.44120955761, 16037.117958512394, 16075.919620401823, 16097.0, 16103.0, 6811.897821532681, 6902.309769023058, 6904.689288982008, 6918.0, 7047.68285427157, 3992.2334713609002, 4037.4953130858644, 4037.9394309085387, 4043.2317859606583, 4077.857274995361, 3031.4846476098674, 3068.3863227354173, 3079.4303053935096, 3088.845557722105, 3091.7990330628436, 563.357772139761, 577.7573419163962, 578.5662095463438, 588.3821986913723, 594.5392320951297, 592.2508027345411, 595.9303051023423, 657.1063353838871, 694.6318451220861, 712.4905692429834, 8261.876071858927, 8310.878031465796, 8329.383827146323, 8476.745697629081, 9121.0, 529.6636635736335, 559.0, 563.5942121672389, 576.0696475192534, 713.7858642407257, 3910.804459777, 4022.8189731462153, 4070.4504891839815, 4138.586141385837, 4152.294110001307, 55552.72223638937, 56985.0, 61074.0, 62015.0, 62105.68947155235, 50126.248106278435, 50902.74548627233, 51130.0, 51169.48830511647, 51468.48531514637, 45090.77454612706, 45562.03846749951, 45753.77123114363, 48828.755856220494, 48890.02219955652, 8332.33341332704, 8465.111163327761, 8591.44155629882, 8644.481331119901, 8776.91223087761, 32722.50916236211, 32919.83540082284, 33826.0, 34671.65328346684, 35242.47136293009, 39297.0, 40876.0, 41193.176136477705, 42322.576774231864, 43805.56194438015, 9920.802823421784, 10279.84580231312, 10312.948435257777, 10442.530086146293, 10526.578936842441, 11698.0, 11804.291742495478, 11824.82262766042, 12020.485742360042, 12278.386080696107, 11041.282316649393, 11149.10807135411, 11174.0, 11182.888171118184, 11474.94262528682, 10445.210613101544, 10620.681379558626, 10640.627578034731, 10702.89297107019, 11076.667699969013, 11115.610953616584, 11130.610428634958, 11237.438128093727, 11254.38100904458, 11300.09599232076, 8847.867281990646, 9214.861777073214, 9241.953790231006, 9289.256859451092, 9569.521523923637, 8754.956225218833, 8994.685186018458, 9068.773280667772, 9118.270538357048, 9327.766805829637], "unit": "score", "name": "yui.html", "value": 6053.867536327253}], "name": "dromaeo_css", "value": 6863.14600215124}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 111.0, 113.0, 113.0, 113.0, 123.0, 113.0, 113.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 113.6}, {"lowerIsBetter": true, "replicates": [161.0, 129.0, 166.0, 167.0, 126.0, 158.0, 157.0, 129.0, 168.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 149.1}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 162.0, 162.0, 163.0, 162.0, 162.0, 163.0, 168.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.0}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 72.0, 73.0, 73.0, 161.0, 75.0, 73.0, 76.0, 75.0], "unit": "score", "name": "audio-fft", "value": 82.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 141.0, 94.0, 95.0, 95.0, 135.0, 96.0, 95.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 116.0, 115.0, 115.0, 116.0, 115.0, 116.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.9}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 147.0, 146.0, 149.0, 146.0, 151.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [61.0, 64.0, 59.0, 60.0, 63.0, 59.0, 61.0, 61.0, 68.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 61.5}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 66.0, 66.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 85.0, 93.0, 85.0, 93.0, 86.0, 91.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.2}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 115.0, 123.0, 118.0, 119.0, 129.0, 122.0, 116.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.4}, {"lowerIsBetter": true, "replicates": [140.0, 154.0, 148.0, 148.0, 147.0, 153.0, 148.0, 150.0, 150.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 69.0, 69.0, 67.0, 67.0, 68.0, 70.0, 82.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.8}], "name": "kraken", "value": 1529.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.0843776106934], "unit": "score", "name": "Richards", "value": 211.28247000000007}, {"lowerIsBetter": false, "replicates": [191.20458891013385], "unit": "score", "name": "DeltaBlue", "value": 345.79713999999984}, {"lowerIsBetter": false, "replicates": [272.92576419213975], "unit": "score", "name": "Encrypt", "value": 975.2871839999998}, {"lowerIsBetter": false, "replicates": [5306.878306878307], "unit": "score", "name": "Decrypt", "value": 50.15773579262209}, {"lowerIsBetter": false, "replicates": [1102.5358324145534], "unit": "score", "name": "RayTrace", "value": 671.170023}, {"lowerIsBetter": false, "replicates": [690.6077348066299], "unit": "score", "name": "Earley", "value": 965.0384240000001}, {"lowerIsBetter": false, "replicates": [12358.024691358025], "unit": "score", "name": "Boyer", "value": 53.929573426573455}, {"lowerIsBetter": false, "replicates": [41306.12244897959], "unit": "score", "name": "RegExp", "value": 22.05447875494071}, {"lowerIsBetter": false, "replicates": [606.151990349819], "unit": "score", "name": "Splay", "value": 134.43987860696515}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 20328.182051428932}]} 22:20:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20328.18"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1529.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6863.15"}}} 22:20:33 INFO - Return code: 0 22:20:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:20:33 INFO - # TBPL SUCCESS # 22:20:33 INFO - Running post-action listener: _resource_record_post_action 22:20:33 INFO - Running post-run listener: _resource_record_post_run 22:20:34 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 550739968; Read time: 0; Write time: 405592 22:20:34 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 236412928; Read time: 0; Write time: 217604 22:20:34 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 314327040; Read time: 0; Write time: 187988 22:20:34 INFO - Running post-run listener: _upload_blobber_files 22:20:34 INFO - Blob upload gear active. 22:20:34 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:20:34 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:20:34 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:20:34 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:20:35 INFO - (blobuploader) - INFO - Open directory for files ... 22:20:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:20:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:20:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:35 INFO - (blobuploader) - INFO - Done attempting. 22:20:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:20:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:20:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:36 INFO - (blobuploader) - INFO - Done attempting. 22:20:36 INFO - (blobuploader) - INFO - Iteration through files over. 22:20:36 INFO - Return code: 0 22:20:36 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:20:36 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:20:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ba870f03b650ec26c0ec4e76a5dfd17378034b74a378efc49c4a4bcad90053e87cc85aa5b3b616bdb127ac3d9be46b84784f51ecf056dbfa9a37ec5acae10685", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1132ee5de31f5d6d9909a5ed5da0f9429d9b50b9c7bc3455fc5993f7155a8a6cceb4b6b9b0574163eb5566e12bd66732c3b1710ab15c13dc417de00ffb730d11"} 22:20:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:20:36 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:20:36 INFO - Contents: 22:20:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ba870f03b650ec26c0ec4e76a5dfd17378034b74a378efc49c4a4bcad90053e87cc85aa5b3b616bdb127ac3d9be46b84784f51ecf056dbfa9a37ec5acae10685", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1132ee5de31f5d6d9909a5ed5da0f9429d9b50b9c7bc3455fc5993f7155a8a6cceb4b6b9b0574163eb5566e12bd66732c3b1710ab15c13dc417de00ffb730d11"} 22:20:36 INFO - Running post-run listener: copy_logs_to_upload_dir 22:20:36 INFO - Copying logs to upload dir... 22:20:36 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:20:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.934254 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-25 22:20:36.319510) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 22:20:36.322857) ========= 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=ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892 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/ba870f03b650ec26c0ec4e76a5dfd17378034b74a378efc49c4a4bcad90053e87cc85aa5b3b616bdb127ac3d9be46b84784f51ecf056dbfa9a37ec5acae10685", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1132ee5de31f5d6d9909a5ed5da0f9429d9b50b9c7bc3455fc5993f7155a8a6cceb4b6b9b0574163eb5566e12bd66732c3b1710ab15c13dc417de00ffb730d11"} build_url:https://queue.taskcluster.net/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.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/ba870f03b650ec26c0ec4e76a5dfd17378034b74a378efc49c4a4bcad90053e87cc85aa5b3b616bdb127ac3d9be46b84784f51ecf056dbfa9a37ec5acae10685", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1132ee5de31f5d6d9909a5ed5da0f9429d9b50b9c7bc3455fc5993f7155a8a6cceb4b6b9b0574163eb5566e12bd66732c3b1710ab15c13dc417de00ffb730d11"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 22:20:36.348992) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 22:20:36.349449) ========= 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=ed14279e38b05397cf4aa391000001a4-1453782271.115430-1987481892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 22:20:36.434538) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 22:20:36.434903) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 22:20:36.435270) ========= ========= Total master_lag: 0.29 =========