builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-016 starttime: 1453150876.47 results: success (0) buildid: 20160118103105 builduid: e6294eb8b89845dcb5fdad691f9b6d22 revision: 1f3dd3fe9116c56a70ea718c0814c36d100e8aea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-18 13:01:16.472728) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-18 13:01:16.473195) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-18 13:01:16.473487) ========= 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=00204705a9daa57ed339a427000001b9-1453146570.951696-721542639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006308 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-18 13:01:16.497045) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-18 13:01:16.497357) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-18 13:01:16.519880) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 13:01:16.520188) ========= 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=00204705a9daa57ed339a427000001b9-1453146570.951696-721542639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004594 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 13:01:16.569179) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-18 13:01:16.569448) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-18 13:01:16.569805) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 13:01:16.570083) ========= 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=00204705a9daa57ed339a427000001b9-1453146570.951696-721542639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-18 13:01:17-- 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% 83.4M=0s 2016-01-18 13:01:17 (83.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162935 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 13:01:16.745051) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 13:01:16.745328) ========= 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=00204705a9daa57ed339a427000001b9-1453146570.951696-721542639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018282 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 13:01:16.796664) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 13:01:16.796977) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1f3dd3fe9116c56a70ea718c0814c36d100e8aea --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 1f3dd3fe9116c56a70ea718c0814c36d100e8aea --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=00204705a9daa57ed339a427000001b9-1453146570.951696-721542639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-18 13:01:17,488 truncating revision to first 12 chars 2016-01-18 13:01:17,489 Setting DEBUG logging. 2016-01-18 13:01:17,489 attempt 1/10 2016-01-18 13:01:17,489 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/1f3dd3fe9116?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-18 13:01:17,766 unpacking tar archive at: mozilla-inbound-1f3dd3fe9116/testing/mozharness/ program finished with exit code 0 elapsedTime=0.590868 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 13:01:17.400374) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-18 13:01:17.400682) ========= 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=00204705a9daa57ed339a427000001b9-1453146570.951696-721542639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.003942 script_repo_revision: '%(revision)s' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-18 13:01:17.449168) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-18 13:01:17.449455) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-18 13:01:17.460373) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-18 13:01:17.460661) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-18 13:01:17.461057) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-18 13:01:17.461341) ========= /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=00204705a9daa57ed339a427000001b9-1453146570.951696-721542639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:01:18 INFO - MultiFileLogger online at 20160118 13:01:18 in /builds/slave/test-pgo 13:01:18 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 13:01:18 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:01:18 INFO - {'append_to_log': False, 13:01:18 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:01:18 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:01:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:01:18 INFO - 'branch': 'Mozilla-Inbound', 13:01:18 INFO - 'buildbot_json_path': 'buildprops.json', 13:01:18 INFO - 'config_files': ('talos/linux_config.py',), 13:01:18 INFO - 'default_actions': ('clobber', 13:01:18 INFO - 'read-buildbot-config', 13:01:18 INFO - 'download-and-extract', 13:01:18 INFO - 'populate-webroot', 13:01:18 INFO - 'create-virtualenv', 13:01:18 INFO - 'install', 13:01:18 INFO - 'run-tests'), 13:01:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:01:18 INFO - 'download_minidump_stackwalk': True, 13:01:18 INFO - 'download_symbols': 'ondemand', 13:01:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:01:18 INFO - 'tooltool.py': '/tools/tooltool.py', 13:01:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:01:18 INFO - '/tools/misc-python/virtualenv.py')}, 13:01:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:01:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:01:18 INFO - 'installer_path': 'installer.exe', 13:01:18 INFO - 'log_level': 'info', 13:01:18 INFO - 'log_name': 'talos', 13:01:18 INFO - 'log_to_console': True, 13:01:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:01:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:01:18 INFO - 'opt_config_files': (), 13:01:18 INFO - 'pip_index': False, 13:01:18 INFO - 'sps_profile': False, 13:01:18 INFO - 'sps_profile_interval': 0, 13:01:18 INFO - 'suite': 'dromaeojs-e10s', 13:01:18 INFO - 'system_bits': '32', 13:01:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:01:18 INFO - 'title': 'talos-linux64-ix-016', 13:01:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:01:18 INFO - 'use_talos_json': True, 13:01:18 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:01:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:01:18 INFO - 'work_dir': 'build'} 13:01:18 INFO - ##### 13:01:18 INFO - ##### Running clobber step. 13:01:18 INFO - ##### 13:01:18 INFO - Running pre-action listener: _resource_record_pre_action 13:01:18 INFO - Running main action method: clobber 13:01:18 INFO - rmtree: /builds/slave/test-pgo/build 13:01:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:01:18 INFO - Running post-action listener: _resource_record_post_action 13:01:18 INFO - ##### 13:01:18 INFO - ##### Running read-buildbot-config step. 13:01:18 INFO - ##### 13:01:18 INFO - Running pre-action listener: _resource_record_pre_action 13:01:18 INFO - Running main action method: read_buildbot_config 13:01:18 INFO - Using buildbot properties: 13:01:18 INFO - { 13:01:18 INFO - "project": "", 13:01:18 INFO - "product": "firefox", 13:01:18 INFO - "script_repo_revision": "production", 13:01:18 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 13:01:18 INFO - "repository": "", 13:01:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 13:01:18 INFO - "buildid": "20160118103105", 13:01:18 INFO - "pgo_build": "True", 13:01:18 INFO - "basedir": "/builds/slave/test-pgo", 13:01:18 INFO - "buildnumber": 261, 13:01:18 INFO - "slavename": "talos-linux64-ix-016", 13:01:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:01:18 INFO - "platform": "ubuntu64_hw", 13:01:18 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 13:01:18 INFO - "branch": "mozilla-inbound", 13:01:18 INFO - "repo_path": "integration/mozilla-inbound", 13:01:18 INFO - "revision": "1f3dd3fe9116c56a70ea718c0814c36d100e8aea", 13:01:18 INFO - "stage_platform": "linux64-pgo", 13:01:18 INFO - "builduid": "e6294eb8b89845dcb5fdad691f9b6d22", 13:01:18 INFO - "slavebuilddir": "test" 13:01:18 INFO - } 13:01:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/C4HSFKp9T122lhx5QOWxqQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 13:01:18 INFO - Running post-action listener: _resource_record_post_action 13:01:18 INFO - ##### 13:01:18 INFO - ##### Running download-and-extract step. 13:01:18 INFO - ##### 13:01:18 INFO - Running pre-action listener: _resource_record_pre_action 13:01:18 INFO - Running main action method: download_and_extract 13:01:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:01:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:01:18 INFO - https://queue.taskcluster.net/v1/task/C4HSFKp9T122lhx5QOWxqQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:01:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4HSFKp9T122lhx5QOWxqQ/artifacts/public/build/test_packages.json 13:01:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4HSFKp9T122lhx5QOWxqQ/artifacts/public/build/test_packages.json 13:01:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4HSFKp9T122lhx5QOWxqQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:01:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4HSFKp9T122lhx5QOWxqQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:01:23 INFO - Downloaded 1448 bytes. 13:01:23 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:01:23 INFO - Using the following test package requirements: 13:01:23 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:01:23 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:01:23 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:01:23 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:23 INFO - u'jsshell-linux-x86_64.zip'], 13:01:23 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:01:23 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:01:23 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:01:23 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:01:23 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:01:23 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:01:23 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:01:23 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:01: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')]} 13:01:23 INFO - https://queue.taskcluster.net/v1/task/C4HSFKp9T122lhx5QOWxqQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:01:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4HSFKp9T122lhx5QOWxqQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:01:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4HSFKp9T122lhx5QOWxqQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:01:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4HSFKp9T122lhx5QOWxqQ/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 13:01:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4HSFKp9T122lhx5QOWxqQ/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 13:01:34 INFO - Downloaded 22484333 bytes. 13:01:34 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'] 13:01:34 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 13:01:35 INFO - Return code: 0 13:01:35 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 13:01:35 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')]} 13:01:35 INFO - https://queue.taskcluster.net/v1/task/C4HSFKp9T122lhx5QOWxqQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:01:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4HSFKp9T122lhx5QOWxqQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:01:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4HSFKp9T122lhx5QOWxqQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:01:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4HSFKp9T122lhx5QOWxqQ/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 13:01:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4HSFKp9T122lhx5QOWxqQ/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 13:01:37 INFO - Downloaded 22484333 bytes. 13:01:37 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'] 13:01:37 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 13:01:39 INFO - Return code: 0 13:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:01:39 INFO - https://queue.taskcluster.net/v1/task/C4HSFKp9T122lhx5QOWxqQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:01:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4HSFKp9T122lhx5QOWxqQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:01:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4HSFKp9T122lhx5QOWxqQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:01:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4HSFKp9T122lhx5QOWxqQ/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 13:01:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4HSFKp9T122lhx5QOWxqQ/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 13:01:41 INFO - Downloaded 11132144 bytes. 13:01:41 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'] 13:01:41 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 13:01:41 INFO - Return code: 0 13:01: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')]} 13:01:41 INFO - https://queue.taskcluster.net/v1/task/C4HSFKp9T122lhx5QOWxqQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:01:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4HSFKp9T122lhx5QOWxqQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:01:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4HSFKp9T122lhx5QOWxqQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:01:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4HSFKp9T122lhx5QOWxqQ/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 13:01:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4HSFKp9T122lhx5QOWxqQ/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 13:01:45 INFO - Downloaded 55947279 bytes. 13:01:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C4HSFKp9T122lhx5QOWxqQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:01:45 INFO - mkdir: /builds/slave/test-pgo/properties 13:01:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:01:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:01:45 INFO - Contents: 13:01:45 INFO - build_url:https://queue.taskcluster.net/v1/task/C4HSFKp9T122lhx5QOWxqQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:01:45 INFO - Running post-action listener: _resource_record_post_action 13:01:45 INFO - Running post-action listener: set_extra_try_arguments 13:01:45 INFO - ##### 13:01:45 INFO - ##### Running populate-webroot step. 13:01:45 INFO - ##### 13:01:45 INFO - Running pre-action listener: _resource_record_pre_action 13:01:45 INFO - Running main action method: populate_webroot 13:01:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:01:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:01:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:01:45 INFO - '--tppagecycles', 13:01:45 INFO - '7'], 13:01:45 INFO - 'tests': ['tsvgm']}}, 13:01:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:01:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:01:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:01:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:01:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:01:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:01:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:01:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:45 INFO - 'talos_options': ['--e10s'], 13:01:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:01:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:45 INFO - 'tests': ['damp', 'tps']}, 13:01:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:45 INFO - 'talos_options': ['--e10s'], 13:01:45 INFO - 'tests': ['damp', 'tps']}, 13:01:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:01:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:01:45 INFO - 'other': {'tests': ['a11yr', 13:01:45 INFO - 'ts_paint', 13:01:45 INFO - 'tpaint', 13:01:45 INFO - 'sessionrestore', 13:01:45 INFO - 'sessionrestore_no_auto_restore']}, 13:01:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:01:45 INFO - 'tests': ['a11yr', 13:01:45 INFO - 'ts_paint', 13:01:45 INFO - 'tpaint', 13:01:45 INFO - 'sessionrestore', 13:01:45 INFO - 'sessionrestore_no_auto_restore']}, 13:01:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:01:45 INFO - 'tests': ['a11yr', 13:01:45 INFO - 'ts_paint', 13:01:45 INFO - 'tpaint', 13:01:45 INFO - 'sessionrestore', 13:01:45 INFO - 'sessionrestore_no_auto_restore']}, 13:01:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:01:45 INFO - 'tests': ['a11yr', 13:01:45 INFO - 'ts_paint', 13:01:45 INFO - 'tpaint', 13:01:45 INFO - 'sessionrestore', 13:01:45 INFO - 'sessionrestore_no_auto_restore']}, 13:01:45 INFO - 'other_l64': {'tests': ['a11yr', 13:01:45 INFO - 'ts_paint', 13:01:45 INFO - 'tpaint', 13:01:45 INFO - 'sessionrestore', 13:01:45 INFO - 'sessionrestore_no_auto_restore']}, 13:01:45 INFO - 'other_nol64': {'tests': ['a11yr', 13:01:45 INFO - 'ts_paint', 13:01:45 INFO - 'tpaint', 13:01:45 INFO - 'sessionrestore', 13:01:45 INFO - 'sessionrestore_no_auto_restore']}, 13:01:45 INFO - 'svgr': {'tests': ['tsvgx', 13:01:45 INFO - 'tsvgr_opacity', 13:01:45 INFO - 'tart', 13:01:45 INFO - 'tscrollx', 13:01:45 INFO - 'cart']}, 13:01:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:01:45 INFO - 'tests': ['tsvgx', 13:01:45 INFO - 'tsvgr_opacity', 13:01:45 INFO - 'tart', 13:01:45 INFO - 'tscrollx', 13:01:45 INFO - 'cart']}, 13:01:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:45 INFO - 'tests': ['tp5o']}, 13:01:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:45 INFO - 'talos_options': ['--e10s'], 13:01:45 INFO - 'tests': ['tp5o']}, 13:01:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:45 INFO - 'talos_options': ['--xperf_path', 13:01:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:01:45 INFO - 'tests': ['tp5n']}, 13:01:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:45 INFO - 'talos_options': ['--e10s', 13:01:45 INFO - '--xperf_path', 13:01:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:01:45 INFO - 'tests': ['tp5n']}}, 13:01:45 INFO - 'talos.zip': {'path': '', 13:01:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:01:45 INFO - Running post-action listener: _resource_record_post_action 13:01:45 INFO - ##### 13:01:45 INFO - ##### Running create-virtualenv step. 13:01:45 INFO - ##### 13:01:45 INFO - Running pre-action listener: _resource_record_pre_action 13:01:45 INFO - Running main action method: create_virtualenv 13:01:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:01:45 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 13:01:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:01:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:01:45 INFO - Using real prefix '/usr' 13:01:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:01:45 INFO - Installing distribute.............................................................................................................................................................................................done. 13:01:47 INFO - Installing pip.................done. 13:01:47 INFO - Return code: 0 13:01:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:01:47 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')]} 13:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:47 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')]} 13:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:47 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 0x7f3f51aa2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266a7f0>, '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 0x25d62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d6760>, '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': '00204705a9daa57ed339a427000001b9-1453146570.951696-721542639', '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 13:01:47 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 13:01:47 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 13:01:47 INFO - Using env: {'DISPLAY': ':0', 13:01:47 INFO - 'HOME': '/home/cltbld', 13:01:47 INFO - 'LANG': 'en_US.UTF-8', 13:01:47 INFO - 'LANGUAGE': 'en_US:en', 13:01:47 INFO - 'LOGNAME': 'cltbld', 13:01:47 INFO - 'MAIL': '/var/mail/cltbld', 13:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:47 INFO - 'MOZ_NO_REMOTE': '1', 13:01:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:47 INFO - 'NO_EM_RESTART': '1', 13:01:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:01:47 INFO - 'PWD': '/builds/slave/test-pgo', 13:01:47 INFO - 'SHELL': '/bin/bash', 13:01:47 INFO - 'SHLVL': '1', 13:01:47 INFO - 'TERM': 'linux', 13:01:47 INFO - 'TMOUT': '86400', 13:01:47 INFO - 'USER': 'cltbld', 13:01:47 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453146570.951696-721542639', 13:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:47 INFO - '_': '/tools/buildbot/bin/python'} 13:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:47 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 13:01:47 INFO - Cleaning up... 13:01:47 INFO - Return code: 0 13:01:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:01:47 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')]} 13:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:47 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')]} 13:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:47 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 0x7f3f51aa2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266a7f0>, '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 0x25d62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d6760>, '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': '00204705a9daa57ed339a427000001b9-1453146570.951696-721542639', '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 13:01:47 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 13:01:47 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 13:01:47 INFO - Using env: {'DISPLAY': ':0', 13:01:47 INFO - 'HOME': '/home/cltbld', 13:01:47 INFO - 'LANG': 'en_US.UTF-8', 13:01:47 INFO - 'LANGUAGE': 'en_US:en', 13:01:47 INFO - 'LOGNAME': 'cltbld', 13:01:47 INFO - 'MAIL': '/var/mail/cltbld', 13:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:47 INFO - 'MOZ_NO_REMOTE': '1', 13:01:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:47 INFO - 'NO_EM_RESTART': '1', 13:01:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:01:47 INFO - 'PWD': '/builds/slave/test-pgo', 13:01:47 INFO - 'SHELL': '/bin/bash', 13:01:47 INFO - 'SHLVL': '1', 13:01:47 INFO - 'TERM': 'linux', 13:01:47 INFO - 'TMOUT': '86400', 13:01:47 INFO - 'USER': 'cltbld', 13:01:47 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453146570.951696-721542639', 13:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:47 INFO - '_': '/tools/buildbot/bin/python'} 13:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:48 INFO - Downloading/unpacking psutil>=0.7.1 13:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:49 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 13:01:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:01:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:01:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:01:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:01:49 INFO - Installing collected packages: psutil 13:01:49 INFO - Running setup.py install for psutil 13:01:50 INFO - building 'psutil._psutil_linux' extension 13:01:50 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 13:01:50 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 13:01:50 INFO - building 'psutil._psutil_posix' extension 13:01:50 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 13:01:50 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 13:01:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:01:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:01:50 INFO - Successfully installed psutil 13:01:50 INFO - Cleaning up... 13:01:50 INFO - Return code: 0 13:01:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:01:50 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')]} 13:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:50 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')]} 13:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:50 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 0x7f3f51aa2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266a7f0>, '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 0x25d62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d6760>, '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': '00204705a9daa57ed339a427000001b9-1453146570.951696-721542639', '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 13:01:50 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 13:01:50 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 13:01:50 INFO - Using env: {'DISPLAY': ':0', 13:01:50 INFO - 'HOME': '/home/cltbld', 13:01:50 INFO - 'LANG': 'en_US.UTF-8', 13:01:50 INFO - 'LANGUAGE': 'en_US:en', 13:01:50 INFO - 'LOGNAME': 'cltbld', 13:01:50 INFO - 'MAIL': '/var/mail/cltbld', 13:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:50 INFO - 'MOZ_NO_REMOTE': '1', 13:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:50 INFO - 'NO_EM_RESTART': '1', 13:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:01:50 INFO - 'PWD': '/builds/slave/test-pgo', 13:01:50 INFO - 'SHELL': '/bin/bash', 13:01:50 INFO - 'SHLVL': '1', 13:01:50 INFO - 'TERM': 'linux', 13:01:50 INFO - 'TMOUT': '86400', 13:01:50 INFO - 'USER': 'cltbld', 13:01:50 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453146570.951696-721542639', 13:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:50 INFO - '_': '/tools/buildbot/bin/python'} 13:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:01:50 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 13:01:50 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 13:01:50 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 13:01:50 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 13:01:50 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 13:01:50 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 13:01:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:01:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:01:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:01:52 INFO - Installing collected packages: mozsystemmonitor 13:01:52 INFO - Running setup.py install for mozsystemmonitor 13:01:52 INFO - Successfully installed mozsystemmonitor 13:01:52 INFO - Cleaning up... 13:01:52 INFO - Return code: 0 13:01:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3f51aa2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266a7f0>, '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 0x25d62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d6760>, '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': '00204705a9daa57ed339a427000001b9-1453146570.951696-721542639', '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 13:01:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 13:01:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:01:52 INFO - Using env: {'DISPLAY': ':0', 13:01:52 INFO - 'HOME': '/home/cltbld', 13:01:52 INFO - 'LANG': 'en_US.UTF-8', 13:01:52 INFO - 'LANGUAGE': 'en_US:en', 13:01:52 INFO - 'LOGNAME': 'cltbld', 13:01:52 INFO - 'MAIL': '/var/mail/cltbld', 13:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:52 INFO - 'MOZ_NO_REMOTE': '1', 13:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:52 INFO - 'NO_EM_RESTART': '1', 13:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:01:52 INFO - 'PWD': '/builds/slave/test-pgo', 13:01:52 INFO - 'SHELL': '/bin/bash', 13:01:52 INFO - 'SHLVL': '1', 13:01:52 INFO - 'TERM': 'linux', 13:01:52 INFO - 'TMOUT': '86400', 13:01:52 INFO - 'USER': 'cltbld', 13:01:52 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453146570.951696-721542639', 13:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:52 INFO - '_': '/tools/buildbot/bin/python'} 13:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:52 INFO - Downloading/unpacking blobuploader==1.2.4 13:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:54 INFO - Downloading blobuploader-1.2.4.tar.gz 13:01:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:01:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:01:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:01:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:01:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:01:55 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 13:01:55 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 13:01:55 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 13:01:55 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 13:01:55 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 13:01:55 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 13:01:55 INFO - Downloading docopt-0.6.1.tar.gz 13:01:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:01:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:01:55 INFO - Installing collected packages: blobuploader, requests, docopt 13:01:55 INFO - Running setup.py install for blobuploader 13:01:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:01:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:01:55 INFO - Running setup.py install for requests 13:01:55 INFO - Running setup.py install for docopt 13:01:55 INFO - Successfully installed blobuploader requests docopt 13:01:55 INFO - Cleaning up... 13:01:55 INFO - Return code: 0 13:01:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:55 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 0x7f3f51aa2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266a7f0>, '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 0x25d62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d6760>, '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': '00204705a9daa57ed339a427000001b9-1453146570.951696-721542639', '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 13:01:55 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 13:01:55 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 13:01:55 INFO - Using env: {'DISPLAY': ':0', 13:01:55 INFO - 'HOME': '/home/cltbld', 13:01:55 INFO - 'LANG': 'en_US.UTF-8', 13:01:55 INFO - 'LANGUAGE': 'en_US:en', 13:01:55 INFO - 'LOGNAME': 'cltbld', 13:01:55 INFO - 'MAIL': '/var/mail/cltbld', 13:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:55 INFO - 'MOZ_NO_REMOTE': '1', 13:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:55 INFO - 'NO_EM_RESTART': '1', 13:01:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:01:55 INFO - 'PWD': '/builds/slave/test-pgo', 13:01:55 INFO - 'SHELL': '/bin/bash', 13:01:55 INFO - 'SHLVL': '1', 13:01:55 INFO - 'TERM': 'linux', 13:01:55 INFO - 'TMOUT': '86400', 13:01:55 INFO - 'USER': 'cltbld', 13:01:55 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453146570.951696-721542639', 13:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:55 INFO - '_': '/tools/buildbot/bin/python'} 13:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:01:56 INFO - Running setup.py (path:/tmp/pip-XLABqx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:01:56 INFO - Running setup.py (path:/tmp/pip-dWl0jX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:01:56 INFO - Running setup.py (path:/tmp/pip-5Tb4YC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:01:56 INFO - Running setup.py (path:/tmp/pip-o4uSPm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:01:56 INFO - Running setup.py (path:/tmp/pip-vwmNjV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:01:56 INFO - Running setup.py (path:/tmp/pip-Jtrfkc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:01:56 INFO - Running setup.py (path:/tmp/pip-JXXEEh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:01:56 INFO - Running setup.py (path:/tmp/pip-MOlkN4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:01:56 INFO - Running setup.py (path:/tmp/pip-ccLO6Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:01:56 INFO - Running setup.py (path:/tmp/pip-ZpMvuM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:01:56 INFO - Running setup.py (path:/tmp/pip-kj3HWx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:01:56 INFO - Running setup.py (path:/tmp/pip-SiCiRE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:01:56 INFO - Running setup.py (path:/tmp/pip-srUjZK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:01:57 INFO - Running setup.py (path:/tmp/pip-Io02Um-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:01:57 INFO - Running setup.py (path:/tmp/pip-2pgLUW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:01:57 INFO - Running setup.py (path:/tmp/pip-gHtbg5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:01:57 INFO - Running setup.py (path:/tmp/pip-EOxC53-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:01:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:01:57 INFO - Running setup.py install for manifestparser 13:01:57 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:01:57 INFO - Running setup.py install for mozcrash 13:01:57 INFO - Running setup.py install for mozdebug 13:01:57 INFO - Running setup.py install for mozdevice 13:01:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:01:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:01:57 INFO - Running setup.py install for mozfile 13:01:57 INFO - Running setup.py install for mozhttpd 13:01:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:01:57 INFO - Running setup.py install for mozinfo 13:01:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:01:58 INFO - Running setup.py install for mozInstall 13:01:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:01:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:01:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:01:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:01:58 INFO - Running setup.py install for mozleak 13:01:58 INFO - Running setup.py install for mozlog 13:01:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:01:58 INFO - Running setup.py install for moznetwork 13:01:58 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:01:58 INFO - Running setup.py install for mozprocess 13:01:58 INFO - Running setup.py install for mozprofile 13:01:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:01:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:01:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:01:58 INFO - Running setup.py install for mozrunner 13:01:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:01:58 INFO - Running setup.py install for mozscreenshot 13:01:58 INFO - Running setup.py install for moztest 13:01:58 INFO - Running setup.py install for mozversion 13:01:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:01:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:01:59 INFO - Cleaning up... 13:01:59 INFO - Return code: 0 13:01:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:01: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')]} 13:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01: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')]} 13:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:59 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 0x7f3f51aa2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266a7f0>, '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 0x25d62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d6760>, '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': '00204705a9daa57ed339a427000001b9-1453146570.951696-721542639', '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 13:01:59 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 13:01:59 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 13:01:59 INFO - Using env: {'DISPLAY': ':0', 13:01:59 INFO - 'HOME': '/home/cltbld', 13:01:59 INFO - 'LANG': 'en_US.UTF-8', 13:01:59 INFO - 'LANGUAGE': 'en_US:en', 13:01:59 INFO - 'LOGNAME': 'cltbld', 13:01:59 INFO - 'MAIL': '/var/mail/cltbld', 13:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:59 INFO - 'MOZ_NO_REMOTE': '1', 13:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:59 INFO - 'NO_EM_RESTART': '1', 13:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:01:59 INFO - 'PWD': '/builds/slave/test-pgo', 13:01:59 INFO - 'SHELL': '/bin/bash', 13:01:59 INFO - 'SHLVL': '1', 13:01:59 INFO - 'TERM': 'linux', 13:01:59 INFO - 'TMOUT': '86400', 13:01:59 INFO - 'USER': 'cltbld', 13:01:59 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453146570.951696-721542639', 13:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:59 INFO - '_': '/tools/buildbot/bin/python'} 13:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:01:59 INFO - Running setup.py (path:/tmp/pip-KYi4ep-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:01:59 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)) 13:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:01:59 INFO - Running setup.py (path:/tmp/pip-ucJiPw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:01:59 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)) 13:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:01:59 INFO - Running setup.py (path:/tmp/pip-tfpUKd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:01:59 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)) 13:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:01:59 INFO - Running setup.py (path:/tmp/pip-WG63p4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:01:59 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)) 13:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:01:59 INFO - Running setup.py (path:/tmp/pip-JPTl7W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:01:59 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)) 13:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:01:59 INFO - Running setup.py (path:/tmp/pip-M9kh4v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:01:59 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)) 13:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:01:59 INFO - Running setup.py (path:/tmp/pip-ElH0dG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:01:59 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)) 13:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:01:59 INFO - Running setup.py (path:/tmp/pip-xw1Mb1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:01:59 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)) 13:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:01:59 INFO - Running setup.py (path:/tmp/pip-4W7wDK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:01:59 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)) 13:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:01:59 INFO - Running setup.py (path:/tmp/pip-lX6Zv0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:02:00 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)) 13:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:02:00 INFO - Running setup.py (path:/tmp/pip-oYpHB7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:02:00 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)) 13:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:02:00 INFO - Running setup.py (path:/tmp/pip-mctJrX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:02:00 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)) 13:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:02:00 INFO - Running setup.py (path:/tmp/pip-s2RQ8D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:02:00 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)) 13:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:02:00 INFO - Running setup.py (path:/tmp/pip-I7vPIu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:02:00 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)) 13:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:02:00 INFO - Running setup.py (path:/tmp/pip-8WCxDC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:02:00 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)) 13:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:02:00 INFO - Running setup.py (path:/tmp/pip-vCzf7n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:02:00 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)) 13:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:02:00 INFO - Running setup.py (path:/tmp/pip-rAX0sy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:02:00 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)) 13:02:00 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)) 13:02:00 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)) 13:02:00 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)) 13:02:00 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)) 13:02:00 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)) 13:02:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:02 INFO - Downloading blessings-1.5.1.tar.gz 13:02:02 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 13:02:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:02:02 INFO - Installing collected packages: blessings 13:02:02 INFO - Running setup.py install for blessings 13:02:02 INFO - Successfully installed blessings 13:02:02 INFO - Cleaning up... 13:02:02 INFO - Return code: 0 13:02:02 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:02:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:02:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:02:02 INFO - Reading from file tmpfile_stdout 13:02:02 INFO - Current package versions: 13:02:02 INFO - argparse == 1.2.1 13:02:02 INFO - blessings == 1.5.1 13:02:02 INFO - blobuploader == 1.2.4 13:02:02 INFO - docopt == 0.6.1 13:02:02 INFO - manifestparser == 1.1 13:02:02 INFO - mozInstall == 1.12 13:02:02 INFO - mozcrash == 0.16 13:02:02 INFO - mozdebug == 0.1 13:02:02 INFO - mozdevice == 0.48 13:02:02 INFO - mozfile == 1.2 13:02:02 INFO - mozhttpd == 0.7 13:02:02 INFO - mozinfo == 0.9 13:02:02 INFO - mozleak == 0.1 13:02:02 INFO - mozlog == 3.1 13:02:02 INFO - moznetwork == 0.27 13:02:02 INFO - mozprocess == 0.22 13:02:02 INFO - mozprofile == 0.28 13:02:02 INFO - mozrunner == 6.11 13:02:02 INFO - mozscreenshot == 0.1 13:02:02 INFO - mozsystemmonitor == 0.0 13:02:02 INFO - moztest == 0.7 13:02:02 INFO - mozversion == 1.4 13:02:02 INFO - psutil == 3.1.1 13:02:02 INFO - requests == 1.2.3 13:02:02 INFO - wsgiref == 0.1.2 13:02:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:02: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')]} 13:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02: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')]} 13:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:02 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 0x7f3f51aa2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266a7f0>, '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 0x25d62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d6760>, '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': '00204705a9daa57ed339a427000001b9-1453146570.951696-721542639', '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 13:02:02 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 13:02:02 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 13:02:02 INFO - Using env: {'DISPLAY': ':0', 13:02:02 INFO - 'HOME': '/home/cltbld', 13:02:02 INFO - 'LANG': 'en_US.UTF-8', 13:02:02 INFO - 'LANGUAGE': 'en_US:en', 13:02:02 INFO - 'LOGNAME': 'cltbld', 13:02:02 INFO - 'MAIL': '/var/mail/cltbld', 13:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:02 INFO - 'MOZ_NO_REMOTE': '1', 13:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:02 INFO - 'NO_EM_RESTART': '1', 13:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:02:02 INFO - 'PWD': '/builds/slave/test-pgo', 13:02:02 INFO - 'SHELL': '/bin/bash', 13:02:02 INFO - 'SHLVL': '1', 13:02:02 INFO - 'TERM': 'linux', 13:02:02 INFO - 'TMOUT': '86400', 13:02:02 INFO - 'USER': 'cltbld', 13:02:02 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453146570.951696-721542639', 13:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:02 INFO - '_': '/tools/buildbot/bin/python'} 13:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:02 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)) 13:02:02 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)) 13:02:02 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)) 13:02:02 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)) 13:02:02 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)) 13:02:02 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)) 13:02:02 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)) 13:02:02 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)) 13:02:02 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)) 13:02:02 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)) 13:02:02 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)) 13:02:02 INFO - Cleaning up... 13:02:02 INFO - Return code: 0 13:02:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:02: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')]} 13:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02: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')]} 13:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:02 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 0x7f3f51aa2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266a7f0>, '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 0x25d62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d6760>, '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': '00204705a9daa57ed339a427000001b9-1453146570.951696-721542639', '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 13:02:02 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 13:02:02 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 13:02:02 INFO - Using env: {'DISPLAY': ':0', 13:02:02 INFO - 'HOME': '/home/cltbld', 13:02:02 INFO - 'LANG': 'en_US.UTF-8', 13:02:02 INFO - 'LANGUAGE': 'en_US:en', 13:02:02 INFO - 'LOGNAME': 'cltbld', 13:02:02 INFO - 'MAIL': '/var/mail/cltbld', 13:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:02 INFO - 'MOZ_NO_REMOTE': '1', 13:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:02 INFO - 'NO_EM_RESTART': '1', 13:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:02:02 INFO - 'PWD': '/builds/slave/test-pgo', 13:02:02 INFO - 'SHELL': '/bin/bash', 13:02:02 INFO - 'SHLVL': '1', 13:02:02 INFO - 'TERM': 'linux', 13:02:02 INFO - 'TMOUT': '86400', 13:02:02 INFO - 'USER': 'cltbld', 13:02:02 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453146570.951696-721542639', 13:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:02 INFO - '_': '/tools/buildbot/bin/python'} 13:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:03 INFO - Downloading/unpacking jsonschema 13:02:03 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 13:02:03 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 13:02:03 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 13:02:03 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 13:02:03 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 13:02:03 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 13:02:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:02:04 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 13:02:04 INFO - Downloading/unpacking functools32 (from jsonschema) 13:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:05 INFO - Downloading functools32-3.2.3-2.tar.gz 13:02:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:02:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:02:05 INFO - warning: no files found matching '*.txt' 13:02:05 INFO - no previously-included directories found matching 'build' 13:02:05 INFO - no previously-included directories found matching 'dist' 13:02:05 INFO - no previously-included directories found matching '.git*' 13:02:05 INFO - Installing collected packages: jsonschema, functools32 13:02:05 INFO - Running setup.py install for functools32 13:02:05 INFO - warning: no files found matching '*.txt' 13:02:05 INFO - no previously-included directories found matching 'build' 13:02:05 INFO - no previously-included directories found matching 'dist' 13:02:05 INFO - no previously-included directories found matching '.git*' 13:02:05 INFO - Successfully installed jsonschema functools32 13:02:05 INFO - Cleaning up... 13:02:05 INFO - Return code: 0 13:02:05 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:02:05 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')]} 13:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:05 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')]} 13:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:05 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 0x7f3f51aa2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266a7f0>, '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 0x25d62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d6760>, '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': '00204705a9daa57ed339a427000001b9-1453146570.951696-721542639', '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 13:02:05 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 13:02:05 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 13:02:05 INFO - Using env: {'DISPLAY': ':0', 13:02:05 INFO - 'HOME': '/home/cltbld', 13:02:05 INFO - 'LANG': 'en_US.UTF-8', 13:02:05 INFO - 'LANGUAGE': 'en_US:en', 13:02:05 INFO - 'LOGNAME': 'cltbld', 13:02:05 INFO - 'MAIL': '/var/mail/cltbld', 13:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:05 INFO - 'MOZ_NO_REMOTE': '1', 13:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:05 INFO - 'NO_EM_RESTART': '1', 13:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:02:05 INFO - 'PWD': '/builds/slave/test-pgo', 13:02:05 INFO - 'SHELL': '/bin/bash', 13:02:05 INFO - 'SHLVL': '1', 13:02:05 INFO - 'TERM': 'linux', 13:02:05 INFO - 'TMOUT': '86400', 13:02:05 INFO - 'USER': 'cltbld', 13:02:05 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453146570.951696-721542639', 13:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:05 INFO - '_': '/tools/buildbot/bin/python'} 13:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:05 INFO - Downloading/unpacking flake8 13:02:05 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 13:02:05 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 13:02:05 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 13:02:05 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 13:02:05 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 13:02:05 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 13:02:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:02:07 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 13:02:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:02:07 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 13:02:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:07 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 13:02:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:02:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:02:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:02:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:02:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:02:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:02:07 INFO - no previously-included directories found matching 'docs/_build' 13:02:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:02:08 INFO - Running setup.py install for pep8 13:02:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:02:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:02:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:02:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:02:08 INFO - no previously-included directories found matching 'docs/_build' 13:02:08 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:02:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:02:08 INFO - Cleaning up... 13:02:08 INFO - Return code: 0 13:02:08 INFO - Running post-action listener: _resource_record_post_action 13:02:08 INFO - Running post-action listener: _start_resource_monitoring 13:02:08 INFO - Starting resource monitoring. 13:02:08 INFO - ##### 13:02:08 INFO - ##### Running install step. 13:02:08 INFO - ##### 13:02:08 INFO - Running pre-action listener: _resource_record_pre_action 13:02:08 INFO - Running main action method: install 13:02:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:02:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:02:08 INFO - Reading from file tmpfile_stdout 13:02:08 INFO - Detecting whether we're running mozinstall >=1.0... 13:02:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:02:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:02:08 INFO - Reading from file tmpfile_stdout 13:02:08 INFO - Output received: 13:02:08 INFO - Usage: mozinstall [options] installer 13:02:08 INFO - Options: 13:02:08 INFO - -h, --help show this help message and exit 13:02:08 INFO - -d DEST, --destination=DEST 13:02:08 INFO - Directory to install application into. [default: 13:02:08 INFO - "/builds/slave/test-pgo"] 13:02:08 INFO - --app=APP Application being installed. [default: firefox] 13:02:08 INFO - mkdir: /builds/slave/test-pgo/build/application 13:02:08 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'] 13:02:08 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 13:02:24 INFO - Reading from file tmpfile_stdout 13:02:24 INFO - Output received: 13:02:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:02:24 INFO - Running post-action listener: _resource_record_post_action 13:02:24 INFO - ##### 13:02:24 INFO - ##### Running run-tests step. 13:02:24 INFO - ##### 13:02:24 INFO - Running pre-action listener: _resource_record_pre_action 13:02:24 INFO - Running main action method: run_tests 13:02:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:02:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:02:24 INFO - Python 2.7.3 13:02:24 INFO - Return code: 0 13:02:24 INFO - grabbing minidump binary from tooltool 13:02:24 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')]} 13:02:24 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 0x266a7f0>, '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 0x25d62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d6760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:02:24 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 13:02:24 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 13:02:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:02:24 INFO - Return code: 0 13:02:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:02:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:02:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:02:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:02:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:02:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:02:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:02:25 INFO - Return code: 0 13:02:25 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/C4HSFKp9T122lhx5QOWxqQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 13:02:25 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/C4HSFKp9T122lhx5QOWxqQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 13:02:25 INFO - Using env: {'DISPLAY': ':0', 13:02:25 INFO - 'HOME': '/home/cltbld', 13:02:25 INFO - 'LANG': 'en_US.UTF-8', 13:02:25 INFO - 'LANGUAGE': 'en_US:en', 13:02:25 INFO - 'LOGNAME': 'cltbld', 13:02:25 INFO - 'MAIL': '/var/mail/cltbld', 13:02:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:02:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:25 INFO - 'MOZ_NO_REMOTE': '1', 13:02:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:02:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:25 INFO - 'NO_EM_RESTART': '1', 13:02:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:02:25 INFO - 'PWD': '/builds/slave/test-pgo', 13:02:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:02:25 INFO - 'SHELL': '/bin/bash', 13:02:25 INFO - 'SHLVL': '1', 13:02:25 INFO - 'TERM': 'linux', 13:02:25 INFO - 'TMOUT': '86400', 13:02:25 INFO - 'USER': 'cltbld', 13:02:25 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453146570.951696-721542639', 13:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:25 INFO - '_': '/tools/buildbot/bin/python'} 13:02:25 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/C4HSFKp9T122lhx5QOWxqQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 13:02:25 INFO - mozversion application_buildid: 20160118103105 13:02:25 INFO - mozversion application_changeset: 1f3dd3fe9116c56a70ea718c0814c36d100e8aea 13:02:25 INFO - mozversion application_display_name: Nightly 13:02:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:02:25 INFO - mozversion application_name: Firefox 13:02:25 INFO - mozversion application_remotingname: firefox 13:02:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:02:25 INFO - mozversion application_vendor: Mozilla 13:02:25 INFO - mozversion application_version: 46.0a1 13:02:25 INFO - mozversion platform_buildid: 20160118103105 13:02:25 INFO - mozversion platform_changeset: 1f3dd3fe9116c56a70ea718c0814c36d100e8aea 13:02:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:02:25 INFO - mozversion platform_version: 46.0a1 13:02:25 INFO - using testdate: 1453150945 13:02:25 INFO - actual date: 1453150945 13:02:25 INFO - starting webserver on 'localhost:40352' 13:02:25 INFO - SUITE-START | Running 3 tests 13:02:25 INFO - TEST-START | dromaeo_css 13:02:25 INFO - operating with platform_type : linux_ 13:02:25 INFO - Initialising browser for dromaeo_css test... 13:02:25 INFO - TEST-INFO | started process 30499 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpS0e90G/profile http://localhost:40352/getInfo.html) 13:02:29 INFO - PROCESS | 30499 | -- checkerboarding starts below -- 13:02:29 INFO - PROCESS | 30499 | RENDERTRACE 0.037874 rect red 0 0 1024 768 // viewport 13:02:29 INFO - PROCESS | 30499 | RENDERTRACE 287.086 rect brown 0 0 1024 768 // page 13:02:29 INFO - PROCESS | 30499 | RENDERTRACE 287.118 rect lightgreen 0 0 1024 768 // painted displayport (this layertree updated) 13:02:29 INFO - PROCESS | 30499 | Checkerboarded for 1 frames (300.543 ms), 786432 peak, 11951 severity. 13:02:29 INFO - PROCESS | 30499 | 13:02:29 INFO - PROCESS | 30499 | (process:30581): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:02:30 INFO - PROCESS | 30499 | __metrics Screen width/height:1600/1200 13:02:30 INFO - PROCESS | 30499 | colorDepth:24 13:02:30 INFO - PROCESS | 30499 | Browser inner width/height: 1024/697 13:02:30 INFO - PROCESS | 30499 | __metrics 13:02:30 INFO - PROCESS | 30499 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:02:31 INFO - TEST-INFO | 30499: exit 0 13:02:31 INFO - Browser initialized. 13:02:31 INFO - Running cycle 1/1 for dromaeo_css test... 13:02:31 INFO - TEST-INFO | started process 30629 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpS0e90G/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:02:31 INFO - PROCESS | 30629 | -- checkerboarding starts below -- 13:02:31 INFO - PROCESS | 30629 | RENDERTRACE 0.035746 rect red 0 0 10 10 // viewport 13:02:31 INFO - PROCESS | 30629 | RENDERTRACE 65.0717 rect brown 0 0 10 10 // page 13:02:31 INFO - PROCESS | 30629 | RENDERTRACE 65.0945 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 13:02:31 INFO - PROCESS | 30629 | Checkerboarded for 1 frames (66.3885 ms), 100 peak, 1 severity. 13:02:32 INFO - PROCESS | 30629 | 13:02:32 INFO - PROCESS | 30629 | (process:30686): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:02:42 INFO - PROCESS | 30629 | RSS: Main: 149737472 13:02:42 INFO - PROCESS | 30629 | 13:03:32 INFO - PROCESS | 30629 | 1453151012543 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] 13:05:41 INFO - PROCESS | 30629 | Cycle 1(1): loaded http://localhost:40352/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40352/tests/dromaeo/cssquery-ext.html) 13:05:42 INFO - PROCESS | 30629 | RSS: Main: 155254784 13:05:42 INFO - PROCESS | 30629 | 13:08:44 INFO - PROCESS | 30629 | Cycle 1(1): loaded http://localhost:40352/tests/dromaeo/cssquery-ext.html (next: http://localhost:40352/tests/dromaeo/cssquery-jquery.html) 13:08:44 INFO - PROCESS | 30629 | RSS: Main: 151298048 13:08:44 INFO - PROCESS | 30629 | 13:11:46 INFO - PROCESS | 30629 | Cycle 1(1): loaded http://localhost:40352/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40352/tests/dromaeo/cssquery-mootools.html) 13:11:47 INFO - PROCESS | 30629 | RSS: Main: 151379968 13:11:47 INFO - PROCESS | 30629 | 13:14:48 INFO - PROCESS | 30629 | Cycle 1(1): loaded http://localhost:40352/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40352/tests/dromaeo/cssquery-prototype.html) 13:14:49 INFO - PROCESS | 30629 | RSS: Main: 150859776 13:14:49 INFO - PROCESS | 30629 | 13:17:51 INFO - PROCESS | 30629 | Cycle 1(1): loaded http://localhost:40352/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40352/tests/dromaeo/cssquery-yui.html) 13:17:52 INFO - PROCESS | 30629 | RSS: Main: 151633920 13:17:52 INFO - PROCESS | 30629 | 13:20:54 INFO - PROCESS | 30629 | Cycle 1(1): loaded http://localhost:40352/tests/dromaeo/cssquery-yui.html (next: http://localhost:40352/tests/dromaeo/cssquery-dojo.html) 13:20:55 INFO - PROCESS | 30629 | RSS: Main: 153968640 13:20:55 INFO - PROCESS | 30629 | 13:20:55 INFO - PROCESS | 30629 | __start_tp_report 13:20:55 INFO - PROCESS | 30629 | _x_x_mozilla_page_load 13:20:55 INFO - PROCESS | 30629 | _x_x_mozilla_page_load_details 13:20:55 INFO - PROCESS | 30629 | |i|pagename|runs| 13:20:55 INFO - PROCESS | 30629 | |0;dojo.html;3183.1564635371615;3183.4906414973607;3211.807291562508;3220.710136087752;3226.2902161524457;5166;5234.136367499363;5275.419703832576;5279.63042587019;5285.471452854713;5239.502247286502;5394.730263486829;5396.838094857151;5416.593755468336;5507.504324610784;4852.175130227852;4877.658563900528;4908.993656300468;4962.15643340633;4965.404151501825;4884.023195360925;4889.462159162489;4934.235193544989;4948.158813001798;4949.678270912379;4729.361536192604;4806.206975848963;4881.316615673773;4942.678725882806;4950.777215025332;4801.591864691505;4802.639802014828;4805.159097158018;4836.153673107192;4869.853904382839;4783.736894470802;4821.397325334333;4821.517848215186;4824.155772739791;4858.805647774085;5192.247124167013;5240.68555886648;5268.209768534713;5295.761690723926;5308.787648494055;5759.395263497315;5771.653700777924;5776.133579963039;5778.191053252548;5778.59549831512;5752.137179423078;5778.913316300259;5782.826515204551;5791.189233507313;5848.122781582797;5463.2078348639625;5466.01611709892;5514.751836167382;5522.447755224526;5564.610477266593;5933.961556727555;5970.641761494324;5982.641041537521;5983.132445795422;6018.789342372996;5614.663120212718;5698.772049117989;5704.11586204139;5754.568407369464;5771.278590176228;5783.681897495594;5788.986927287792;5831.241938548046;5836.620619659709;5878.470937615635;5744.597878148489;5746.8793585251315;5806.912896306559;5810.593258471951;5813.302403711497;5667.1782591524;5713.171590119409;5739.913901291484;5760.84783043393;5795.594308398456;4456.24243878535;4464.2633965396;4465.910681786346;4479.059397526556;4498.527654596286;3975.3241948868763;3975.8012099394914;3985.1830374773103;4028.3957406389277;4042.110735638155;5205.29728486657;5306.124489459196;5322.787088516416;5372.059889519319;5379.78480860769;5658.179563963202;5698.31620205578;5725.799597014085;5749.971250143806;5761.942380576141;5236.24074509194;5256.737163141827;5281.551068159172;5290.164630642753;5342.412334643186;4898.093852637274;4930.6795058321095;4970.453250142481;4977.626677999165;5011.373578302712;5975.492083172979;5986.132010858489;5991;6005.279366476051;6008.729607167688;5542.69515176653;5617.691026993554;5765.971170144123;5779.988502012047;5789.218455508452;5915.231019967377;5926.259217597801;5930.584859059824;5963.194968679173;6011.128386383863;5668.404817494104;5730.684812335195;5741.368449470471;5759.856003599776;5761.078227483583;5696.458836410535;5777.768889244551;5804.1293805929445;5830.4461076197695;5846.766129354778;5433.782648694008;5473.343198816167;5661.688607126483;5742.397048309867;5788.797392091256;5677.943220567741;5696.544276457957;5702.401247868914;5710.457506536873;5718.056520674042;5429.158480435539;5591.356993945586;5600.327960644749;5612.747426365741;5617.32592088952;5584.748686309207;5633.8309850704545;5778.422157784188;5789.247397838254;5817.476427121579;5453.7545810439415;5518.42056584069;5522.723863806713;5529.917051244154;5531.115021596525 13:20:55 INFO - PROCESS | 30629 | |1;ext.html;543.8232574413315;547.2639300141309;560.1569637695269;567.4297331182162;568.4230506036374;34983.65016349836;35622.64377356225;35753;35812;35817.92546223614;37547.436788448125;37773.055673608105;38088;38161.61838381615;38179.80910095446;8491;8664.653413863438;8693.130686931288;8701.95649021754;8703.869441958375;8366.414350995403;8524.744257672248;8564.229219370256;8567.443116197459;8583.313334933222;8538.914610853904;8599.097094805049;8599.44103633265;8613.741587752378;8634.784130396727;8444.493330400164;8504.914950850536;8588.527630980325;8597.785055373603;8601.698940537051;8433.283170930417;8555.27280181179;8573.356998225096;8589.871151932726;8599.5700214989;35863.924082277576;36305.45541816875;36374.454383184275;36484;36516.63483365159;3329.433996220624;3495.0912762681887;3525.2596954639557;3580.283943211342;3764.73646844721;27981.860090699618;28556.71443285582;28786.424271514454;28791.42417151666;28850;3752.2870654575545;3778.452124441968;3900.843966241347;4014.959850401488;4023.054582173187;215441;219922;220171;220589;220742.9999999984;58882.70558647265;59272;59464.405355945884;59582.40417595855;59637.70181149067;61841.690791545756;62068.689656551425;62385.376146237955;62668.37331626716;71576;13190.60428187156;13193.934030329787;13290.800637990438;13299.401526931311;13302.334883255799;9951.651692190884;10033.494975753696;10037.096661300518;10038.146757525692;10043.548040338203;20647.483812904797;21721;21836.126554937942;21852.344429667137;21862.45343866416;8351.58242087893;8958.641654333753;9017.368784185175;9032.909670903338;9072.8639070414;996.4668902137322;1009.0010889219766;1013.761765984993;1034.4724190662666;1048.764028093688;28447.573286400722;28790.424191516053;29002.41995160085;29029;29323.120306390843;1045.033344156652;1052.2581579986092;1082.0207712020633;1131.5700033987198;1141;14983.850161498463;15138.470153544573;15175.089494630136;15325;15393.461228856937;616121;620432;620531;621815;623132;55040;55052.72473637686;55363;55468;55686.72156639191;1302.439950821137;1306.144475368635;1350.0077443079329;1368.6783605852618;1382.156884300576;29702.702972969993;30532.847335763177;30554.694453055185;30757.23106922345;30943.69056309498;46100.538994609626;46506.767466162455;46809.765951170026;46846.76576617095;47047.52952470432;284320;284681;286172.569137153;288078;288856;33123.83438082794;38410.80794596009;41236.58763412447;45233;45353.77323113364;37848.43227351537;41668.1666366677;42504;42744;42822;37074.81462592778;40406.1918761629;40472.595274046886;40991.385129222486;42965.570344297405;36368.636313636525;36509.45235821412;36597.81701091584;36629.81685091557;37085;34949;35748.28503429865;35826;35898.8205058973;35912.82043589765;30079.69920300769;32695.346093078482;32984;33133.66866331402;33351.83324083364;24743.257702268962;25085.122020729188;25206.405053675513;25297.241082767545;25350.619740704275 13:20:55 INFO - PROCESS | 30629 | |2;jquery.html;356.5382829236139;363.47840848382555;364.56434560699967;365.570454715709;368.55220906598475;15463.458778942739;16694.83305166948;16924.49226523203;17551.73672394915;18151.364702235423;11120.944395278033;11694;16333.18334083294;16431.753523697153;16458;4652.860414187571;4952.331435256248;4980.601551875841;4985.825496107637;4993.900121997558;4747.501512341206;4856.490068542787;4918.114739346916;4923.77842997066;4940.456549779521;4889.437714662824;4902.975485122587;5039.798408063673;5259.5529380002745;5262.05283049051;5163.922541161867;5202.2196670499725;5240.318758561381;5268.394134674504;5467.07059799831;5241.73791310433;5243.449437809013;5261.289725886994;5264.2893209416625;5264.8683782905355;13567.45730170792;18990.71513927292;19247.13387897548;19694.80305196944;19955.90022049895;2172.4568857785553;2207.3377986603955;2217.9001944912516;2265.8753768542724;2272.7272727272666;8904.643814247422;9296.39573427725;12673.239605623692;12819.679508012374;13104.148230364995;1748.5016770220427;1759.8504127149208;1817.6364727054643;1830.8809927354812;1871.56018335691;50686;51946;52424.99999999962;52527.737361312946;52948.73525632386;9644.710658680111;9779.706608801747;9949.104580587782;9969.80060398788;9980.301378903552;12713.682157945941;12741.936290318488;12743.36283185837;12749.107562470537;12751.553695620609;6681.064650948871;6695.631740254333;6748.93251067483;6829.4877884157895;6925.861482770317;6471.0940468334475;6519.380658837403;6581.76963806274;6601.075849381091;6610;4424.535423780521;4467.463904331436;4473.731576105444;4494.797734101973;4495.955040449619;1856.3502774029253;1857.3963461874944;1901.847852171823;1918.1080797428983;1937.0992488492918;909.1953621045423;932.5477143585356;934.1219253901311;956;963.8891527474431;15602.29789659468;16499.58751031234;16560.254788534545;16998.745018824728;17384.65230695379;861.875028120919;926.786839027014;948.6774496671165;953.8569214617863;1033.5297439664935;8786.60460279289;9159.49622770754;9351.672691455766;9920.801583968425;9923.305368624271;373711;379173;380631;528657;533530;63166.684166578874;67293;67864;68107.3189268101;68379;1108.3682301088302;1159.9014083802801;1169.4678921091054;1170.39724541861;1178.4225729392708;14459.927700361432;14625.561233163022;14993;15268.083914965138;15328.156951367782;21187.152513899888;24009.159679411136;27051.458970820866;32884.34231315312;34073;42914.35628465638;43179.78410107929;43182.13635727331;43222.567774321855;43401.34897976596;7046.577205367695;7307.3058059484265;7363.190049094703;7400.9866661381775;7438.995735575628;7988.800279993046;8216.876746848682;10740.355578664992;10923.632302199898;10979.066779323528;8901.287896968357;8992.59533320989;9521.095495927875;9560.665376711782;9615.086566776145;9577.473238971923;9618;9754.66941902706;9804.509774511389;9854.753631159278;3075.2465645916895;4776.808927642995;5728.7396772709935;6556.377144171296;8523.573821309034;6044.84887877789;7445.888311675221;7465.776026719207;7478.626068696434;7496.812579685334;8901.376903616685;9900.257480688833;9903.603855845686;9904.306698531034;9935.850962235716 13:20:55 INFO - PROCESS | 30629 | |3;mootools.html;1452;1473.270730988161;1613.2337139858569;1757.5430388099091;1789.6420715856832;7581.734639287626;7667.003289572354;7741.961290193555;7837.725679601215;7886.842263154734;7830.960845195766;7865.960670196641;7931.6827326907;7934.285914267714;7939.483933544316;2288.2220045184636;2323.163661082009;2323.453988312745;2330.778576035274;2332.2303639798824;2310.8151347892212;2317.9884100579475;2378.8929498172624;2381.7022872140983;2385;2302.7466978632337;2323.9658352033352;2327.5810354136247;2328.8253380996407;2344.3318654183563;2365.7042869641296;2388.785009349167;2391.976080239193;2396.1972739132325;2398.280515845257;2361.1381845626393;2382.4520360317224;2395.616701327779;2395.748446413119;2404.9398765030837;7588.468807183499;7639.350655194316;7641.579713115776;7643.235676432368;7655.846883062308;4707.9877826267175;4775.976120119377;4843.3219349290775;4862.878428039292;4898.069366820293;3164.715175634181;3187.3306605612847;3276.19733165376;3318.0377690469736;3318.0875259303643;1052.1109662335314;1053.6996955867542;1067.2571491267445;1089.54239219528;1098.1331736048749;10673;10834.241603087787;10854.945725271324;10858.185636077247;10867.51096200665;4363.694541382073;4391.429114215131;4445;4464.196444639931;4532.410786597721;9397.248220142372;9433.386829856037;9445.858312125323;9468.526573671288;9470.763230919145;4916.237983112624;4935.925961110586;4943.184374578226;4964.709175614294;4988.875278118004;4417.271150260171;4460.041091165415;4461.08547747711;4479.552044795494;4509.481409637868;3662.3957047087465;3663.432168013962;3705.2404257127223;3733.8506459741307;3739.2895349883433;1197.9580714674944;1225.748721512088;1234.3087870792206;1239.2874097394035;1240.3302216802826;993.8509223616371;1030.443560477334;1084.35480888871;1232.5008371609513;1369.7329020840841;7170.318819712119;7214.170370407471;7237.529560578546;7247.710091596383;7366.668499917517;1124.8425220469142;1130.7016072538565;1150.1776229995594;1177.935213563245;1181.704573856536;5925.851853703692;5958.165856780054;5967.6419414835245;5976.312724036705;5982.4017598239825;8881.37830351882;9071.909280907239;9078.137576930314;9097.226735727405;9476.289278304155;8963.372563920593;9009.909900900908;9086.636534538677;9135.31485138604;9138.268938484905;7174.246704095995;7249.673764680602;7370.078740157373;7400.444966627524;7435.1449583297535;7278.526895751759;7293.197748247582;7323.194448610755;7350.338469537767;7366.263373662591;8299;8450.366222533457;8457.83084338322;8546.401751877309;8609.65561377538;8513.40406171562;8794.868076978722;8810.779730506532;8838.602262898057;8923.107689231025;7199.856002879808;7455.329020388191;7464.888026679713;7483.438742094256;7519.285667861544;7414.332710056121;7501.887471688038;7512.248775122444;7515.511491753018;7539.962300188464;7023.719051238098;7196.6041867695685;7225.819354515969;7300.488965772345;7302.379297759538;6866.896996544956;6918.688659010256;6926.44588432914;7028.859422811617;7122.180949190702;7190.532615379983;7196.10048743907;7229.674664639999;7266.418686505172;7267.563946163247;6611.239707433707;6611.867762644816;6650.634215118215;6678.599284042973;6684.364985326386;6397;6503.707333170113;6508.153939987771;6523.543351965317;6523.836904077246 13:20:55 INFO - PROCESS | 30629 | |4;prototype.html;347.91128262293114;350.44979382369655;351.24657609427777;352.5821901047258;352.9728490093827;6129.816105516842;6175.783847565336;6254.155688981986;6295.150154729116;6334.746610135595;6038.57729958903;6240.812775616728;6257;6259.780907668232;6276.905846412307;4794.856154315367;4806.759662016902;4812.398450193726;4816;4825.565699087081;4807.78364973577;4809.470958194595;4817.0847538967655;4822.734749588772;4824.372831531896;4678.812847486097;4767.4755776864695;4775.832845850396;4777.235642297233;4788.970371370155;4778.1638213312535;4784.64115191362;4796.3524924135145;4803.711777293373;4808.374911261549;4211.05251318454;4225.514065882432;4231.915361692749;4242;4243.511996120455;5883.352831188566;5939.762409503614;5962.5528085393335;5976.491998180117;5976.61152025117;5426.077566813651;5582.162675598652;5599.580031497654;5605.579581531401;5618.438156184389;6606.372394622503;6619.735210591571;6623.4701223901975;6631.204255489324;6632;4689.343491911135;4700.788464519105;4704.6001089907395;4707.5763181313505;4719.292106184065;6768.39084482394;6932.48006399517;7001.649917504155;7027.227005029443;7043.471739619549;4700.788464519105;4711.340412342275;4718.159917632058;4718.598919091915;4718.646101542398;4751.714897106184;4756.809727610926;4778.450478195052;4778.832740854054;4779.545943135397;5523.7238138092935;5542.3626282977975;5544.417836127229;5547.55619550435;5547.861303467364;6525.641089740015;6715.56348837324;6735.461163106939;6735.797926062226;6742.49431292655;1673.7405702116191;1704.667589819998;1744.1628018551166;1746.1356628468989;1751.6671832352067;1142.702897246705;1177.670252329349;1189.7263629365295;1193.7194759231575;1194.1640851404052;6152.507799376039;6182.845428864224;6185.134081228632;6193.256809182837;6210.192674952317;6793.5244532882225;6873.48448866337;6875.724971001204;6883.483738719616;6899.6205208714;6075.787347442907;6182.227221597301;6184.072389141665;6194.721237544231;6197.411245931629;3679.5400574928135;3687.59436461989;3694.4088945769086;3697.90755231116;3699.9815000924823;7051.330123638246;7097.680604372816;7097.858042839114;7102.822429439202;7123.857522849514;6945.548539344926;6950.721971121199;6951.617661028591;6969.0940177776565;6996.790096297017;7187.892181617175;7256.492045556761;7271.454640901953;7280.235575264627;7287.854242915112;6915.792526224222;6917.89623155643;6938.653067346713;6939.653017349214;6948.965255173692;6748.662566871735;6777.322267773183;6845.247022827385;6889.724411023703;6900.137482814648;7222.133343998754;7253.927460725326;7255.274472552703;7259.201487836228;7273.527220730635;4676.94768677045;4696;4731.574158325767;4732.597729193058;4739.004808990151;6903.275156108536;6993.335633114846;6993.580385176906;6997.265287144776;7062.117235345582;6878.037074809631;6897.482688798461;6925.757598484029;6927.203371612128;6947.79156625302;6854.897176542456;6857.525631989146;6860.313968603299;6867.450603951572;6867.656617169221;6515.804525864231;6670.533062685759;6670.966645166744;6673.866522669617;6697.430718388991;6800.013997970365;6808.523403361915;6821.761238356634;6867.2102708189195;6876.484263680344;6645.368689974444;6673.833154171185;6679;6681.098051763144;6686.866262674816 13:20:55 INFO - PROCESS | 30629 | |5;yui.html;738.9224131466196;765.1239330966041;766.5553978692359;772.5171767645222;889.412987428297;13095.672608184801;13219.801702974462;13236.602901912946;13295.7340853183;13303.733925321489;12458.81311780324;12802.80795788064;12876.67808304793;12939.288339141343;12952.028597855151;817.2848757337345;821.0024819843889;826.6032304493847;830.754927296446;844.0209357145712;837.4556538250156;839.0686338164663;839.2321026260994;841.20506121715;846.9534175620338;866.1208872993916;867.41449521573;872.62477134832;873.2664561768114;876.5441970175505;866.5407334112962;868.6699054359303;868.9522076285801;869.9347548933823;870.1516021878617;635.4598591197491;637.8596708724074;639.9552031357807;644.4554351572914;647.2233320015999;13618;13642.181469111785;13649.181049136983;13651.726965460735;13662.795058074136;12379;12551.937240313831;12592.244465332018;12800.295983720891;12877.935610321982;10396.740081497948;10430.79138417235;10593.629222977235;10713.35719856811;10753.032227099598;3509.491123787062;3574.374484465234;3623.40213864712;3686.189038411572;3697.926041479155;45855.31217031747;47058;47214.52785472136;47281.76359118217;47386.289205661946;10036.849447258297;10301.126623794933;10405.9479702601;10435.582576697;10514.106300964504;17181.656366872594;17322.653546928992;17609.11954402275;17719.29122835098;17740.82259177392;7773.611319434006;8020.398470114765;8030.638621262057;8053.7982565379825;8226.341892648574;4277.657787377002;4375.16871794358;4424.446944131983;4476.731396116178;4571.51999040096;3057.9847100764355;3062.38752249551;3085.274960384308;3095.411871744361;3107.6115485564305;576.5474102829259;585.3356440440047;595.9374265702126;599.7541008186622;601.0743455079216;608.699537765684;636.9681515924185;645.1516256123183;662.5031226580065;689.0731965506386;8017.759467215993;8024.5185288881685;8123.309518690978;8176.264136227649;8270.37972152091;564.2157401212236;636.7739452494297;637.4804534304527;642.6401215319436;658.2660333727858;3697.7797326882064;3782;3884.6115388460926;3958.3072962232072;4039.2790553138593;55118.448815512136;56578.15132773012;56755.43244567584;57500.712496438086;57849;50754.74622626863;51329;51397;51399.48600513947;52248.47751522436;46778.532214678096;47007.29489057667;47260.527394725614;48030.75984620055;50086.749566251936;7869.567173805495;8071.596420179085;8151.959240203761;8172.182781722018;8205.220504052106;34455.31089378249;34468.48297275493;34587.654123458444;34941.47587786135;35331;39718.404223936086;40067;41248.79375603103;44236.11527769491;44672;11379.715507112389;11413.086953043903;11431.256968297033;11475.770484590428;11620.88379116198;12202.633920982385;12355.75288494243;12477.126601138196;12500.872130689928;12775.105742597929;11170.888291116984;11514.30914145154;11813.515782987999;11959.701007474534;12189;11349.319040857245;11420.600278990196;11708.297502149899;11712.91980518353;11856.525738970344;11236.157288203254;11398.20212585111;11399.658010259705;11545.653630391102;11641.88358116408;8778;8823.955880220557;8969.327300452362;9060.592273347584;9148.130927561871;8870.42342247752;8988.820223595361;9152.95423522878;9359.298052645943;9863.654772082942 13:20:55 INFO - PROCESS | 30629 | __end_tp_report 13:20:55 INFO - PROCESS | 30629 | __start_cc_report 13:20:55 INFO - PROCESS | 30629 | _x_x_mozilla_cycle_collect,314 13:20:55 INFO - PROCESS | 30629 | __end_cc_report 13:20:55 INFO - PROCESS | 30629 | __startTimestamp1453152055144__endTimestamp 13:20:55 INFO - PROCESS | 30629 | 13:20:55 INFO - PROCESS | 30629 | ------- Summary: start ------- 13:20:55 INFO - PROCESS | 30629 | Number of tests: 6 13:20:55 INFO - PROCESS | 30629 | 13:20:55 INFO - PROCESS | 30629 | [#0] dojo.html Cycles:165 Average:5351.04 Median:5542.70 stddev:602.13 (10.9%) stddev-sans-first:579.46 13:20:55 INFO - PROCESS | 30629 | Values: 3183.2 3183.5 3211.8 3220.7 3226.3 5166.0 5234.1 5275.4 5279.6 5285.5 5239.5 5394.7 5396.8 5416.6 5507.5 4852.2 4877.7 4909.0 4962.2 4965.4 4884.0 4889.5 4934.2 4948.2 4949.7 4729.4 4806.2 4881.3 4942.7 4950.8 4801.6 4802.6 4805.2 4836.2 4869.9 4783.7 4821.4 4821.5 4824.2 4858.8 5192.2 5240.7 5268.2 5295.8 5308.8 5759.4 5771.7 5776.1 5778.2 5778.6 5752.1 5778.9 5782.8 5791.2 5848.1 5463.2 5466.0 5514.8 5522.4 5564.6 5934.0 5970.6 5982.6 5983.1 6018.8 5614.7 5698.8 5704.1 5754.6 5771.3 5783.7 5789.0 5831.2 5836.6 5878.5 5744.6 5746.9 5806.9 5810.6 5813.3 5667.2 5713.2 5739.9 5760.8 5795.6 4456.2 4464.3 4465.9 4479.1 4498.5 3975.3 3975.8 3985.2 4028.4 4042.1 5205.3 5306.1 5322.8 5372.1 5379.8 5658.2 5698.3 5725.8 5750.0 5761.9 5236.2 5256.7 5281.6 5290.2 5342.4 4898.1 4930.7 4970.5 4977.6 5011.4 5975.5 5986.1 5991.0 6005.3 6008.7 5542.7 5617.7 5766.0 5780.0 5789.2 5915.2 5926.3 5930.6 5963.2 6011.1 5668.4 5730.7 5741.4 5759.9 5761.1 5696.5 5777.8 5804.1 5830.4 5846.8 5433.8 5473.3 5661.7 5742.4 5788.8 5677.9 5696.5 5702.4 5710.5 5718.1 5429.2 5591.4 5600.3 5612.7 5617.3 5584.7 5633.8 5778.4 5789.2 5817.5 5453.8 5518.4 5522.7 5529.9 5531.1 13:20:55 INFO - PROCESS | 30629 | 13:20:55 INFO - PROCESS | 30629 | [#1] ext.html Cycles:180 Average:53479.16 Median:36613.82 stddev:111165.03 (303.6%) stddev-sans-first:111405.83 13:20:55 INFO - PROCESS | 30629 | Values: 543.8 547.3 560.2 567.4 568.4 34983.7 35622.6 35753.0 35812.0 35817.9 37547.4 37773.1 38088.0 38161.6 38179.8 8491.0 8664.7 8693.1 8702.0 8703.9 8366.4 8524.7 8564.2 8567.4 8583.3 8538.9 8599.1 8599.4 8613.7 8634.8 8444.5 8504.9 8588.5 8597.8 8601.7 8433.3 8555.3 8573.4 8589.9 8599.6 35863.9 36305.5 36374.5 36484.0 36516.6 3329.4 3495.1 3525.3 3580.3 3764.7 27981.9 28556.7 28786.4 28791.4 28850.0 3752.3 3778.5 3900.8 4015.0 4023.1 215441.0 219922.0 220171.0 220589.0 220743.0 58882.7 59272.0 59464.4 59582.4 59637.7 61841.7 62068.7 62385.4 62668.4 71576.0 13190.6 13193.9 13290.8 13299.4 13302.3 9951.7 10033.5 10037.1 10038.1 10043.5 20647.5 21721.0 21836.1 21852.3 21862.5 8351.6 8958.6 9017.4 9032.9 9072.9 996.5 1009.0 1013.8 1034.5 1048.8 28447.6 28790.4 29002.4 29029.0 29323.1 1045.0 1052.3 1082.0 1131.6 1141.0 14983.9 15138.5 15175.1 15325.0 15393.5 616121.0 620432.0 620531.0 621815.0 623132.0 55040.0 55052.7 55363.0 55468.0 55686.7 1302.4 1306.1 1350.0 1368.7 1382.2 29702.7 30532.8 30554.7 30757.2 30943.7 46100.5 46506.8 46809.8 46846.8 47047.5 284320.0 284681.0 286172.6 288078.0 288856.0 33123.8 38410.8 41236.6 45233.0 45353.8 37848.4 41668.2 42504.0 42744.0 42822.0 37074.8 40406.2 40472.6 40991.4 42965.6 36368.6 36509.5 36597.8 36629.8 37085.0 34949.0 35748.3 35826.0 35898.8 35912.8 30079.7 32695.3 32984.0 33133.7 33351.8 24743.3 25085.1 25206.4 25297.2 25350.6 13:20:55 INFO - PROCESS | 30629 | 13:20:55 INFO - PROCESS | 30629 | [#2] jquery.html Cycles:180 Average:24030.35 Median:4966.47 stddev:72881.41 (1467.5%) stddev-sans-first:73064.18 13:20:55 INFO - PROCESS | 30629 | Values: 356.5 363.5 364.6 365.6 368.6 15463.5 16694.8 16924.5 17551.7 18151.4 11120.9 11694.0 16333.2 16431.8 16458.0 4652.9 4952.3 4980.6 4985.8 4993.9 4747.5 4856.5 4918.1 4923.8 4940.5 4889.4 4903.0 5039.8 5259.6 5262.1 5163.9 5202.2 5240.3 5268.4 5467.1 5241.7 5243.4 5261.3 5264.3 5264.9 13567.5 18990.7 19247.1 19694.8 19955.9 2172.5 2207.3 2217.9 2265.9 2272.7 8904.6 9296.4 12673.2 12819.7 13104.1 1748.5 1759.9 1817.6 1830.9 1871.6 50686.0 51946.0 52425.0 52527.7 52948.7 9644.7 9779.7 9949.1 9969.8 9980.3 12713.7 12741.9 12743.4 12749.1 12751.6 6681.1 6695.6 6748.9 6829.5 6925.9 6471.1 6519.4 6581.8 6601.1 6610.0 4424.5 4467.5 4473.7 4494.8 4496.0 1856.4 1857.4 1901.8 1918.1 1937.1 909.2 932.5 934.1 956.0 963.9 15602.3 16499.6 16560.3 16998.7 17384.7 861.9 926.8 948.7 953.9 1033.5 8786.6 9159.5 9351.7 9920.8 9923.3 373711.0 379173.0 380631.0 528657.0 533530.0 63166.7 67293.0 67864.0 68107.3 68379.0 1108.4 1159.9 1169.5 1170.4 1178.4 14459.9 14625.6 14993.0 15268.1 15328.2 21187.2 24009.2 27051.5 32884.3 34073.0 42914.4 43179.8 43182.1 43222.6 43401.3 7046.6 7307.3 7363.2 7401.0 7439.0 7988.8 8216.9 10740.4 10923.6 10979.1 8901.3 8992.6 9521.1 9560.7 9615.1 9577.5 9618.0 9754.7 9804.5 9854.8 3075.2 4776.8 5728.7 6556.4 8523.6 6044.8 7445.9 7465.8 7478.6 7496.8 8901.4 9900.3 9903.6 9904.3 9935.9 13:20:55 INFO - PROCESS | 30629 | 13:20:55 INFO - PROCESS | 30629 | [#3] mootools.html Cycles:180 Average:5553.29 Median:6505.93 stddev:2817.53 (43.3%) stddev-sans-first:2808.57 13:20:55 INFO - PROCESS | 30629 | Values: 1452.0 1473.3 1613.2 1757.5 1789.6 7581.7 7667.0 7742.0 7837.7 7886.8 7831.0 7866.0 7931.7 7934.3 7939.5 2288.2 2323.2 2323.5 2330.8 2332.2 2310.8 2318.0 2378.9 2381.7 2385.0 2302.7 2324.0 2327.6 2328.8 2344.3 2365.7 2388.8 2392.0 2396.2 2398.3 2361.1 2382.5 2395.6 2395.7 2404.9 7588.5 7639.4 7641.6 7643.2 7655.8 4708.0 4776.0 4843.3 4862.9 4898.1 3164.7 3187.3 3276.2 3318.0 3318.1 1052.1 1053.7 1067.3 1089.5 1098.1 10673.0 10834.2 10854.9 10858.2 10867.5 4363.7 4391.4 4445.0 4464.2 4532.4 9397.2 9433.4 9445.9 9468.5 9470.8 4916.2 4935.9 4943.2 4964.7 4988.9 4417.3 4460.0 4461.1 4479.6 4509.5 3662.4 3663.4 3705.2 3733.9 3739.3 1198.0 1225.7 1234.3 1239.3 1240.3 993.9 1030.4 1084.4 1232.5 1369.7 7170.3 7214.2 7237.5 7247.7 7366.7 1124.8 1130.7 1150.2 1177.9 1181.7 5925.9 5958.2 5967.6 5976.3 5982.4 8881.4 9071.9 9078.1 9097.2 9476.3 8963.4 9009.9 9086.6 9135.3 9138.3 7174.2 7249.7 7370.1 7400.4 7435.1 7278.5 7293.2 7323.2 7350.3 7366.3 8299.0 8450.4 8457.8 8546.4 8609.7 8513.4 8794.9 8810.8 8838.6 8923.1 7199.9 7455.3 7464.9 7483.4 7519.3 7414.3 7501.9 7512.2 7515.5 7540.0 7023.7 7196.6 7225.8 7300.5 7302.4 6866.9 6918.7 6926.4 7028.9 7122.2 7190.5 7196.1 7229.7 7266.4 7267.6 6611.2 6611.9 6650.6 6678.6 6684.4 6397.0 6503.7 6508.2 6523.5 6523.8 13:20:55 INFO - PROCESS | 30629 | 13:20:55 INFO - PROCESS | 30629 | [#4] prototype.html Cycles:180 Average:5597.32 Median:6196.07 stddev:1691.88 (27.3%) stddev-sans-first:1650.11 13:20:55 INFO - PROCESS | 30629 | Values: 347.9 350.4 351.2 352.6 353.0 6129.8 6175.8 6254.2 6295.2 6334.7 6038.6 6240.8 6257.0 6259.8 6276.9 4794.9 4806.8 4812.4 4816.0 4825.6 4807.8 4809.5 4817.1 4822.7 4824.4 4678.8 4767.5 4775.8 4777.2 4789.0 4778.2 4784.6 4796.4 4803.7 4808.4 4211.1 4225.5 4231.9 4242.0 4243.5 5883.4 5939.8 5962.6 5976.5 5976.6 5426.1 5582.2 5599.6 5605.6 5618.4 6606.4 6619.7 6623.5 6631.2 6632.0 4689.3 4700.8 4704.6 4707.6 4719.3 6768.4 6932.5 7001.6 7027.2 7043.5 4700.8 4711.3 4718.2 4718.6 4718.6 4751.7 4756.8 4778.5 4778.8 4779.5 5523.7 5542.4 5544.4 5547.6 5547.9 6525.6 6715.6 6735.5 6735.8 6742.5 1673.7 1704.7 1744.2 1746.1 1751.7 1142.7 1177.7 1189.7 1193.7 1194.2 6152.5 6182.8 6185.1 6193.3 6210.2 6793.5 6873.5 6875.7 6883.5 6899.6 6075.8 6182.2 6184.1 6194.7 6197.4 3679.5 3687.6 3694.4 3697.9 3700.0 7051.3 7097.7 7097.9 7102.8 7123.9 6945.5 6950.7 6951.6 6969.1 6996.8 7187.9 7256.5 7271.5 7280.2 7287.9 6915.8 6917.9 6938.7 6939.7 6949.0 6748.7 6777.3 6845.2 6889.7 6900.1 7222.1 7253.9 7255.3 7259.2 7273.5 4676.9 4696.0 4731.6 4732.6 4739.0 6903.3 6993.3 6993.6 6997.3 7062.1 6878.0 6897.5 6925.8 6927.2 6947.8 6854.9 6857.5 6860.3 6867.5 6867.7 6515.8 6670.5 6671.0 6673.9 6697.4 6800.0 6808.5 6821.8 6867.2 6876.5 6645.4 6673.8 6679.0 6681.1 6686.9 13:20:55 INFO - PROCESS | 30629 | 13:20:55 INFO - PROCESS | 30629 | [#5] yui.html Cycles:180 Average:13703.55 Median:46316.92 stddev:15769.42 (34.0%) stddev-sans-first:15783.61 13:20:55 INFO - PROCESS | 30629 | Values: 738.9 765.1 766.6 772.5 889.4 13095.7 13219.8 13236.6 13295.7 13303.7 12458.8 12802.8 12876.7 12939.3 12952.0 817.3 821.0 826.6 830.8 844.0 837.5 839.1 839.2 841.2 847.0 866.1 867.4 872.6 873.3 876.5 866.5 868.7 869.0 869.9 870.2 635.5 637.9 640.0 644.5 647.2 13618.0 13642.2 13649.2 13651.7 13662.8 12379.0 12551.9 12592.2 12800.3 12877.9 10396.7 10430.8 10593.6 10713.4 10753.0 3509.5 3574.4 3623.4 3686.2 3697.9 45855.3 47058.0 47214.5 47281.8 47386.3 10036.8 10301.1 10405.9 10435.6 10514.1 17181.7 17322.7 17609.1 17719.3 17740.8 7773.6 8020.4 8030.6 8053.8 8226.3 4277.7 4375.2 4424.4 4476.7 4571.5 3058.0 3062.4 3085.3 3095.4 3107.6 576.5 585.3 595.9 599.8 601.1 608.7 637.0 645.2 662.5 689.1 8017.8 8024.5 8123.3 8176.3 8270.4 564.2 636.8 637.5 642.6 658.3 3697.8 3782.0 3884.6 3958.3 4039.3 55118.4 56578.2 56755.4 57500.7 57849.0 50754.7 51329.0 51397.0 51399.5 52248.5 46778.5 47007.3 47260.5 48030.8 50086.7 7869.6 8071.6 8152.0 8172.2 8205.2 34455.3 34468.5 34587.7 34941.5 35331.0 39718.4 40067.0 41248.8 44236.1 44672.0 11379.7 11413.1 11431.3 11475.8 11620.9 12202.6 12355.8 12477.1 12500.9 12775.1 11170.9 11514.3 11813.5 11959.7 12189.0 11349.3 11420.6 11708.3 11712.9 11856.5 11236.2 11398.2 11399.7 11545.7 11641.9 8778.0 8824.0 8969.3 9060.6 9148.1 8870.4 8988.8 9153.0 9359.3 9863.7 13:20:55 INFO - PROCESS | 30629 | -------- Summary: end -------- 13:20:55 INFO - PROCESS | 30629 | 13:20:55 INFO - TEST-INFO | 30629: exit 0 13:20:55 INFO - TEST-OK | dromaeo_css | took 1110046ms 13:20:55 INFO - TEST-START | kraken 13:20:55 INFO - operating with platform_type : linux_ 13:20:55 INFO - Initialising browser for kraken test... 13:20:55 INFO - TEST-INFO | started process 30870 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgM5QdO/profile http://localhost:40352/getInfo.html) 13:20:59 INFO - PROCESS | 30870 | 13:20:59 INFO - PROCESS | 30870 | (process:30943): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:21:00 INFO - PROCESS | 30870 | __metrics Screen width/height:1600/1200 13:21:00 INFO - PROCESS | 30870 | colorDepth:24 13:21:00 INFO - PROCESS | 30870 | Browser inner width/height: 1024/697 13:21:00 INFO - PROCESS | 30870 | __metrics 13:21:00 INFO - PROCESS | 30870 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:21:01 INFO - TEST-INFO | 30870: exit 0 13:21:01 INFO - Browser initialized. 13:21:01 INFO - Running cycle 1/1 for kraken test... 13:21:01 INFO - TEST-INFO | started process 30991 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgM5QdO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:21:01 INFO - PROCESS | 30991 | -- checkerboarding starts below -- 13:21:01 INFO - PROCESS | 30991 | RENDERTRACE 0.040243 rect red 0 0 10 10 // viewport 13:21:01 INFO - PROCESS | 30991 | RENDERTRACE 4.80399 rect red 0 0 10 10 // viewport 13:21:01 INFO - PROCESS | 30991 | RENDERTRACE 22.6875 rect brown 0 0 10 10 // page 13:21:01 INFO - PROCESS | 30991 | RENDERTRACE 22.7068 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 13:21:01 INFO - PROCESS | 30991 | Checkerboarded for 2 frames (38.0486 ms), 100 peak, 479 severity. 13:21:02 INFO - PROCESS | 30991 | 13:21:02 INFO - PROCESS | 30991 | (process:31049): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:21:12 INFO - PROCESS | 30991 | RSS: Main: 150478848 13:21:12 INFO - PROCESS | 30991 | 13:21:15 INFO - PROCESS | 30991 | Cycle 1(1): loaded http://localhost:40352/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40352/tests/kraken/driver.html?testName=audio-beat-detection) 13:21:16 INFO - PROCESS | 30991 | RSS: Main: 151056384 13:21:16 INFO - PROCESS | 30991 | 13:21:18 INFO - PROCESS | 30991 | Cycle 1(1): loaded http://localhost:40352/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40352/tests/kraken/driver.html?testName=audio-dft) 13:21:19 INFO - PROCESS | 30991 | RSS: Main: 155049984 13:21:19 INFO - PROCESS | 30991 | 13:21:22 INFO - PROCESS | 30991 | Cycle 1(1): loaded http://localhost:40352/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40352/tests/kraken/driver.html?testName=audio-fft) 13:21:22 INFO - PROCESS | 30991 | RSS: Main: 147120128 13:21:22 INFO - PROCESS | 30991 | 13:21:24 INFO - PROCESS | 30991 | Cycle 1(1): loaded http://localhost:40352/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40352/tests/kraken/driver.html?testName=audio-oscillator) 13:21:25 INFO - PROCESS | 30991 | RSS: Main: 148467712 13:21:25 INFO - PROCESS | 30991 | 13:21:27 INFO - PROCESS | 30991 | Cycle 1(1): loaded http://localhost:40352/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40352/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:21:28 INFO - PROCESS | 30991 | RSS: Main: 148889600 13:21:28 INFO - PROCESS | 30991 | 13:21:31 INFO - PROCESS | 30991 | Cycle 1(1): loaded http://localhost:40352/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40352/tests/kraken/driver.html?testName=imaging-darkroom) 13:21:31 INFO - PROCESS | 30991 | RSS: Main: 147034112 13:21:31 INFO - PROCESS | 30991 | 13:21:35 INFO - PROCESS | 30991 | Cycle 1(1): loaded http://localhost:40352/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40352/tests/kraken/driver.html?testName=imaging-desaturate) 13:21:35 INFO - PROCESS | 30991 | RSS: Main: 148508672 13:21:35 INFO - PROCESS | 30991 | 13:21:38 INFO - PROCESS | 30991 | Cycle 1(1): loaded http://localhost:40352/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40352/tests/kraken/driver.html?testName=json-parse-financial) 13:21:39 INFO - PROCESS | 30991 | RSS: Main: 149708800 13:21:39 INFO - PROCESS | 30991 | 13:21:40 INFO - PROCESS | 30991 | Cycle 1(1): loaded http://localhost:40352/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40352/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:21:41 INFO - PROCESS | 30991 | RSS: Main: 151269376 13:21:41 INFO - PROCESS | 30991 | 13:21:43 INFO - PROCESS | 30991 | Cycle 1(1): loaded http://localhost:40352/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40352/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:21:43 INFO - PROCESS | 30991 | RSS: Main: 149372928 13:21:43 INFO - PROCESS | 30991 | 13:21:45 INFO - PROCESS | 30991 | Cycle 1(1): loaded http://localhost:40352/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40352/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:21:46 INFO - PROCESS | 30991 | RSS: Main: 149725184 13:21:46 INFO - PROCESS | 30991 | 13:21:49 INFO - PROCESS | 30991 | Cycle 1(1): loaded http://localhost:40352/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40352/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:21:49 INFO - PROCESS | 30991 | RSS: Main: 149757952 13:21:49 INFO - PROCESS | 30991 | 13:21:52 INFO - PROCESS | 30991 | Cycle 1(1): loaded http://localhost:40352/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40352/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:21:52 INFO - PROCESS | 30991 | RSS: Main: 151056384 13:21:52 INFO - PROCESS | 30991 | 13:21:54 INFO - PROCESS | 30991 | Cycle 1(1): loaded http://localhost:40352/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40352/tests/kraken/driver.html?testName=ai-astar) 13:21:54 INFO - PROCESS | 30991 | RSS: Main: 151994368 13:21:54 INFO - PROCESS | 30991 | 13:21:54 INFO - PROCESS | 30991 | __start_tp_report 13:21:54 INFO - PROCESS | 30991 | _x_x_mozilla_page_load 13:21:54 INFO - PROCESS | 30991 | _x_x_mozilla_page_load_details 13:21:54 INFO - PROCESS | 30991 | |i|pagename|runs| 13:21:54 INFO - PROCESS | 30991 | |0;ai-astar;113;114;112;111;112;124;110;110;111;112 13:21:54 INFO - PROCESS | 30991 | |1;audio-beat-detection;152;127;161;165;128;165;162;130;166;130 13:21:54 INFO - PROCESS | 30991 | |2;audio-dft;163;164;162;162;162;162;161;166;165;162 13:21:54 INFO - PROCESS | 30991 | |3;audio-fft;73;74;73;75;74;129;73;73;74;74 13:21:54 INFO - PROCESS | 30991 | |4;audio-oscillator;96;98;145;95;95;96;149;96;97;137 13:21:54 INFO - PROCESS | 30991 | |5;imaging-gaussian-blur;110;109;109;109;110;110;109;109;110;111 13:21:54 INFO - PROCESS | 30991 | |6;imaging-darkroom;147;153;146;145;146;148;150;146;146;147 13:21:54 INFO - PROCESS | 30991 | |7;imaging-desaturate;96;97;96;98;96;96;97;98;97;97 13:21:54 INFO - PROCESS | 30991 | |8;json-parse-financial;58;61;60;60;61;58;60;59;62;59 13:21:54 INFO - PROCESS | 30991 | |9;json-stringify-tinderbox;68;67;67;68;68;67;68;67;68;69 13:21:54 INFO - PROCESS | 30991 | |10;stanford-crypto-aes;81;82;81;82;82;81;81;82;81;82 13:21:54 INFO - PROCESS | 30991 | |11;stanford-crypto-ccm;121;120;117;128;131;120;118;117;144;129 13:21:54 INFO - PROCESS | 30991 | |12;stanford-crypto-pbkdf2;133;143;144;142;143;134;148;144;146;134 13:21:54 INFO - PROCESS | 30991 | |13;stanford-crypto-sha256-iterative;67;68;68;67;68;69;67;65;67;71 13:21:54 INFO - PROCESS | 30991 | __end_tp_report 13:21:54 INFO - PROCESS | 30991 | __start_cc_report 13:21:54 INFO - PROCESS | 30991 | _x_x_mozilla_cycle_collect,741 13:21:54 INFO - PROCESS | 30991 | __end_cc_report 13:21:54 INFO - PROCESS | 30991 | __startTimestamp1453152114627__endTimestamp 13:21:54 INFO - PROCESS | 30991 | 13:21:54 INFO - PROCESS | 30991 | ------- Summary: start ------- 13:21:54 INFO - PROCESS | 30991 | Number of tests: 14 13:21:54 INFO - PROCESS | 30991 | 13:21:54 INFO - PROCESS | 30991 | [#0] ai-astar Cycles:10 Average:112.90 Median:112.00 stddev:4.09 (3.7%) stddev-sans-first:4.34 13:21:54 INFO - PROCESS | 30991 | Values: 113.0 114.0 112.0 111.0 112.0 124.0 110.0 110.0 111.0 112.0 13:21:54 INFO - PROCESS | 30991 | 13:21:54 INFO - PROCESS | 30991 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:161.50 stddev:17.54 (10.9%) stddev-sans-first:18.56 13:21:54 INFO - PROCESS | 30991 | Values: 152.0 127.0 161.0 165.0 128.0 165.0 162.0 130.0 166.0 130.0 13:21:54 INFO - PROCESS | 30991 | 13:21:54 INFO - PROCESS | 30991 | [#2] audio-dft Cycles:10 Average:162.90 Median:162.50 stddev:1.60 (1.0%) stddev-sans-first:1.69 13:21:54 INFO - PROCESS | 30991 | Values: 163.0 164.0 162.0 162.0 162.0 162.0 161.0 166.0 165.0 162.0 13:21:54 INFO - PROCESS | 30991 | 13:21:54 INFO - PROCESS | 30991 | [#3] audio-fft Cycles:10 Average:79.20 Median:74.00 stddev:17.51 (23.7%) stddev-sans-first:18.43 13:21:54 INFO - PROCESS | 30991 | Values: 73.0 74.0 73.0 75.0 74.0 129.0 73.0 73.0 74.0 74.0 13:21:54 INFO - PROCESS | 30991 | 13:21:54 INFO - PROCESS | 30991 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:96.00 stddev:23.15 (24.1%) stddev-sans-first:23.96 13:21:54 INFO - PROCESS | 30991 | Values: 96.0 98.0 145.0 95.0 95.0 96.0 149.0 96.0 97.0 137.0 13:21:54 INFO - PROCESS | 30991 | 13:21:54 INFO - PROCESS | 30991 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 13:21:54 INFO - PROCESS | 30991 | Values: 110.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 110.0 111.0 13:21:54 INFO - PROCESS | 30991 | 13:21:54 INFO - PROCESS | 30991 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:2.41 (1.6%) stddev-sans-first:2.55 13:21:54 INFO - PROCESS | 30991 | Values: 147.0 153.0 146.0 145.0 146.0 148.0 150.0 146.0 146.0 147.0 13:21:54 INFO - PROCESS | 30991 | 13:21:54 INFO - PROCESS | 30991 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:97.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 13:21:54 INFO - PROCESS | 30991 | Values: 96.0 97.0 96.0 98.0 96.0 96.0 97.0 98.0 97.0 97.0 13:21:54 INFO - PROCESS | 30991 | 13:21:54 INFO - PROCESS | 30991 | [#8] json-parse-financial Cycles:10 Average:59.80 Median:60.00 stddev:1.32 (2.2%) stddev-sans-first:1.22 13:21:54 INFO - PROCESS | 30991 | Values: 58.0 61.0 60.0 60.0 61.0 58.0 60.0 59.0 62.0 59.0 13:21:54 INFO - PROCESS | 30991 | 13:21:54 INFO - PROCESS | 30991 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 13:21:54 INFO - PROCESS | 30991 | Values: 68.0 67.0 67.0 68.0 68.0 67.0 68.0 67.0 68.0 69.0 13:21:54 INFO - PROCESS | 30991 | 13:21:54 INFO - PROCESS | 30991 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:82.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 13:21:54 INFO - PROCESS | 30991 | Values: 81.0 82.0 81.0 82.0 82.0 81.0 81.0 82.0 81.0 82.0 13:21:54 INFO - PROCESS | 30991 | 13:21:54 INFO - PROCESS | 30991 | [#11] stanford-crypto-ccm Cycles:10 Average:124.50 Median:124.50 stddev:8.58 (6.9%) stddev-sans-first:9.01 13:21:54 INFO - PROCESS | 30991 | Values: 121.0 120.0 117.0 128.0 131.0 120.0 118.0 117.0 144.0 129.0 13:21:54 INFO - PROCESS | 30991 | 13:21:54 INFO - PROCESS | 30991 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.10 Median:143.50 stddev:5.40 (3.8%) stddev-sans-first:4.87 13:21:54 INFO - PROCESS | 30991 | Values: 133.0 143.0 144.0 142.0 143.0 134.0 148.0 144.0 146.0 134.0 13:21:54 INFO - PROCESS | 30991 | 13:21:54 INFO - PROCESS | 30991 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.57 (2.3%) stddev-sans-first:1.64 13:21:54 INFO - PROCESS | 30991 | Values: 67.0 68.0 68.0 67.0 68.0 69.0 67.0 65.0 67.0 71.0 13:21:54 INFO - PROCESS | 30991 | -------- Summary: end -------- 13:21:54 INFO - PROCESS | 30991 | 13:21:55 INFO - TEST-INFO | 30991: exit 0 13:21:55 INFO - TEST-OK | kraken | took 59855ms 13:21:55 INFO - TEST-START | v8_7 13:21:55 INFO - operating with platform_type : linux_ 13:21:55 INFO - Initialising browser for v8_7 test... 13:21:55 INFO - TEST-INFO | started process 31276 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnNtE_Y/profile http://localhost:40352/getInfo.html) 13:21:59 INFO - PROCESS | 31276 | -- checkerboarding starts below -- 13:21:59 INFO - PROCESS | 31276 | RENDERTRACE 0.035098 rect red 0 0 1024 768 // viewport 13:21:59 INFO - PROCESS | 31276 | RENDERTRACE 313.448 rect brown 0 0 1024 768 // page 13:21:59 INFO - PROCESS | 31276 | RENDERTRACE 313.489 rect lightgreen 0 0 1024 768 // painted displayport (this layertree updated) 13:21:59 INFO - PROCESS | 31276 | Checkerboarded for 1 frames (316.36 ms), 786432 peak, 11129 severity. 13:21:59 INFO - PROCESS | 31276 | 13:21:59 INFO - PROCESS | 31276 | (process:31345): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:22:00 INFO - PROCESS | 31276 | __metrics Screen width/height:1600/1200 13:22:00 INFO - PROCESS | 31276 | colorDepth:24 13:22:00 INFO - PROCESS | 31276 | Browser inner width/height: 1024/697 13:22:00 INFO - PROCESS | 31276 | __metrics 13:22:00 INFO - PROCESS | 31276 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:22:01 INFO - TEST-INFO | 31276: exit 0 13:22:01 INFO - Browser initialized. 13:22:01 INFO - Running cycle 1/1 for v8_7 test... 13:22:01 INFO - TEST-INFO | started process 31393 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnNtE_Y/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:22:01 INFO - PROCESS | 31393 | -- checkerboarding starts below -- 13:22:01 INFO - PROCESS | 31393 | RENDERTRACE 0.068058 rect red 0 0 10 10 // viewport 13:22:01 INFO - PROCESS | 31393 | RENDERTRACE 16.6092 rect brown 0 0 10 10 // page 13:22:01 INFO - PROCESS | 31393 | RENDERTRACE 16.6338 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 13:22:01 INFO - PROCESS | 31393 | Checkerboarded for 1 frames (33.189 ms), 100 peak, 2 severity. 13:22:02 INFO - PROCESS | 31393 | 13:22:02 INFO - PROCESS | 31393 | (process:31453): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:22:12 INFO - PROCESS | 31393 | RSS: Main: 150855680 13:22:12 INFO - PROCESS | 31393 | 13:22:35 INFO - PROCESS | 31393 | Cycle 1(1): loaded http://localhost:40352/tests/v8_7/run.html (next: http://localhost:40352/tests/v8_7/run.html) 13:22:35 INFO - PROCESS | 31393 | RSS: Main: 147091456 13:22:35 INFO - PROCESS | 31393 | 13:22:35 INFO - PROCESS | 31393 | __start_tp_report 13:22:35 INFO - PROCESS | 31393 | _x_x_mozilla_page_load 13:22:35 INFO - PROCESS | 31393 | _x_x_mozilla_page_load_details 13:22:35 INFO - PROCESS | 31393 | |i|pagename|runs| 13:22:35 INFO - PROCESS | 31393 | |0;Richards;171.40898183064792 13:22:35 INFO - PROCESS | 31393 | |1;DeltaBlue;189.0359168241966 13:22:35 INFO - PROCESS | 31393 | |2;Encrypt;279.2516056967328 13:22:35 INFO - PROCESS | 31393 | |3;Decrypt;5256.544502617801 13:22:35 INFO - PROCESS | 31393 | |4;RayTrace;1085.7763300760043 13:22:35 INFO - PROCESS | 31393 | |5;Earley;751.3148009015778 13:22:35 INFO - PROCESS | 31393 | |6;Boyer;12481.481481481482 13:22:35 INFO - PROCESS | 31393 | |7;RegExp;41877.551020408166 13:22:35 INFO - PROCESS | 31393 | |8;Splay;606.060606060606 13:22:35 INFO - PROCESS | 31393 | |9;NavierStokes;4826.923076923077 13:22:35 INFO - PROCESS | 31393 | __end_tp_report 13:22:35 INFO - PROCESS | 31393 | __startTimestamp1453152155555__endTimestamp 13:22:35 INFO - PROCESS | 31393 | 13:22:35 INFO - PROCESS | 31393 | ------- Summary: start ------- 13:22:35 INFO - PROCESS | 31393 | Number of tests: 10 13:22:35 INFO - PROCESS | 31393 | 13:22:35 INFO - PROCESS | 31393 | [#0] Richards Cycles:1 Average:171.41 Median:171.41 stddev:0.00 (0.0%) 13:22:35 INFO - PROCESS | 31393 | Values: 171.4 13:22:35 INFO - PROCESS | 31393 | 13:22:35 INFO - PROCESS | 31393 | [#1] DeltaBlue Cycles:1 Average:189.04 Median:189.04 stddev:0.00 (0.0%) 13:22:35 INFO - PROCESS | 31393 | Values: 189.0 13:22:35 INFO - PROCESS | 31393 | 13:22:35 INFO - PROCESS | 31393 | [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 13:22:35 INFO - PROCESS | 31393 | Values: 279.3 13:22:35 INFO - PROCESS | 31393 | 13:22:35 INFO - PROCESS | 31393 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 13:22:35 INFO - PROCESS | 31393 | Values: 5256.5 13:22:35 INFO - PROCESS | 31393 | 13:22:35 INFO - PROCESS | 31393 | [#4] RayTrace Cycles:1 Average:1085.78 Median:1085.78 stddev:0.00 (0.0%) 13:22:35 INFO - PROCESS | 31393 | Values: 1085.8 13:22:35 INFO - PROCESS | 31393 | 13:22:35 INFO - PROCESS | 31393 | [#5] Earley Cycles:1 Average:751.31 Median:751.31 stddev:0.00 (0.0%) 13:22:35 INFO - PROCESS | 31393 | Values: 751.3 13:22:35 INFO - PROCESS | 31393 | 13:22:35 INFO - PROCESS | 31393 | [#6] Boyer Cycles:1 Average:12481.48 Median:12481.48 stddev:0.00 (0.0%) 13:22:35 INFO - PROCESS | 31393 | Values: 12481.5 13:22:35 INFO - PROCESS | 31393 | 13:22:35 INFO - PROCESS | 31393 | [#7] RegExp Cycles:1 Average:41877.55 Median:41877.55 stddev:0.00 (0.0%) 13:22:35 INFO - PROCESS | 31393 | Values: 41877.6 13:22:35 INFO - PROCESS | 31393 | 13:22:35 INFO - PROCESS | 31393 | [#8] Splay Cycles:1 Average:606.06 Median:606.06 stddev:0.00 (0.0%) 13:22:35 INFO - PROCESS | 31393 | Values: 606.1 13:22:35 INFO - PROCESS | 31393 | 13:22:35 INFO - PROCESS | 31393 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 13:22:35 INFO - PROCESS | 31393 | Values: 4826.9 13:22:35 INFO - PROCESS | 31393 | -------- Summary: end -------- 13:22:35 INFO - PROCESS | 31393 | 13:22:36 INFO - TEST-INFO | 31393: exit 0 13:22:36 INFO - TEST-OK | v8_7 | took 40779ms 13:22:36 INFO - SUITE-END | took 1210s 13:22:36 INFO - Completed test suite (00:20:10) 13:22:36 INFO - Working with test: dromaeo_css 13:22:36 INFO - Generating results file: dromaeo_css 13:22:36 INFO - Working with test: kraken 13:22:36 INFO - Generating results file: kraken 13:22:36 INFO - javascript benchmark 13:22:36 INFO - Working with test: v8_7 13:22:36 INFO - Generating results file: v8_7 13:22:36 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:22:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 13:22:36 INFO - process_Request line: dromaeo_css 6964.33 graph.html#tests=[[72,63,43]] 13:22:36 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:22:36 INFO - process_Request line: kraken 1510.10 graph.html#tests=[[232,63,43]] 13:22:36 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:22:36 INFO - process_Request line: v8_7 20082.08 graph.html#tests=[[230,63,43]] 13:22:36 INFO - RETURN: dromaeo_css: 6964.33 13:22:36 INFO - RETURN: kraken: 1510.10 13:22:36 INFO - RETURN: v8_7: 20082.08 13:22:36 INFO - javascript benchmark 13:22:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3183.1564635371615, 3183.4906414973607, 3211.807291562508, 3220.710136087752, 3226.2902161524457, 5166.0, 5234.136367499363, 5275.419703832576, 5279.63042587019, 5285.471452854713, 5239.502247286502, 5394.730263486829, 5396.838094857151, 5416.593755468336, 5507.504324610784, 4852.175130227852, 4877.658563900528, 4908.993656300468, 4962.15643340633, 4965.404151501825, 4884.023195360925, 4889.462159162489, 4934.235193544989, 4948.158813001798, 4949.678270912379, 4729.361536192604, 4806.206975848963, 4881.316615673773, 4942.678725882806, 4950.777215025332, 4801.591864691505, 4802.639802014828, 4805.159097158018, 4836.153673107192, 4869.853904382839, 4783.736894470802, 4821.397325334333, 4821.517848215186, 4824.155772739791, 4858.805647774085, 5192.247124167013, 5240.68555886648, 5268.209768534713, 5295.761690723926, 5308.787648494055, 5759.395263497315, 5771.653700777924, 5776.133579963039, 5778.191053252548, 5778.59549831512, 5752.137179423078, 5778.913316300259, 5782.826515204551, 5791.189233507313, 5848.122781582797, 5463.2078348639625, 5466.01611709892, 5514.751836167382, 5522.447755224526, 5564.610477266593, 5933.961556727555, 5970.641761494324, 5982.641041537521, 5983.132445795422, 6018.789342372996, 5614.663120212718, 5698.772049117989, 5704.11586204139, 5754.568407369464, 5771.278590176228, 5783.681897495594, 5788.986927287792, 5831.241938548046, 5836.620619659709, 5878.470937615635, 5744.597878148489, 5746.8793585251315, 5806.912896306559, 5810.593258471951, 5813.302403711497, 5667.1782591524, 5713.171590119409, 5739.913901291484, 5760.84783043393, 5795.594308398456, 4456.24243878535, 4464.2633965396, 4465.910681786346, 4479.059397526556, 4498.527654596286, 3975.3241948868763, 3975.8012099394914, 3985.1830374773103, 4028.3957406389277, 4042.110735638155, 5205.29728486657, 5306.124489459196, 5322.787088516416, 5372.059889519319, 5379.78480860769, 5658.179563963202, 5698.31620205578, 5725.799597014085, 5749.971250143806, 5761.942380576141, 5236.24074509194, 5256.737163141827, 5281.551068159172, 5290.164630642753, 5342.412334643186, 4898.093852637274, 4930.6795058321095, 4970.453250142481, 4977.626677999165, 5011.373578302712, 5975.492083172979, 5986.132010858489, 5991.0, 6005.279366476051, 6008.729607167688, 5542.69515176653, 5617.691026993554, 5765.971170144123, 5779.988502012047, 5789.218455508452, 5915.231019967377, 5926.259217597801, 5930.584859059824, 5963.194968679173, 6011.128386383863, 5668.404817494104, 5730.684812335195, 5741.368449470471, 5759.856003599776, 5761.078227483583, 5696.458836410535, 5777.768889244551, 5804.1293805929445, 5830.4461076197695, 5846.766129354778, 5433.782648694008, 5473.343198816167, 5661.688607126483, 5742.397048309867, 5788.797392091256, 5677.943220567741, 5696.544276457957, 5702.401247868914, 5710.457506536873, 5718.056520674042, 5429.158480435539, 5591.356993945586, 5600.327960644749, 5612.747426365741, 5617.32592088952, 5584.748686309207, 5633.8309850704545, 5778.422157784188, 5789.247397838254, 5817.476427121579, 5453.7545810439415, 5518.42056584069, 5522.723863806713, 5529.917051244154, 5531.115021596525], "unit": "score", "name": "dojo.html", "value": 5311.656528233415}, {"lowerIsBetter": false, "replicates": [543.8232574413315, 547.2639300141309, 560.1569637695269, 567.4297331182162, 568.4230506036374, 34983.65016349836, 35622.64377356225, 35753.0, 35812.0, 35817.92546223614, 37547.436788448125, 37773.055673608105, 38088.0, 38161.61838381615, 38179.80910095446, 8491.0, 8664.653413863438, 8693.130686931288, 8701.95649021754, 8703.869441958375, 8366.414350995403, 8524.744257672248, 8564.229219370256, 8567.443116197459, 8583.313334933222, 8538.914610853904, 8599.097094805049, 8599.44103633265, 8613.741587752378, 8634.784130396727, 8444.493330400164, 8504.914950850536, 8588.527630980325, 8597.785055373603, 8601.698940537051, 8433.283170930417, 8555.27280181179, 8573.356998225096, 8589.871151932726, 8599.5700214989, 35863.924082277576, 36305.45541816875, 36374.454383184275, 36484.0, 36516.63483365159, 3329.433996220624, 3495.0912762681887, 3525.2596954639557, 3580.283943211342, 3764.73646844721, 27981.860090699618, 28556.71443285582, 28786.424271514454, 28791.42417151666, 28850.0, 3752.2870654575545, 3778.452124441968, 3900.843966241347, 4014.959850401488, 4023.054582173187, 215441.0, 219922.0, 220171.0, 220589.0, 220742.9999999984, 58882.70558647265, 59272.0, 59464.405355945884, 59582.40417595855, 59637.70181149067, 61841.690791545756, 62068.689656551425, 62385.376146237955, 62668.37331626716, 71576.0, 13190.60428187156, 13193.934030329787, 13290.800637990438, 13299.401526931311, 13302.334883255799, 9951.651692190884, 10033.494975753696, 10037.096661300518, 10038.146757525692, 10043.548040338203, 20647.483812904797, 21721.0, 21836.126554937942, 21852.344429667137, 21862.45343866416, 8351.58242087893, 8958.641654333753, 9017.368784185175, 9032.909670903338, 9072.8639070414, 996.4668902137322, 1009.0010889219766, 1013.761765984993, 1034.4724190662666, 1048.764028093688, 28447.573286400722, 28790.424191516053, 29002.41995160085, 29029.0, 29323.120306390843, 1045.033344156652, 1052.2581579986092, 1082.0207712020633, 1131.5700033987198, 1141.0, 14983.850161498463, 15138.470153544573, 15175.089494630136, 15325.0, 15393.461228856937, 616121.0, 620432.0, 620531.0, 621815.0, 623132.0, 55040.0, 55052.72473637686, 55363.0, 55468.0, 55686.72156639191, 1302.439950821137, 1306.144475368635, 1350.0077443079329, 1368.6783605852618, 1382.156884300576, 29702.702972969993, 30532.847335763177, 30554.694453055185, 30757.23106922345, 30943.69056309498, 46100.538994609626, 46506.767466162455, 46809.765951170026, 46846.76576617095, 47047.52952470432, 284320.0, 284681.0, 286172.569137153, 288078.0, 288856.0, 33123.83438082794, 38410.80794596009, 41236.58763412447, 45233.0, 45353.77323113364, 37848.43227351537, 41668.1666366677, 42504.0, 42744.0, 42822.0, 37074.81462592778, 40406.1918761629, 40472.595274046886, 40991.385129222486, 42965.570344297405, 36368.636313636525, 36509.45235821412, 36597.81701091584, 36629.81685091557, 37085.0, 34949.0, 35748.28503429865, 35826.0, 35898.8205058973, 35912.82043589765, 30079.69920300769, 32695.346093078482, 32984.0, 33133.66866331402, 33351.83324083364, 24743.257702268962, 25085.122020729188, 25206.405053675513, 25297.241082767545, 25350.619740704275], "unit": "score", "name": "ext.html", "value": 18779.12427905547}, {"lowerIsBetter": false, "replicates": [356.5382829236139, 363.47840848382555, 364.56434560699967, 365.570454715709, 368.55220906598475, 15463.458778942739, 16694.83305166948, 16924.49226523203, 17551.73672394915, 18151.364702235423, 11120.944395278033, 11694.0, 16333.18334083294, 16431.753523697153, 16458.0, 4652.860414187571, 4952.331435256248, 4980.601551875841, 4985.825496107637, 4993.900121997558, 4747.501512341206, 4856.490068542787, 4918.114739346916, 4923.77842997066, 4940.456549779521, 4889.437714662824, 4902.975485122587, 5039.798408063673, 5259.5529380002745, 5262.05283049051, 5163.922541161867, 5202.2196670499725, 5240.318758561381, 5268.394134674504, 5467.07059799831, 5241.73791310433, 5243.449437809013, 5261.289725886994, 5264.2893209416625, 5264.8683782905355, 13567.45730170792, 18990.71513927292, 19247.13387897548, 19694.80305196944, 19955.90022049895, 2172.4568857785553, 2207.3377986603955, 2217.9001944912516, 2265.8753768542724, 2272.7272727272666, 8904.643814247422, 9296.39573427725, 12673.239605623692, 12819.679508012374, 13104.148230364995, 1748.5016770220427, 1759.8504127149208, 1817.6364727054643, 1830.8809927354812, 1871.56018335691, 50686.0, 51946.0, 52424.99999999962, 52527.737361312946, 52948.73525632386, 9644.710658680111, 9779.706608801747, 9949.104580587782, 9969.80060398788, 9980.301378903552, 12713.682157945941, 12741.936290318488, 12743.36283185837, 12749.107562470537, 12751.553695620609, 6681.064650948871, 6695.631740254333, 6748.93251067483, 6829.4877884157895, 6925.861482770317, 6471.0940468334475, 6519.380658837403, 6581.76963806274, 6601.075849381091, 6610.0, 4424.535423780521, 4467.463904331436, 4473.731576105444, 4494.797734101973, 4495.955040449619, 1856.3502774029253, 1857.3963461874944, 1901.847852171823, 1918.1080797428983, 1937.0992488492918, 909.1953621045423, 932.5477143585356, 934.1219253901311, 956.0, 963.8891527474431, 15602.29789659468, 16499.58751031234, 16560.254788534545, 16998.745018824728, 17384.65230695379, 861.875028120919, 926.786839027014, 948.6774496671165, 953.8569214617863, 1033.5297439664935, 8786.60460279289, 9159.49622770754, 9351.672691455766, 9920.801583968425, 9923.305368624271, 373711.0, 379173.0, 380631.0, 528657.0, 533530.0, 63166.684166578874, 67293.0, 67864.0, 68107.3189268101, 68379.0, 1108.3682301088302, 1159.9014083802801, 1169.4678921091054, 1170.39724541861, 1178.4225729392708, 14459.927700361432, 14625.561233163022, 14993.0, 15268.083914965138, 15328.156951367782, 21187.152513899888, 24009.159679411136, 27051.458970820866, 32884.34231315312, 34073.0, 42914.35628465638, 43179.78410107929, 43182.13635727331, 43222.567774321855, 43401.34897976596, 7046.577205367695, 7307.3058059484265, 7363.190049094703, 7400.9866661381775, 7438.995735575628, 7988.800279993046, 8216.876746848682, 10740.355578664992, 10923.632302199898, 10979.066779323528, 8901.287896968357, 8992.59533320989, 9521.095495927875, 9560.665376711782, 9615.086566776145, 9577.473238971923, 9618.0, 9754.66941902706, 9804.509774511389, 9854.753631159278, 3075.2465645916895, 4776.808927642995, 5728.7396772709935, 6556.377144171296, 8523.573821309034, 6044.84887877789, 7445.888311675221, 7465.776026719207, 7478.626068696434, 7496.812579685334, 8901.376903616685, 9900.257480688833, 9903.603855845686, 9904.306698531034, 9935.850962235716], "unit": "score", "name": "jquery.html", "value": 7809.16141402057}, {"lowerIsBetter": false, "replicates": [1452.0, 1473.270730988161, 1613.2337139858569, 1757.5430388099091, 1789.6420715856832, 7581.734639287626, 7667.003289572354, 7741.961290193555, 7837.725679601215, 7886.842263154734, 7830.960845195766, 7865.960670196641, 7931.6827326907, 7934.285914267714, 7939.483933544316, 2288.2220045184636, 2323.163661082009, 2323.453988312745, 2330.778576035274, 2332.2303639798824, 2310.8151347892212, 2317.9884100579475, 2378.8929498172624, 2381.7022872140983, 2385.0, 2302.7466978632337, 2323.9658352033352, 2327.5810354136247, 2328.8253380996407, 2344.3318654183563, 2365.7042869641296, 2388.785009349167, 2391.976080239193, 2396.1972739132325, 2398.280515845257, 2361.1381845626393, 2382.4520360317224, 2395.616701327779, 2395.748446413119, 2404.9398765030837, 7588.468807183499, 7639.350655194316, 7641.579713115776, 7643.235676432368, 7655.846883062308, 4707.9877826267175, 4775.976120119377, 4843.3219349290775, 4862.878428039292, 4898.069366820293, 3164.715175634181, 3187.3306605612847, 3276.19733165376, 3318.0377690469736, 3318.0875259303643, 1052.1109662335314, 1053.6996955867542, 1067.2571491267445, 1089.54239219528, 1098.1331736048749, 10673.0, 10834.241603087787, 10854.945725271324, 10858.185636077247, 10867.51096200665, 4363.694541382073, 4391.429114215131, 4445.0, 4464.196444639931, 4532.410786597721, 9397.248220142372, 9433.386829856037, 9445.858312125323, 9468.526573671288, 9470.763230919145, 4916.237983112624, 4935.925961110586, 4943.184374578226, 4964.709175614294, 4988.875278118004, 4417.271150260171, 4460.041091165415, 4461.08547747711, 4479.552044795494, 4509.481409637868, 3662.3957047087465, 3663.432168013962, 3705.2404257127223, 3733.8506459741307, 3739.2895349883433, 1197.9580714674944, 1225.748721512088, 1234.3087870792206, 1239.2874097394035, 1240.3302216802826, 993.8509223616371, 1030.443560477334, 1084.35480888871, 1232.5008371609513, 1369.7329020840841, 7170.318819712119, 7214.170370407471, 7237.529560578546, 7247.710091596383, 7366.668499917517, 1124.8425220469142, 1130.7016072538565, 1150.1776229995594, 1177.935213563245, 1181.704573856536, 5925.851853703692, 5958.165856780054, 5967.6419414835245, 5976.312724036705, 5982.4017598239825, 8881.37830351882, 9071.909280907239, 9078.137576930314, 9097.226735727405, 9476.289278304155, 8963.372563920593, 9009.909900900908, 9086.636534538677, 9135.31485138604, 9138.268938484905, 7174.246704095995, 7249.673764680602, 7370.078740157373, 7400.444966627524, 7435.1449583297535, 7278.526895751759, 7293.197748247582, 7323.194448610755, 7350.338469537767, 7366.263373662591, 8299.0, 8450.366222533457, 8457.83084338322, 8546.401751877309, 8609.65561377538, 8513.40406171562, 8794.868076978722, 8810.779730506532, 8838.602262898057, 8923.107689231025, 7199.856002879808, 7455.329020388191, 7464.888026679713, 7483.438742094256, 7519.285667861544, 7414.332710056121, 7501.887471688038, 7512.248775122444, 7515.511491753018, 7539.962300188464, 7023.719051238098, 7196.6041867695685, 7225.819354515969, 7300.488965772345, 7302.379297759538, 6866.896996544956, 6918.688659010256, 6926.44588432914, 7028.859422811617, 7122.180949190702, 7190.532615379983, 7196.10048743907, 7229.674664639999, 7266.418686505172, 7267.563946163247, 6611.239707433707, 6611.867762644816, 6650.634215118215, 6678.599284042973, 6684.364985326386, 6397.0, 6503.707333170113, 6508.153939987771, 6523.543351965317, 6523.836904077246], "unit": "score", "name": "mootools.html", "value": 4593.529897603549}, {"lowerIsBetter": false, "replicates": [347.91128262293114, 350.44979382369655, 351.24657609427777, 352.5821901047258, 352.9728490093827, 6129.816105516842, 6175.783847565336, 6254.155688981986, 6295.150154729116, 6334.746610135595, 6038.57729958903, 6240.812775616728, 6257.0, 6259.780907668232, 6276.905846412307, 4794.856154315367, 4806.759662016902, 4812.398450193726, 4816.0, 4825.565699087081, 4807.78364973577, 4809.470958194595, 4817.0847538967655, 4822.734749588772, 4824.372831531896, 4678.812847486097, 4767.4755776864695, 4775.832845850396, 4777.235642297233, 4788.970371370155, 4778.1638213312535, 4784.64115191362, 4796.3524924135145, 4803.711777293373, 4808.374911261549, 4211.05251318454, 4225.514065882432, 4231.915361692749, 4242.0, 4243.511996120455, 5883.352831188566, 5939.762409503614, 5962.5528085393335, 5976.491998180117, 5976.61152025117, 5426.077566813651, 5582.162675598652, 5599.580031497654, 5605.579581531401, 5618.438156184389, 6606.372394622503, 6619.735210591571, 6623.4701223901975, 6631.204255489324, 6632.0, 4689.343491911135, 4700.788464519105, 4704.6001089907395, 4707.5763181313505, 4719.292106184065, 6768.39084482394, 6932.48006399517, 7001.649917504155, 7027.227005029443, 7043.471739619549, 4700.788464519105, 4711.340412342275, 4718.159917632058, 4718.598919091915, 4718.646101542398, 4751.714897106184, 4756.809727610926, 4778.450478195052, 4778.832740854054, 4779.545943135397, 5523.7238138092935, 5542.3626282977975, 5544.417836127229, 5547.55619550435, 5547.861303467364, 6525.641089740015, 6715.56348837324, 6735.461163106939, 6735.797926062226, 6742.49431292655, 1673.7405702116191, 1704.667589819998, 1744.1628018551166, 1746.1356628468989, 1751.6671832352067, 1142.702897246705, 1177.670252329349, 1189.7263629365295, 1193.7194759231575, 1194.1640851404052, 6152.507799376039, 6182.845428864224, 6185.134081228632, 6193.256809182837, 6210.192674952317, 6793.5244532882225, 6873.48448866337, 6875.724971001204, 6883.483738719616, 6899.6205208714, 6075.787347442907, 6182.227221597301, 6184.072389141665, 6194.721237544231, 6197.411245931629, 3679.5400574928135, 3687.59436461989, 3694.4088945769086, 3697.90755231116, 3699.9815000924823, 7051.330123638246, 7097.680604372816, 7097.858042839114, 7102.822429439202, 7123.857522849514, 6945.548539344926, 6950.721971121199, 6951.617661028591, 6969.0940177776565, 6996.790096297017, 7187.892181617175, 7256.492045556761, 7271.454640901953, 7280.235575264627, 7287.854242915112, 6915.792526224222, 6917.89623155643, 6938.653067346713, 6939.653017349214, 6948.965255173692, 6748.662566871735, 6777.322267773183, 6845.247022827385, 6889.724411023703, 6900.137482814648, 7222.133343998754, 7253.927460725326, 7255.274472552703, 7259.201487836228, 7273.527220730635, 4676.94768677045, 4696.0, 4731.574158325767, 4732.597729193058, 4739.004808990151, 6903.275156108536, 6993.335633114846, 6993.580385176906, 6997.265287144776, 7062.117235345582, 6878.037074809631, 6897.482688798461, 6925.757598484029, 6927.203371612128, 6947.79156625302, 6854.897176542456, 6857.525631989146, 6860.313968603299, 6867.450603951572, 6867.656617169221, 6515.804525864231, 6670.533062685759, 6670.966645166744, 6673.866522669617, 6697.430718388991, 6800.013997970365, 6808.523403361915, 6821.761238356634, 6867.2102708189195, 6876.484263680344, 6645.368689974444, 6673.833154171185, 6679.0, 6681.098051763144, 6686.866262674816], "unit": "score", "name": "prototype.html", "value": 5050.77988506412}, {"lowerIsBetter": false, "replicates": [738.9224131466196, 765.1239330966041, 766.5553978692359, 772.5171767645222, 889.412987428297, 13095.672608184801, 13219.801702974462, 13236.602901912946, 13295.7340853183, 13303.733925321489, 12458.81311780324, 12802.80795788064, 12876.67808304793, 12939.288339141343, 12952.028597855151, 817.2848757337345, 821.0024819843889, 826.6032304493847, 830.754927296446, 844.0209357145712, 837.4556538250156, 839.0686338164663, 839.2321026260994, 841.20506121715, 846.9534175620338, 866.1208872993916, 867.41449521573, 872.62477134832, 873.2664561768114, 876.5441970175505, 866.5407334112962, 868.6699054359303, 868.9522076285801, 869.9347548933823, 870.1516021878617, 635.4598591197491, 637.8596708724074, 639.9552031357807, 644.4554351572914, 647.2233320015999, 13618.0, 13642.181469111785, 13649.181049136983, 13651.726965460735, 13662.795058074136, 12379.0, 12551.937240313831, 12592.244465332018, 12800.295983720891, 12877.935610321982, 10396.740081497948, 10430.79138417235, 10593.629222977235, 10713.35719856811, 10753.032227099598, 3509.491123787062, 3574.374484465234, 3623.40213864712, 3686.189038411572, 3697.926041479155, 45855.31217031747, 47058.0, 47214.52785472136, 47281.76359118217, 47386.289205661946, 10036.849447258297, 10301.126623794933, 10405.9479702601, 10435.582576697, 10514.106300964504, 17181.656366872594, 17322.653546928992, 17609.11954402275, 17719.29122835098, 17740.82259177392, 7773.611319434006, 8020.398470114765, 8030.638621262057, 8053.7982565379825, 8226.341892648574, 4277.657787377002, 4375.16871794358, 4424.446944131983, 4476.731396116178, 4571.51999040096, 3057.9847100764355, 3062.38752249551, 3085.274960384308, 3095.411871744361, 3107.6115485564305, 576.5474102829259, 585.3356440440047, 595.9374265702126, 599.7541008186622, 601.0743455079216, 608.699537765684, 636.9681515924185, 645.1516256123183, 662.5031226580065, 689.0731965506386, 8017.759467215993, 8024.5185288881685, 8123.309518690978, 8176.264136227649, 8270.37972152091, 564.2157401212236, 636.7739452494297, 637.4804534304527, 642.6401215319436, 658.2660333727858, 3697.7797326882064, 3782.0, 3884.6115388460926, 3958.3072962232072, 4039.2790553138593, 55118.448815512136, 56578.15132773012, 56755.43244567584, 57500.712496438086, 57849.0, 50754.74622626863, 51329.0, 51397.0, 51399.48600513947, 52248.47751522436, 46778.532214678096, 47007.29489057667, 47260.527394725614, 48030.75984620055, 50086.749566251936, 7869.567173805495, 8071.596420179085, 8151.959240203761, 8172.182781722018, 8205.220504052106, 34455.31089378249, 34468.48297275493, 34587.654123458444, 34941.47587786135, 35331.0, 39718.404223936086, 40067.0, 41248.79375603103, 44236.11527769491, 44672.0, 11379.715507112389, 11413.086953043903, 11431.256968297033, 11475.770484590428, 11620.88379116198, 12202.633920982385, 12355.75288494243, 12477.126601138196, 12500.872130689928, 12775.105742597929, 11170.888291116984, 11514.30914145154, 11813.515782987999, 11959.701007474534, 12189.0, 11349.319040857245, 11420.600278990196, 11708.297502149899, 11712.91980518353, 11856.525738970344, 11236.157288203254, 11398.20212585111, 11399.658010259705, 11545.653630391102, 11641.88358116408, 8778.0, 8823.955880220557, 8969.327300452362, 9060.592273347584, 9148.130927561871, 8870.42342247752, 8988.820223595361, 9152.95423522878, 9359.298052645943, 9863.654772082942], "unit": "score", "name": "yui.html", "value": 6312.843641396841}], "name": "dromaeo_css", "value": 6964.328268308564}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 114.0, 112.0, 111.0, 112.0, 124.0, 110.0, 110.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.9}, {"lowerIsBetter": true, "replicates": [152.0, 127.0, 161.0, 165.0, 128.0, 165.0, 162.0, 130.0, 166.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 162.0, 162.0, 162.0, 162.0, 161.0, 166.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.9}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 73.0, 75.0, 74.0, 129.0, 73.0, 73.0, 74.0, 74.0], "unit": "score", "name": "audio-fft", "value": 79.2}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 145.0, 95.0, 95.0, 96.0, 149.0, 96.0, 97.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 110.4}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 153.0, 146.0, 145.0, 146.0, 148.0, 150.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.4}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 98.0, 96.0, 96.0, 97.0, 98.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [58.0, 61.0, 60.0, 60.0, 61.0, 58.0, 60.0, 59.0, 62.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 59.8}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 68.0, 68.0, 67.0, 68.0, 67.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 81.0, 82.0, 82.0, 81.0, 81.0, 82.0, 81.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.5}, {"lowerIsBetter": true, "replicates": [121.0, 120.0, 117.0, 128.0, 131.0, 120.0, 118.0, 117.0, 144.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.5}, {"lowerIsBetter": true, "replicates": [133.0, 143.0, 144.0, 142.0, 143.0, 134.0, 148.0, 144.0, 146.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.1}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 67.0, 68.0, 69.0, 67.0, 65.0, 67.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1510.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [171.40898183064792], "unit": "score", "name": "Richards", "value": 205.95186799999996}, {"lowerIsBetter": false, "replicates": [189.0359168241966], "unit": "score", "name": "DeltaBlue", "value": 349.7642200000001}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1085.7763300760043], "unit": "score", "name": "RayTrace", "value": 681.5298690000002}, {"lowerIsBetter": false, "replicates": [751.3148009015778], "unit": "score", "name": "Earley", "value": 887.0622530000003}, {"lowerIsBetter": false, "replicates": [12481.481481481482], "unit": "score", "name": "Boyer", "value": 53.39614540059344}, {"lowerIsBetter": false, "replicates": [41877.551020408166], "unit": "score", "name": "RegExp", "value": 21.753540448343067}, {"lowerIsBetter": false, "replicates": [606.060606060606], "unit": "score", "name": "Splay", "value": 134.46015000000003}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20082.076746058912}]} 13:22:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20082.08"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1510.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6964.33"}}} 13:22:36 INFO - Return code: 0 13:22:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:22:36 INFO - # TBPL SUCCESS # 13:22:36 INFO - Running post-action listener: _resource_record_post_action 13:22:36 INFO - Running post-run listener: _resource_record_post_run 13:22:37 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 553447424; Read time: 0; Write time: 360728 13:22:37 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 237780992; Read time: 0; Write time: 184480 13:22:37 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 315666432; Read time: 0; Write time: 176248 13:22:37 INFO - Running post-run listener: _upload_blobber_files 13:22:37 INFO - Blob upload gear active. 13:22:37 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 13:22:37 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 13:22:37 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'] 13:22:37 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 13:22:38 INFO - (blobuploader) - INFO - Open directory for files ... 13:22:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:22:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:22:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:22:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:22:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:22:39 INFO - (blobuploader) - INFO - Done attempting. 13:22:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:22:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:22:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:22:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:22:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:22:40 INFO - (blobuploader) - INFO - Done attempting. 13:22:40 INFO - (blobuploader) - INFO - Iteration through files over. 13:22:40 INFO - Return code: 0 13:22:40 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 13:22:40 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 13:22:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ae1792674c9f52d451ab192786e461c956d5aa48f4e3a8d669cb602eacf6fdde3868b11a1e097d9ccb3a0615251857a7871e5f7b1c571b566dddce2d6318d175", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e7965904e0950a0abfd7bb825040d2d7f9a556c1cc3c47b21e1ff7aa15a409a35f65d3456ab278d4cba0ecc44d96f9436ba1afbd5187da2344b4142142c56f7c"} 13:22:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 13:22:40 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 13:22:40 INFO - Contents: 13:22:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ae1792674c9f52d451ab192786e461c956d5aa48f4e3a8d669cb602eacf6fdde3868b11a1e097d9ccb3a0615251857a7871e5f7b1c571b566dddce2d6318d175", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e7965904e0950a0abfd7bb825040d2d7f9a556c1cc3c47b21e1ff7aa15a409a35f65d3456ab278d4cba0ecc44d96f9436ba1afbd5187da2344b4142142c56f7c"} 13:22:40 INFO - Running post-run listener: copy_logs_to_upload_dir 13:22:40 INFO - Copying logs to upload dir... 13:22:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 13:22:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.136478 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-18 13:22:39.624502) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-18 13:22:39.628266) ========= 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=00204705a9daa57ed339a427000001b9-1453146570.951696-721542639 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/ae1792674c9f52d451ab192786e461c956d5aa48f4e3a8d669cb602eacf6fdde3868b11a1e097d9ccb3a0615251857a7871e5f7b1c571b566dddce2d6318d175", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e7965904e0950a0abfd7bb825040d2d7f9a556c1cc3c47b21e1ff7aa15a409a35f65d3456ab278d4cba0ecc44d96f9436ba1afbd5187da2344b4142142c56f7c"} build_url:https://queue.taskcluster.net/v1/task/C4HSFKp9T122lhx5QOWxqQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011559 build_url: 'https://queue.taskcluster.net/v1/task/C4HSFKp9T122lhx5QOWxqQ/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/ae1792674c9f52d451ab192786e461c956d5aa48f4e3a8d669cb602eacf6fdde3868b11a1e097d9ccb3a0615251857a7871e5f7b1c571b566dddce2d6318d175", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e7965904e0950a0abfd7bb825040d2d7f9a556c1cc3c47b21e1ff7aa15a409a35f65d3456ab278d4cba0ecc44d96f9436ba1afbd5187da2344b4142142c56f7c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-18 13:22:39.656584) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 13:22:39.657260) ========= 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=00204705a9daa57ed339a427000001b9-1453146570.951696-721542639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004578 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 13:22:39.740859) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-18 13:22:39.741243) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-18 13:22:39.741657) ========= ========= Total master_lag: 0.29 =========