builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-066 starttime: 1453204958.25 results: success (0) buildid: 20160119013024 builduid: 84652575bd68427d9ad386b95c510433 revision: 9bb1872a676cfc39fd9419fb5d7310bd80258d56 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 04:02:38.249115) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 04:02:38.249611) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 04:02:38.249973) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006379 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 04:02:38.307397) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 04:02:38.307729) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 04:02:38.371637) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 04:02:38.371934) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004631 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 04:02:38.426930) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 04:02:38.427228) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 04:02:38.427659) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 04:02:38.427963) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-19 04:02:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.5M=0s 2016-01-19 04:02:39 (35.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.143599 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 04:02:38.595445) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 04:02:38.595778) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022352 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 04:02:38.652030) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-19 04:02:38.652396) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 9bb1872a676cfc39fd9419fb5d7310bd80258d56 --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 9bb1872a676cfc39fd9419fb5d7310bd80258d56 --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=82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-19 04:02:39,849 truncating revision to first 12 chars 2016-01-19 04:02:39,849 Setting DEBUG logging. 2016-01-19 04:02:39,849 attempt 1/10 2016-01-19 04:02:39,849 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/9bb1872a676c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-19 04:02:40,872 unpacking tar archive at: mozilla-inbound-9bb1872a676c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.296368 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-19 04:02:39.962180) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 04:02:39.962581) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004342 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 04:02:40.012980) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 04:02:40.013393) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 04:02:40.023948) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 04:02:40.024431) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 04:02:40.025142) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-19 04:02:40.025562) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:02:41 INFO - MultiFileLogger online at 20160119 04:02:41 in /builds/slave/test-pgo 04:02:41 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 04:02:41 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:02:41 INFO - {'append_to_log': False, 04:02:41 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:02:41 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:02:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:02:41 INFO - 'branch': 'Mozilla-Inbound', 04:02:41 INFO - 'buildbot_json_path': 'buildprops.json', 04:02:41 INFO - 'config_files': ('talos/linux_config.py',), 04:02:41 INFO - 'default_actions': ('clobber', 04:02:41 INFO - 'read-buildbot-config', 04:02:41 INFO - 'download-and-extract', 04:02:41 INFO - 'populate-webroot', 04:02:41 INFO - 'create-virtualenv', 04:02:41 INFO - 'install', 04:02:41 INFO - 'run-tests'), 04:02:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:02:41 INFO - 'download_minidump_stackwalk': True, 04:02:41 INFO - 'download_symbols': 'ondemand', 04:02:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:02:41 INFO - 'tooltool.py': '/tools/tooltool.py', 04:02:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:02:41 INFO - '/tools/misc-python/virtualenv.py')}, 04:02:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:02:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:02:41 INFO - 'installer_path': 'installer.exe', 04:02:41 INFO - 'log_level': 'info', 04:02:41 INFO - 'log_name': 'talos', 04:02:41 INFO - 'log_to_console': True, 04:02:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:02:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:02:41 INFO - 'opt_config_files': (), 04:02:41 INFO - 'pip_index': False, 04:02:41 INFO - 'sps_profile': False, 04:02:41 INFO - 'sps_profile_interval': 0, 04:02:41 INFO - 'suite': 'dromaeojs-e10s', 04:02:41 INFO - 'system_bits': '32', 04:02:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:02:41 INFO - 'title': 'talos-linux64-ix-066', 04:02:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:02:41 INFO - 'use_talos_json': True, 04:02:41 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:02:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:02:41 INFO - 'work_dir': 'build'} 04:02:41 INFO - ##### 04:02:41 INFO - ##### Running clobber step. 04:02:41 INFO - ##### 04:02:41 INFO - Running pre-action listener: _resource_record_pre_action 04:02:41 INFO - Running main action method: clobber 04:02:41 INFO - rmtree: /builds/slave/test-pgo/build 04:02:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:02:41 INFO - Running post-action listener: _resource_record_post_action 04:02:41 INFO - ##### 04:02:41 INFO - ##### Running read-buildbot-config step. 04:02:41 INFO - ##### 04:02:41 INFO - Running pre-action listener: _resource_record_pre_action 04:02:41 INFO - Running main action method: read_buildbot_config 04:02:41 INFO - Using buildbot properties: 04:02:41 INFO - { 04:02:41 INFO - "project": "", 04:02:41 INFO - "product": "firefox", 04:02:41 INFO - "script_repo_revision": "production", 04:02:41 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 04:02:41 INFO - "repository": "", 04:02:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 04:02:41 INFO - "buildid": "20160119013024", 04:02:41 INFO - "pgo_build": "True", 04:02:41 INFO - "basedir": "/builds/slave/test-pgo", 04:02:41 INFO - "buildnumber": 634, 04:02:41 INFO - "slavename": "talos-linux64-ix-066", 04:02:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:02:41 INFO - "platform": "ubuntu64_hw", 04:02:41 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:02:41 INFO - "branch": "mozilla-inbound", 04:02:41 INFO - "repo_path": "integration/mozilla-inbound", 04:02:41 INFO - "revision": "9bb1872a676cfc39fd9419fb5d7310bd80258d56", 04:02:41 INFO - "stage_platform": "linux64-pgo", 04:02:41 INFO - "builduid": "84652575bd68427d9ad386b95c510433", 04:02:41 INFO - "slavebuilddir": "test" 04:02:41 INFO - } 04:02:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:02:41 INFO - Running post-action listener: _resource_record_post_action 04:02:41 INFO - ##### 04:02:41 INFO - ##### Running download-and-extract step. 04:02:41 INFO - ##### 04:02:41 INFO - Running pre-action listener: _resource_record_pre_action 04:02:41 INFO - Running main action method: download_and_extract 04:02:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:41 INFO - https://queue.taskcluster.net/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:02:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/test_packages.json 04:02:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/test_packages.json 04:02:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:02:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:02:49 INFO - Downloaded 1448 bytes. 04:02:49 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:02:49 INFO - Using the following test package requirements: 04:02:49 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:02:49 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:02:49 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:02:49 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:49 INFO - u'jsshell-linux-x86_64.zip'], 04:02:49 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:02:49 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:02:49 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:02:49 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:02:49 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:02:49 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:02:49 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:02:49 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:02: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')]} 04:02:49 INFO - https://queue.taskcluster.net/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:02:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:02:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:02:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:02:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:02:58 INFO - Downloaded 22484333 bytes. 04:02:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:02:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 04:02:59 INFO - Return code: 0 04:02:59 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:02: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')]} 04:02:59 INFO - https://queue.taskcluster.net/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:02:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:02:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:02:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:02:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:03:01 INFO - Downloaded 22484333 bytes. 04:03:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:03:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 04:03:02 INFO - Return code: 0 04:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:02 INFO - https://queue.taskcluster.net/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:03:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:03:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:03:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:03:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:03:03 INFO - Downloaded 11132144 bytes. 04:03:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:03:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 04:03:04 INFO - Return code: 0 04:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:04 INFO - https://queue.taskcluster.net/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:03:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:03:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:03:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:03:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:03:05 INFO - Downloaded 55941535 bytes. 04:03:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:03:05 INFO - mkdir: /builds/slave/test-pgo/properties 04:03:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:03:05 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:03:05 INFO - Contents: 04:03:05 INFO - build_url:https://queue.taskcluster.net/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:03:05 INFO - Running post-action listener: _resource_record_post_action 04:03:05 INFO - Running post-action listener: set_extra_try_arguments 04:03:05 INFO - ##### 04:03:05 INFO - ##### Running populate-webroot step. 04:03:05 INFO - ##### 04:03:05 INFO - Running pre-action listener: _resource_record_pre_action 04:03:05 INFO - Running main action method: populate_webroot 04:03:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:03:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:03:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:03:05 INFO - '--tppagecycles', 04:03:05 INFO - '7'], 04:03:05 INFO - 'tests': ['tsvgm']}}, 04:03:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:03:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:03:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:03:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:03:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:03:05 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:03:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:03:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:05 INFO - 'talos_options': ['--e10s'], 04:03:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:03:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:05 INFO - 'tests': ['damp', 'tps']}, 04:03:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:05 INFO - 'talos_options': ['--e10s'], 04:03:05 INFO - 'tests': ['damp', 'tps']}, 04:03:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:03:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:03:05 INFO - 'other': {'tests': ['a11yr', 04:03:05 INFO - 'ts_paint', 04:03:05 INFO - 'tpaint', 04:03:05 INFO - 'sessionrestore', 04:03:05 INFO - 'sessionrestore_no_auto_restore']}, 04:03:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:03:05 INFO - 'tests': ['a11yr', 04:03:05 INFO - 'ts_paint', 04:03:05 INFO - 'tpaint', 04:03:05 INFO - 'sessionrestore', 04:03:05 INFO - 'sessionrestore_no_auto_restore']}, 04:03:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:03:05 INFO - 'tests': ['a11yr', 04:03:05 INFO - 'ts_paint', 04:03:05 INFO - 'tpaint', 04:03:05 INFO - 'sessionrestore', 04:03:05 INFO - 'sessionrestore_no_auto_restore']}, 04:03:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:03:05 INFO - 'tests': ['a11yr', 04:03:05 INFO - 'ts_paint', 04:03:05 INFO - 'tpaint', 04:03:05 INFO - 'sessionrestore', 04:03:05 INFO - 'sessionrestore_no_auto_restore']}, 04:03:05 INFO - 'other_l64': {'tests': ['a11yr', 04:03:05 INFO - 'ts_paint', 04:03:05 INFO - 'tpaint', 04:03:05 INFO - 'sessionrestore', 04:03:05 INFO - 'sessionrestore_no_auto_restore']}, 04:03:05 INFO - 'other_nol64': {'tests': ['a11yr', 04:03:05 INFO - 'ts_paint', 04:03:05 INFO - 'tpaint', 04:03:05 INFO - 'sessionrestore', 04:03:05 INFO - 'sessionrestore_no_auto_restore']}, 04:03:05 INFO - 'svgr': {'tests': ['tsvgx', 04:03:05 INFO - 'tsvgr_opacity', 04:03:05 INFO - 'tart', 04:03:05 INFO - 'tscrollx', 04:03:05 INFO - 'cart']}, 04:03:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:03:05 INFO - 'tests': ['tsvgx', 04:03:05 INFO - 'tsvgr_opacity', 04:03:05 INFO - 'tart', 04:03:05 INFO - 'tscrollx', 04:03:05 INFO - 'cart']}, 04:03:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:05 INFO - 'tests': ['tp5o']}, 04:03:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:05 INFO - 'talos_options': ['--e10s'], 04:03:05 INFO - 'tests': ['tp5o']}, 04:03:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:05 INFO - 'talos_options': ['--xperf_path', 04:03:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:03:05 INFO - 'tests': ['tp5n']}, 04:03:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:05 INFO - 'talos_options': ['--e10s', 04:03:05 INFO - '--xperf_path', 04:03:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:03:05 INFO - 'tests': ['tp5n']}}, 04:03:05 INFO - 'talos.zip': {'path': '', 04:03:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:03:05 INFO - Running post-action listener: _resource_record_post_action 04:03:05 INFO - ##### 04:03:05 INFO - ##### Running create-virtualenv step. 04:03:05 INFO - ##### 04:03:05 INFO - Running pre-action listener: _resource_record_pre_action 04:03:05 INFO - Running main action method: create_virtualenv 04:03:05 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:03:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 04:03:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:03:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:03:05 INFO - Using real prefix '/usr' 04:03:05 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:03:06 INFO - Installing distribute.............................................................................................................................................................................................done. 04:03:08 INFO - Installing pip.................done. 04:03:08 INFO - Return code: 0 04:03:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6acfa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2346230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d87f0>, '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 0x23442d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2344760>, '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': '82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:03:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 04:03:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:03:08 INFO - Using env: {'DISPLAY': ':0', 04:03:08 INFO - 'HOME': '/home/cltbld', 04:03:08 INFO - 'LANG': 'en_US.UTF-8', 04:03:08 INFO - 'LANGUAGE': 'en_US:en', 04:03:08 INFO - 'LOGNAME': 'cltbld', 04:03:08 INFO - 'MAIL': '/var/mail/cltbld', 04:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:08 INFO - 'MOZ_NO_REMOTE': '1', 04:03:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:08 INFO - 'NO_EM_RESTART': '1', 04:03:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:03:08 INFO - 'PWD': '/builds/slave/test-pgo', 04:03:08 INFO - 'SHELL': '/bin/bash', 04:03:08 INFO - 'SHLVL': '1', 04:03:08 INFO - 'TERM': 'linux', 04:03:08 INFO - 'TMOUT': '86400', 04:03:08 INFO - 'USER': 'cltbld', 04:03:08 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781', 04:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:08 INFO - '_': '/tools/buildbot/bin/python'} 04:03:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:03:08 INFO - Cleaning up... 04:03:08 INFO - Return code: 0 04:03:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe6acfa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2346230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d87f0>, '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 0x23442d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2344760>, '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': '82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:03:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 04:03:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:03:08 INFO - Using env: {'DISPLAY': ':0', 04:03:08 INFO - 'HOME': '/home/cltbld', 04:03:08 INFO - 'LANG': 'en_US.UTF-8', 04:03:08 INFO - 'LANGUAGE': 'en_US:en', 04:03:08 INFO - 'LOGNAME': 'cltbld', 04:03:08 INFO - 'MAIL': '/var/mail/cltbld', 04:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:08 INFO - 'MOZ_NO_REMOTE': '1', 04:03:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:08 INFO - 'NO_EM_RESTART': '1', 04:03:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:03:08 INFO - 'PWD': '/builds/slave/test-pgo', 04:03:08 INFO - 'SHELL': '/bin/bash', 04:03:08 INFO - 'SHLVL': '1', 04:03:08 INFO - 'TERM': 'linux', 04:03:08 INFO - 'TMOUT': '86400', 04:03:08 INFO - 'USER': 'cltbld', 04:03:08 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781', 04:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:08 INFO - '_': '/tools/buildbot/bin/python'} 04:03:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:08 INFO - Downloading/unpacking psutil>=0.7.1 04:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:10 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:03:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:03:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:03:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:03:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:03:10 INFO - Installing collected packages: psutil 04:03:10 INFO - Running setup.py install for psutil 04:03:10 INFO - building 'psutil._psutil_linux' extension 04:03:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:03:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:03:10 INFO - building 'psutil._psutil_posix' extension 04:03:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:03:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:03:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:03:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:03:10 INFO - Successfully installed psutil 04:03:10 INFO - Cleaning up... 04:03:10 INFO - Return code: 0 04:03:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:03:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6acfa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2346230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d87f0>, '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 0x23442d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2344760>, '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': '82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:03:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 04:03:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:03:10 INFO - Using env: {'DISPLAY': ':0', 04:03:10 INFO - 'HOME': '/home/cltbld', 04:03:10 INFO - 'LANG': 'en_US.UTF-8', 04:03:10 INFO - 'LANGUAGE': 'en_US:en', 04:03:10 INFO - 'LOGNAME': 'cltbld', 04:03:10 INFO - 'MAIL': '/var/mail/cltbld', 04:03:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:10 INFO - 'MOZ_NO_REMOTE': '1', 04:03:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:10 INFO - 'NO_EM_RESTART': '1', 04:03:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:03:10 INFO - 'PWD': '/builds/slave/test-pgo', 04:03:10 INFO - 'SHELL': '/bin/bash', 04:03:10 INFO - 'SHLVL': '1', 04:03:10 INFO - 'TERM': 'linux', 04:03:10 INFO - 'TMOUT': '86400', 04:03:10 INFO - 'USER': 'cltbld', 04:03:10 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781', 04:03:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:10 INFO - '_': '/tools/buildbot/bin/python'} 04:03:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:03:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:03:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:03:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:03:12 INFO - Installing collected packages: mozsystemmonitor 04:03:12 INFO - Running setup.py install for mozsystemmonitor 04:03:12 INFO - Successfully installed mozsystemmonitor 04:03:12 INFO - Cleaning up... 04:03:13 INFO - Return code: 0 04:03:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:03:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6acfa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2346230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d87f0>, '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 0x23442d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2344760>, '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': '82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:03:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 04:03:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:03:13 INFO - Using env: {'DISPLAY': ':0', 04:03:13 INFO - 'HOME': '/home/cltbld', 04:03:13 INFO - 'LANG': 'en_US.UTF-8', 04:03:13 INFO - 'LANGUAGE': 'en_US:en', 04:03:13 INFO - 'LOGNAME': 'cltbld', 04:03:13 INFO - 'MAIL': '/var/mail/cltbld', 04:03:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:13 INFO - 'MOZ_NO_REMOTE': '1', 04:03:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:13 INFO - 'NO_EM_RESTART': '1', 04:03:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:03:13 INFO - 'PWD': '/builds/slave/test-pgo', 04:03:13 INFO - 'SHELL': '/bin/bash', 04:03:13 INFO - 'SHLVL': '1', 04:03:13 INFO - 'TERM': 'linux', 04:03:13 INFO - 'TMOUT': '86400', 04:03:13 INFO - 'USER': 'cltbld', 04:03:13 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781', 04:03:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:13 INFO - '_': '/tools/buildbot/bin/python'} 04:03:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:13 INFO - Downloading/unpacking blobuploader==1.2.4 04:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:14 INFO - Downloading blobuploader-1.2.4.tar.gz 04:03:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:03:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:03:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:03:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:03:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:15 INFO - Downloading docopt-0.6.1.tar.gz 04:03:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:03:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:03:15 INFO - Installing collected packages: blobuploader, requests, docopt 04:03:15 INFO - Running setup.py install for blobuploader 04:03:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:03:15 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:03:15 INFO - Running setup.py install for requests 04:03:16 INFO - Running setup.py install for docopt 04:03:16 INFO - Successfully installed blobuploader requests docopt 04:03:16 INFO - Cleaning up... 04:03:16 INFO - Return code: 0 04:03:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:03:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6acfa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2346230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d87f0>, '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 0x23442d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2344760>, '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': '82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:03:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:03:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:03:16 INFO - Using env: {'DISPLAY': ':0', 04:03:16 INFO - 'HOME': '/home/cltbld', 04:03:16 INFO - 'LANG': 'en_US.UTF-8', 04:03:16 INFO - 'LANGUAGE': 'en_US:en', 04:03:16 INFO - 'LOGNAME': 'cltbld', 04:03:16 INFO - 'MAIL': '/var/mail/cltbld', 04:03:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:16 INFO - 'MOZ_NO_REMOTE': '1', 04:03:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:16 INFO - 'NO_EM_RESTART': '1', 04:03:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:03:16 INFO - 'PWD': '/builds/slave/test-pgo', 04:03:16 INFO - 'SHELL': '/bin/bash', 04:03:16 INFO - 'SHLVL': '1', 04:03:16 INFO - 'TERM': 'linux', 04:03:16 INFO - 'TMOUT': '86400', 04:03:16 INFO - 'USER': 'cltbld', 04:03:16 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781', 04:03:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:16 INFO - '_': '/tools/buildbot/bin/python'} 04:03:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:03:16 INFO - Running setup.py (path:/tmp/pip-Np6eJk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:03:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:03:16 INFO - Running setup.py (path:/tmp/pip-SUw0CF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:03:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:03:16 INFO - Running setup.py (path:/tmp/pip-HjrmqB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:03:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:03:16 INFO - Running setup.py (path:/tmp/pip-MKDZ28-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:03:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:03:16 INFO - Running setup.py (path:/tmp/pip-U6q51s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:03:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:03:16 INFO - Running setup.py (path:/tmp/pip-nsb3Sx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:03:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:03:16 INFO - Running setup.py (path:/tmp/pip-bNdZ0q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:03:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:03:16 INFO - Running setup.py (path:/tmp/pip-fOvupn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:03:17 INFO - Running setup.py (path:/tmp/pip-n1Ye1n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:03:17 INFO - Running setup.py (path:/tmp/pip-4Sy5pC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:03:17 INFO - Running setup.py (path:/tmp/pip-WZzHhs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:03:17 INFO - Running setup.py (path:/tmp/pip-8a19BD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:03:17 INFO - Running setup.py (path:/tmp/pip-8E6Yx7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:03:17 INFO - Running setup.py (path:/tmp/pip-UxuvgQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:03:17 INFO - Running setup.py (path:/tmp/pip-ugagSz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:03:17 INFO - Running setup.py (path:/tmp/pip-qR3OG5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:03:17 INFO - Running setup.py (path:/tmp/pip-IQzKJb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:03:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:03:17 INFO - Running setup.py install for manifestparser 04:03:17 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:03:17 INFO - Running setup.py install for mozcrash 04:03:17 INFO - Running setup.py install for mozdebug 04:03:17 INFO - Running setup.py install for mozdevice 04:03:18 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:03:18 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:03:18 INFO - Running setup.py install for mozfile 04:03:18 INFO - Running setup.py install for mozhttpd 04:03:18 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:03:18 INFO - Running setup.py install for mozinfo 04:03:18 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:03:18 INFO - Running setup.py install for mozInstall 04:03:18 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:03:18 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:03:18 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:03:18 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:03:18 INFO - Running setup.py install for mozleak 04:03:18 INFO - Running setup.py install for mozlog 04:03:18 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:03:18 INFO - Running setup.py install for moznetwork 04:03:18 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:03:18 INFO - Running setup.py install for mozprocess 04:03:18 INFO - Running setup.py install for mozprofile 04:03:19 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:03:19 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:03:19 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:03:19 INFO - Running setup.py install for mozrunner 04:03:19 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:03:19 INFO - Running setup.py install for mozscreenshot 04:03:19 INFO - Running setup.py install for moztest 04:03:19 INFO - Running setup.py install for mozversion 04:03:19 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:03:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:03:19 INFO - Cleaning up... 04:03:19 INFO - Return code: 0 04:03:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:03:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6acfa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2346230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d87f0>, '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 0x23442d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2344760>, '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': '82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:03:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:03:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:03:19 INFO - Using env: {'DISPLAY': ':0', 04:03:19 INFO - 'HOME': '/home/cltbld', 04:03:19 INFO - 'LANG': 'en_US.UTF-8', 04:03:19 INFO - 'LANGUAGE': 'en_US:en', 04:03:19 INFO - 'LOGNAME': 'cltbld', 04:03:19 INFO - 'MAIL': '/var/mail/cltbld', 04:03:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:19 INFO - 'MOZ_NO_REMOTE': '1', 04:03:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:19 INFO - 'NO_EM_RESTART': '1', 04:03:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:03:19 INFO - 'PWD': '/builds/slave/test-pgo', 04:03:19 INFO - 'SHELL': '/bin/bash', 04:03:19 INFO - 'SHLVL': '1', 04:03:19 INFO - 'TERM': 'linux', 04:03:19 INFO - 'TMOUT': '86400', 04:03:19 INFO - 'USER': 'cltbld', 04:03:19 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781', 04:03:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:19 INFO - '_': '/tools/buildbot/bin/python'} 04:03:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:03:19 INFO - Running setup.py (path:/tmp/pip-4Nz4rM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:03:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 04:03:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:03:19 INFO - Running setup.py (path:/tmp/pip-Mu2jxE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:03:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:03:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:03:19 INFO - Running setup.py (path:/tmp/pip-XC6H9_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:03:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:03:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:03:19 INFO - Running setup.py (path:/tmp/pip-3230HC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:03:20 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)) 04:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:03:20 INFO - Running setup.py (path:/tmp/pip-u1lGsR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 04:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:03:20 INFO - Running setup.py (path:/tmp/pip-Ii9wzd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 04:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:03:20 INFO - Running setup.py (path:/tmp/pip-Aotbqr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 04:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:03:20 INFO - Running setup.py (path:/tmp/pip-5I_A2s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 04:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:03:20 INFO - Running setup.py (path:/tmp/pip-yJV0Kb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 04:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:03:20 INFO - Running setup.py (path:/tmp/pip-aJN5_y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:03:20 INFO - Running setup.py (path:/tmp/pip-Eb9V17-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 04:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:03:20 INFO - Running setup.py (path:/tmp/pip-Tl2Cbn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 04:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:03:20 INFO - Running setup.py (path:/tmp/pip-m_xCGu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:03:20 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)) 04:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:03:20 INFO - Running setup.py (path:/tmp/pip-4r1X9e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 04:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:03:20 INFO - Running setup.py (path:/tmp/pip-Juyp0R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 04:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:03:20 INFO - Running setup.py (path:/tmp/pip-6XJjDg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 04:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:03:20 INFO - Running setup.py (path:/tmp/pip-lXy_V2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 04:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:03:20 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)) 04:03:20 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)) 04:03:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:22 INFO - Downloading blessings-1.5.1.tar.gz 04:03:22 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:03:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:03:22 INFO - Installing collected packages: blessings 04:03:22 INFO - Running setup.py install for blessings 04:03:22 INFO - Successfully installed blessings 04:03:22 INFO - Cleaning up... 04:03:22 INFO - Return code: 0 04:03:22 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:03:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:03:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:03:23 INFO - Reading from file tmpfile_stdout 04:03:23 INFO - Current package versions: 04:03:23 INFO - argparse == 1.2.1 04:03:23 INFO - blessings == 1.5.1 04:03:23 INFO - blobuploader == 1.2.4 04:03:23 INFO - docopt == 0.6.1 04:03:23 INFO - manifestparser == 1.1 04:03:23 INFO - mozInstall == 1.12 04:03:23 INFO - mozcrash == 0.16 04:03:23 INFO - mozdebug == 0.1 04:03:23 INFO - mozdevice == 0.48 04:03:23 INFO - mozfile == 1.2 04:03:23 INFO - mozhttpd == 0.7 04:03:23 INFO - mozinfo == 0.9 04:03:23 INFO - mozleak == 0.1 04:03:23 INFO - mozlog == 3.1 04:03:23 INFO - moznetwork == 0.27 04:03:23 INFO - mozprocess == 0.22 04:03:23 INFO - mozprofile == 0.28 04:03:23 INFO - mozrunner == 6.11 04:03:23 INFO - mozscreenshot == 0.1 04:03:23 INFO - mozsystemmonitor == 0.0 04:03:23 INFO - moztest == 0.7 04:03:23 INFO - mozversion == 1.4 04:03:23 INFO - psutil == 3.1.1 04:03:23 INFO - requests == 1.2.3 04:03:23 INFO - wsgiref == 0.1.2 04:03:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:03:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6acfa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2346230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d87f0>, '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 0x23442d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2344760>, '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': '82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:03:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 04:03:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:03:23 INFO - Using env: {'DISPLAY': ':0', 04:03:23 INFO - 'HOME': '/home/cltbld', 04:03:23 INFO - 'LANG': 'en_US.UTF-8', 04:03:23 INFO - 'LANGUAGE': 'en_US:en', 04:03:23 INFO - 'LOGNAME': 'cltbld', 04:03:23 INFO - 'MAIL': '/var/mail/cltbld', 04:03:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:23 INFO - 'MOZ_NO_REMOTE': '1', 04:03:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:23 INFO - 'NO_EM_RESTART': '1', 04:03:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:03:23 INFO - 'PWD': '/builds/slave/test-pgo', 04:03:23 INFO - 'SHELL': '/bin/bash', 04:03:23 INFO - 'SHLVL': '1', 04:03:23 INFO - 'TERM': 'linux', 04:03:23 INFO - 'TMOUT': '86400', 04:03:23 INFO - 'USER': 'cltbld', 04:03:23 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781', 04:03:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:23 INFO - '_': '/tools/buildbot/bin/python'} 04:03:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:23 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)) 04:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 04:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 04:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 04:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 04:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 04:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 04:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 04:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 04:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 04:03:23 INFO - Cleaning up... 04:03:23 INFO - Return code: 0 04:03:23 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:03:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6acfa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2346230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d87f0>, '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 0x23442d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2344760>, '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': '82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:03:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 04:03:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:03:23 INFO - Using env: {'DISPLAY': ':0', 04:03:23 INFO - 'HOME': '/home/cltbld', 04:03:23 INFO - 'LANG': 'en_US.UTF-8', 04:03:23 INFO - 'LANGUAGE': 'en_US:en', 04:03:23 INFO - 'LOGNAME': 'cltbld', 04:03:23 INFO - 'MAIL': '/var/mail/cltbld', 04:03:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:23 INFO - 'MOZ_NO_REMOTE': '1', 04:03:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:23 INFO - 'NO_EM_RESTART': '1', 04:03:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:03:23 INFO - 'PWD': '/builds/slave/test-pgo', 04:03:23 INFO - 'SHELL': '/bin/bash', 04:03:23 INFO - 'SHLVL': '1', 04:03:23 INFO - 'TERM': 'linux', 04:03:23 INFO - 'TMOUT': '86400', 04:03:23 INFO - 'USER': 'cltbld', 04:03:23 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781', 04:03:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:23 INFO - '_': '/tools/buildbot/bin/python'} 04:03:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:23 INFO - Downloading/unpacking jsonschema 04:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:03:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:03:25 INFO - Downloading/unpacking functools32 (from jsonschema) 04:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:25 INFO - Downloading functools32-3.2.3-2.tar.gz 04:03:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:03:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:03:25 INFO - warning: no files found matching '*.txt' 04:03:25 INFO - no previously-included directories found matching 'build' 04:03:25 INFO - no previously-included directories found matching 'dist' 04:03:25 INFO - no previously-included directories found matching '.git*' 04:03:25 INFO - Installing collected packages: jsonschema, functools32 04:03:25 INFO - Running setup.py install for functools32 04:03:25 INFO - warning: no files found matching '*.txt' 04:03:25 INFO - no previously-included directories found matching 'build' 04:03:25 INFO - no previously-included directories found matching 'dist' 04:03:25 INFO - no previously-included directories found matching '.git*' 04:03:25 INFO - Successfully installed jsonschema functools32 04:03:25 INFO - Cleaning up... 04:03:25 INFO - Return code: 0 04:03:25 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:03:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6acfa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2346230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d87f0>, '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 0x23442d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2344760>, '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': '82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:03:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 04:03:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:03:25 INFO - Using env: {'DISPLAY': ':0', 04:03:25 INFO - 'HOME': '/home/cltbld', 04:03:25 INFO - 'LANG': 'en_US.UTF-8', 04:03:25 INFO - 'LANGUAGE': 'en_US:en', 04:03:25 INFO - 'LOGNAME': 'cltbld', 04:03:25 INFO - 'MAIL': '/var/mail/cltbld', 04:03:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:25 INFO - 'MOZ_NO_REMOTE': '1', 04:03:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:25 INFO - 'NO_EM_RESTART': '1', 04:03:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:03:25 INFO - 'PWD': '/builds/slave/test-pgo', 04:03:25 INFO - 'SHELL': '/bin/bash', 04:03:25 INFO - 'SHLVL': '1', 04:03:25 INFO - 'TERM': 'linux', 04:03:25 INFO - 'TMOUT': '86400', 04:03:25 INFO - 'USER': 'cltbld', 04:03:25 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781', 04:03:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:25 INFO - '_': '/tools/buildbot/bin/python'} 04:03:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:25 INFO - Downloading/unpacking flake8 04:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:03:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:03:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:03:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:03:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:03:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:03:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:03:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:03:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:03:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:03:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:03:28 INFO - no previously-included directories found matching 'docs/_build' 04:03:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:03:28 INFO - Running setup.py install for pep8 04:03:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:03:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:03:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:03:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:03:28 INFO - no previously-included directories found matching 'docs/_build' 04:03:28 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:03:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:03:28 INFO - Cleaning up... 04:03:28 INFO - Return code: 0 04:03:28 INFO - Running post-action listener: _resource_record_post_action 04:03:28 INFO - Running post-action listener: _start_resource_monitoring 04:03:28 INFO - Starting resource monitoring. 04:03:28 INFO - ##### 04:03:28 INFO - ##### Running install step. 04:03:28 INFO - ##### 04:03:28 INFO - Running pre-action listener: _resource_record_pre_action 04:03:28 INFO - Running main action method: install 04:03:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:03:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:03:28 INFO - Reading from file tmpfile_stdout 04:03:28 INFO - Detecting whether we're running mozinstall >=1.0... 04:03:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:03:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:03:28 INFO - Reading from file tmpfile_stdout 04:03:28 INFO - Output received: 04:03:28 INFO - Usage: mozinstall [options] installer 04:03:28 INFO - Options: 04:03:28 INFO - -h, --help show this help message and exit 04:03:28 INFO - -d DEST, --destination=DEST 04:03:28 INFO - Directory to install application into. [default: 04:03:28 INFO - "/builds/slave/test-pgo"] 04:03:28 INFO - --app=APP Application being installed. [default: firefox] 04:03:28 INFO - mkdir: /builds/slave/test-pgo/build/application 04:03:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 04:03:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 04:03:44 INFO - Reading from file tmpfile_stdout 04:03:44 INFO - Output received: 04:03:44 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:03:44 INFO - Running post-action listener: _resource_record_post_action 04:03:44 INFO - ##### 04:03:44 INFO - ##### Running run-tests step. 04:03:44 INFO - ##### 04:03:44 INFO - Running pre-action listener: _resource_record_pre_action 04:03:44 INFO - Running main action method: run_tests 04:03:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:03:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:03:44 INFO - Python 2.7.3 04:03:44 INFO - Return code: 0 04:03:44 INFO - grabbing minidump binary from tooltool 04:03: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')]} 04:03:44 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 0x23d87f0>, '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 0x23442d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2344760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:03:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 04:03:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:03:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:03:44 INFO - Return code: 0 04:03:44 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:03:44 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:03:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:03:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:03:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:03:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:03:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:03:45 INFO - Return code: 0 04:03:45 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/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 04:03:45 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/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 04:03:45 INFO - Using env: {'DISPLAY': ':0', 04:03:45 INFO - 'HOME': '/home/cltbld', 04:03:45 INFO - 'LANG': 'en_US.UTF-8', 04:03:45 INFO - 'LANGUAGE': 'en_US:en', 04:03:45 INFO - 'LOGNAME': 'cltbld', 04:03:45 INFO - 'MAIL': '/var/mail/cltbld', 04:03:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:03:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:45 INFO - 'MOZ_NO_REMOTE': '1', 04:03:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:45 INFO - 'NO_EM_RESTART': '1', 04:03:45 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:03:45 INFO - 'PWD': '/builds/slave/test-pgo', 04:03:45 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:03:45 INFO - 'SHELL': '/bin/bash', 04:03:45 INFO - 'SHLVL': '1', 04:03:45 INFO - 'TERM': 'linux', 04:03:45 INFO - 'TMOUT': '86400', 04:03:45 INFO - 'USER': 'cltbld', 04:03:45 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781', 04:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:45 INFO - '_': '/tools/buildbot/bin/python'} 04:03:45 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/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 04:03:46 INFO - mozversion application_buildid: 20160119013024 04:03:46 INFO - mozversion application_changeset: 9bb1872a676cfc39fd9419fb5d7310bd80258d56 04:03:46 INFO - mozversion application_display_name: Nightly 04:03:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:03:46 INFO - mozversion application_name: Firefox 04:03:46 INFO - mozversion application_remotingname: firefox 04:03:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:03:46 INFO - mozversion application_vendor: Mozilla 04:03:46 INFO - mozversion application_version: 46.0a1 04:03:46 INFO - mozversion platform_buildid: 20160119013024 04:03:46 INFO - mozversion platform_changeset: 9bb1872a676cfc39fd9419fb5d7310bd80258d56 04:03:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:03:46 INFO - mozversion platform_version: 46.0a1 04:03:46 INFO - using testdate: 1453205026 04:03:46 INFO - actual date: 1453205026 04:03:46 INFO - starting webserver on 'localhost:49027' 04:03:46 INFO - SUITE-START | Running 3 tests 04:03:46 INFO - TEST-START | dromaeo_css 04:03:46 INFO - operating with platform_type : linux_ 04:03:46 INFO - Initialising browser for dromaeo_css test... 04:03:46 INFO - TEST-INFO | started process 5446 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcwmtz_/profile http://localhost:49027/getInfo.html) 04:03:49 INFO - PROCESS | 5446 | 04:03:49 INFO - PROCESS | 5446 | (process:5528): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:03:50 INFO - PROCESS | 5446 | __metrics Screen width/height:1600/1200 04:03:50 INFO - PROCESS | 5446 | colorDepth:24 04:03:50 INFO - PROCESS | 5446 | Browser inner width/height: 1024/697 04:03:50 INFO - PROCESS | 5446 | __metrics 04:03:50 INFO - PROCESS | 5446 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:03:51 INFO - TEST-INFO | 5446: exit 0 04:03:51 INFO - Browser initialized. 04:03:51 INFO - Running cycle 1/1 for dromaeo_css test... 04:03:51 INFO - TEST-INFO | started process 5577 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcwmtz_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:03:52 INFO - PROCESS | 5577 | -- checkerboarding starts below -- 04:03:52 INFO - PROCESS | 5577 | RENDERTRACE 0.130672 rect red 0 0 10 10 // viewport 04:03:52 INFO - PROCESS | 5577 | RENDERTRACE 35.7192 rect brown 0 0 10 10 // page 04:03:52 INFO - PROCESS | 5577 | RENDERTRACE 35.7575 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 04:03:52 INFO - PROCESS | 5577 | Checkerboarded for 1 frames (38.1679 ms), 100 peak, 10 severity. 04:03:53 INFO - PROCESS | 5577 | 04:03:53 INFO - PROCESS | 5577 | (process:5634): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:04:03 INFO - PROCESS | 5577 | RSS: Main: 150138880 04:04:03 INFO - PROCESS | 5577 | 04:04:53 INFO - PROCESS | 5577 | 1453205093196 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:07:01 INFO - PROCESS | 5577 | Cycle 1(1): loaded http://localhost:49027/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49027/tests/dromaeo/cssquery-ext.html) 04:07:03 INFO - PROCESS | 5577 | RSS: Main: 155680768 04:07:03 INFO - PROCESS | 5577 | 04:10:05 INFO - PROCESS | 5577 | Cycle 1(1): loaded http://localhost:49027/tests/dromaeo/cssquery-ext.html (next: http://localhost:49027/tests/dromaeo/cssquery-jquery.html) 04:10:05 INFO - PROCESS | 5577 | RSS: Main: 153231360 04:10:05 INFO - PROCESS | 5577 | 04:13:07 INFO - PROCESS | 5577 | Cycle 1(1): loaded http://localhost:49027/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49027/tests/dromaeo/cssquery-mootools.html) 04:13:07 INFO - PROCESS | 5577 | RSS: Main: 151126016 04:13:07 INFO - PROCESS | 5577 | 04:16:09 INFO - PROCESS | 5577 | Cycle 1(1): loaded http://localhost:49027/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49027/tests/dromaeo/cssquery-prototype.html) 04:16:10 INFO - PROCESS | 5577 | RSS: Main: 150691840 04:16:10 INFO - PROCESS | 5577 | 04:19:12 INFO - PROCESS | 5577 | Cycle 1(1): loaded http://localhost:49027/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49027/tests/dromaeo/cssquery-yui.html) 04:19:13 INFO - PROCESS | 5577 | RSS: Main: 151097344 04:19:13 INFO - PROCESS | 5577 | 04:22:15 INFO - PROCESS | 5577 | Cycle 1(1): loaded http://localhost:49027/tests/dromaeo/cssquery-yui.html (next: http://localhost:49027/tests/dromaeo/cssquery-dojo.html) 04:22:15 INFO - PROCESS | 5577 | RSS: Main: 153268224 04:22:15 INFO - PROCESS | 5577 | 04:22:15 INFO - PROCESS | 5577 | __start_tp_report 04:22:15 INFO - PROCESS | 5577 | _x_x_mozilla_page_load 04:22:15 INFO - PROCESS | 5577 | _x_x_mozilla_page_load_details 04:22:15 INFO - PROCESS | 5577 | |i|pagename|runs| 04:22:15 INFO - PROCESS | 5577 | |0;dojo.html;3234.547163397124;3244.789088709232;3267.1342094344986;3277.3445310937805;3300.3399320135964;5209.453007434222;5375.623706340548;5376.973115134424;5388.515033646971;5392.2181283713835;5276.762545685444;5395.460453954603;5418.943306055321;5451.236826844245;5454.972725136378;4819.301201325806;4904.190808516591;4959.925601115986;4970.105381031431;5020.623453241022;4996.825111121111;4997.675151115184;5061.16490779021;5064.392272927235;5068.265101560271;4802.23164293713;4892.437369702494;4922.064807686528;5014.949850501484;5027.195648696191;4909.116359055369;4911.386076740408;4930.383702037246;4936.580390666798;4983.8504844854715;4724.71651700899;4895.143349913751;4907.092187945206;4924.261360795874;4930.482299358551;5132.461091585405;5217.452167522393;5240.947590524084;5247.842564723064;5269.683818970874;5862.706864656793;5896.262967129109;5899.852503687399;5901.793437229677;5913.2608423947;5645.237892884449;5728.369879313273;5905.2323197984415;5908.261467316585;5914.881702365971;5350.411454739976;5416.702081385522;5421.078416669176;5437.157240627709;5479;5849.766009359578;5853.122031695195;5858.238429004202;5860.2381690380835;5860.706964651836;5502.9174562381595;5589.329280486368;5639.830805075854;5663.178839068312;5765.221695071195;5737.225474560881;5748;5761.6254943429385;5776.711164441761;5800.651960882361;5757.424257574209;5762.9135562966585;5795.565332599987;5801.6519008859605;5812.011957967071;5560.443955604407;5683.147527870769;5787.450192231731;5826.980278451254;5911.083782013795;4511.458624964959;4514.503404625489;4523.276275795857;4530.071335376306;4558.49856515783;4002.8799136025964;4013.0569316210667;4015.3575427931974;4064.9593504065174;4077.6330130287824;5275.868103297448;5376.274202982548;5485.314335708036;5497.697626630494;5502.449755024546;5860.062390017577;5922.318933322636;5924.674142922181;5924.881502369928;5929.318128415288;5211.478852114758;5462.699551524624;5464.644798088111;5509.283793106871;5519.116941289374;4787.904241915142;4843.491433399513;4882.145624515695;4883.487233840467;4923.01539692063;6064.120702498113;6071.787487437919;6072.696365181723;6076.605020673642;6080.969595152084;5531.032069387921;5713.428657134254;5839.182514447895;5848.912266316093;5885.676287804212;5937.34689184198;6019.668918209365;6065.059915713072;6067.54493412987;6070.453659170696;5593.07714227148;5605.299337582802;5620.8032718856275;5650.547956163415;5651.321841378896;5620.409856965123;5736.6558006519745;5749.91375129365;5759.39526349744;5792.1311803229855;5556.91664625039;5557.472040156179;5594.608377413542;5603.523700485342;5640.182173584725;5709.771609135754;5726.370099289158;5761.135829625589;5765.7117144141785;5766.221560089334;5321.733913304397;5432.239486471976;5610.747516361692;5641.8589535261945;5660.094384898561;5495.53287970527;5534.501894829485;5560.91658625129;5590.161475778503;5611.607187496836;5578.386377498391;5599.776008959596;5631.493165615114;5639.464250896158;5653.067243904874 04:22:15 INFO - PROCESS | 5577 | |1;ext.html;543.5271313956856;551.2090150633841;565.476933836202;570.1732487892557;572.0418299348592;34165;34730;34849.12877178072;34984.475232871526;35032.2993540129;38211.61788382122;38396;38743.612563874354;38770;38792;8556.358273129525;8683.826323473526;8702.695405660803;8718.607662655195;8733.912660873406;8539.188777066169;8610.182032706884;8659.437136586133;8681.782955426102;8689.217970382664;8622.31021518277;8740.257078148365;8753.737387878375;8753.949526056851;8766.167214114681;8581.570921453902;8659.177378149066;8681.869771953427;8682.26200772932;8690.08754080825;8438.831223375559;8656.437331573428;8662.696805611773;8668.089850565726;8685.478871267744;38404.80797596022;38941.80529097365;38964.415533767016;39223;39283.607163928566;3184.2039490127468;3188.7289580385695;3249.414956252122;3347.297067615804;3847.9230415391535;28639.570406443712;29020.27449313784;29147.708522914712;29244.853775731197;29451.852740736373;3852.7880966546827;3953.8007520110964;3986.740861844;3991.920161596781;4057.127717540743;197823;198164;199320;200176;200218;55423.722881385336;55722;55745;55752;55837.720811396495;66034;67046;67155;67164;67513.32486675169;13618.659533511543;13679.794803077963;13714.24571648549;13740.587782366545;13770.449182032808;10545;10622.628208012682;10657.413842238597;10667.83998240027;10669.19981001428;19711.211551538065;19867.60264794696;19931.701024484646;20112.59774804496;20575.794242057687;7869.134395216522;8011.959940200379;8014.879776803353;8022.879656805153;8152.470089444168;963.4123184857232;1028.6091285311534;1121.315997241682;1128.2102528230107;1150.2868221702597;28056.43887122287;28143.155705328463;28722.712772872004;28795.42409151847;28859;1049.9002594753485;1070.5182667799522;1076.311160857052;1147.3804145761362;1157.8494795676509;14824.703505930036;14868.62828429298;14907.254637268094;14949.70100597982;15052.967849340417;329521;329598;330735;332188;334521;50496.49503504918;50722.746386267834;51121.233181502306;51190.74404627953;51224;1312.4881296294452;1323.7551053055215;1328.8671132886634;1335.9265240411871;1343.7715588350004;26658.466830663667;27863.86068069728;27959.440811184068;28328.85835570809;28545.28636784097;44921.55078449174;45128.77435612801;45467.54532454633;45532.77233613811;45550.77224613856;311004;312459;312812;314076;314296;31902;41485.58514414817;42956;43063.784681076395;43141.352879707454;44509.33236001398;46187;46317.305240422094;46432.07135857332;46956.530434696586;33676;34859.47710784391;35395.941106247104;35499;35821.1044723884;35545;35788.28423431569;36095.45856812097;36267.637323626426;36360;34390;35055.47416788801;35540;35542;35650;30501.694983050773;31771.523427149074;32037.359252814345;32200.677993219768;32452.35095298128;24446.755532444447;24730.876345618155;24903.875480623206;24959.500809983336;25418.872905635355 04:22:15 INFO - PROCESS | 5577 | |2;jquery.html;370.78752479392386;371.34643028270256;372.194199557957;375.4593385524843;377.9773213607182;15567.221638918052;16660.333586656536;16772.496825095266;17407.564810879736;17441.04074275914;11040.944795276033;11437.542498300058;14887.18120503372;14923.104613723184;14953.102813831178;4965.106280869451;5227.111391063529;5557.5831812614015;5570.805021824237;5575.0522411189995;5063.139266324715;5444.237806707044;5462.121893455651;5472.808451704191;5480.91778623321;5337.2527846101575;5359.598030147735;5361.973190134064;5408.8377348679605;5604.047311956977;5317.533272051457;5556.91664625031;5573.972130139324;5580.358258800249;5673.035583950697;5440.646357986758;5441.972790136064;5466.835994920159;5467.343918729738;5480.3971563128025;12399.75200495994;12445.066620003536;12544.620091789895;12554.623361299176;12599.433025513783;2096.6540520814046;2104.5790841831695;2124.076026928291;2144.7747986461354;2151.2900742754855;9434.716958491188;9484.33609647325;9534;9867.950660246725;9917.107460328605;1799.2533098763997;1801.2074687137617;1819.5269230000295;1871.8221768932067;1885.1422602715732;54685.179722304194;54881.45118548803;55989;56509.71745141248;56932.71533642347;9968.80062398748;10197.18422526196;10289.176865850714;10290.948545257226;10343.60361351223;13264.270465124511;13420;13424.530141445002;13460.93269533646;13468.595942121752;7164.426845852319;7166.856662866818;7447.478676492702;7460.589667568227;7490.962545187239;7043.119610048744;7056.435485161175;7098.716051357991;7101.325374089453;7107.786766396913;4373.737575745466;4495.9325610115875;4500.279955207151;4502.4371953505815;4515.300128480091;1851.4075495841203;1879.8778079424794;1896.2604584212168;1905.4378958207362;1906.9904650476935;875.0942774228643;911.2709832134266;958.0993865766158;961.1829944547079;1015.5886865819355;14648.780268295985;15090.698186036218;16640;16659.500214993568;17084.91457542729;908.2506931781174;913.5340976102103;933.4725879877848;946.8059047895165;1004.3070281505737;9640;9769.31614786958;9780.168685661656;9798.363106398205;9832.655857044969;495932;503394;507913;508107.9189208061;511453;68247;71662.2833771666;71754.64122679354;72469.6376518114;74168.25831741614;1100.7743412600398;1109.4951796932376;1148.3052753084264;1161.349644199251;1162.953481860716;14133.646658833612;14534.709305814036;14562.635934101732;14961.925190373979;15025.699486010437;29595.112146635634;30701.846490767402;30860.69139308668;30866.53700194544;31383.529247061768;38772.80613597027;40726.38910416287;40974.385384218665;40988.1802363957;41357.1728565433;7221.53060051095;7483.775486735407;7579.5073320234005;7595.734149304748;7718.884216736866;9957.253206009433;11173.385463799244;11428.828567571327;11491.48288327044;11894.940525297317;7225.783226503213;7421.578783027809;7755.844883102193;9579.808403831745;9726.610935562781;4207.969047583361;7013.211631034053;9561.282903782105;9568.76078098053;9976.301658884098;9865.901340986786;10016.549255283675;10115.544800483849;10135.49322533885;10353.4305613192;7289.744858929912;7619.619019049136;7762.262585054411;7792.415568832474;7811.765647030598;8947.910520894708;9496.667616633385;9772.462514561767;9829.803403932025;9905.653302134679 04:22:15 INFO - PROCESS | 5577 | |3;mootools.html;1467.8238611366635;1482.3774014913736;1656.7183578791605;1795.7216631422134;1830.3959693301204;7816.648250828712;7865.252800983897;7940.444168908171;8015.438919275646;8124.553149576771;8045.597720113986;8112.553809540473;8159.10249872515;8173.305269052123;8186.140455252202;2423.72127205371;2451.1298489036403;2453.153661986612;2459.1270099114827;2466.6793316868784;2288.9198878039274;2311.364374796936;2316.884155792212;2316.93049208524;2399.4361325088676;2029.4419034765483;2072.4715197624587;2244.438890277431;2316.779905908936;2338.754430784769;2338.7193536775612;2344.765523447659;2348.976510234893;2359.5634807560655;2361.551305252005;2285.1887579909057;2374.03851440167;2375.2161786610377;2386.7135943686694;2387.9880600596885;7839.725609603636;7869.488483248628;7906.090799558067;7906.248906353887;7910.841783164362;4866.537678920532;4927.162382395001;4972.254161875711;4983.825566105169;5003.249512573143;3126.6873312668777;3181.459151944152;3258.3483303339426;3258.885938992124;3311.403947289487;1076.3057827701168;1090.2095980414215;1104.8729396119468;1107.374333501569;1137.1925932587872;11259.774804503946;11310.491027903765;11325.150613703923;11341.489632966453;11359.091272698248;4365.3670217818235;4433.8669839904205;4438.201123797683;4487.371767952489;4497.302918047708;8709.562922117779;8786.824263514694;8804.075572064969;8813.294936405073;8830;4917.409910810726;4922.237053256751;4939.1109600271575;4951.90096198074;4956.306117143603;4522.615577675869;4538.478075021415;4540.273556231054;4576.4508259009135;4587.839425620087;3566.661167189113;3615.7830530168276;3636.4181730922924;3644.435112557505;3671.687906527975;1109.3343993603935;1109.5561775289948;1111.855458790352;1114.4984756859446;1131.6095946898306;1043.1133536494071;1047.8585390972273;1075.8440026196158;1184.4729095552568;1332.666833291677;7318.96340518294;7357.0803649543805;7372.889406658905;7393.334599886036;7399.223081576464;1103.4813637590319;1119.4067144413473;1140.9674244808461;1142.9142814288962;1148.8506494155706;5809.970950145223;5840.445157710095;5893.616914900518;5905.143754155623;5941.049432090845;9089.909100908906;9382.953085234667;9498.430094194371;9588.328816982883;9646.083622055894;9210.309226808016;9286.257099432165;9344.906550934404;9349.672761453316;9412.576434060484;7293.562386256947;7370;7380.926190738024;7435.628218589049;7456.888146677696;7275.163356214103;7294.890576641461;7314.4514161439165;7342.5227360221415;7355.816104597214;8033.799155021171;8182.22268884455;8305.044919834296;8390.119037500974;8434.156584341763;8309.740227487258;8686.82626347482;8718.17177368149;8741;8748.47509149453;7554.320111190019;7610.391168706601;7707.768766937001;7792.10390805042;7796.961015194887;7797.7660670179985;7833.529988200727;7857.607119643881;7864.331531819631;7886.72396466121;6791.93208067913;7168.89246661311;7320.450966177452;7342;7557.962210189134;7016.368861676871;7117.572945623279;7146.142462904485;7161.606111663908;7198.316159964795;7329.9267007329245;7353.338199562065;7357.484976051625;7359.116905971104;7384.298491643285;6733.562318449285;6750.898736518858;6755.392014718699;6770.356816102462;6773.729050838108;6560.147180866456;6650.401463868275;6686.264510903894;6701.597904125768;6737.629430381376 04:22:15 INFO - PROCESS | 5577 | |4;prototype.html;331.5822064199109;345.19397207520444;355.9466080087988;356.0884136610278;357.27829783836665;6217.906731399033;6249.468795152412;6275.905861412082;6348.301686814447;6469.57947733397;6199.473044791187;6294.150289710888;6348.206474190726;6350.523710721691;6388.77639282624;4757.381540399743;4764.761761911908;4778.068276686039;4786.617070634341;4789.712617242976;4773.284007398901;4773.451053128882;4782.1153086678905;4796.040791841629;4796.44840843304;4644.6516511261625;4738.218193998004;4740.217864052427;4743.051389722053;4753.85738427846;4716.834910778106;4724.40944881888;4732.550407711262;4733.715977041388;4747.477777444478;4069.674426045909;4101.179764047202;4107.363358679409;4115.938260926088;4130.380442933554;5944.464998150144;5944.554158438091;5987.922174008677;5995.411216027713;6002.309734380515;5378.310844577712;5540.529055030287;5542.91685624716;5550.417206193332;5557.638753481011;6617.106690596756;6661.800145995628;6668.499862510331;6676.198856137246;6685.231198412148;4557.430321209848;4572.199865023607;4572.565606267399;4585.014221942299;4586.472555656109;6790.898136527956;6900.654967251618;6908.585484870924;6980.895286570705;6986.54587451814;4648.465426475931;4686.179918514246;4687.460941991646;4696.03731235096;4703.270992996091;4752.334673145762;4758.595519380822;4759.690620109682;4765.594924431392;4766.380370551806;5452.536534394541;5488.396276409591;5511.3937466878615;5526.889462210734;5531.059719847635;6586.85927073703;6607.174103237096;6688.598684078874;6707.6981535831;6712.463002959751;1659.8174200837898;1688.3162319260719;1708.8376604222578;1713.4773893962213;1713.8628909687195;1180.710725872167;1187.5071845184152;1193.4271549656214;1198.6224339333257;1201.0631707268344;6227.09707092469;6265.8746825063245;6273.780417685359;6282.403171698681;6292.559520833498;6750.459963202932;6783.932160678429;6797.966010169917;6799.150106236721;6801.557898736566;5958.582899197015;6109.602875813147;6123.38766123393;6128.509719222451;6134.018557030943;3658.7804731716183;3678.9264214715554;3687.2994131115;3690.8708195213576;3703.092742278159;7081;7084.43324534036;7084.645767711594;7089.184743754431;7096.751613693599;6723.831904202336;6942.93057069433;6962.338577835098;6965.442764578822;6973.442124630017;6855.5543889647015;6884.449244060564;6925.307469253135;6935.653217339213;7093.716251349992;6775.356341147583;6799.286074962256;6806.65966701653;6829.93170068293;6850.45196384298;6556.082148499309;6701.530892837454;6706.497012724163;6738.898916516158;6750.223724271772;7035.788926332219;7057.50597458173;7066.364027237573;7077.5399599025895;7095.503314767917;4787.497312782108;4821.63837712166;4821.831235906727;4846.224604063333;4848.32123502717;6688;6765.458763299022;6792.490563207878;6823.795286141423;6951.304869513008;6695.899561506484;6747.730090796509;6750.9873518972545;6751.797446076625;6754.696038678173;6660.933390666031;6720.294369091175;6729.596224226562;6731.562448440835;6732.192136943598;6471.2234531856475;6605.801825945229;6686.933130668631;6703.597784132968;6711.832204194934;6843.452523798183;6861.519693621399;6870.519063665495;6879.380855723009;6889.3455121765355;6588.341165883373;6606.8017959461295;6624.9337506624315;6630.701618427279;6639.867202656016 04:22:15 INFO - PROCESS | 5577 | |5;yui.html;773.7872085176576;808.1352952340994;821.5974172655401;841.1084250694261;854.6923107681233;13380.531681391154;13473.258970756604;13556.93221533891;13642.658933526654;13669.521566745178;12372.443240054197;13159.210447373165;13168.73662526749;13189.604311870635;13243.536476223335;784.2784638132918;798.8442253760519;799.5083023940293;800.3877034068913;800.8038030682491;817.5952903312868;820.819419727662;826.1903334731966;831.1231650608605;831.1231650608636;840.6133178737788;841.4951029382353;842.5787106446777;842.6503001254472;846.7163500227431;838.3628442383771;842.0064324097593;842.4818736477023;842.4818736477084;844.4806444036903;630.4074170279922;631.2992578238152;631.7094136697125;631.8451979265063;633.24959922492;13529;13556.118852274669;13563.932180339134;13564.593062208149;13622.386992585358;12359.32023738694;12579.245245285312;12705.132877676642;12733.61799146027;12756.553520626734;10382.9480852596;10407.843882341771;10454.634087806966;10500.474976251156;10589.629362972337;3607.1162565171703;3677.4483827425834;3682.963170368316;3709.7774133552075;3712.962870371289;41731.37402938958;42042.369364459555;42165;42302.788486057376;42370.57629423728;9335.646331281927;9570.473623950611;9577.425354478753;9913.256505761952;9950.950245248872;16650.16749162537;17205.56986075333;17274.395396161075;17342.219600118024;17360.305587776347;7337.41300695943;7428.6285685716575;7467.514611550232;7499.437542184358;7567.545947243183;4147.564505726916;4213.852515161954;4214.557471465513;4215.199112168678;4250.914981700349;3160.2573395252098;3178.7139157475476;3188.28263640679;3188.649248582654;3189.521571764254;549.6042849148606;552.6324993879025;555.1507581277538;563.8731285460821;586.5190543754165;513.5865628169284;630.4105661206786;650.8372906773307;678.6776281266359;679.4055201698513;8851.911480885237;8967.282617390592;9003.324750643596;9052.954735226282;9240.7689807754;592.3720855892767;647.8930976388843;671.7245929169018;677.7600031894635;680.2585182151479;4047.170330082385;4282.186384586918;4305.56944305567;4392.736435813861;4416.3596278539435;53542;53871.46128538664;53934.46065539294;54311.45688543143;54416.72791636016;48359.516404836206;48528.7573562137;48603;48782.26826597604;48896.5110348892;43534.7823260888;44716.10567788626;44731;45051.09897802026;45144.54855451403;7938.56337901421;8133.2680058794995;8255.298299644597;8277.255047045795;8322.916770832215;32015.35969280555;32086.518702219953;32093.358132836747;32839.34321313513;33386;37928.431073533364;38278.42582361322;43619.345709813744;43751.56248437475;44268.7786561078;10547.57809687604;10596.947015265183;10681.679549613524;10814.89185108139;10843.728906777395;11825.172237943261;11834.881651183377;11885.94057029744;12210.633680989584;12506.937465312616;11304.717382065513;11566.074714023027;11576.652700419001;11630.709232268922;11995.880041199476;11271;11588.826167607323;11661.825072624088;11873.82189267179;11926.165168438127;11515.827262591236;11714.062874969812;11762.294262344287;11964.521419143137;12015.158938874194;9649.951750241486;9702.75743106428;9752.219822414048;10012.69961901144;10254.487275636338;9219.262459003397;9442.433453992782;9631.229501639993;10217.795644086927;10450.529726162189 04:22:15 INFO - PROCESS | 5577 | __end_tp_report 04:22:15 INFO - PROCESS | 5577 | __start_cc_report 04:22:15 INFO - PROCESS | 5577 | _x_x_mozilla_cycle_collect,320 04:22:15 INFO - PROCESS | 5577 | __end_cc_report 04:22:15 INFO - PROCESS | 5577 | __startTimestamp1453206135963__endTimestamp 04:22:15 INFO - PROCESS | 5577 | 04:22:15 INFO - PROCESS | 5577 | ------- Summary: start ------- 04:22:15 INFO - PROCESS | 5577 | Number of tests: 6 04:22:15 INFO - PROCESS | 5577 | 04:22:15 INFO - PROCESS | 5577 | [#0] dojo.html Cycles:165 Average:5374.29 Median:5557.47 stddev:590.30 (10.6%) stddev-sans-first:567.74 04:22:15 INFO - PROCESS | 5577 | Values: 3234.5 3244.8 3267.1 3277.3 3300.3 5209.5 5375.6 5377.0 5388.5 5392.2 5276.8 5395.5 5418.9 5451.2 5455.0 4819.3 4904.2 4959.9 4970.1 5020.6 4996.8 4997.7 5061.2 5064.4 5068.3 4802.2 4892.4 4922.1 5014.9 5027.2 4909.1 4911.4 4930.4 4936.6 4983.9 4724.7 4895.1 4907.1 4924.3 4930.5 5132.5 5217.5 5240.9 5247.8 5269.7 5862.7 5896.3 5899.9 5901.8 5913.3 5645.2 5728.4 5905.2 5908.3 5914.9 5350.4 5416.7 5421.1 5437.2 5479.0 5849.8 5853.1 5858.2 5860.2 5860.7 5502.9 5589.3 5639.8 5663.2 5765.2 5737.2 5748.0 5761.6 5776.7 5800.7 5757.4 5762.9 5795.6 5801.7 5812.0 5560.4 5683.1 5787.5 5827.0 5911.1 4511.5 4514.5 4523.3 4530.1 4558.5 4002.9 4013.1 4015.4 4065.0 4077.6 5275.9 5376.3 5485.3 5497.7 5502.4 5860.1 5922.3 5924.7 5924.9 5929.3 5211.5 5462.7 5464.6 5509.3 5519.1 4787.9 4843.5 4882.1 4883.5 4923.0 6064.1 6071.8 6072.7 6076.6 6081.0 5531.0 5713.4 5839.2 5848.9 5885.7 5937.3 6019.7 6065.1 6067.5 6070.5 5593.1 5605.3 5620.8 5650.5 5651.3 5620.4 5736.7 5749.9 5759.4 5792.1 5556.9 5557.5 5594.6 5603.5 5640.2 5709.8 5726.4 5761.1 5765.7 5766.2 5321.7 5432.2 5610.7 5641.9 5660.1 5495.5 5534.5 5560.9 5590.2 5611.6 5578.4 5599.8 5631.5 5639.5 5653.1 04:22:15 INFO - PROCESS | 5577 | 04:22:15 INFO - PROCESS | 5577 | [#1] ext.html Cycles:180 Average:45325.71 Median:35541.00 stddev:75277.30 (211.8%) stddev-sans-first:75413.38 04:22:15 INFO - PROCESS | 5577 | Values: 543.5 551.2 565.5 570.2 572.0 34165.0 34730.0 34849.1 34984.5 35032.3 38211.6 38396.0 38743.6 38770.0 38792.0 8556.4 8683.8 8702.7 8718.6 8733.9 8539.2 8610.2 8659.4 8681.8 8689.2 8622.3 8740.3 8753.7 8753.9 8766.2 8581.6 8659.2 8681.9 8682.3 8690.1 8438.8 8656.4 8662.7 8668.1 8685.5 38404.8 38941.8 38964.4 39223.0 39283.6 3184.2 3188.7 3249.4 3347.3 3847.9 28639.6 29020.3 29147.7 29244.9 29451.9 3852.8 3953.8 3986.7 3991.9 4057.1 197823.0 198164.0 199320.0 200176.0 200218.0 55423.7 55722.0 55745.0 55752.0 55837.7 66034.0 67046.0 67155.0 67164.0 67513.3 13618.7 13679.8 13714.2 13740.6 13770.4 10545.0 10622.6 10657.4 10667.8 10669.2 19711.2 19867.6 19931.7 20112.6 20575.8 7869.1 8012.0 8014.9 8022.9 8152.5 963.4 1028.6 1121.3 1128.2 1150.3 28056.4 28143.2 28722.7 28795.4 28859.0 1049.9 1070.5 1076.3 1147.4 1157.8 14824.7 14868.6 14907.3 14949.7 15053.0 329521.0 329598.0 330735.0 332188.0 334521.0 50496.5 50722.7 51121.2 51190.7 51224.0 1312.5 1323.8 1328.9 1335.9 1343.8 26658.5 27863.9 27959.4 28328.9 28545.3 44921.6 45128.8 45467.5 45532.8 45550.8 311004.0 312459.0 312812.0 314076.0 314296.0 31902.0 41485.6 42956.0 43063.8 43141.4 44509.3 46187.0 46317.3 46432.1 46956.5 33676.0 34859.5 35395.9 35499.0 35821.1 35545.0 35788.3 36095.5 36267.6 36360.0 34390.0 35055.5 35540.0 35542.0 35650.0 30501.7 31771.5 32037.4 32200.7 32452.4 24446.8 24730.9 24903.9 24959.5 25418.9 04:22:15 INFO - PROCESS | 5577 | 04:22:15 INFO - PROCESS | 5577 | [#2] jquery.html Cycles:180 Average:26063.44 Median:509780.46 stddev:82596.37 (16.2%) stddev-sans-first:82805.55 04:22:15 INFO - PROCESS | 5577 | Values: 370.8 371.3 372.2 375.5 378.0 15567.2 16660.3 16772.5 17407.6 17441.0 11040.9 11437.5 14887.2 14923.1 14953.1 4965.1 5227.1 5557.6 5570.8 5575.1 5063.1 5444.2 5462.1 5472.8 5480.9 5337.3 5359.6 5362.0 5408.8 5604.0 5317.5 5556.9 5574.0 5580.4 5673.0 5440.6 5442.0 5466.8 5467.3 5480.4 12399.8 12445.1 12544.6 12554.6 12599.4 2096.7 2104.6 2124.1 2144.8 2151.3 9434.7 9484.3 9534.0 9868.0 9917.1 1799.3 1801.2 1819.5 1871.8 1885.1 54685.2 54881.5 55989.0 56509.7 56932.7 9968.8 10197.2 10289.2 10290.9 10343.6 13264.3 13420.0 13424.5 13460.9 13468.6 7164.4 7166.9 7447.5 7460.6 7491.0 7043.1 7056.4 7098.7 7101.3 7107.8 4373.7 4495.9 4500.3 4502.4 4515.3 1851.4 1879.9 1896.3 1905.4 1907.0 875.1 911.3 958.1 961.2 1015.6 14648.8 15090.7 16640.0 16659.5 17084.9 908.3 913.5 933.5 946.8 1004.3 9640.0 9769.3 9780.2 9798.4 9832.7 495932.0 503394.0 507913.0 508107.9 511453.0 68247.0 71662.3 71754.6 72469.6 74168.3 1100.8 1109.5 1148.3 1161.3 1163.0 14133.6 14534.7 14562.6 14961.9 15025.7 29595.1 30701.8 30860.7 30866.5 31383.5 38772.8 40726.4 40974.4 40988.2 41357.2 7221.5 7483.8 7579.5 7595.7 7718.9 9957.3 11173.4 11428.8 11491.5 11894.9 7225.8 7421.6 7755.8 9579.8 9726.6 4208.0 7013.2 9561.3 9568.8 9976.3 9865.9 10016.5 10115.5 10135.5 10353.4 7289.7 7619.6 7762.3 7792.4 7811.8 8947.9 9496.7 9772.5 9829.8 9905.7 04:22:15 INFO - PROCESS | 5577 | 04:22:15 INFO - PROCESS | 5577 | [#3] mootools.html Cycles:180 Average:5609.81 Median:6605.27 stddev:2878.13 (43.6%) stddev-sans-first:2869.36 04:22:15 INFO - PROCESS | 5577 | Values: 1467.8 1482.4 1656.7 1795.7 1830.4 7816.6 7865.3 7940.4 8015.4 8124.6 8045.6 8112.6 8159.1 8173.3 8186.1 2423.7 2451.1 2453.2 2459.1 2466.7 2288.9 2311.4 2316.9 2316.9 2399.4 2029.4 2072.5 2244.4 2316.8 2338.8 2338.7 2344.8 2349.0 2359.6 2361.6 2285.2 2374.0 2375.2 2386.7 2388.0 7839.7 7869.5 7906.1 7906.2 7910.8 4866.5 4927.2 4972.3 4983.8 5003.2 3126.7 3181.5 3258.3 3258.9 3311.4 1076.3 1090.2 1104.9 1107.4 1137.2 11259.8 11310.5 11325.2 11341.5 11359.1 4365.4 4433.9 4438.2 4487.4 4497.3 8709.6 8786.8 8804.1 8813.3 8830.0 4917.4 4922.2 4939.1 4951.9 4956.3 4522.6 4538.5 4540.3 4576.5 4587.8 3566.7 3615.8 3636.4 3644.4 3671.7 1109.3 1109.6 1111.9 1114.5 1131.6 1043.1 1047.9 1075.8 1184.5 1332.7 7319.0 7357.1 7372.9 7393.3 7399.2 1103.5 1119.4 1141.0 1142.9 1148.9 5810.0 5840.4 5893.6 5905.1 5941.0 9089.9 9383.0 9498.4 9588.3 9646.1 9210.3 9286.3 9344.9 9349.7 9412.6 7293.6 7370.0 7380.9 7435.6 7456.9 7275.2 7294.9 7314.5 7342.5 7355.8 8033.8 8182.2 8305.0 8390.1 8434.2 8309.7 8686.8 8718.2 8741.0 8748.5 7554.3 7610.4 7707.8 7792.1 7797.0 7797.8 7833.5 7857.6 7864.3 7886.7 6791.9 7168.9 7320.5 7342.0 7558.0 7016.4 7117.6 7146.1 7161.6 7198.3 7329.9 7353.3 7357.5 7359.1 7384.3 6733.6 6750.9 6755.4 6770.4 6773.7 6560.1 6650.4 6686.3 6701.6 6737.6 04:22:15 INFO - PROCESS | 5577 | 04:22:15 INFO - PROCESS | 5577 | [#4] prototype.html Cycles:180 Average:5549.41 Median:6274.84 stddev:1668.73 (26.6%) stddev-sans-first:1626.81 04:22:15 INFO - PROCESS | 5577 | Values: 331.6 345.2 355.9 356.1 357.3 6217.9 6249.5 6275.9 6348.3 6469.6 6199.5 6294.2 6348.2 6350.5 6388.8 4757.4 4764.8 4778.1 4786.6 4789.7 4773.3 4773.5 4782.1 4796.0 4796.4 4644.7 4738.2 4740.2 4743.1 4753.9 4716.8 4724.4 4732.6 4733.7 4747.5 4069.7 4101.2 4107.4 4115.9 4130.4 5944.5 5944.6 5987.9 5995.4 6002.3 5378.3 5540.5 5542.9 5550.4 5557.6 6617.1 6661.8 6668.5 6676.2 6685.2 4557.4 4572.2 4572.6 4585.0 4586.5 6790.9 6900.7 6908.6 6980.9 6986.5 4648.5 4686.2 4687.5 4696.0 4703.3 4752.3 4758.6 4759.7 4765.6 4766.4 5452.5 5488.4 5511.4 5526.9 5531.1 6586.9 6607.2 6688.6 6707.7 6712.5 1659.8 1688.3 1708.8 1713.5 1713.9 1180.7 1187.5 1193.4 1198.6 1201.1 6227.1 6265.9 6273.8 6282.4 6292.6 6750.5 6783.9 6798.0 6799.2 6801.6 5958.6 6109.6 6123.4 6128.5 6134.0 3658.8 3678.9 3687.3 3690.9 3703.1 7081.0 7084.4 7084.6 7089.2 7096.8 6723.8 6942.9 6962.3 6965.4 6973.4 6855.6 6884.4 6925.3 6935.7 7093.7 6775.4 6799.3 6806.7 6829.9 6850.5 6556.1 6701.5 6706.5 6738.9 6750.2 7035.8 7057.5 7066.4 7077.5 7095.5 4787.5 4821.6 4821.8 4846.2 4848.3 6688.0 6765.5 6792.5 6823.8 6951.3 6695.9 6747.7 6751.0 6751.8 6754.7 6660.9 6720.3 6729.6 6731.6 6732.2 6471.2 6605.8 6686.9 6703.6 6711.8 6843.5 6861.5 6870.5 6879.4 6889.3 6588.3 6606.8 6624.9 6630.7 6639.9 04:22:15 INFO - PROCESS | 5577 | 04:22:15 INFO - PROCESS | 5577 | [#5] yui.html Cycles:180 Average:13268.02 Median:43685.45 stddev:14790.30 (33.9%) stddev-sans-first:14802.02 04:22:15 INFO - PROCESS | 5577 | Values: 773.8 808.1 821.6 841.1 854.7 13380.5 13473.3 13556.9 13642.7 13669.5 12372.4 13159.2 13168.7 13189.6 13243.5 784.3 798.8 799.5 800.4 800.8 817.6 820.8 826.2 831.1 831.1 840.6 841.5 842.6 842.7 846.7 838.4 842.0 842.5 842.5 844.5 630.4 631.3 631.7 631.8 633.2 13529.0 13556.1 13563.9 13564.6 13622.4 12359.3 12579.2 12705.1 12733.6 12756.6 10382.9 10407.8 10454.6 10500.5 10589.6 3607.1 3677.4 3683.0 3709.8 3713.0 41731.4 42042.4 42165.0 42302.8 42370.6 9335.6 9570.5 9577.4 9913.3 9951.0 16650.2 17205.6 17274.4 17342.2 17360.3 7337.4 7428.6 7467.5 7499.4 7567.5 4147.6 4213.9 4214.6 4215.2 4250.9 3160.3 3178.7 3188.3 3188.6 3189.5 549.6 552.6 555.2 563.9 586.5 513.6 630.4 650.8 678.7 679.4 8851.9 8967.3 9003.3 9053.0 9240.8 592.4 647.9 671.7 677.8 680.3 4047.2 4282.2 4305.6 4392.7 4416.4 53542.0 53871.5 53934.5 54311.5 54416.7 48359.5 48528.8 48603.0 48782.3 48896.5 43534.8 44716.1 44731.0 45051.1 45144.5 7938.6 8133.3 8255.3 8277.3 8322.9 32015.4 32086.5 32093.4 32839.3 33386.0 37928.4 38278.4 43619.3 43751.6 44268.8 10547.6 10596.9 10681.7 10814.9 10843.7 11825.2 11834.9 11885.9 12210.6 12506.9 11304.7 11566.1 11576.7 11630.7 11995.9 11271.0 11588.8 11661.8 11873.8 11926.2 11515.8 11714.1 11762.3 11964.5 12015.2 9650.0 9702.8 9752.2 10012.7 10254.5 9219.3 9442.4 9631.2 10217.8 10450.5 04:22:15 INFO - PROCESS | 5577 | -------- Summary: end -------- 04:22:15 INFO - PROCESS | 5577 | 04:22:16 INFO - TEST-INFO | 5577: exit 0 04:22:16 INFO - TEST-OK | dromaeo_css | took 1110488ms 04:22:16 INFO - TEST-START | kraken 04:22:16 INFO - operating with platform_type : linux_ 04:22:16 INFO - Initialising browser for kraken test... 04:22:16 INFO - TEST-INFO | started process 5820 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSBefaV/profile http://localhost:49027/getInfo.html) 04:22:20 INFO - PROCESS | 5820 | 04:22:20 INFO - PROCESS | 5820 | (process:5892): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:22:21 INFO - PROCESS | 5820 | __metrics Screen width/height:1600/1200 04:22:21 INFO - PROCESS | 5820 | colorDepth:24 04:22:21 INFO - PROCESS | 5820 | Browser inner width/height: 1024/697 04:22:21 INFO - PROCESS | 5820 | __metrics 04:22:21 INFO - PROCESS | 5820 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:22:22 INFO - TEST-INFO | 5820: exit 0 04:22:22 INFO - Browser initialized. 04:22:22 INFO - Running cycle 1/1 for kraken test... 04:22:22 INFO - TEST-INFO | started process 5941 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSBefaV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:22:22 INFO - PROCESS | 5941 | -- checkerboarding starts below -- 04:22:22 INFO - PROCESS | 5941 | RENDERTRACE 0.033603 rect red 0 0 10 10 // viewport 04:22:22 INFO - PROCESS | 5941 | RENDERTRACE 76.0441 rect brown 0 0 10 10 // page 04:22:22 INFO - PROCESS | 5941 | RENDERTRACE 76.0645 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 04:22:22 INFO - PROCESS | 5941 | Checkerboarded for 1 frames (83.5913 ms), 100 peak, 1 severity. 04:22:23 INFO - PROCESS | 5941 | 04:22:23 INFO - PROCESS | 5941 | (process:6000): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:22:33 INFO - PROCESS | 5941 | RSS: Main: 150286336 04:22:33 INFO - PROCESS | 5941 | 04:22:36 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:49027/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49027/tests/kraken/driver.html?testName=audio-beat-detection) 04:22:36 INFO - PROCESS | 5941 | RSS: Main: 150757376 04:22:36 INFO - PROCESS | 5941 | 04:22:39 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:49027/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49027/tests/kraken/driver.html?testName=audio-dft) 04:22:40 INFO - PROCESS | 5941 | RSS: Main: 154361856 04:22:40 INFO - PROCESS | 5941 | 04:22:43 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:49027/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49027/tests/kraken/driver.html?testName=audio-fft) 04:22:43 INFO - PROCESS | 5941 | RSS: Main: 147415040 04:22:43 INFO - PROCESS | 5941 | 04:22:45 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:49027/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49027/tests/kraken/driver.html?testName=audio-oscillator) 04:22:46 INFO - PROCESS | 5941 | RSS: Main: 147415040 04:22:46 INFO - PROCESS | 5941 | 04:22:48 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:49027/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49027/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:22:49 INFO - PROCESS | 5941 | RSS: Main: 147996672 04:22:49 INFO - PROCESS | 5941 | 04:22:52 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:49027/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49027/tests/kraken/driver.html?testName=imaging-darkroom) 04:22:52 INFO - PROCESS | 5941 | RSS: Main: 146620416 04:22:52 INFO - PROCESS | 5941 | 04:22:56 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:49027/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49027/tests/kraken/driver.html?testName=imaging-desaturate) 04:22:56 INFO - PROCESS | 5941 | RSS: Main: 146915328 04:22:56 INFO - PROCESS | 5941 | 04:22:59 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:49027/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49027/tests/kraken/driver.html?testName=json-parse-financial) 04:23:00 INFO - PROCESS | 5941 | RSS: Main: 149270528 04:23:00 INFO - PROCESS | 5941 | 04:23:01 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:49027/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49027/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:23:02 INFO - PROCESS | 5941 | RSS: Main: 151031808 04:23:02 INFO - PROCESS | 5941 | 04:23:04 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:49027/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49027/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:23:04 INFO - PROCESS | 5941 | RSS: Main: 151392256 04:23:04 INFO - PROCESS | 5941 | 04:23:06 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:49027/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49027/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:23:07 INFO - PROCESS | 5941 | RSS: Main: 151416832 04:23:07 INFO - PROCESS | 5941 | 04:23:09 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:49027/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:23:10 INFO - PROCESS | 5941 | RSS: Main: 149688320 04:23:10 INFO - PROCESS | 5941 | 04:23:12 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:49027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:23:13 INFO - PROCESS | 5941 | RSS: Main: 151318528 04:23:13 INFO - PROCESS | 5941 | 04:23:15 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:49027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49027/tests/kraken/driver.html?testName=ai-astar) 04:23:15 INFO - PROCESS | 5941 | RSS: Main: 150568960 04:23:15 INFO - PROCESS | 5941 | 04:23:15 INFO - PROCESS | 5941 | __start_tp_report 04:23:15 INFO - PROCESS | 5941 | _x_x_mozilla_page_load 04:23:15 INFO - PROCESS | 5941 | _x_x_mozilla_page_load_details 04:23:15 INFO - PROCESS | 5941 | |i|pagename|runs| 04:23:15 INFO - PROCESS | 5941 | |0;ai-astar;113;105;110;112;112;124;111;111;111;111 04:23:15 INFO - PROCESS | 5941 | |1;audio-beat-detection;156;126;153;169;127;157;163;132;168;126 04:23:15 INFO - PROCESS | 5941 | |2;audio-dft;164;162;164;163;163;163;164;166;175;163 04:23:15 INFO - PROCESS | 5941 | |3;audio-fft;74;73;72;74;73;74;169;77;77;73 04:23:15 INFO - PROCESS | 5941 | |4;audio-oscillator;96;96;140;97;97;95;144;96;96;148 04:23:15 INFO - PROCESS | 5941 | |5;imaging-gaussian-blur;110;110;110;110;110;110;110;110;111;110 04:23:15 INFO - PROCESS | 5941 | |6;imaging-darkroom;146;146;147;148;147;146;147;146;147;147 04:23:15 INFO - PROCESS | 5941 | |7;imaging-desaturate;96;97;96;96;97;96;97;97;102;98 04:23:15 INFO - PROCESS | 5941 | |8;json-parse-financial;59;60;59;60;62;61;59;62;73;58 04:23:15 INFO - PROCESS | 5941 | |9;json-stringify-tinderbox;69;69;67;68;69;69;69;70;68;69 04:23:15 INFO - PROCESS | 5941 | |10;stanford-crypto-aes;82;81;83;84;84;84;89;82;83;84 04:23:15 INFO - PROCESS | 5941 | |11;stanford-crypto-ccm;118;130;118;121;125;118;116;121;117;117 04:23:15 INFO - PROCESS | 5941 | |12;stanford-crypto-pbkdf2;131;144;142;148;152;148;146;142;143;141 04:23:15 INFO - PROCESS | 5941 | |13;stanford-crypto-sha256-iterative;66;70;66;67;66;67;69;66;69;66 04:23:15 INFO - PROCESS | 5941 | __end_tp_report 04:23:15 INFO - PROCESS | 5941 | __start_cc_report 04:23:15 INFO - PROCESS | 5941 | _x_x_mozilla_cycle_collect,738 04:23:15 INFO - PROCESS | 5941 | __end_cc_report 04:23:15 INFO - PROCESS | 5941 | __startTimestamp1453206195508__endTimestamp 04:23:15 INFO - PROCESS | 5941 | 04:23:15 INFO - PROCESS | 5941 | ------- Summary: start ------- 04:23:15 INFO - PROCESS | 5941 | Number of tests: 14 04:23:15 INFO - PROCESS | 5941 | 04:23:15 INFO - PROCESS | 5941 | [#0] ai-astar Cycles:10 Average:112.00 Median:111.50 stddev:4.74 (4.2%) stddev-sans-first:5.01 04:23:15 INFO - PROCESS | 5941 | Values: 113.0 105.0 110.0 112.0 112.0 124.0 111.0 111.0 111.0 111.0 04:23:15 INFO - PROCESS | 5941 | 04:23:15 INFO - PROCESS | 5941 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:156.50 stddev:17.95 (11.5%) stddev-sans-first:18.79 04:23:15 INFO - PROCESS | 5941 | Values: 156.0 126.0 153.0 169.0 127.0 157.0 163.0 132.0 168.0 126.0 04:23:15 INFO - PROCESS | 5941 | 04:23:15 INFO - PROCESS | 5941 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.00 stddev:3.77 (2.3%) stddev-sans-first:3.99 04:23:15 INFO - PROCESS | 5941 | Values: 164.0 162.0 164.0 163.0 163.0 163.0 164.0 166.0 175.0 163.0 04:23:15 INFO - PROCESS | 5941 | 04:23:15 INFO - PROCESS | 5941 | [#3] audio-fft Cycles:10 Average:83.60 Median:74.00 stddev:30.05 (40.6%) stddev-sans-first:31.67 04:23:15 INFO - PROCESS | 5941 | Values: 74.0 73.0 72.0 74.0 73.0 74.0 169.0 77.0 77.0 73.0 04:23:15 INFO - PROCESS | 5941 | 04:23:15 INFO - PROCESS | 5941 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:96.00 stddev:23.20 (24.2%) stddev-sans-first:24.01 04:23:15 INFO - PROCESS | 5941 | Values: 96.0 96.0 140.0 97.0 97.0 95.0 144.0 96.0 96.0 148.0 04:23:15 INFO - PROCESS | 5941 | 04:23:15 INFO - PROCESS | 5941 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:23:15 INFO - PROCESS | 5941 | Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 111.0 110.0 04:23:15 INFO - PROCESS | 5941 | 04:23:15 INFO - PROCESS | 5941 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 04:23:15 INFO - PROCESS | 5941 | Values: 146.0 146.0 147.0 148.0 147.0 146.0 147.0 146.0 147.0 147.0 04:23:15 INFO - PROCESS | 5941 | 04:23:15 INFO - PROCESS | 5941 | [#7] imaging-desaturate Cycles:10 Average:97.20 Median:97.00 stddev:1.81 (1.9%) stddev-sans-first:1.87 04:23:15 INFO - PROCESS | 5941 | Values: 96.0 97.0 96.0 96.0 97.0 96.0 97.0 97.0 102.0 98.0 04:23:15 INFO - PROCESS | 5941 | 04:23:15 INFO - PROCESS | 5941 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:60.50 stddev:4.32 (7.1%) stddev-sans-first:4.50 04:23:15 INFO - PROCESS | 5941 | Values: 59.0 60.0 59.0 60.0 62.0 61.0 59.0 62.0 73.0 58.0 04:23:15 INFO - PROCESS | 5941 | 04:23:15 INFO - PROCESS | 5941 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 04:23:15 INFO - PROCESS | 5941 | Values: 69.0 69.0 67.0 68.0 69.0 69.0 69.0 70.0 68.0 69.0 04:23:15 INFO - PROCESS | 5941 | 04:23:15 INFO - PROCESS | 5941 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.00 stddev:2.17 (2.6%) stddev-sans-first:2.22 04:23:15 INFO - PROCESS | 5941 | Values: 82.0 81.0 83.0 84.0 84.0 84.0 89.0 82.0 83.0 84.0 04:23:15 INFO - PROCESS | 5941 | 04:23:15 INFO - PROCESS | 5941 | [#11] stanford-crypto-ccm Cycles:10 Average:120.10 Median:119.50 stddev:4.38 (3.7%) stddev-sans-first:4.58 04:23:15 INFO - PROCESS | 5941 | Values: 118.0 130.0 118.0 121.0 125.0 118.0 116.0 121.0 117.0 117.0 04:23:15 INFO - PROCESS | 5941 | 04:23:15 INFO - PROCESS | 5941 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.70 Median:145.00 stddev:5.64 (3.9%) stddev-sans-first:3.66 04:23:15 INFO - PROCESS | 5941 | Values: 131.0 144.0 142.0 148.0 152.0 148.0 146.0 142.0 143.0 141.0 04:23:15 INFO - PROCESS | 5941 | 04:23:15 INFO - PROCESS | 5941 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.55 (2.3%) stddev-sans-first:1.58 04:23:15 INFO - PROCESS | 5941 | Values: 66.0 70.0 66.0 67.0 66.0 67.0 69.0 66.0 69.0 66.0 04:23:15 INFO - PROCESS | 5941 | -------- Summary: end -------- 04:23:15 INFO - PROCESS | 5941 | 04:23:16 INFO - TEST-INFO | 5941: exit 0 04:23:16 INFO - TEST-OK | kraken | took 60128ms 04:23:16 INFO - TEST-START | v8_7 04:23:16 INFO - operating with platform_type : linux_ 04:23:16 INFO - Initialising browser for v8_7 test... 04:23:16 INFO - TEST-INFO | started process 6228 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCI9ZPv/profile http://localhost:49027/getInfo.html) 04:23:20 INFO - PROCESS | 6228 | 04:23:20 INFO - PROCESS | 6228 | (process:6301): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:23:21 INFO - PROCESS | 6228 | __metrics Screen width/height:1600/1200 04:23:21 INFO - PROCESS | 6228 | colorDepth:24 04:23:21 INFO - PROCESS | 6228 | Browser inner width/height: 1024/697 04:23:21 INFO - PROCESS | 6228 | __metrics 04:23:21 INFO - PROCESS | 6228 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:23:22 INFO - TEST-INFO | 6228: exit 0 04:23:22 INFO - Browser initialized. 04:23:22 INFO - Running cycle 1/1 for v8_7 test... 04:23:22 INFO - TEST-INFO | started process 6350 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCI9ZPv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:23:23 INFO - PROCESS | 6350 | -- checkerboarding starts below -- 04:23:23 INFO - PROCESS | 6350 | RENDERTRACE 0.034923 rect red 0 0 10 10 // viewport 04:23:23 INFO - PROCESS | 6350 | RENDERTRACE 34.8551 rect brown 0 0 10 10 // page 04:23:23 INFO - PROCESS | 6350 | RENDERTRACE 34.8777 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 04:23:23 INFO - PROCESS | 6350 | Checkerboarded for 1 frames (36.0584 ms), 100 peak, 1 severity. 04:23:23 INFO - PROCESS | 6350 | 04:23:23 INFO - PROCESS | 6350 | (process:6410): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:23:34 INFO - PROCESS | 6350 | RSS: Main: 150687744 04:23:34 INFO - PROCESS | 6350 | 04:23:56 INFO - PROCESS | 6350 | Cycle 1(1): loaded http://localhost:49027/tests/v8_7/run.html (next: http://localhost:49027/tests/v8_7/run.html) 04:23:56 INFO - PROCESS | 6350 | RSS: Main: 146460672 04:23:56 INFO - PROCESS | 6350 | 04:23:56 INFO - PROCESS | 6350 | __start_tp_report 04:23:56 INFO - PROCESS | 6350 | _x_x_mozilla_page_load 04:23:56 INFO - PROCESS | 6350 | _x_x_mozilla_page_load_details 04:23:56 INFO - PROCESS | 6350 | |i|pagename|runs| 04:23:56 INFO - PROCESS | 6350 | |0;Richards;166.38935108153078 04:23:56 INFO - PROCESS | 6350 | |1;DeltaBlue;188.5014137606032 04:23:56 INFO - PROCESS | 6350 | |2;Encrypt;281.5315315315315 04:23:56 INFO - PROCESS | 6350 | |3;Decrypt;5191.709844559586 04:23:56 INFO - PROCESS | 6350 | |4;RayTrace;1091.703056768559 04:23:56 INFO - PROCESS | 6350 | |5;Earley;761.6146230007616 04:23:56 INFO - PROCESS | 6350 | |6;Boyer;12525 04:23:56 INFO - PROCESS | 6350 | |7;RegExp;41180 04:23:56 INFO - PROCESS | 6350 | |8;Splay;574.3825387708214 04:23:56 INFO - PROCESS | 6350 | |9;NavierStokes;4822.115384615385 04:23:56 INFO - PROCESS | 6350 | __end_tp_report 04:23:56 INFO - PROCESS | 6350 | __startTimestamp1453206236894__endTimestamp 04:23:56 INFO - PROCESS | 6350 | 04:23:56 INFO - PROCESS | 6350 | ------- Summary: start ------- 04:23:56 INFO - PROCESS | 6350 | Number of tests: 10 04:23:56 INFO - PROCESS | 6350 | 04:23:56 INFO - PROCESS | 6350 | [#0] Richards Cycles:1 Average:166.39 Median:166.39 stddev:0.00 (0.0%) 04:23:56 INFO - PROCESS | 6350 | Values: 166.4 04:23:56 INFO - PROCESS | 6350 | 04:23:56 INFO - PROCESS | 6350 | [#1] DeltaBlue Cycles:1 Average:188.50 Median:188.50 stddev:0.00 (0.0%) 04:23:56 INFO - PROCESS | 6350 | Values: 188.5 04:23:56 INFO - PROCESS | 6350 | 04:23:56 INFO - PROCESS | 6350 | [#2] Encrypt Cycles:1 Average:281.53 Median:281.53 stddev:0.00 (0.0%) 04:23:56 INFO - PROCESS | 6350 | Values: 281.5 04:23:56 INFO - PROCESS | 6350 | 04:23:56 INFO - PROCESS | 6350 | [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 04:23:56 INFO - PROCESS | 6350 | Values: 5191.7 04:23:56 INFO - PROCESS | 6350 | 04:23:56 INFO - PROCESS | 6350 | [#4] RayTrace Cycles:1 Average:1091.70 Median:1091.70 stddev:0.00 (0.0%) 04:23:56 INFO - PROCESS | 6350 | Values: 1091.7 04:23:56 INFO - PROCESS | 6350 | 04:23:56 INFO - PROCESS | 6350 | [#5] Earley Cycles:1 Average:761.61 Median:761.61 stddev:0.00 (0.0%) 04:23:56 INFO - PROCESS | 6350 | Values: 761.6 04:23:56 INFO - PROCESS | 6350 | 04:23:56 INFO - PROCESS | 6350 | [#6] Boyer Cycles:1 Average:12525.00 Median:12525.00 stddev:0.00 (0.0%) 04:23:56 INFO - PROCESS | 6350 | Values: 12525.0 04:23:56 INFO - PROCESS | 6350 | 04:23:56 INFO - PROCESS | 6350 | [#7] RegExp Cycles:1 Average:41180.00 Median:41180.00 stddev:0.00 (0.0%) 04:23:56 INFO - PROCESS | 6350 | Values: 41180.0 04:23:56 INFO - PROCESS | 6350 | 04:23:56 INFO - PROCESS | 6350 | [#8] Splay Cycles:1 Average:574.38 Median:574.38 stddev:0.00 (0.0%) 04:23:56 INFO - PROCESS | 6350 | Values: 574.4 04:23:56 INFO - PROCESS | 6350 | 04:23:56 INFO - PROCESS | 6350 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 04:23:56 INFO - PROCESS | 6350 | Values: 4822.1 04:23:56 INFO - PROCESS | 6350 | -------- Summary: end -------- 04:23:56 INFO - PROCESS | 6350 | 04:23:57 INFO - TEST-INFO | 6350: exit 0 04:23:57 INFO - TEST-OK | v8_7 | took 41088ms 04:23:57 INFO - SUITE-END | took 1211s 04:23:57 INFO - Completed test suite (00:20:11) 04:23:57 INFO - Working with test: dromaeo_css 04:23:57 INFO - Generating results file: dromaeo_css 04:23:57 INFO - Working with test: kraken 04:23:57 INFO - Generating results file: kraken 04:23:57 INFO - javascript benchmark 04:23:57 INFO - Working with test: v8_7 04:23:57 INFO - Generating results file: v8_7 04:23:57 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:23:57 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 04:23:57 INFO - process_Request line: dromaeo_css 6948.74 graph.html#tests=[[72,63,43]] 04:23:57 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:23:57 INFO - process_Request line: kraken 1517.10 graph.html#tests=[[232,63,43]] 04:23:57 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:23:58 INFO - process_Request line: v8_7 20253.05 graph.html#tests=[[230,63,43]] 04:23:58 INFO - RETURN: dromaeo_css: 6948.74 04:23:58 INFO - RETURN: kraken: 1517.10 04:23:58 INFO - RETURN: v8_7: 20253.05 04:23:58 INFO - javascript benchmark 04:23:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3234.547163397124, 3244.789088709232, 3267.1342094344986, 3277.3445310937805, 3300.3399320135964, 5209.453007434222, 5375.623706340548, 5376.973115134424, 5388.515033646971, 5392.2181283713835, 5276.762545685444, 5395.460453954603, 5418.943306055321, 5451.236826844245, 5454.972725136378, 4819.301201325806, 4904.190808516591, 4959.925601115986, 4970.105381031431, 5020.623453241022, 4996.825111121111, 4997.675151115184, 5061.16490779021, 5064.392272927235, 5068.265101560271, 4802.23164293713, 4892.437369702494, 4922.064807686528, 5014.949850501484, 5027.195648696191, 4909.116359055369, 4911.386076740408, 4930.383702037246, 4936.580390666798, 4983.8504844854715, 4724.71651700899, 4895.143349913751, 4907.092187945206, 4924.261360795874, 4930.482299358551, 5132.461091585405, 5217.452167522393, 5240.947590524084, 5247.842564723064, 5269.683818970874, 5862.706864656793, 5896.262967129109, 5899.852503687399, 5901.793437229677, 5913.2608423947, 5645.237892884449, 5728.369879313273, 5905.2323197984415, 5908.261467316585, 5914.881702365971, 5350.411454739976, 5416.702081385522, 5421.078416669176, 5437.157240627709, 5479.0, 5849.766009359578, 5853.122031695195, 5858.238429004202, 5860.2381690380835, 5860.706964651836, 5502.9174562381595, 5589.329280486368, 5639.830805075854, 5663.178839068312, 5765.221695071195, 5737.225474560881, 5748.0, 5761.6254943429385, 5776.711164441761, 5800.651960882361, 5757.424257574209, 5762.9135562966585, 5795.565332599987, 5801.6519008859605, 5812.011957967071, 5560.443955604407, 5683.147527870769, 5787.450192231731, 5826.980278451254, 5911.083782013795, 4511.458624964959, 4514.503404625489, 4523.276275795857, 4530.071335376306, 4558.49856515783, 4002.8799136025964, 4013.0569316210667, 4015.3575427931974, 4064.9593504065174, 4077.6330130287824, 5275.868103297448, 5376.274202982548, 5485.314335708036, 5497.697626630494, 5502.449755024546, 5860.062390017577, 5922.318933322636, 5924.674142922181, 5924.881502369928, 5929.318128415288, 5211.478852114758, 5462.699551524624, 5464.644798088111, 5509.283793106871, 5519.116941289374, 4787.904241915142, 4843.491433399513, 4882.145624515695, 4883.487233840467, 4923.01539692063, 6064.120702498113, 6071.787487437919, 6072.696365181723, 6076.605020673642, 6080.969595152084, 5531.032069387921, 5713.428657134254, 5839.182514447895, 5848.912266316093, 5885.676287804212, 5937.34689184198, 6019.668918209365, 6065.059915713072, 6067.54493412987, 6070.453659170696, 5593.07714227148, 5605.299337582802, 5620.8032718856275, 5650.547956163415, 5651.321841378896, 5620.409856965123, 5736.6558006519745, 5749.91375129365, 5759.39526349744, 5792.1311803229855, 5556.91664625039, 5557.472040156179, 5594.608377413542, 5603.523700485342, 5640.182173584725, 5709.771609135754, 5726.370099289158, 5761.135829625589, 5765.7117144141785, 5766.221560089334, 5321.733913304397, 5432.239486471976, 5610.747516361692, 5641.8589535261945, 5660.094384898561, 5495.53287970527, 5534.501894829485, 5560.91658625129, 5590.161475778503, 5611.607187496836, 5578.386377498391, 5599.776008959596, 5631.493165615114, 5639.464250896158, 5653.067243904874], "unit": "score", "name": "dojo.html", "value": 5336.910465412035}, {"lowerIsBetter": false, "replicates": [543.5271313956856, 551.2090150633841, 565.476933836202, 570.1732487892557, 572.0418299348592, 34165.0, 34730.0, 34849.12877178072, 34984.475232871526, 35032.2993540129, 38211.61788382122, 38396.0, 38743.612563874354, 38770.0, 38792.0, 8556.358273129525, 8683.826323473526, 8702.695405660803, 8718.607662655195, 8733.912660873406, 8539.188777066169, 8610.182032706884, 8659.437136586133, 8681.782955426102, 8689.217970382664, 8622.31021518277, 8740.257078148365, 8753.737387878375, 8753.949526056851, 8766.167214114681, 8581.570921453902, 8659.177378149066, 8681.869771953427, 8682.26200772932, 8690.08754080825, 8438.831223375559, 8656.437331573428, 8662.696805611773, 8668.089850565726, 8685.478871267744, 38404.80797596022, 38941.80529097365, 38964.415533767016, 39223.0, 39283.607163928566, 3184.2039490127468, 3188.7289580385695, 3249.414956252122, 3347.297067615804, 3847.9230415391535, 28639.570406443712, 29020.27449313784, 29147.708522914712, 29244.853775731197, 29451.852740736373, 3852.7880966546827, 3953.8007520110964, 3986.740861844, 3991.920161596781, 4057.127717540743, 197823.0, 198164.0, 199320.0, 200176.0, 200218.0, 55423.722881385336, 55722.0, 55745.0, 55752.0, 55837.720811396495, 66034.0, 67046.0, 67155.0, 67164.0, 67513.32486675169, 13618.659533511543, 13679.794803077963, 13714.24571648549, 13740.587782366545, 13770.449182032808, 10545.0, 10622.628208012682, 10657.413842238597, 10667.83998240027, 10669.19981001428, 19711.211551538065, 19867.60264794696, 19931.701024484646, 20112.59774804496, 20575.794242057687, 7869.134395216522, 8011.959940200379, 8014.879776803353, 8022.879656805153, 8152.470089444168, 963.4123184857232, 1028.6091285311534, 1121.315997241682, 1128.2102528230107, 1150.2868221702597, 28056.43887122287, 28143.155705328463, 28722.712772872004, 28795.42409151847, 28859.0, 1049.9002594753485, 1070.5182667799522, 1076.311160857052, 1147.3804145761362, 1157.8494795676509, 14824.703505930036, 14868.62828429298, 14907.254637268094, 14949.70100597982, 15052.967849340417, 329521.0, 329598.0, 330735.0, 332188.0, 334521.0, 50496.49503504918, 50722.746386267834, 51121.233181502306, 51190.74404627953, 51224.0, 1312.4881296294452, 1323.7551053055215, 1328.8671132886634, 1335.9265240411871, 1343.7715588350004, 26658.466830663667, 27863.86068069728, 27959.440811184068, 28328.85835570809, 28545.28636784097, 44921.55078449174, 45128.77435612801, 45467.54532454633, 45532.77233613811, 45550.77224613856, 311004.0, 312459.0, 312812.0, 314076.0, 314296.0, 31902.0, 41485.58514414817, 42956.0, 43063.784681076395, 43141.352879707454, 44509.33236001398, 46187.0, 46317.305240422094, 46432.07135857332, 46956.530434696586, 33676.0, 34859.47710784391, 35395.941106247104, 35499.0, 35821.1044723884, 35545.0, 35788.28423431569, 36095.45856812097, 36267.637323626426, 36360.0, 34390.0, 35055.47416788801, 35540.0, 35542.0, 35650.0, 30501.694983050773, 31771.523427149074, 32037.359252814345, 32200.677993219768, 32452.35095298128, 24446.755532444447, 24730.876345618155, 24903.875480623206, 24959.500809983336, 25418.872905635355], "unit": "score", "name": "ext.html", "value": 18308.321346366192}, {"lowerIsBetter": false, "replicates": [370.78752479392386, 371.34643028270256, 372.194199557957, 375.4593385524843, 377.9773213607182, 15567.221638918052, 16660.333586656536, 16772.496825095266, 17407.564810879736, 17441.04074275914, 11040.944795276033, 11437.542498300058, 14887.18120503372, 14923.104613723184, 14953.102813831178, 4965.106280869451, 5227.111391063529, 5557.5831812614015, 5570.805021824237, 5575.0522411189995, 5063.139266324715, 5444.237806707044, 5462.121893455651, 5472.808451704191, 5480.91778623321, 5337.2527846101575, 5359.598030147735, 5361.973190134064, 5408.8377348679605, 5604.047311956977, 5317.533272051457, 5556.91664625031, 5573.972130139324, 5580.358258800249, 5673.035583950697, 5440.646357986758, 5441.972790136064, 5466.835994920159, 5467.343918729738, 5480.3971563128025, 12399.75200495994, 12445.066620003536, 12544.620091789895, 12554.623361299176, 12599.433025513783, 2096.6540520814046, 2104.5790841831695, 2124.076026928291, 2144.7747986461354, 2151.2900742754855, 9434.716958491188, 9484.33609647325, 9534.0, 9867.950660246725, 9917.107460328605, 1799.2533098763997, 1801.2074687137617, 1819.5269230000295, 1871.8221768932067, 1885.1422602715732, 54685.179722304194, 54881.45118548803, 55989.0, 56509.71745141248, 56932.71533642347, 9968.80062398748, 10197.18422526196, 10289.176865850714, 10290.948545257226, 10343.60361351223, 13264.270465124511, 13420.0, 13424.530141445002, 13460.93269533646, 13468.595942121752, 7164.426845852319, 7166.856662866818, 7447.478676492702, 7460.589667568227, 7490.962545187239, 7043.119610048744, 7056.435485161175, 7098.716051357991, 7101.325374089453, 7107.786766396913, 4373.737575745466, 4495.9325610115875, 4500.279955207151, 4502.4371953505815, 4515.300128480091, 1851.4075495841203, 1879.8778079424794, 1896.2604584212168, 1905.4378958207362, 1906.9904650476935, 875.0942774228643, 911.2709832134266, 958.0993865766158, 961.1829944547079, 1015.5886865819355, 14648.780268295985, 15090.698186036218, 16640.0, 16659.500214993568, 17084.91457542729, 908.2506931781174, 913.5340976102103, 933.4725879877848, 946.8059047895165, 1004.3070281505737, 9640.0, 9769.31614786958, 9780.168685661656, 9798.363106398205, 9832.655857044969, 495932.0, 503394.0, 507913.0, 508107.9189208061, 511453.0, 68247.0, 71662.2833771666, 71754.64122679354, 72469.6376518114, 74168.25831741614, 1100.7743412600398, 1109.4951796932376, 1148.3052753084264, 1161.349644199251, 1162.953481860716, 14133.646658833612, 14534.709305814036, 14562.635934101732, 14961.925190373979, 15025.699486010437, 29595.112146635634, 30701.846490767402, 30860.69139308668, 30866.53700194544, 31383.529247061768, 38772.80613597027, 40726.38910416287, 40974.385384218665, 40988.1802363957, 41357.1728565433, 7221.53060051095, 7483.775486735407, 7579.5073320234005, 7595.734149304748, 7718.884216736866, 9957.253206009433, 11173.385463799244, 11428.828567571327, 11491.48288327044, 11894.940525297317, 7225.783226503213, 7421.578783027809, 7755.844883102193, 9579.808403831745, 9726.610935562781, 4207.969047583361, 7013.211631034053, 9561.282903782105, 9568.76078098053, 9976.301658884098, 9865.901340986786, 10016.549255283675, 10115.544800483849, 10135.49322533885, 10353.4305613192, 7289.744858929912, 7619.619019049136, 7762.262585054411, 7792.415568832474, 7811.765647030598, 8947.910520894708, 9496.667616633385, 9772.462514561767, 9829.803403932025, 9905.653302134679], "unit": "score", "name": "jquery.html", "value": 7965.954072253297}, {"lowerIsBetter": false, "replicates": [1467.8238611366635, 1482.3774014913736, 1656.7183578791605, 1795.7216631422134, 1830.3959693301204, 7816.648250828712, 7865.252800983897, 7940.444168908171, 8015.438919275646, 8124.553149576771, 8045.597720113986, 8112.553809540473, 8159.10249872515, 8173.305269052123, 8186.140455252202, 2423.72127205371, 2451.1298489036403, 2453.153661986612, 2459.1270099114827, 2466.6793316868784, 2288.9198878039274, 2311.364374796936, 2316.884155792212, 2316.93049208524, 2399.4361325088676, 2029.4419034765483, 2072.4715197624587, 2244.438890277431, 2316.779905908936, 2338.754430784769, 2338.7193536775612, 2344.765523447659, 2348.976510234893, 2359.5634807560655, 2361.551305252005, 2285.1887579909057, 2374.03851440167, 2375.2161786610377, 2386.7135943686694, 2387.9880600596885, 7839.725609603636, 7869.488483248628, 7906.090799558067, 7906.248906353887, 7910.841783164362, 4866.537678920532, 4927.162382395001, 4972.254161875711, 4983.825566105169, 5003.249512573143, 3126.6873312668777, 3181.459151944152, 3258.3483303339426, 3258.885938992124, 3311.403947289487, 1076.3057827701168, 1090.2095980414215, 1104.8729396119468, 1107.374333501569, 1137.1925932587872, 11259.774804503946, 11310.491027903765, 11325.150613703923, 11341.489632966453, 11359.091272698248, 4365.3670217818235, 4433.8669839904205, 4438.201123797683, 4487.371767952489, 4497.302918047708, 8709.562922117779, 8786.824263514694, 8804.075572064969, 8813.294936405073, 8830.0, 4917.409910810726, 4922.237053256751, 4939.1109600271575, 4951.90096198074, 4956.306117143603, 4522.615577675869, 4538.478075021415, 4540.273556231054, 4576.4508259009135, 4587.839425620087, 3566.661167189113, 3615.7830530168276, 3636.4181730922924, 3644.435112557505, 3671.687906527975, 1109.3343993603935, 1109.5561775289948, 1111.855458790352, 1114.4984756859446, 1131.6095946898306, 1043.1133536494071, 1047.8585390972273, 1075.8440026196158, 1184.4729095552568, 1332.666833291677, 7318.96340518294, 7357.0803649543805, 7372.889406658905, 7393.334599886036, 7399.223081576464, 1103.4813637590319, 1119.4067144413473, 1140.9674244808461, 1142.9142814288962, 1148.8506494155706, 5809.970950145223, 5840.445157710095, 5893.616914900518, 5905.143754155623, 5941.049432090845, 9089.909100908906, 9382.953085234667, 9498.430094194371, 9588.328816982883, 9646.083622055894, 9210.309226808016, 9286.257099432165, 9344.906550934404, 9349.672761453316, 9412.576434060484, 7293.562386256947, 7370.0, 7380.926190738024, 7435.628218589049, 7456.888146677696, 7275.163356214103, 7294.890576641461, 7314.4514161439165, 7342.5227360221415, 7355.816104597214, 8033.799155021171, 8182.22268884455, 8305.044919834296, 8390.119037500974, 8434.156584341763, 8309.740227487258, 8686.82626347482, 8718.17177368149, 8741.0, 8748.47509149453, 7554.320111190019, 7610.391168706601, 7707.768766937001, 7792.10390805042, 7796.961015194887, 7797.7660670179985, 7833.529988200727, 7857.607119643881, 7864.331531819631, 7886.72396466121, 6791.93208067913, 7168.89246661311, 7320.450966177452, 7342.0, 7557.962210189134, 7016.368861676871, 7117.572945623279, 7146.142462904485, 7161.606111663908, 7198.316159964795, 7329.9267007329245, 7353.338199562065, 7357.484976051625, 7359.116905971104, 7384.298491643285, 6733.562318449285, 6750.898736518858, 6755.392014718699, 6770.356816102462, 6773.729050838108, 6560.147180866456, 6650.401463868275, 6686.264510903894, 6701.597904125768, 6737.629430381376], "unit": "score", "name": "mootools.html", "value": 4614.849951563807}, {"lowerIsBetter": false, "replicates": [331.5822064199109, 345.19397207520444, 355.9466080087988, 356.0884136610278, 357.27829783836665, 6217.906731399033, 6249.468795152412, 6275.905861412082, 6348.301686814447, 6469.57947733397, 6199.473044791187, 6294.150289710888, 6348.206474190726, 6350.523710721691, 6388.77639282624, 4757.381540399743, 4764.761761911908, 4778.068276686039, 4786.617070634341, 4789.712617242976, 4773.284007398901, 4773.451053128882, 4782.1153086678905, 4796.040791841629, 4796.44840843304, 4644.6516511261625, 4738.218193998004, 4740.217864052427, 4743.051389722053, 4753.85738427846, 4716.834910778106, 4724.40944881888, 4732.550407711262, 4733.715977041388, 4747.477777444478, 4069.674426045909, 4101.179764047202, 4107.363358679409, 4115.938260926088, 4130.380442933554, 5944.464998150144, 5944.554158438091, 5987.922174008677, 5995.411216027713, 6002.309734380515, 5378.310844577712, 5540.529055030287, 5542.91685624716, 5550.417206193332, 5557.638753481011, 6617.106690596756, 6661.800145995628, 6668.499862510331, 6676.198856137246, 6685.231198412148, 4557.430321209848, 4572.199865023607, 4572.565606267399, 4585.014221942299, 4586.472555656109, 6790.898136527956, 6900.654967251618, 6908.585484870924, 6980.895286570705, 6986.54587451814, 4648.465426475931, 4686.179918514246, 4687.460941991646, 4696.03731235096, 4703.270992996091, 4752.334673145762, 4758.595519380822, 4759.690620109682, 4765.594924431392, 4766.380370551806, 5452.536534394541, 5488.396276409591, 5511.3937466878615, 5526.889462210734, 5531.059719847635, 6586.85927073703, 6607.174103237096, 6688.598684078874, 6707.6981535831, 6712.463002959751, 1659.8174200837898, 1688.3162319260719, 1708.8376604222578, 1713.4773893962213, 1713.8628909687195, 1180.710725872167, 1187.5071845184152, 1193.4271549656214, 1198.6224339333257, 1201.0631707268344, 6227.09707092469, 6265.8746825063245, 6273.780417685359, 6282.403171698681, 6292.559520833498, 6750.459963202932, 6783.932160678429, 6797.966010169917, 6799.150106236721, 6801.557898736566, 5958.582899197015, 6109.602875813147, 6123.38766123393, 6128.509719222451, 6134.018557030943, 3658.7804731716183, 3678.9264214715554, 3687.2994131115, 3690.8708195213576, 3703.092742278159, 7081.0, 7084.43324534036, 7084.645767711594, 7089.184743754431, 7096.751613693599, 6723.831904202336, 6942.93057069433, 6962.338577835098, 6965.442764578822, 6973.442124630017, 6855.5543889647015, 6884.449244060564, 6925.307469253135, 6935.653217339213, 7093.716251349992, 6775.356341147583, 6799.286074962256, 6806.65966701653, 6829.93170068293, 6850.45196384298, 6556.082148499309, 6701.530892837454, 6706.497012724163, 6738.898916516158, 6750.223724271772, 7035.788926332219, 7057.50597458173, 7066.364027237573, 7077.5399599025895, 7095.503314767917, 4787.497312782108, 4821.63837712166, 4821.831235906727, 4846.224604063333, 4848.32123502717, 6688.0, 6765.458763299022, 6792.490563207878, 6823.795286141423, 6951.304869513008, 6695.899561506484, 6747.730090796509, 6750.9873518972545, 6751.797446076625, 6754.696038678173, 6660.933390666031, 6720.294369091175, 6729.596224226562, 6731.562448440835, 6732.192136943598, 6471.2234531856475, 6605.801825945229, 6686.933130668631, 6703.597784132968, 6711.832204194934, 6843.452523798183, 6861.519693621399, 6870.519063665495, 6879.380855723009, 6889.3455121765355, 6588.341165883373, 6606.8017959461295, 6624.9337506624315, 6630.701618427279, 6639.867202656016], "unit": "score", "name": "prototype.html", "value": 5010.875432350188}, {"lowerIsBetter": false, "replicates": [773.7872085176576, 808.1352952340994, 821.5974172655401, 841.1084250694261, 854.6923107681233, 13380.531681391154, 13473.258970756604, 13556.93221533891, 13642.658933526654, 13669.521566745178, 12372.443240054197, 13159.210447373165, 13168.73662526749, 13189.604311870635, 13243.536476223335, 784.2784638132918, 798.8442253760519, 799.5083023940293, 800.3877034068913, 800.8038030682491, 817.5952903312868, 820.819419727662, 826.1903334731966, 831.1231650608605, 831.1231650608636, 840.6133178737788, 841.4951029382353, 842.5787106446777, 842.6503001254472, 846.7163500227431, 838.3628442383771, 842.0064324097593, 842.4818736477023, 842.4818736477084, 844.4806444036903, 630.4074170279922, 631.2992578238152, 631.7094136697125, 631.8451979265063, 633.24959922492, 13529.0, 13556.118852274669, 13563.932180339134, 13564.593062208149, 13622.386992585358, 12359.32023738694, 12579.245245285312, 12705.132877676642, 12733.61799146027, 12756.553520626734, 10382.9480852596, 10407.843882341771, 10454.634087806966, 10500.474976251156, 10589.629362972337, 3607.1162565171703, 3677.4483827425834, 3682.963170368316, 3709.7774133552075, 3712.962870371289, 41731.37402938958, 42042.369364459555, 42165.0, 42302.788486057376, 42370.57629423728, 9335.646331281927, 9570.473623950611, 9577.425354478753, 9913.256505761952, 9950.950245248872, 16650.16749162537, 17205.56986075333, 17274.395396161075, 17342.219600118024, 17360.305587776347, 7337.41300695943, 7428.6285685716575, 7467.514611550232, 7499.437542184358, 7567.545947243183, 4147.564505726916, 4213.852515161954, 4214.557471465513, 4215.199112168678, 4250.914981700349, 3160.2573395252098, 3178.7139157475476, 3188.28263640679, 3188.649248582654, 3189.521571764254, 549.6042849148606, 552.6324993879025, 555.1507581277538, 563.8731285460821, 586.5190543754165, 513.5865628169284, 630.4105661206786, 650.8372906773307, 678.6776281266359, 679.4055201698513, 8851.911480885237, 8967.282617390592, 9003.324750643596, 9052.954735226282, 9240.7689807754, 592.3720855892767, 647.8930976388843, 671.7245929169018, 677.7600031894635, 680.2585182151479, 4047.170330082385, 4282.186384586918, 4305.56944305567, 4392.736435813861, 4416.3596278539435, 53542.0, 53871.46128538664, 53934.46065539294, 54311.45688543143, 54416.72791636016, 48359.516404836206, 48528.7573562137, 48603.0, 48782.26826597604, 48896.5110348892, 43534.7823260888, 44716.10567788626, 44731.0, 45051.09897802026, 45144.54855451403, 7938.56337901421, 8133.2680058794995, 8255.298299644597, 8277.255047045795, 8322.916770832215, 32015.35969280555, 32086.518702219953, 32093.358132836747, 32839.34321313513, 33386.0, 37928.431073533364, 38278.42582361322, 43619.345709813744, 43751.56248437475, 44268.7786561078, 10547.57809687604, 10596.947015265183, 10681.679549613524, 10814.89185108139, 10843.728906777395, 11825.172237943261, 11834.881651183377, 11885.94057029744, 12210.633680989584, 12506.937465312616, 11304.717382065513, 11566.074714023027, 11576.652700419001, 11630.709232268922, 11995.880041199476, 11271.0, 11588.826167607323, 11661.825072624088, 11873.82189267179, 11926.165168438127, 11515.827262591236, 11714.062874969812, 11762.294262344287, 11964.521419143137, 12015.158938874194, 9649.951750241486, 9702.75743106428, 9752.219822414048, 10012.69961901144, 10254.487275636338, 9219.262459003397, 9442.433453992782, 9631.229501639993, 10217.795644086927, 10450.529726162189], "unit": "score", "name": "yui.html", "value": 6253.9625012462975}], "name": "dromaeo_css", "value": 6948.743102132688}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 105.0, 110.0, 112.0, 112.0, 124.0, 111.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.0}, {"lowerIsBetter": true, "replicates": [156.0, 126.0, 153.0, 169.0, 127.0, 157.0, 163.0, 132.0, 168.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 147.7}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 164.0, 163.0, 163.0, 163.0, 164.0, 166.0, 175.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.7}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 72.0, 74.0, 73.0, 74.0, 169.0, 77.0, 77.0, 73.0], "unit": "score", "name": "audio-fft", "value": 83.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 140.0, 97.0, 97.0, 95.0, 144.0, 96.0, 96.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 110.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 148.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 97.0, 97.0, 102.0, 98.0], "unit": "score", "name": "imaging-desaturate", "value": 97.2}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 59.0, 60.0, 62.0, 61.0, 59.0, 62.0, 73.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 61.3}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 67.0, 68.0, 69.0, 69.0, 69.0, 70.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 83.0, 84.0, 84.0, 84.0, 89.0, 82.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [118.0, 130.0, 118.0, 121.0, 125.0, 118.0, 116.0, 121.0, 117.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.1}, {"lowerIsBetter": true, "replicates": [131.0, 144.0, 142.0, 148.0, 152.0, 148.0, 146.0, 142.0, 143.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.7}, {"lowerIsBetter": true, "replicates": [66.0, 70.0, 66.0, 67.0, 66.0, 67.0, 69.0, 66.0, 69.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1517.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.38935108153078], "unit": "score", "name": "Richards", "value": 212.16501999999997}, {"lowerIsBetter": false, "replicates": [188.5014137606032], "unit": "score", "name": "DeltaBlue", "value": 350.7559900000001}, {"lowerIsBetter": false, "replicates": [281.5315315315315], "unit": "score", "name": "Encrypt", "value": 945.4749119999998}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1091.703056768559], "unit": "score", "name": "RayTrace", "value": 677.8299240000001}, {"lowerIsBetter": false, "replicates": [761.6146230007616], "unit": "score", "name": "Earley", "value": 875.065919}, {"lowerIsBetter": false, "replicates": [12525.0], "unit": "score", "name": "Boyer", "value": 53.21061876247504}, {"lowerIsBetter": false, "replicates": [41180.0], "unit": "score", "name": "RegExp", "value": 22.12202525497815}, {"lowerIsBetter": false, "replicates": [574.3825387708214], "unit": "score", "name": "Splay", "value": 141.87583100000003}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 20253.046690506886}]} 04:23:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20253.05"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1517.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6948.74"}}} 04:23:58 INFO - Return code: 0 04:23:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:23:58 INFO - # TBPL SUCCESS # 04:23:58 INFO - Running post-action listener: _resource_record_post_action 04:23:58 INFO - Running post-run listener: _resource_record_post_run 04:23:59 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 553238528; Read time: 0; Write time: 632768 04:23:59 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237465600; Read time: 0; Write time: 372764 04:23:59 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 315772928; Read time: 0; Write time: 260004 04:23:59 INFO - Running post-run listener: _upload_blobber_files 04:23:59 INFO - Blob upload gear active. 04:23:59 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 04:23:59 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 04:23:59 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'] 04:23:59 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 04:23:59 INFO - (blobuploader) - INFO - Open directory for files ... 04:23:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:23:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:23:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:24:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:24:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:24:00 INFO - (blobuploader) - INFO - Done attempting. 04:24:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:24:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:24:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:24:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:24:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:24:01 INFO - (blobuploader) - INFO - Done attempting. 04:24:01 INFO - (blobuploader) - INFO - Iteration through files over. 04:24:01 INFO - Return code: 0 04:24:01 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 04:24:01 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 04:24:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a5bf3c677d6a11cbdaad03cde2fbc1b06d66520631d74f5615ba3436eb19b1a6c04c719e266c848a3ff9bd7bdba10b4e724fd67d42b94f58b7acdef837f7d00b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c2af868f230be40030778b4adabdfe918f3214fbd3c59d52f28723f6d915c68878eca460e020027546cf3028aea1b47bd710383b85049a7f04ae88f7bda784e1"} 04:24:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 04:24:01 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 04:24:01 INFO - Contents: 04:24:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a5bf3c677d6a11cbdaad03cde2fbc1b06d66520631d74f5615ba3436eb19b1a6c04c719e266c848a3ff9bd7bdba10b4e724fd67d42b94f58b7acdef837f7d00b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c2af868f230be40030778b4adabdfe918f3214fbd3c59d52f28723f6d915c68878eca460e020027546cf3028aea1b47bd710383b85049a7f04ae88f7bda784e1"} 04:24:01 INFO - Running post-run listener: copy_logs_to_upload_dir 04:24:01 INFO - Copying logs to upload dir... 04:24:01 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 04:24:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.113031 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-19 04:24:00.134898) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 04:24:00.138811) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781 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/a5bf3c677d6a11cbdaad03cde2fbc1b06d66520631d74f5615ba3436eb19b1a6c04c719e266c848a3ff9bd7bdba10b4e724fd67d42b94f58b7acdef837f7d00b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c2af868f230be40030778b4adabdfe918f3214fbd3c59d52f28723f6d915c68878eca460e020027546cf3028aea1b47bd710383b85049a7f04ae88f7bda784e1"} build_url:https://queue.taskcluster.net/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011354 build_url: 'https://queue.taskcluster.net/v1/task/P8QVQMyGQFuMKGmC-FWLkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a5bf3c677d6a11cbdaad03cde2fbc1b06d66520631d74f5615ba3436eb19b1a6c04c719e266c848a3ff9bd7bdba10b4e724fd67d42b94f58b7acdef837f7d00b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c2af868f230be40030778b4adabdfe918f3214fbd3c59d52f28723f6d915c68878eca460e020027546cf3028aea1b47bd710383b85049a7f04ae88f7bda784e1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 04:24:00.163226) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 04:24:00.163558) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1453202786.468520-1747917781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 04:24:00.248279) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 04:24:00.248601) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 04:24:00.248891) ========= ========= Total master_lag: 0.31 =========