builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1453143673.07 results: success (0) buildid: 20160118083134 builduid: 1a402ba1099743eb8d40a9f32a69e6ea revision: eb1e9ec43a36fa7d64f973f0662103f3250acf75 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-18 11:01:13.075260) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-18 11:01:13.075750) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-18 11:01:13.076033) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006369 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-18 11:01:13.099208) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-18 11:01:13.099528) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-18 11:01:13.113213) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 11:01:13.113706) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004571 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 11:01:13.163080) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-18 11:01:13.163388) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-18 11:01:13.163743) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 11:01:13.164010) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-18 11:01:15-- 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% 34.4M=0s 2016-01-18 11:01:15 (34.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.209088 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 11:01:13.385652) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 11:01:13.385994) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020537 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 11:01:13.436344) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 11:01:13.436689) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev eb1e9ec43a36fa7d64f973f0662103f3250acf75 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev eb1e9ec43a36fa7d64f973f0662103f3250acf75 --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=97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-18 11:01:15,720 truncating revision to first 12 chars 2016-01-18 11:01:15,720 Setting DEBUG logging. 2016-01-18 11:01:15,720 attempt 1/10 2016-01-18 11:01:15,721 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/eb1e9ec43a36?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-18 11:01:15,992 unpacking tar archive at: fx-team-eb1e9ec43a36/testing/mozharness/ program finished with exit code 0 elapsedTime=0.600782 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 11:01:14.050129) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-18 11:01:14.050492) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004744 script_repo_revision: '%(revision)s' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-18 11:01:14.098896) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-18 11:01:14.099210) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-18 11:01:14.109079) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-18 11:01:14.109465) ========= 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 11:01:14.109894) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-18 11:01:14.110170) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:01:16 INFO - MultiFileLogger online at 20160118 11:01:16 in /builds/slave/test-pgo 11:01:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:01:16 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:01:16 INFO - {'append_to_log': False, 11:01:16 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:01:16 INFO - 'blob_upload_branch': 'Fx-Team', 11:01:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:01:16 INFO - 'branch': 'Fx-Team', 11:01:16 INFO - 'buildbot_json_path': 'buildprops.json', 11:01:16 INFO - 'config_files': ('talos/linux_config.py',), 11:01:16 INFO - 'default_actions': ('clobber', 11:01:16 INFO - 'read-buildbot-config', 11:01:16 INFO - 'download-and-extract', 11:01:16 INFO - 'populate-webroot', 11:01:16 INFO - 'create-virtualenv', 11:01:16 INFO - 'install', 11:01:16 INFO - 'run-tests'), 11:01:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:01:16 INFO - 'download_minidump_stackwalk': True, 11:01:16 INFO - 'download_symbols': 'ondemand', 11:01:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:01:16 INFO - 'tooltool.py': '/tools/tooltool.py', 11:01:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:01:16 INFO - '/tools/misc-python/virtualenv.py')}, 11:01:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:01:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:01:16 INFO - 'installer_path': 'installer.exe', 11:01:16 INFO - 'log_level': 'info', 11:01:16 INFO - 'log_name': 'talos', 11:01:16 INFO - 'log_to_console': True, 11:01:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:01:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:01:16 INFO - 'opt_config_files': (), 11:01:16 INFO - 'pip_index': False, 11:01:16 INFO - 'sps_profile': False, 11:01:16 INFO - 'sps_profile_interval': 0, 11:01:16 INFO - 'suite': 'dromaeojs', 11:01:16 INFO - 'system_bits': '32', 11:01:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:01:16 INFO - 'title': 'talos-linux64-ix-068', 11:01:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:01:16 INFO - 'use_talos_json': True, 11:01:16 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:01:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:01:16 INFO - 'work_dir': 'build'} 11:01:16 INFO - ##### 11:01:16 INFO - ##### Running clobber step. 11:01:16 INFO - ##### 11:01:16 INFO - Running pre-action listener: _resource_record_pre_action 11:01:16 INFO - Running main action method: clobber 11:01:16 INFO - rmtree: /builds/slave/test-pgo/build 11:01:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:01:16 INFO - Running post-action listener: _resource_record_post_action 11:01:16 INFO - ##### 11:01:16 INFO - ##### Running read-buildbot-config step. 11:01:16 INFO - ##### 11:01:16 INFO - Running pre-action listener: _resource_record_pre_action 11:01:16 INFO - Running main action method: read_buildbot_config 11:01:16 INFO - Using buildbot properties: 11:01:16 INFO - { 11:01:16 INFO - "project": "", 11:01:16 INFO - "product": "firefox", 11:01:16 INFO - "script_repo_revision": "production", 11:01:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:01:16 INFO - "repository": "", 11:01:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:01:16 INFO - "buildid": "20160118083134", 11:01:16 INFO - "pgo_build": "True", 11:01:16 INFO - "basedir": "/builds/slave/test-pgo", 11:01:16 INFO - "buildnumber": 899, 11:01:16 INFO - "slavename": "talos-linux64-ix-068", 11:01:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:01:16 INFO - "platform": "ubuntu64_hw", 11:01:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:01:16 INFO - "branch": "fx-team", 11:01:16 INFO - "repo_path": "integration/fx-team", 11:01:16 INFO - "revision": "eb1e9ec43a36fa7d64f973f0662103f3250acf75", 11:01:16 INFO - "stage_platform": "linux64-pgo", 11:01:16 INFO - "builduid": "1a402ba1099743eb8d40a9f32a69e6ea", 11:01:16 INFO - "slavebuilddir": "test" 11:01:16 INFO - } 11:01:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 11:01:16 INFO - Running post-action listener: _resource_record_post_action 11:01:16 INFO - ##### 11:01:16 INFO - ##### Running download-and-extract step. 11:01:16 INFO - ##### 11:01:16 INFO - Running pre-action listener: _resource_record_pre_action 11:01:16 INFO - Running main action method: download_and_extract 11:01:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:16 INFO - https://queue.taskcluster.net/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:01:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/artifacts/public/build/test_packages.json 11:01:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/artifacts/public/build/test_packages.json 11:01:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:01:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:01:21 INFO - Downloaded 1448 bytes. 11:01:21 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:01:21 INFO - Using the following test package requirements: 11:01:21 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:01:21 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:01:21 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:01:21 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:21 INFO - u'jsshell-linux-x86_64.zip'], 11:01:21 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:01:21 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:01:21 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:01:21 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:01:21 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:01:21 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:01:21 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:01:21 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:21 INFO - https://queue.taskcluster.net/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:01:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:01:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:01:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/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 11:01:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/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 11:01:25 INFO - Downloaded 22484168 bytes. 11:01:25 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'] 11:01:25 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 11:01:26 INFO - Return code: 0 11:01:26 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 11:01:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:26 INFO - https://queue.taskcluster.net/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:01:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:01:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:01:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/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 11:01:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/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 11:01:34 INFO - Downloaded 22484168 bytes. 11: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'] 11: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 11:01:35 INFO - Return code: 0 11: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')]} 11:01:35 INFO - https://queue.taskcluster.net/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:01:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:01:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:01:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/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 11:01:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/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 11:01:38 INFO - Downloaded 11132144 bytes. 11:01:38 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'] 11:01:38 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 11:01:38 INFO - Return code: 0 11:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:38 INFO - https://queue.taskcluster.net/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:01:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:01:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:01:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/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 11:01:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/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 11:01:41 INFO - Downloaded 55946383 bytes. 11:01:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:01:41 INFO - mkdir: /builds/slave/test-pgo/properties 11:01:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:01:41 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:01:41 INFO - Contents: 11:01:41 INFO - build_url:https://queue.taskcluster.net/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:01:41 INFO - Running post-action listener: _resource_record_post_action 11:01:41 INFO - Running post-action listener: set_extra_try_arguments 11:01:41 INFO - ##### 11:01:41 INFO - ##### Running populate-webroot step. 11:01:41 INFO - ##### 11:01:41 INFO - Running pre-action listener: _resource_record_pre_action 11:01:41 INFO - Running main action method: populate_webroot 11:01:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:01:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:01:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:01:41 INFO - '--tppagecycles', 11:01:41 INFO - '7'], 11:01:41 INFO - 'tests': ['tsvgm']}}, 11:01:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:01:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:01:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:01:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:01:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:01:41 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:01:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:01:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:41 INFO - 'talos_options': ['--e10s'], 11:01:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:01:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:41 INFO - 'tests': ['damp', 'tps']}, 11:01:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:41 INFO - 'talos_options': ['--e10s'], 11:01:41 INFO - 'tests': ['damp', 'tps']}, 11:01:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:01:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:01:41 INFO - 'other': {'tests': ['a11yr', 11:01:41 INFO - 'ts_paint', 11:01:41 INFO - 'tpaint', 11:01:41 INFO - 'sessionrestore', 11:01:41 INFO - 'sessionrestore_no_auto_restore']}, 11:01:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:01:41 INFO - 'tests': ['a11yr', 11:01:41 INFO - 'ts_paint', 11:01:41 INFO - 'tpaint', 11:01:41 INFO - 'sessionrestore', 11:01:41 INFO - 'sessionrestore_no_auto_restore']}, 11:01:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:01:41 INFO - 'tests': ['a11yr', 11:01:41 INFO - 'ts_paint', 11:01:41 INFO - 'tpaint', 11:01:41 INFO - 'sessionrestore', 11:01:41 INFO - 'sessionrestore_no_auto_restore']}, 11:01:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:01:41 INFO - 'tests': ['a11yr', 11:01:41 INFO - 'ts_paint', 11:01:41 INFO - 'tpaint', 11:01:41 INFO - 'sessionrestore', 11:01:41 INFO - 'sessionrestore_no_auto_restore']}, 11:01:41 INFO - 'other_l64': {'tests': ['a11yr', 11:01:41 INFO - 'ts_paint', 11:01:41 INFO - 'tpaint', 11:01:41 INFO - 'sessionrestore', 11:01:41 INFO - 'sessionrestore_no_auto_restore']}, 11:01:41 INFO - 'other_nol64': {'tests': ['a11yr', 11:01:41 INFO - 'ts_paint', 11:01:41 INFO - 'tpaint', 11:01:41 INFO - 'sessionrestore', 11:01:41 INFO - 'sessionrestore_no_auto_restore']}, 11:01:41 INFO - 'svgr': {'tests': ['tsvgx', 11:01:41 INFO - 'tsvgr_opacity', 11:01:41 INFO - 'tart', 11:01:41 INFO - 'tscrollx', 11:01:41 INFO - 'cart']}, 11:01:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:01:41 INFO - 'tests': ['tsvgx', 11:01:41 INFO - 'tsvgr_opacity', 11:01:41 INFO - 'tart', 11:01:41 INFO - 'tscrollx', 11:01:41 INFO - 'cart']}, 11:01:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:41 INFO - 'tests': ['tp5o']}, 11:01:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:41 INFO - 'talos_options': ['--e10s'], 11:01:41 INFO - 'tests': ['tp5o']}, 11:01:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:41 INFO - 'talos_options': ['--xperf_path', 11:01:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:01:41 INFO - 'tests': ['tp5n']}, 11:01:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:41 INFO - 'talos_options': ['--e10s', 11:01:41 INFO - '--xperf_path', 11:01:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:01:41 INFO - 'tests': ['tp5n']}}, 11:01:41 INFO - 'talos.zip': {'path': '', 11:01:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:01:41 INFO - Running post-action listener: _resource_record_post_action 11:01:41 INFO - ##### 11:01:41 INFO - ##### Running create-virtualenv step. 11:01:41 INFO - ##### 11:01:41 INFO - Running pre-action listener: _resource_record_pre_action 11:01:41 INFO - Running main action method: create_virtualenv 11:01:41 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:01:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 11:01:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:01:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:01:41 INFO - Using real prefix '/usr' 11:01:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:01:41 INFO - Installing distribute.............................................................................................................................................................................................done. 11:01:43 INFO - Installing pip.................done. 11:01:43 INFO - Return code: 0 11:01:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:43 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 0x7f065c1a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2751630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e2840>, '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 0x274f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274fb60>, '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': '97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295', '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 11:01:43 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 11:01:43 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 11:01:43 INFO - Using env: {'DISPLAY': ':0', 11:01:43 INFO - 'HOME': '/home/cltbld', 11:01:43 INFO - 'LANG': 'en_US.UTF-8', 11:01:43 INFO - 'LANGUAGE': 'en_US:en', 11:01:43 INFO - 'LOGNAME': 'cltbld', 11:01:43 INFO - 'MAIL': '/var/mail/cltbld', 11:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:43 INFO - 'MOZ_NO_REMOTE': '1', 11:01:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:43 INFO - 'NO_EM_RESTART': '1', 11:01:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:43 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:43 INFO - 'SHELL': '/bin/bash', 11:01:43 INFO - 'SHLVL': '1', 11:01:43 INFO - 'TERM': 'linux', 11:01:43 INFO - 'TMOUT': '86400', 11:01:43 INFO - 'USER': 'cltbld', 11:01:43 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295', 11:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:43 INFO - '_': '/tools/buildbot/bin/python'} 11:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:43 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 11:01:43 INFO - Cleaning up... 11:01:43 INFO - Return code: 0 11:01:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:43 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 0x7f065c1a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2751630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e2840>, '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 0x274f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274fb60>, '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': '97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295', '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 11:01:43 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 11:01:43 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 11:01:43 INFO - Using env: {'DISPLAY': ':0', 11:01:43 INFO - 'HOME': '/home/cltbld', 11:01:43 INFO - 'LANG': 'en_US.UTF-8', 11:01:43 INFO - 'LANGUAGE': 'en_US:en', 11:01:43 INFO - 'LOGNAME': 'cltbld', 11:01:43 INFO - 'MAIL': '/var/mail/cltbld', 11:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:43 INFO - 'MOZ_NO_REMOTE': '1', 11:01:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:43 INFO - 'NO_EM_RESTART': '1', 11:01:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:43 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:43 INFO - 'SHELL': '/bin/bash', 11:01:43 INFO - 'SHLVL': '1', 11:01:43 INFO - 'TERM': 'linux', 11:01:43 INFO - 'TMOUT': '86400', 11:01:43 INFO - 'USER': 'cltbld', 11:01:43 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295', 11:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:43 INFO - '_': '/tools/buildbot/bin/python'} 11:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:44 INFO - Downloading/unpacking psutil>=0.7.1 11:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:45 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 11:01:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:01:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:01:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:01:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:01:46 INFO - Installing collected packages: psutil 11:01:46 INFO - Running setup.py install for psutil 11:01:46 INFO - building 'psutil._psutil_linux' extension 11:01:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:01:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:01:46 INFO - building 'psutil._psutil_posix' extension 11:01:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:01:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:01:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:01:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:01:46 INFO - Successfully installed psutil 11:01:46 INFO - Cleaning up... 11:01:46 INFO - Return code: 0 11:01:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:46 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 0x7f065c1a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2751630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e2840>, '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 0x274f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274fb60>, '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': '97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295', '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 11:01:46 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 11:01:46 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 11:01:46 INFO - Using env: {'DISPLAY': ':0', 11:01:46 INFO - 'HOME': '/home/cltbld', 11:01:46 INFO - 'LANG': 'en_US.UTF-8', 11:01:46 INFO - 'LANGUAGE': 'en_US:en', 11:01:46 INFO - 'LOGNAME': 'cltbld', 11:01:46 INFO - 'MAIL': '/var/mail/cltbld', 11:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:46 INFO - 'MOZ_NO_REMOTE': '1', 11:01:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:46 INFO - 'NO_EM_RESTART': '1', 11:01:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:46 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:46 INFO - 'SHELL': '/bin/bash', 11:01:46 INFO - 'SHLVL': '1', 11:01:46 INFO - 'TERM': 'linux', 11:01:46 INFO - 'TMOUT': '86400', 11:01:46 INFO - 'USER': 'cltbld', 11:01:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295', 11:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:46 INFO - '_': '/tools/buildbot/bin/python'} 11:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:01:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:01:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:01:48 INFO - Installing collected packages: mozsystemmonitor 11:01:48 INFO - Running setup.py install for mozsystemmonitor 11:01:48 INFO - Successfully installed mozsystemmonitor 11:01:48 INFO - Cleaning up... 11:01:48 INFO - Return code: 0 11:01:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:48 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 0x7f065c1a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2751630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e2840>, '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 0x274f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274fb60>, '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': '97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295', '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 11:01:48 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 11:01:48 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 11:01:48 INFO - Using env: {'DISPLAY': ':0', 11:01:48 INFO - 'HOME': '/home/cltbld', 11:01:48 INFO - 'LANG': 'en_US.UTF-8', 11:01:48 INFO - 'LANGUAGE': 'en_US:en', 11:01:48 INFO - 'LOGNAME': 'cltbld', 11:01:48 INFO - 'MAIL': '/var/mail/cltbld', 11:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:48 INFO - 'MOZ_NO_REMOTE': '1', 11:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:48 INFO - 'NO_EM_RESTART': '1', 11:01:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:48 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:48 INFO - 'SHELL': '/bin/bash', 11:01:48 INFO - 'SHLVL': '1', 11:01:48 INFO - 'TERM': 'linux', 11:01:48 INFO - 'TMOUT': '86400', 11:01:48 INFO - 'USER': 'cltbld', 11:01:48 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295', 11:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:48 INFO - '_': '/tools/buildbot/bin/python'} 11:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:48 INFO - Downloading/unpacking blobuploader==1.2.4 11: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 11: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 11: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 11: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 11: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 11: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 11:01:50 INFO - Downloading blobuploader-1.2.4.tar.gz 11:01:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:01:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:01:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11: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 11: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 11: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 11: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 11: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 11: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 11:01:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:01:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:01:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:51 INFO - Downloading docopt-0.6.1.tar.gz 11:01:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:01:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:01:51 INFO - Installing collected packages: blobuploader, requests, docopt 11:01:51 INFO - Running setup.py install for blobuploader 11:01:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:01:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:01:51 INFO - Running setup.py install for requests 11:01:51 INFO - Running setup.py install for docopt 11:01:51 INFO - Successfully installed blobuploader requests docopt 11:01:51 INFO - Cleaning up... 11:01:51 INFO - Return code: 0 11:01:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:01:51 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')]} 11:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:51 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')]} 11:01:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:51 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 0x7f065c1a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2751630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e2840>, '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 0x274f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274fb60>, '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': '97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295', '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 11:01:51 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 11:01:51 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 11:01:51 INFO - Using env: {'DISPLAY': ':0', 11:01:51 INFO - 'HOME': '/home/cltbld', 11:01:51 INFO - 'LANG': 'en_US.UTF-8', 11:01:51 INFO - 'LANGUAGE': 'en_US:en', 11:01:51 INFO - 'LOGNAME': 'cltbld', 11:01:51 INFO - 'MAIL': '/var/mail/cltbld', 11:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:51 INFO - 'MOZ_NO_REMOTE': '1', 11:01:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:51 INFO - 'NO_EM_RESTART': '1', 11:01:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:51 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:51 INFO - 'SHELL': '/bin/bash', 11:01:51 INFO - 'SHLVL': '1', 11:01:51 INFO - 'TERM': 'linux', 11:01:51 INFO - 'TMOUT': '86400', 11:01:51 INFO - 'USER': 'cltbld', 11:01:51 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295', 11:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:51 INFO - '_': '/tools/buildbot/bin/python'} 11:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:01:52 INFO - Running setup.py (path:/tmp/pip-VNcaBY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:01:52 INFO - Running setup.py (path:/tmp/pip-X4TuNi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:01:52 INFO - Running setup.py (path:/tmp/pip-cf6MV7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:01:52 INFO - Running setup.py (path:/tmp/pip-RAuFRl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:01:52 INFO - Running setup.py (path:/tmp/pip-AJ94Qh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:01:52 INFO - Running setup.py (path:/tmp/pip-kcw_2X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:01:52 INFO - Running setup.py (path:/tmp/pip-zv3Dtn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:01:52 INFO - Running setup.py (path:/tmp/pip-bvYK6w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:01:52 INFO - Running setup.py (path:/tmp/pip-i0cNjg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:01:52 INFO - Running setup.py (path:/tmp/pip-_Ztf7c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:01:52 INFO - Running setup.py (path:/tmp/pip-FjSxlq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:01:52 INFO - Running setup.py (path:/tmp/pip-DOPQzN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:01:53 INFO - Running setup.py (path:/tmp/pip-jJrq5_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:01:53 INFO - Running setup.py (path:/tmp/pip-xtSlny-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:01:53 INFO - Running setup.py (path:/tmp/pip-GmGorT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:01:53 INFO - Running setup.py (path:/tmp/pip-2ZP8HF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:01:53 INFO - Running setup.py (path:/tmp/pip-5eRNaG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:01:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:01:53 INFO - Running setup.py install for manifestparser 11:01:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:01:53 INFO - Running setup.py install for mozcrash 11:01:53 INFO - Running setup.py install for mozdebug 11:01:53 INFO - Running setup.py install for mozdevice 11:01:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:01:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:01:53 INFO - Running setup.py install for mozfile 11:01:53 INFO - Running setup.py install for mozhttpd 11:01:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:01:53 INFO - Running setup.py install for mozinfo 11:01:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:01:54 INFO - Running setup.py install for mozInstall 11:01:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:01:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:01:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:01:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:01:54 INFO - Running setup.py install for mozleak 11:01:54 INFO - Running setup.py install for mozlog 11:01:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:01:54 INFO - Running setup.py install for moznetwork 11:01:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:01:54 INFO - Running setup.py install for mozprocess 11:01:54 INFO - Running setup.py install for mozprofile 11:01:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:01:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:01:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:01:54 INFO - Running setup.py install for mozrunner 11:01:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:01:54 INFO - Running setup.py install for mozscreenshot 11:01:54 INFO - Running setup.py install for moztest 11:01:55 INFO - Running setup.py install for mozversion 11:01:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:01:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:01:55 INFO - Cleaning up... 11:01:55 INFO - Return code: 0 11:01:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11: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')]} 11:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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')]} 11:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:55 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 0x7f065c1a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2751630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e2840>, '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 0x274f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274fb60>, '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': '97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295', '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 11:01:55 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 11:01:55 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 11:01:55 INFO - Using env: {'DISPLAY': ':0', 11:01:55 INFO - 'HOME': '/home/cltbld', 11:01:55 INFO - 'LANG': 'en_US.UTF-8', 11:01:55 INFO - 'LANGUAGE': 'en_US:en', 11:01:55 INFO - 'LOGNAME': 'cltbld', 11:01:55 INFO - 'MAIL': '/var/mail/cltbld', 11:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:55 INFO - 'MOZ_NO_REMOTE': '1', 11:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:55 INFO - 'NO_EM_RESTART': '1', 11:01:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:55 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:55 INFO - 'SHELL': '/bin/bash', 11:01:55 INFO - 'SHLVL': '1', 11:01:55 INFO - 'TERM': 'linux', 11:01:55 INFO - 'TMOUT': '86400', 11:01:55 INFO - 'USER': 'cltbld', 11:01:55 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295', 11:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:55 INFO - '_': '/tools/buildbot/bin/python'} 11:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:01:55 INFO - Running setup.py (path:/tmp/pip-Rwv1yH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 11:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:01:55 INFO - Running setup.py (path:/tmp/pip-RXhMMO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:01:55 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)) 11:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:01:55 INFO - Running setup.py (path:/tmp/pip-bVQBHu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:01:55 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)) 11:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:01:55 INFO - Running setup.py (path:/tmp/pip-dnKo4n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:01:55 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)) 11:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:01:55 INFO - Running setup.py (path:/tmp/pip-TpA1IQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:01:55 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)) 11:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:01:55 INFO - Running setup.py (path:/tmp/pip-jXzUCr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:01:55 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)) 11:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:01:55 INFO - Running setup.py (path:/tmp/pip-g1Nws4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:01:55 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)) 11:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:01:55 INFO - Running setup.py (path:/tmp/pip-6Aithr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:01:55 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)) 11:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:01:55 INFO - Running setup.py (path:/tmp/pip-pswuNy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 11:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:01:56 INFO - Running setup.py (path:/tmp/pip-hB1dBV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:01:56 INFO - Running setup.py (path:/tmp/pip-8gCFmw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 11:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:01:56 INFO - Running setup.py (path:/tmp/pip-7bSwUQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 11:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:01:56 INFO - Running setup.py (path:/tmp/pip-Mn4MF7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 11:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:01:56 INFO - Running setup.py (path:/tmp/pip-TplEUv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 11:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:01:56 INFO - Running setup.py (path:/tmp/pip-r22XGN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:01:56 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)) 11:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:01:56 INFO - Running setup.py (path:/tmp/pip-da2dfQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:01:56 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)) 11:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:01:56 INFO - Running setup.py (path:/tmp/pip-hTSihW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:01:56 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)) 11:01:56 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)) 11:01:56 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)) 11:01:56 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)) 11:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:01:56 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)) 11:01:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:58 INFO - Downloading blessings-1.5.1.tar.gz 11:01:58 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 11:01:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:01:58 INFO - Installing collected packages: blessings 11:01:58 INFO - Running setup.py install for blessings 11:01:58 INFO - Successfully installed blessings 11:01:58 INFO - Cleaning up... 11:01:58 INFO - Return code: 0 11:01:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:01:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:01:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:01:58 INFO - Reading from file tmpfile_stdout 11:01:58 INFO - Current package versions: 11:01:58 INFO - argparse == 1.2.1 11:01:58 INFO - blessings == 1.5.1 11:01:58 INFO - blobuploader == 1.2.4 11:01:58 INFO - docopt == 0.6.1 11:01:58 INFO - manifestparser == 1.1 11:01:58 INFO - mozInstall == 1.12 11:01:58 INFO - mozcrash == 0.16 11:01:58 INFO - mozdebug == 0.1 11:01:58 INFO - mozdevice == 0.48 11:01:58 INFO - mozfile == 1.2 11:01:58 INFO - mozhttpd == 0.7 11:01:58 INFO - mozinfo == 0.9 11:01:58 INFO - mozleak == 0.1 11:01:58 INFO - mozlog == 3.1 11:01:58 INFO - moznetwork == 0.27 11:01:58 INFO - mozprocess == 0.22 11:01:58 INFO - mozprofile == 0.28 11:01:58 INFO - mozrunner == 6.11 11:01:58 INFO - mozscreenshot == 0.1 11:01:58 INFO - mozsystemmonitor == 0.0 11:01:58 INFO - moztest == 0.7 11:01:58 INFO - mozversion == 1.4 11:01:58 INFO - psutil == 3.1.1 11:01:58 INFO - requests == 1.2.3 11:01:58 INFO - wsgiref == 0.1.2 11:01:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:58 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 0x7f065c1a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2751630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e2840>, '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 0x274f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274fb60>, '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': '97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295', '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 11:01:58 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 11:01:58 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 11:01:58 INFO - Using env: {'DISPLAY': ':0', 11:01:58 INFO - 'HOME': '/home/cltbld', 11:01:58 INFO - 'LANG': 'en_US.UTF-8', 11:01:58 INFO - 'LANGUAGE': 'en_US:en', 11:01:58 INFO - 'LOGNAME': 'cltbld', 11:01:58 INFO - 'MAIL': '/var/mail/cltbld', 11:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:58 INFO - 'MOZ_NO_REMOTE': '1', 11:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:58 INFO - 'NO_EM_RESTART': '1', 11:01:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:58 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:58 INFO - 'SHELL': '/bin/bash', 11:01:58 INFO - 'SHLVL': '1', 11:01:58 INFO - 'TERM': 'linux', 11:01:58 INFO - 'TMOUT': '86400', 11:01:58 INFO - 'USER': 'cltbld', 11:01:58 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295', 11:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:58 INFO - '_': '/tools/buildbot/bin/python'} 11:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:58 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)) 11:01:58 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)) 11:01:58 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)) 11:01:58 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)) 11:01:58 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)) 11:01:58 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)) 11:01:58 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)) 11:01:58 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)) 11:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 11:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 11:01:59 INFO - Cleaning up... 11:01:59 INFO - Return code: 0 11:01:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11: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')]} 11:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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')]} 11:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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', '--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 0x7f065c1a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2751630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e2840>, '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 0x274f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274fb60>, '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': '97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295', '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 11: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', '--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 11: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 --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 11:01:59 INFO - Using env: {'DISPLAY': ':0', 11:01:59 INFO - 'HOME': '/home/cltbld', 11:01:59 INFO - 'LANG': 'en_US.UTF-8', 11:01:59 INFO - 'LANGUAGE': 'en_US:en', 11:01:59 INFO - 'LOGNAME': 'cltbld', 11:01:59 INFO - 'MAIL': '/var/mail/cltbld', 11:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:59 INFO - 'MOZ_NO_REMOTE': '1', 11:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:59 INFO - 'NO_EM_RESTART': '1', 11:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:59 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:59 INFO - 'SHELL': '/bin/bash', 11:01:59 INFO - 'SHLVL': '1', 11:01:59 INFO - 'TERM': 'linux', 11:01:59 INFO - 'TMOUT': '86400', 11:01:59 INFO - 'USER': 'cltbld', 11:01:59 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295', 11:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:59 INFO - '_': '/tools/buildbot/bin/python'} 11:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:59 INFO - Downloading/unpacking jsonschema 11:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:02:00 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 11:02:00 INFO - Downloading/unpacking functools32 (from jsonschema) 11: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 11: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 11: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 11: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 11: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 11: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 11:02:01 INFO - Downloading functools32-3.2.3-2.tar.gz 11:02:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:02:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:02:01 INFO - warning: no files found matching '*.txt' 11:02:01 INFO - no previously-included directories found matching 'build' 11:02:01 INFO - no previously-included directories found matching 'dist' 11:02:01 INFO - no previously-included directories found matching '.git*' 11:02:01 INFO - Installing collected packages: jsonschema, functools32 11:02:01 INFO - Running setup.py install for functools32 11:02:01 INFO - warning: no files found matching '*.txt' 11:02:01 INFO - no previously-included directories found matching 'build' 11:02:01 INFO - no previously-included directories found matching 'dist' 11:02:01 INFO - no previously-included directories found matching '.git*' 11:02:01 INFO - Successfully installed jsonschema functools32 11:02:01 INFO - Cleaning up... 11:02:01 INFO - Return code: 0 11:02:01 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:02:01 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')]} 11:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:01 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')]} 11:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:01 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 0x7f065c1a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2751630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e2840>, '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 0x274f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274fb60>, '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': '97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295', '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 11:02:01 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 11:02:01 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 11:02:01 INFO - Using env: {'DISPLAY': ':0', 11:02:01 INFO - 'HOME': '/home/cltbld', 11:02:01 INFO - 'LANG': 'en_US.UTF-8', 11:02:01 INFO - 'LANGUAGE': 'en_US:en', 11:02:01 INFO - 'LOGNAME': 'cltbld', 11:02:01 INFO - 'MAIL': '/var/mail/cltbld', 11:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:01 INFO - 'MOZ_NO_REMOTE': '1', 11:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:01 INFO - 'NO_EM_RESTART': '1', 11:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:02:01 INFO - 'PWD': '/builds/slave/test-pgo', 11:02:01 INFO - 'SHELL': '/bin/bash', 11:02:01 INFO - 'SHLVL': '1', 11:02:01 INFO - 'TERM': 'linux', 11:02:01 INFO - 'TMOUT': '86400', 11:02:01 INFO - 'USER': 'cltbld', 11:02:01 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295', 11:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:01 INFO - '_': '/tools/buildbot/bin/python'} 11:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:01 INFO - Downloading/unpacking flake8 11:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:02:03 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 11:02:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11: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 11: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 11: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 11: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 11: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 11: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 11:02:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:02:03 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 11:02:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11: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 11: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 11: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 11: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 11: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 11: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 11:02:03 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 11:02:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11: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 11: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 11: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 11: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 11: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 11: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 11:02:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:02:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:02:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:02:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:02:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:02:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:02:03 INFO - no previously-included directories found matching 'docs/_build' 11:02:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:02:04 INFO - Running setup.py install for pep8 11:02:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:02:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:02:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:02:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:02:04 INFO - no previously-included directories found matching 'docs/_build' 11:02:04 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:02:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:02:04 INFO - Cleaning up... 11:02:04 INFO - Return code: 0 11:02:04 INFO - Running post-action listener: _resource_record_post_action 11:02:04 INFO - Running post-action listener: _start_resource_monitoring 11:02:04 INFO - Starting resource monitoring. 11:02:04 INFO - ##### 11:02:04 INFO - ##### Running install step. 11:02:04 INFO - ##### 11:02:04 INFO - Running pre-action listener: _resource_record_pre_action 11:02:04 INFO - Running main action method: install 11:02:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:02:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:02:04 INFO - Reading from file tmpfile_stdout 11:02:04 INFO - Detecting whether we're running mozinstall >=1.0... 11:02:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:02:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:02:04 INFO - Reading from file tmpfile_stdout 11:02:04 INFO - Output received: 11:02:04 INFO - Usage: mozinstall [options] installer 11:02:04 INFO - Options: 11:02:04 INFO - -h, --help show this help message and exit 11:02:04 INFO - -d DEST, --destination=DEST 11:02:04 INFO - Directory to install application into. [default: 11:02:04 INFO - "/builds/slave/test-pgo"] 11:02:04 INFO - --app=APP Application being installed. [default: firefox] 11:02:04 INFO - mkdir: /builds/slave/test-pgo/build/application 11:02:04 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'] 11:02:04 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 11:02:20 INFO - Reading from file tmpfile_stdout 11:02:20 INFO - Output received: 11:02:20 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:02:20 INFO - Running post-action listener: _resource_record_post_action 11:02:20 INFO - ##### 11:02:20 INFO - ##### Running run-tests step. 11:02:20 INFO - ##### 11:02:20 INFO - Running pre-action listener: _resource_record_pre_action 11:02:20 INFO - Running main action method: run_tests 11:02:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:02:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:02:20 INFO - Python 2.7.3 11:02:20 INFO - Return code: 0 11:02:20 INFO - grabbing minidump binary from tooltool 11:02:20 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')]} 11:02:20 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 0x27e2840>, '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 0x274f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274fb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:02:20 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 11:02:20 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 11:02:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:02:20 INFO - Return code: 0 11:02:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:02:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:02:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:02:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:02:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:02:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:02:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:02:21 INFO - Return code: 0 11:02:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 11:02:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 11:02:21 INFO - Using env: {'DISPLAY': ':0', 11:02:21 INFO - 'HOME': '/home/cltbld', 11:02:21 INFO - 'LANG': 'en_US.UTF-8', 11:02:21 INFO - 'LANGUAGE': 'en_US:en', 11:02:21 INFO - 'LOGNAME': 'cltbld', 11:02:21 INFO - 'MAIL': '/var/mail/cltbld', 11:02:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:02:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:21 INFO - 'MOZ_NO_REMOTE': '1', 11:02:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:02:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:21 INFO - 'NO_EM_RESTART': '1', 11:02:21 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:02:21 INFO - 'PWD': '/builds/slave/test-pgo', 11:02:21 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:02:21 INFO - 'SHELL': '/bin/bash', 11:02:21 INFO - 'SHLVL': '1', 11:02:21 INFO - 'TERM': 'linux', 11:02:21 INFO - 'TMOUT': '86400', 11:02:21 INFO - 'USER': 'cltbld', 11:02:21 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295', 11:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:21 INFO - '_': '/tools/buildbot/bin/python'} 11:02:21 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:02:21 INFO - mozversion application_buildid: 20160118083134 11:02:21 INFO - mozversion application_changeset: eb1e9ec43a36fa7d64f973f0662103f3250acf75 11:02:21 INFO - mozversion application_display_name: Nightly 11:02:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:02:21 INFO - mozversion application_name: Firefox 11:02:21 INFO - mozversion application_remotingname: firefox 11:02:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:02:21 INFO - mozversion application_vendor: Mozilla 11:02:21 INFO - mozversion application_version: 46.0a1 11:02:21 INFO - mozversion platform_buildid: 20160118083134 11:02:21 INFO - mozversion platform_changeset: eb1e9ec43a36fa7d64f973f0662103f3250acf75 11:02:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:02:21 INFO - mozversion platform_version: 46.0a1 11:02:21 INFO - using testdate: 1453143741 11:02:21 INFO - actual date: 1453143741 11:02:21 INFO - starting webserver on 'localhost:45419' 11:02:21 INFO - SUITE-START | Running 3 tests 11:02:21 INFO - TEST-START | dromaeo_css 11:02:21 INFO - operating with platform_type : linux_ 11:02:21 INFO - Initialising browser for dromaeo_css test... 11:02:21 INFO - TEST-INFO | started process 24758 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp55wAbT/profile http://localhost:45419/getInfo.html) 11:02:26 INFO - PROCESS | 24758 | __metrics Screen width/height:1600/1200 11:02:26 INFO - PROCESS | 24758 | colorDepth:24 11:02:26 INFO - PROCESS | 24758 | Browser inner width/height: 1024/697 11:02:26 INFO - PROCESS | 24758 | __metrics 11:02:26 INFO - PROCESS | 24758 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:02:26 INFO - PROCESS | 24758 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:02:27 INFO - TEST-INFO | 24758: exit 0 11:02:27 INFO - Browser initialized. 11:02:27 INFO - Running cycle 1/1 for dromaeo_css test... 11:02:27 INFO - TEST-INFO | started process 24851 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp55wAbT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:02:39 INFO - PROCESS | 24851 | RSS: Main: 149848064 11:02:39 INFO - PROCESS | 24851 | 11:03:31 INFO - PROCESS | 24851 | 1453143811021 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] 11:05:38 INFO - PROCESS | 24851 | Cycle 1(1): loaded http://localhost:45419/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45419/tests/dromaeo/cssquery-ext.html) 11:05:40 INFO - PROCESS | 24851 | RSS: Main: 272560128 11:05:40 INFO - PROCESS | 24851 | 11:08:42 INFO - PROCESS | 24851 | Cycle 1(1): loaded http://localhost:45419/tests/dromaeo/cssquery-ext.html (next: http://localhost:45419/tests/dromaeo/cssquery-jquery.html) 11:08:43 INFO - PROCESS | 24851 | RSS: Main: 233431040 11:08:43 INFO - PROCESS | 24851 | 11:11:45 INFO - PROCESS | 24851 | Cycle 1(1): loaded http://localhost:45419/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45419/tests/dromaeo/cssquery-mootools.html) 11:11:45 INFO - PROCESS | 24851 | RSS: Main: 242655232 11:11:45 INFO - PROCESS | 24851 | 11:14:47 INFO - PROCESS | 24851 | Cycle 1(1): loaded http://localhost:45419/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45419/tests/dromaeo/cssquery-prototype.html) 11:14:48 INFO - PROCESS | 24851 | RSS: Main: 211587072 11:14:48 INFO - PROCESS | 24851 | 11:17:50 INFO - PROCESS | 24851 | Cycle 1(1): loaded http://localhost:45419/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45419/tests/dromaeo/cssquery-yui.html) 11:17:51 INFO - PROCESS | 24851 | RSS: Main: 212922368 11:17:51 INFO - PROCESS | 24851 | 11:20:53 INFO - PROCESS | 24851 | Cycle 1(1): loaded http://localhost:45419/tests/dromaeo/cssquery-yui.html (next: http://localhost:45419/tests/dromaeo/cssquery-dojo.html) 11:20:54 INFO - PROCESS | 24851 | RSS: Main: 232857600 11:20:54 INFO - PROCESS | 24851 | 11:20:54 INFO - PROCESS | 24851 | __start_tp_report 11:20:54 INFO - PROCESS | 24851 | _x_x_mozilla_page_load 11:20:54 INFO - PROCESS | 24851 | _x_x_mozilla_page_load_details 11:20:54 INFO - PROCESS | 24851 | |i|pagename|runs| 11:20:54 INFO - PROCESS | 24851 | |0;dojo.html;3085.737712294455;3108.9378212435768;3149.2126968257935;3151.43274210642;3176.34884848606;4899.657024008312;4983.103041452537;5025.773840177191;5038.269450929618;5070.391553013639;4953.752312384385;4979.950200497994;5041.445441001496;5107.412647545533;5110.974445127769;4548;4554.886127846806;4600.217962946307;4673.135469938055;4697.318888761128;4580.175568397687;4696.506866778973;4701.036287561059;4719.976400117995;4728.881777955561;4582.633389328846;4628.282616194495;4658.906821863544;4705.741184234866;4750.3349531065505;4562.498125206224;4584.289435137559;4604.37840891482;4622.121796858586;4630.930536041962;4590.3344015117955;4591.885202869921;4593.356930029765;4610.608098311614;4634.3048542718525;4807.831725889577;4860.270959356089;4862.927056094161;4887.218045112765;4922.409310882717;5336.91994620081;5378.058839703036;5379.112446446332;5381.48875856793;5428.212909128154;5429.837104886859;5444.564434845203;5448.182772584105;5451.454854514556;5461.15352120422;4956.504349565051;5054.69671819692;5072.34059572257;5105.999999999963;5165.070287348313;5482.80810171642;5497.5601951843755;5501;5507.201455788968;5519.116941289455;5287.788488460418;5295.973520132375;5296.09966305729;5296.867578310496;5350.705711185844;5264.947350526522;5331.386890507563;5360.222767698662;5377.677339359573;5418.91871621926;5286.62993590445;5338.252644629755;5340.706261155674;5344.198370244494;5344.3853956795465;5336.146216605324;5336.386315573759;5345.572354211654;5349.1976203569;5385.165299378603;4166.7708276045105;4210.179015092028;4243.8090285937205;4265.253580623441;4266.957330426656;3751.5685696144747;3784.394496880486;3790.6967442604528;3823.655870971626;3823.713221508398;5033.874153146201;5034.572061374751;5040.243963405518;5041.949580504222;5045.192769156917;5313.203019547099;5364.329458817648;5399.676019438846;5428.077226871442;5477.4796394342475;4999.850004499871;5006.224035274538;5021.046001259822;5023.547880690755;5067.721275329893;4571.131485017836;4626.722396656144;4633.0039041606215;4638.814447422133;4675.158471475167;5553.389127196006;5609.551235901118;5620.241267428926;5643.5203007743985;5707.942920570824;5399.730013499231;5407.78368865241;5412.43169467216;5417.83746487606;5418.485243901823;5461.590380721541;5557.221988921473;5616.747246373841;5630.19197901339;5665.065264231355;5275.419703832498;5288.312519372457;5327.520523152934;5357.383900851296;5376.086065368819;5397.217403476396;5413.7834486620095;5433.809816656398;5459.4540545946675;5469;5245.475452454724;5320.574354051744;5336.039512887717;5336.17289320156;5364.168553874156;5198.532132108128;5229.660072095302;5237.292965449616;5257.684538927677;5266.473352664703;5134.998675258289;5144.562712169508;5147.9227811582105;5153.0466863630345;5159;5193.636445448933;5236.633435659467;5242.16125419931;5247.081760691787;5339.572834173335;5111.923321150261;5150.4592017837585;5172.508611681884;5185.585153187661;5215.843524694265 11:20:54 INFO - PROCESS | 24851 | |1;ext.html;543.9156930675745;552.8313864271397;561.4750208555;566.5241197394188;568.5820921622607;28416.289592760193;29083;35512;36212.45681314776;36221.456678149785;42388.364174537404;42903.138717515416;42924;42936.78531607338;42939.785301073454;8561.486310821356;8698.91263592051;8758.211760941515;8762.079981601935;8770.780730481758;8528.061913189544;8655.69705060323;8656.394052416334;8670.783230419227;8682.218600325969;8624.956875215616;8626.784330391727;8683.435576687527;8713.825723485526;8725;8578;8637.827243455096;8664.436811607226;8668.8699669505;8671.696490622799;8468.195521425454;8563.100874408223;8607.784805379853;8622.180892815235;8623.870641940375;38976.61023389787;39378.21243575141;39581.20837583232;39633;39642.80178599089;3196.8881089162;3255.96744032559;3302.554155189043;3338.7162091222276;3859.1702783901596;30047.69952300471;30155.547666785016;30313.393732125456;30410.695893041007;31053.534196987064;3740.9064773380883;3818.4081467372603;3891.630295121959;3908.468679219103;3951.822168002418;277818;280700;281861;282773;283225;49165;50360.49639503558;54880.72559637176;56374.43625563774;57624;51762.741186293824;51848.481515184365;52211;52225.7388713054;52248;12500.68748281282;12657.240565566095;12687.809682854764;12709.110362274738;12715.173513721578;9728.075832795874;9763.560639771227;10197.694069177936;10299.742506437398;10578.788424231472;17873.910630447026;17989.640207195782;18013.369532066314;18021.27914883416;18096.18567164481;7301.707931682673;7392.926070739331;7518.473706840578;7538;7543.660535275926;888.9066648001996;972.8686627305365;983.5623147699205;1014.5992333028413;1063.361982810323;28227;28546.571801422997;28670.71329286722;29028.709712903023;29029.41941161207;1007.8185926533148;1012.2357619997002;1038.3925403638955;1105.8949399807007;1119.9496022678836;14798.186099764616;14881.553553393416;14921.328540215716;15143.772843407358;15159.09045457254;324457;330321;330840;330946;331285;50736.49263507391;50953.23570146451;51016;51048.489515104375;51064.74467627638;1277.0932637827248;1288.2141893444991;1289.1040726694857;1289.4390939941156;1314.80277958307;26759.464810704067;27552.58671119975;28198.71801282043;28308.85845570759;30025.5496167562;47175.292370615156;47316.52683473121;47504.2874356878;47578.76210618925;47750;245005;385874;388050;390522;398674;30735.2316192097;30832.53751193689;30926.536101958038;30959.845200773852;31282.843585781924;42643.3603495954;43219.78390108029;43398.78300608477;44018.33972490351;44536.77731611321;35371.82314088413;35905;36348.818255908554;36545.634543654225;36793.26413471662;32614.34771304608;35186.64813351936;35237.94286171419;36192.457113142795;36520.26959460849;34121.48817767785;34246.657533424346;35095.47356789599;35100.64899351076;35108;29777;32125.35749285048;32148.196295091875;32236.677633224306;32545.674543254263;24247.757522425254;24430.63354049655;24476.877615611807;24912.37719057038;24913.50172996566 11:20:54 INFO - PROCESS | 24851 | |2;jquery.html;343.4950622584801;345.6111874141591;347.93563190809687;347.94432890737477;351.37806083232664;13208.471661133568;13662.726745465085;15449.227538623067;15697.450589229366;17417.564560885985;10004.59981600735;10091.69724908254;10316.535755890984;13343.733125337487;13723;4425.468943726749;4960.33035540201;4962.6526143169995;4969.652124351297;5176.378834539842;3793.279276937387;3859.4982652255308;5287.41838397776;5304.310439642841;5528.806491772789;5270.235815806705;5486.972565137189;5497.780088796443;5508.862278443051;5530.308711411074;5567.777288908439;5574.331080270353;5585.3297604287545;5604.915926261109;5615.634983726065;5262.394824595182;5290.100682883881;5370.865728356823;5392.91910621341;5395.163749618815;19536.902315488333;19772;20104.095315710827;20395.79604203954;20404.387868363974;2092.7593326767465;2121.9151233950624;2138.561594873063;2173.793489618484;2262.8868556572106;9382.577783999737;9905.257105717028;11457.484413201342;12805.743885122245;12972.416241269166;1759.4545690835882;1831.8076601956868;1864.9160787764583;1934.9226030958744;1968.5767559974531;54599.727001364736;57630.7118464405;57961;58328.12507812386;58534.414655853325;9707.223422126213;9912.702618921443;10078.244131690153;10098.545565449573;10183.54174062169;13402.262875541745;13458.596242112557;13472.5284615038;13497.055206135672;13498.59504214875;7265.745698900513;7270.054892863894;7271.3455788979245;7326.67029983652;7330.193678695339;6986.9650651746415;7000;7048.118985126859;7056.6118863463;7078.964605177044;3771.981140094282;4346.47842258931;4411.647068234533;4428.446444194476;4459.1973444779605;1719.552916241761;1720.1657196259805;1781.732740088971;1796.514940965958;1803.73845792362;841.8532741509127;884.4560595233885;886.9512176830336;948.9098535639104;987.7728122531714;12842.9357853212;15169.469068582546;15929.68140637204;16216.59458513523;16354.918225408797;913.4747520175792;921.9953900230456;922.7599181759803;928.5635751196927;940.8494640857567;9290.349675522648;9389.38968967015;9394.718158455258;9566.952165239269;9578.233741300679;543143;544950;545148;566025;567402.4889626659;70617;71901;72636.63681681664;73357.26642733612;75254.24745752582;1070.5824728355947;1077.956881724738;1084.6095405653957;1087.8259478483405;1092.7432053467428;14689.41242350294;14753.336099875745;14756.63108422298;14772;15011.174385408907;33305.83347083249;33662.18863699964;33932.98201053972;34154.48768268528;34168.82915585406;43372.56627433685;44393.778031109636;44646.553534465536;46527;47496.287555687384;6811.659417029228;6908.585484870924;6923.688434020381;6965.47758918073;7025.859482810418;9000.63997440095;10203.285769996326;10300.484975751033;10334.86316505199;10462.110720588835;8791.472511649321;8932.017478077276;8949.418287811272;9164.95417522908;9310.487923164292;7344.669489872862;9295.860562091439;9659.178969787366;9724.222062235145;9826.754331141492;9196.26429885621;9520.66677666306;9770.658026969022;9905.405675659484;9911.405315681082;7231;7325.890111648223;7326;7390.778276651709;7409.851802963803;7836;9580.23358131334;9662.951685241529;9696.660616878375;9796.510174491104 11:20:54 INFO - PROCESS | 24851 | |3;mootools.html;1334.7864341705317;1477.3573495529445;1500.7973923520321;1633.9918300408497;1787.3565516414096;7069.752558660448;7558.546487210771;7576.204498527658;7667.1182813976475;7673.155952845196;7609.657565409556;7794.688212471508;7798.259165379294;7799.025121859768;7815.257550532705;1974.3583335416047;2017.2334512885157;2256.4810093678466;2315.444293369596;2335.32275640065;2317.895694693743;2321.210788331967;2323.94190145246;2326.0463210083867;2326.581215381231;2266.2974477911816;2341.95316093678;2342.847714898535;2344.765523447659;2346.5893468643003;2282.8173746100356;2315.849469784467;2341.180586794608;2346.049849810821;2347.1784875293683;2259.7740225977436;2279.384566167142;2285.223024171773;2299.057386471555;2348.295511346589;7975.481593696391;8024.799380015488;8037.437379383446;8046.959765201195;8049.959750201211;4640.2343613303765;4740.431148262196;4747.35910652061;4752.097101550694;4769.308450274725;3171.9841400792848;3241.594800649919;3269.378818024568;3286.720628746559;3297.159224397787;1005.4671024357102;1010.2563848104272;1043.4834756795358;1057.1859668055554;1072.088724584105;10977.670669879917;10994.725131871688;11025.61410350634;11042.282251653698;11043.503042363112;4449.421575195204;4450.399196108484;4456.732596044248;4464.531224221475;4472.105578884236;9363.859542106873;9378.202852757455;9378.390404623678;9396.90603093974;9404.811903762024;4656.930146047812;4667.8599642010795;4695.248760198352;4702.952970470252;4704;4247.49030116388;4302.419173411612;4307.784610769449;4312.849050283287;4320.43834301545;3434.759566830348;3496.5804103507235;3664.2488289900507;3700.16746232101;3735.8505659773305;1191.4519321112386;1193.6836738264367;1194.2297218294152;1199.9760004799855;1202.1765090912752;983.2871168402851;994.7712026234007;1002.2633364477103;1102.685734565661;1319.228251472899;7353.963230183922;7381.077365329334;7382.741604043833;7388.630568471555;7393.9260607393235;1187.9524819007315;1192.65413030222;1194.0984556659666;1198.2930071257824;1203.7652657731833;5649.06790379591;5678.233438485834;5731.684757338303;5751.884962300731;5757.481826635623;9426.858597121049;9539.284553658503;9659.420434773936;9826.950865245628;9838.852417213748;9396.812063758687;9481.4785186814;9607;9615.51922403877;9618;7316.195218525958;7422.888656670154;7493.475456718086;7497.437692173109;7525.2098529654695;7123.501354905107;7154.570725756471;7193.3166349196745;7218.133823941161;7221.891671624825;8229.053658829072;8652.956735216536;8730.257928075931;8743.737687869374;8755.693550725695;8521.616527256412;8591.226789588967;8597.484150950713;8600.569971501525;8615.439996400213;6230.719617617127;7012.894806578008;7150.213476517683;7152.070230869954;7156.785296441115;6955.095837541087;7323.816904577215;7511;7513.511621744788;7519.924800751923;6864.519483636098;7056;7154.105736782903;7252.746153884589;7277.599732014578;6684.16447944007;6817.761378351734;6822.147231596051;6940.271271516418;7061.152661680631;7017.157941047107;7074.115735533059;7078.646067696492;7119.145702515524;7123.7506687265695;6693.397594216543;6759.966200169164;6760.93239067603;6767.25560188369;6771.559848609824;6614.570052946543;6636.966815165893;6650.866982660223;6655.101561289358;6656.134702488645 11:20:54 INFO - PROCESS | 24851 | |4;prototype.html;323.9352129574085;328.57449602764416;334.2145957001047;348.0758585954292;355.4526029913931;5692;5800.274965629296;5826.504747096491;5890.676012819298;5901.763929442823;5660.60375773695;5794.217780599628;5841.445062719045;5847.8245652630385;5870.798450581032;4489.820407183725;4529.614982726455;4530.093981203772;4531.68278220523;4532.365468834366;4358.084802191528;4470.910581788362;4472.3515090311885;4479.148961697283;4527;4366.759828209447;4438.689291749579;4471;4484.394606728099;4491.371208030879;4437.245668236407;4447.599716025541;4451.710638808483;4455.353973673831;4464.843730469451;3926.096997690547;3926.332523471017;3928.351821949375;3929.2337994091163;3930.744501607386;5458.263134476834;5566.359868615121;5592.7762889484375;5594.104943209108;5640.520555752766;5227.242049902781;5227.693076730818;5228.529432351107;5231.110711179109;5231.163013917755;5935.73289201987;6243.1883855099;6244.687765611701;6248.3751624837605;6251;4155.729877557949;4265.957340426587;4272.594103560157;4274.380214868826;4278.058827058042;6417.93582064178;6448.419642232175;6477.028445733131;6480.578762380477;6505;4374.300111982067;4419.0940857124215;4421.602055814992;4438.045820148684;4440.511543730187;4322.8703138905885;4460.888477788081;4501.414816073955;4503.144402563503;4503.144402563503;5129.256257842667;5129.666571672829;5132.666376685504;5134.640575159778;5135.717535535507;6171.166892469549;6245;6286.057091436322;6292.119103325538;6334.714937827809;1546.8917175797585;1561.851624095709;1562.5078100398339;1563.5309407177801;1564.608847788053;1020.3112898793433;1020.974475638115;1025.7128004158847;1053.3048188195753;1065.760203954104;5930.436608522184;5932.762689492372;5937.317208521075;5938.584299099108;5946.316173640001;6364.236291645032;6365.586236894587;6367.299597044322;6374.458171055419;6406.4554512866;5909.704514774244;5925.614835035709;5929.881402371929;5930.525557955353;5931.525477961839;3361.6302206757236;3443.9655603443643;3447.1899103710607;3447.4828775683345;3449.913752156166;6611.074449577063;6647.966760166265;6652.600843949282;6657.300983396771;6659.433948114368;6613.404793568602;6661.467082633378;6679.56582822115;6680.0981867448245;6681.76613818514;6576.80269591913;6734.326567343324;6756.594604323658;6759.831004224835;6765.188177418643;6189.412005859436;6299.464545513682;6389.520785941166;6394.200724909387;6414.069959855888;6118.143459915526;6187.412195841388;6274.215723034621;6390.872182556416;6394.90407643895;6720.8319792005595;6731.495137864582;6739.797806065826;6740;6744.0895479109695;4302.268614335633;4477.776111194362;4523.2988886722615;4526.434195725535;4528.977355113203;6368.140301059298;6407.16706828128;6446.323136070832;6449.355064493513;6450.9354906450335;6264.34224406449;6279.089532017923;6282.748690052346;6289.182406287154;6293.779717709858;6170.660613666112;6236.469900058364;6266.498680105672;6266.874662506633;6273.215848018997;6129.478994285536;6133.527953291267;6144.78493252734;6145.6927153641245;6154.292256390393;6276.435120839146;6276.497880169667;6280.371962803683;6285.1515045470105;6294.905576416449;5972;6111.174991376285;6130.417610327012;6130.846728831815;6157.4458298753325 11:20:54 INFO - PROCESS | 24851 | |5;yui.html;744.5160645580369;815.714499925026;821.4044817507304;829.5561874397197;843.6288033265363;12569.560065397713;12688.30214338211;12802;12805.039622028338;13024.739505209891;12719.109662323617;12771.936140319309;12795.168314059603;12845.22928624281;12868.549600763976;670.6546128743701;679.6771533521562;801.8436404901047;818.2267756969666;818.3289702443998;795.6379847169553;811.6712731343815;816.995915020427;817.995910020452;818.7625588579305;846.4498076250425;848.9702860399888;849.4054162086534;849.7790574450626;850.158343240194;682.3347236444476;693.8646963842078;834.0616806093145;843.0894633795517;849.129642116829;624.4598422364668;624.6127401011356;624.684534310175;625.2559454249474;625.3152797686525;12663.93668031654;12719.30043847588;12763.553275635308;12805.48778048877;12813.87186128136;12480.188787728768;12847.357632118357;12858.678533036655;12870.48518059286;13275.203487790763;10355.637552685695;10456.163506919504;10522.894771052344;10546.314489558154;10553.525091370906;3538.2039041215776;3574.803385813779;3595.227026189356;3599.4960705501253;3732.794696291703;46553.5344646556;46755;46779.298310525366;46923.5307646926;46980;9386.624535018524;9412.482313472688;9654.662086826927;9811.116999470081;10065.993400659876;18283.908580457013;18416.447506574823;18527.0736463179;18530.16614252362;18537.81462185388;7490.962545187239;7615.923840761632;7727;7789.454738168387;8080.8383832323025;4443.311286750559;4453.864264612503;4517.254652982287;4518.819247230074;4632.745199014086;3061.8162910225456;3079.8614062367246;3106.5806116174026;3106.6116735408073;3110.828904410279;537.0601447466933;555.0730280431688;561.0714267886655;564.0749171358974;572.2960758267354;518.8443466959897;608.2305883057935;634.4860662863003;641.5861769158867;655.3381085104079;7983.8403231935035;8128.309093727099;8291.917080829235;8303.252707256375;9188.540572971324;429.2509570798976;582.4292193650161;635.3487675132933;636.277824669004;647.0843756085087;3771.321162190832;4016.2971479990883;4079.3676980068135;4105.220008198433;4170.562654911919;54569.727151363986;56028;56080.15879761807;56336.436635633116;56378.43621563814;49313.26030109551;49430.25854612112;49710.75144624254;51415;51738;44389.55610443919;44710.32934505985;44919.55080449219;44995.325070123974;45191.32213016741;7991.200879912195;8336.291415229773;8411.242988131098;8715.172058654418;8795.25240354577;32985.83507082449;33185.50221746627;34067.14832129217;34314.82842585771;34384.82807585946;41685.58314416817;42231;44881.55118448774;45282;45656.77171614121;10299.227557933034;10342.172626190037;10570.894291056991;10596.933597948326;10889.128869690247;10456;10878.510467028844;11336.376499292619;11355.54577816878;11375.488103035548;10672.359658420519;10796.460176991277;10905.672829815117;11048.226624136234;11505.022073123879;10586;10676.519556619816;10680.252382333161;10697.197710171613;11008.554816863647;7545.924540754741;10085.949570252102;10467.319624224401;10893.291936024134;11113.555457781598;8699.608517616596;9000;9281.071892810665;9546.474943878153;9567.856482152634;8767.517786521803;8912;9100.317476189444;9563.474008929297;9770.169535589555 11:20:54 INFO - PROCESS | 24851 | __end_tp_report 11:20:54 INFO - PROCESS | 24851 | __start_cc_report 11:20:54 INFO - PROCESS | 24851 | _x_x_mozilla_cycle_collect,935 11:20:54 INFO - PROCESS | 24851 | __end_cc_report 11:20:54 INFO - PROCESS | 24851 | __startTimestamp1453144854029__endTimestamp 11:20:54 INFO - PROCESS | 24851 | 11:20:54 INFO - PROCESS | 24851 | ------- Summary: start ------- 11:20:54 INFO - PROCESS | 24851 | Number of tests: 6 11:20:54 INFO - PROCESS | 24851 | 11:20:54 INFO - PROCESS | 24851 | [#0] dojo.html Cycles:165 Average:5017.44 Median:5172.51 stddev:526.23 (10.2%) stddev-sans-first:505.55 11:20:54 INFO - PROCESS | 24851 | Values: 3085.7 3108.9 3149.2 3151.4 3176.3 4899.7 4983.1 5025.8 5038.3 5070.4 4953.8 4980.0 5041.4 5107.4 5111.0 4548.0 4554.9 4600.2 4673.1 4697.3 4580.2 4696.5 4701.0 4720.0 4728.9 4582.6 4628.3 4658.9 4705.7 4750.3 4562.5 4584.3 4604.4 4622.1 4630.9 4590.3 4591.9 4593.4 4610.6 4634.3 4807.8 4860.3 4862.9 4887.2 4922.4 5336.9 5378.1 5379.1 5381.5 5428.2 5429.8 5444.6 5448.2 5451.5 5461.2 4956.5 5054.7 5072.3 5106.0 5165.1 5482.8 5497.6 5501.0 5507.2 5519.1 5287.8 5296.0 5296.1 5296.9 5350.7 5264.9 5331.4 5360.2 5377.7 5418.9 5286.6 5338.3 5340.7 5344.2 5344.4 5336.1 5336.4 5345.6 5349.2 5385.2 4166.8 4210.2 4243.8 4265.3 4267.0 3751.6 3784.4 3790.7 3823.7 3823.7 5033.9 5034.6 5040.2 5041.9 5045.2 5313.2 5364.3 5399.7 5428.1 5477.5 4999.9 5006.2 5021.0 5023.5 5067.7 4571.1 4626.7 4633.0 4638.8 4675.2 5553.4 5609.6 5620.2 5643.5 5707.9 5399.7 5407.8 5412.4 5417.8 5418.5 5461.6 5557.2 5616.7 5630.2 5665.1 5275.4 5288.3 5327.5 5357.4 5376.1 5397.2 5413.8 5433.8 5459.5 5469.0 5245.5 5320.6 5336.0 5336.2 5364.2 5198.5 5229.7 5237.3 5257.7 5266.5 5135.0 5144.6 5147.9 5153.0 5159.0 5193.6 5236.6 5242.2 5247.1 5339.6 5111.9 5150.5 5172.5 5185.6 5215.8 11:20:54 INFO - PROCESS | 24851 | 11:20:54 INFO - PROCESS | 24851 | [#1] ext.html Cycles:180 Average:48161.16 Median:36285.14 stddev:86104.59 (237.3%) stddev-sans-first:86271.91 11:20:54 INFO - PROCESS | 24851 | Values: 543.9 552.8 561.5 566.5 568.6 28416.3 29083.0 35512.0 36212.5 36221.5 42388.4 42903.1 42924.0 42936.8 42939.8 8561.5 8698.9 8758.2 8762.1 8770.8 8528.1 8655.7 8656.4 8670.8 8682.2 8625.0 8626.8 8683.4 8713.8 8725.0 8578.0 8637.8 8664.4 8668.9 8671.7 8468.2 8563.1 8607.8 8622.2 8623.9 38976.6 39378.2 39581.2 39633.0 39642.8 3196.9 3256.0 3302.6 3338.7 3859.2 30047.7 30155.5 30313.4 30410.7 31053.5 3740.9 3818.4 3891.6 3908.5 3951.8 277818.0 280700.0 281861.0 282773.0 283225.0 49165.0 50360.5 54880.7 56374.4 57624.0 51762.7 51848.5 52211.0 52225.7 52248.0 12500.7 12657.2 12687.8 12709.1 12715.2 9728.1 9763.6 10197.7 10299.7 10578.8 17873.9 17989.6 18013.4 18021.3 18096.2 7301.7 7392.9 7518.5 7538.0 7543.7 888.9 972.9 983.6 1014.6 1063.4 28227.0 28546.6 28670.7 29028.7 29029.4 1007.8 1012.2 1038.4 1105.9 1119.9 14798.2 14881.6 14921.3 15143.8 15159.1 324457.0 330321.0 330840.0 330946.0 331285.0 50736.5 50953.2 51016.0 51048.5 51064.7 1277.1 1288.2 1289.1 1289.4 1314.8 26759.5 27552.6 28198.7 28308.9 30025.5 47175.3 47316.5 47504.3 47578.8 47750.0 245005.0 385874.0 388050.0 390522.0 398674.0 30735.2 30832.5 30926.5 30959.8 31282.8 42643.4 43219.8 43398.8 44018.3 44536.8 35371.8 35905.0 36348.8 36545.6 36793.3 32614.3 35186.6 35237.9 36192.5 36520.3 34121.5 34246.7 35095.5 35100.6 35108.0 29777.0 32125.4 32148.2 32236.7 32545.7 24247.8 24430.6 24476.9 24912.4 24913.5 11:20:54 INFO - PROCESS | 24851 | 11:20:54 INFO - PROCESS | 24851 | [#2] jquery.html Cycles:180 Average:27743.86 Median:5297.21 stddev:90455.88 (1707.6%) stddev-sans-first:90686.24 11:20:54 INFO - PROCESS | 24851 | Values: 343.5 345.6 347.9 347.9 351.4 13208.5 13662.7 15449.2 15697.5 17417.6 10004.6 10091.7 10316.5 13343.7 13723.0 4425.5 4960.3 4962.7 4969.7 5176.4 3793.3 3859.5 5287.4 5304.3 5528.8 5270.2 5487.0 5497.8 5508.9 5530.3 5567.8 5574.3 5585.3 5604.9 5615.6 5262.4 5290.1 5370.9 5392.9 5395.2 19536.9 19772.0 20104.1 20395.8 20404.4 2092.8 2121.9 2138.6 2173.8 2262.9 9382.6 9905.3 11457.5 12805.7 12972.4 1759.5 1831.8 1864.9 1934.9 1968.6 54599.7 57630.7 57961.0 58328.1 58534.4 9707.2 9912.7 10078.2 10098.5 10183.5 13402.3 13458.6 13472.5 13497.1 13498.6 7265.7 7270.1 7271.3 7326.7 7330.2 6987.0 7000.0 7048.1 7056.6 7079.0 3772.0 4346.5 4411.6 4428.4 4459.2 1719.6 1720.2 1781.7 1796.5 1803.7 841.9 884.5 887.0 948.9 987.8 12842.9 15169.5 15929.7 16216.6 16354.9 913.5 922.0 922.8 928.6 940.8 9290.3 9389.4 9394.7 9567.0 9578.2 543143.0 544950.0 545148.0 566025.0 567402.5 70617.0 71901.0 72636.6 73357.3 75254.2 1070.6 1078.0 1084.6 1087.8 1092.7 14689.4 14753.3 14756.6 14772.0 15011.2 33305.8 33662.2 33933.0 34154.5 34168.8 43372.6 44393.8 44646.6 46527.0 47496.3 6811.7 6908.6 6923.7 6965.5 7025.9 9000.6 10203.3 10300.5 10334.9 10462.1 8791.5 8932.0 8949.4 9165.0 9310.5 7344.7 9295.9 9659.2 9724.2 9826.8 9196.3 9520.7 9770.7 9905.4 9911.4 7231.0 7325.9 7326.0 7390.8 7409.9 7836.0 9580.2 9663.0 9696.7 9796.5 11:20:54 INFO - PROCESS | 24851 | 11:20:54 INFO - PROCESS | 24851 | [#3] mootools.html Cycles:180 Average:5531.81 Median:6643.92 stddev:2875.86 (43.3%) stddev-sans-first:2866.62 11:20:54 INFO - PROCESS | 24851 | Values: 1334.8 1477.4 1500.8 1634.0 1787.4 7069.8 7558.5 7576.2 7667.1 7673.2 7609.7 7794.7 7798.3 7799.0 7815.3 1974.4 2017.2 2256.5 2315.4 2335.3 2317.9 2321.2 2323.9 2326.0 2326.6 2266.3 2342.0 2342.8 2344.8 2346.6 2282.8 2315.8 2341.2 2346.0 2347.2 2259.8 2279.4 2285.2 2299.1 2348.3 7975.5 8024.8 8037.4 8047.0 8050.0 4640.2 4740.4 4747.4 4752.1 4769.3 3172.0 3241.6 3269.4 3286.7 3297.2 1005.5 1010.3 1043.5 1057.2 1072.1 10977.7 10994.7 11025.6 11042.3 11043.5 4449.4 4450.4 4456.7 4464.5 4472.1 9363.9 9378.2 9378.4 9396.9 9404.8 4656.9 4667.9 4695.2 4703.0 4704.0 4247.5 4302.4 4307.8 4312.8 4320.4 3434.8 3496.6 3664.2 3700.2 3735.9 1191.5 1193.7 1194.2 1200.0 1202.2 983.3 994.8 1002.3 1102.7 1319.2 7354.0 7381.1 7382.7 7388.6 7393.9 1188.0 1192.7 1194.1 1198.3 1203.8 5649.1 5678.2 5731.7 5751.9 5757.5 9426.9 9539.3 9659.4 9827.0 9838.9 9396.8 9481.5 9607.0 9615.5 9618.0 7316.2 7422.9 7493.5 7497.4 7525.2 7123.5 7154.6 7193.3 7218.1 7221.9 8229.1 8653.0 8730.3 8743.7 8755.7 8521.6 8591.2 8597.5 8600.6 8615.4 6230.7 7012.9 7150.2 7152.1 7156.8 6955.1 7323.8 7511.0 7513.5 7519.9 6864.5 7056.0 7154.1 7252.7 7277.6 6684.2 6817.8 6822.1 6940.3 7061.2 7017.2 7074.1 7078.6 7119.1 7123.8 6693.4 6760.0 6760.9 6767.3 6771.6 6614.6 6637.0 6650.9 6655.1 6656.1 11:20:54 INFO - PROCESS | 24851 | 11:20:54 INFO - PROCESS | 24851 | [#4] prototype.html Cycles:180 Average:5203.77 Median:5917.66 stddev:1574.91 (26.6%) stddev-sans-first:1536.15 11:20:54 INFO - PROCESS | 24851 | Values: 323.9 328.6 334.2 348.1 355.5 5692.0 5800.3 5826.5 5890.7 5901.8 5660.6 5794.2 5841.4 5847.8 5870.8 4489.8 4529.6 4530.1 4531.7 4532.4 4358.1 4470.9 4472.4 4479.1 4527.0 4366.8 4438.7 4471.0 4484.4 4491.4 4437.2 4447.6 4451.7 4455.4 4464.8 3926.1 3926.3 3928.4 3929.2 3930.7 5458.3 5566.4 5592.8 5594.1 5640.5 5227.2 5227.7 5228.5 5231.1 5231.2 5935.7 6243.2 6244.7 6248.4 6251.0 4155.7 4266.0 4272.6 4274.4 4278.1 6417.9 6448.4 6477.0 6480.6 6505.0 4374.3 4419.1 4421.6 4438.0 4440.5 4322.9 4460.9 4501.4 4503.1 4503.1 5129.3 5129.7 5132.7 5134.6 5135.7 6171.2 6245.0 6286.1 6292.1 6334.7 1546.9 1561.9 1562.5 1563.5 1564.6 1020.3 1021.0 1025.7 1053.3 1065.8 5930.4 5932.8 5937.3 5938.6 5946.3 6364.2 6365.6 6367.3 6374.5 6406.5 5909.7 5925.6 5929.9 5930.5 5931.5 3361.6 3444.0 3447.2 3447.5 3449.9 6611.1 6648.0 6652.6 6657.3 6659.4 6613.4 6661.5 6679.6 6680.1 6681.8 6576.8 6734.3 6756.6 6759.8 6765.2 6189.4 6299.5 6389.5 6394.2 6414.1 6118.1 6187.4 6274.2 6390.9 6394.9 6720.8 6731.5 6739.8 6740.0 6744.1 4302.3 4477.8 4523.3 4526.4 4529.0 6368.1 6407.2 6446.3 6449.4 6450.9 6264.3 6279.1 6282.7 6289.2 6293.8 6170.7 6236.5 6266.5 6266.9 6273.2 6129.5 6133.5 6144.8 6145.7 6154.3 6276.4 6276.5 6280.4 6285.2 6294.9 5972.0 6111.2 6130.4 6130.8 6157.4 11:20:54 INFO - PROCESS | 24851 | 11:20:54 INFO - PROCESS | 24851 | [#5] yui.html Cycles:180 Average:13427.39 Median:25593.14 stddev:15544.30 (60.7%) stddev-sans-first:15558.73 11:20:54 INFO - PROCESS | 24851 | Values: 744.5 815.7 821.4 829.6 843.6 12569.6 12688.3 12802.0 12805.0 13024.7 12719.1 12771.9 12795.2 12845.2 12868.5 670.7 679.7 801.8 818.2 818.3 795.6 811.7 817.0 818.0 818.8 846.4 849.0 849.4 849.8 850.2 682.3 693.9 834.1 843.1 849.1 624.5 624.6 624.7 625.3 625.3 12663.9 12719.3 12763.6 12805.5 12813.9 12480.2 12847.4 12858.7 12870.5 13275.2 10355.6 10456.2 10522.9 10546.3 10553.5 3538.2 3574.8 3595.2 3599.5 3732.8 46553.5 46755.0 46779.3 46923.5 46980.0 9386.6 9412.5 9654.7 9811.1 10066.0 18283.9 18416.4 18527.1 18530.2 18537.8 7491.0 7615.9 7727.0 7789.5 8080.8 4443.3 4453.9 4517.3 4518.8 4632.7 3061.8 3079.9 3106.6 3106.6 3110.8 537.1 555.1 561.1 564.1 572.3 518.8 608.2 634.5 641.6 655.3 7983.8 8128.3 8291.9 8303.3 9188.5 429.3 582.4 635.3 636.3 647.1 3771.3 4016.3 4079.4 4105.2 4170.6 54569.7 56028.0 56080.2 56336.4 56378.4 49313.3 49430.3 49710.8 51415.0 51738.0 44389.6 44710.3 44919.6 44995.3 45191.3 7991.2 8336.3 8411.2 8715.2 8795.3 32985.8 33185.5 34067.1 34314.8 34384.8 41685.6 42231.0 44881.6 45282.0 45656.8 10299.2 10342.2 10570.9 10596.9 10889.1 10456.0 10878.5 11336.4 11355.5 11375.5 10672.4 10796.5 10905.7 11048.2 11505.0 10586.0 10676.5 10680.3 10697.2 11008.6 7545.9 10085.9 10467.3 10893.3 11113.6 8699.6 9000.0 9281.1 9546.5 9567.9 8767.5 8912.0 9100.3 9563.5 9770.2 11:20:54 INFO - PROCESS | 24851 | -------- Summary: end -------- 11:20:54 INFO - PROCESS | 24851 | 11:20:54 INFO - TEST-INFO | 24851: exit 0 11:20:54 INFO - TEST-OK | dromaeo_css | took 1112889ms 11:20:54 INFO - TEST-START | kraken 11:20:54 INFO - operating with platform_type : linux_ 11:20:54 INFO - Initialising browser for kraken test... 11:20:54 INFO - TEST-INFO | started process 25054 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnK4aG9/profile http://localhost:45419/getInfo.html) 11:20:59 INFO - PROCESS | 25054 | __metrics Screen width/height:1600/1200 11:20:59 INFO - PROCESS | 25054 | colorDepth:24 11:20:59 INFO - PROCESS | 25054 | Browser inner width/height: 1024/697 11:20:59 INFO - PROCESS | 25054 | __metrics 11:20:59 INFO - PROCESS | 25054 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:20:59 INFO - PROCESS | 25054 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:21:00 INFO - TEST-INFO | 25054: exit 0 11:21:00 INFO - Browser initialized. 11:21:00 INFO - Running cycle 1/1 for kraken test... 11:21:00 INFO - TEST-INFO | started process 25139 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnK4aG9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:11 INFO - PROCESS | 25139 | RSS: Main: 149450752 11:21:11 INFO - PROCESS | 25139 | 11:21:14 INFO - PROCESS | 25139 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45419/tests/kraken/driver.html?testName=audio-beat-detection) 11:21:15 INFO - PROCESS | 25139 | RSS: Main: 186621952 11:21:15 INFO - PROCESS | 25139 | 11:21:17 INFO - PROCESS | 25139 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45419/tests/kraken/driver.html?testName=audio-dft) 11:21:18 INFO - PROCESS | 25139 | RSS: Main: 179535872 11:21:18 INFO - PROCESS | 25139 | 11:21:21 INFO - PROCESS | 25139 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45419/tests/kraken/driver.html?testName=audio-fft) 11:21:21 INFO - PROCESS | 25139 | RSS: Main: 167063552 11:21:21 INFO - PROCESS | 25139 | 11:21:23 INFO - PROCESS | 25139 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45419/tests/kraken/driver.html?testName=audio-oscillator) 11:21:24 INFO - PROCESS | 25139 | RSS: Main: 165978112 11:21:24 INFO - PROCESS | 25139 | 11:21:26 INFO - PROCESS | 25139 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45419/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:21:26 INFO - PROCESS | 25139 | RSS: Main: 167088128 11:21:26 INFO - PROCESS | 25139 | 11:21:29 INFO - PROCESS | 25139 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45419/tests/kraken/driver.html?testName=imaging-darkroom) 11:21:30 INFO - PROCESS | 25139 | RSS: Main: 165015552 11:21:30 INFO - PROCESS | 25139 | 11:21:33 INFO - PROCESS | 25139 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45419/tests/kraken/driver.html?testName=imaging-desaturate) 11:21:34 INFO - PROCESS | 25139 | RSS: Main: 166608896 11:21:34 INFO - PROCESS | 25139 | 11:21:37 INFO - PROCESS | 25139 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45419/tests/kraken/driver.html?testName=json-parse-financial) 11:21:37 INFO - PROCESS | 25139 | RSS: Main: 166854656 11:21:37 INFO - PROCESS | 25139 | 11:21:39 INFO - PROCESS | 25139 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45419/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:21:39 INFO - PROCESS | 25139 | RSS: Main: 179793920 11:21:39 INFO - PROCESS | 25139 | 11:21:41 INFO - PROCESS | 25139 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45419/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:21:42 INFO - PROCESS | 25139 | RSS: Main: 179326976 11:21:42 INFO - PROCESS | 25139 | 11:21:44 INFO - PROCESS | 25139 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45419/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:21:44 INFO - PROCESS | 25139 | RSS: Main: 188874752 11:21:44 INFO - PROCESS | 25139 | 11:21:47 INFO - PROCESS | 25139 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45419/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:21:47 INFO - PROCESS | 25139 | RSS: Main: 194129920 11:21:47 INFO - PROCESS | 25139 | 11:21:50 INFO - PROCESS | 25139 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45419/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:21:50 INFO - PROCESS | 25139 | RSS: Main: 191381504 11:21:50 INFO - PROCESS | 25139 | 11:21:52 INFO - PROCESS | 25139 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45419/tests/kraken/driver.html?testName=ai-astar) 11:21:52 INFO - PROCESS | 25139 | RSS: Main: 249483264 11:21:52 INFO - PROCESS | 25139 | 11:21:52 INFO - PROCESS | 25139 | __start_tp_report 11:21:52 INFO - PROCESS | 25139 | _x_x_mozilla_page_load 11:21:52 INFO - PROCESS | 25139 | _x_x_mozilla_page_load_details 11:21:52 INFO - PROCESS | 25139 | |i|pagename|runs| 11:21:52 INFO - PROCESS | 25139 | |0;ai-astar;112;110;105;111;109;110;111;111;103;109 11:21:52 INFO - PROCESS | 25139 | |1;audio-beat-detection;159;129;146;166;125;154;147;122;167;128 11:21:52 INFO - PROCESS | 25139 | |2;audio-dft;160;160;160;162;161;163;163;161;161;161 11:21:52 INFO - PROCESS | 25139 | |3;audio-fft;71;73;72;152;74;74;73;76;154;74 11:21:52 INFO - PROCESS | 25139 | |4;audio-oscillator;97;97;151;96;97;96;144;96;97;136 11:21:52 INFO - PROCESS | 25139 | |5;imaging-gaussian-blur;109;109;109;109;109;110;110;109;109;110 11:21:52 INFO - PROCESS | 25139 | |6;imaging-darkroom;148;148;147;148;147;147;148;147;148;146 11:21:52 INFO - PROCESS | 25139 | |7;imaging-desaturate;95;96;95;96;96;95;95;96;96;95 11:21:52 INFO - PROCESS | 25139 | |8;json-parse-financial;58;57;56;56;56;56;58;57;55;55 11:21:52 INFO - PROCESS | 25139 | |9;json-stringify-tinderbox;67;67;67;67;69;69;68;68;69;67 11:21:52 INFO - PROCESS | 25139 | |10;stanford-crypto-aes;80;81;81;82;82;84;82;83;84;83 11:21:52 INFO - PROCESS | 25139 | |11;stanford-crypto-ccm;115;115;115;116;111;124;117;115;114;121 11:21:52 INFO - PROCESS | 25139 | |12;stanford-crypto-pbkdf2;140;139;140;144;142;129;149;140;139;139 11:21:52 INFO - PROCESS | 25139 | |13;stanford-crypto-sha256-iterative;66;67;66;65;67;64;65;66;65;65 11:21:52 INFO - PROCESS | 25139 | __end_tp_report 11:21:52 INFO - PROCESS | 25139 | __start_cc_report 11:21:52 INFO - PROCESS | 25139 | _x_x_mozilla_cycle_collect,919 11:21:52 INFO - PROCESS | 25139 | __end_cc_report 11:21:52 INFO - PROCESS | 25139 | __startTimestamp1453144912846__endTimestamp 11:21:52 INFO - PROCESS | 25139 | 11:21:52 INFO - PROCESS | 25139 | ------- Summary: start ------- 11:21:52 INFO - PROCESS | 25139 | Number of tests: 14 11:21:52 INFO - PROCESS | 25139 | 11:21:52 INFO - PROCESS | 25139 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.50 stddev:2.88 (2.6%) stddev-sans-first:2.86 11:21:52 INFO - PROCESS | 25139 | Values: 112.0 110.0 105.0 111.0 109.0 110.0 111.0 111.0 103.0 109.0 11:21:52 INFO - PROCESS | 25139 | 11:21:52 INFO - PROCESS | 25139 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:150.50 stddev:17.24 (11.5%) stddev-sans-first:17.45 11:21:52 INFO - PROCESS | 25139 | Values: 159.0 129.0 146.0 166.0 125.0 154.0 147.0 122.0 167.0 128.0 11:21:52 INFO - PROCESS | 25139 | 11:21:52 INFO - PROCESS | 25139 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.12 11:21:52 INFO - PROCESS | 25139 | Values: 160.0 160.0 160.0 162.0 161.0 163.0 163.0 161.0 161.0 161.0 11:21:52 INFO - PROCESS | 25139 | 11:21:52 INFO - PROCESS | 25139 | [#3] audio-fft Cycles:10 Average:89.30 Median:73.50 stddev:33.60 (45.7%) stddev-sans-first:34.98 11:21:52 INFO - PROCESS | 25139 | Values: 71.0 73.0 72.0 152.0 74.0 74.0 73.0 76.0 154.0 74.0 11:21:52 INFO - PROCESS | 25139 | 11:21:52 INFO - PROCESS | 25139 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:96.50 stddev:23.03 (23.9%) stddev-sans-first:23.88 11:21:52 INFO - PROCESS | 25139 | Values: 97.0 97.0 151.0 96.0 97.0 96.0 144.0 96.0 97.0 136.0 11:21:52 INFO - PROCESS | 25139 | 11:21:52 INFO - PROCESS | 25139 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 11:21:52 INFO - PROCESS | 25139 | Values: 109.0 109.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 110.0 11:21:52 INFO - PROCESS | 25139 | 11:21:52 INFO - PROCESS | 25139 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 11:21:52 INFO - PROCESS | 25139 | Values: 148.0 148.0 147.0 148.0 147.0 147.0 148.0 147.0 148.0 146.0 11:21:52 INFO - PROCESS | 25139 | 11:21:52 INFO - PROCESS | 25139 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 11:21:52 INFO - PROCESS | 25139 | Values: 95.0 96.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 95.0 11:21:52 INFO - PROCESS | 25139 | 11:21:52 INFO - PROCESS | 25139 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.50 stddev:1.07 (1.9%) stddev-sans-first:0.97 11:21:52 INFO - PROCESS | 25139 | Values: 58.0 57.0 56.0 56.0 56.0 56.0 58.0 57.0 55.0 55.0 11:21:52 INFO - PROCESS | 25139 | 11:21:52 INFO - PROCESS | 25139 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 11:21:52 INFO - PROCESS | 25139 | Values: 67.0 67.0 67.0 67.0 69.0 69.0 68.0 68.0 69.0 67.0 11:21:52 INFO - PROCESS | 25139 | 11:21:52 INFO - PROCESS | 25139 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.50 stddev:1.32 (1.6%) stddev-sans-first:1.13 11:21:52 INFO - PROCESS | 25139 | Values: 80.0 81.0 81.0 82.0 82.0 84.0 82.0 83.0 84.0 83.0 11:21:52 INFO - PROCESS | 25139 | 11:21:52 INFO - PROCESS | 25139 | [#11] stanford-crypto-ccm Cycles:10 Average:116.30 Median:115.50 stddev:3.68 (3.2%) stddev-sans-first:3.88 11:21:52 INFO - PROCESS | 25139 | Values: 115.0 115.0 115.0 116.0 111.0 124.0 117.0 115.0 114.0 121.0 11:21:52 INFO - PROCESS | 25139 | 11:21:52 INFO - PROCESS | 25139 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.10 Median:140.00 stddev:5.00 (3.6%) stddev-sans-first:5.30 11:21:52 INFO - PROCESS | 25139 | Values: 140.0 139.0 140.0 144.0 142.0 129.0 149.0 140.0 139.0 139.0 11:21:52 INFO - PROCESS | 25139 | 11:21:52 INFO - PROCESS | 25139 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 11:21:52 INFO - PROCESS | 25139 | Values: 66.0 67.0 66.0 65.0 67.0 64.0 65.0 66.0 65.0 65.0 11:21:52 INFO - PROCESS | 25139 | -------- Summary: end -------- 11:21:52 INFO - PROCESS | 25139 | 11:21:53 INFO - TEST-INFO | 25139: exit 0 11:21:53 INFO - TEST-OK | kraken | took 59070ms 11:21:53 INFO - TEST-START | v8_7 11:21:53 INFO - operating with platform_type : linux_ 11:21:53 INFO - Initialising browser for v8_7 test... 11:21:53 INFO - TEST-INFO | started process 25386 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpD5IZFZ/profile http://localhost:45419/getInfo.html) 11:21:58 INFO - PROCESS | 25386 | __metrics Screen width/height:1600/1200 11:21:58 INFO - PROCESS | 25386 | colorDepth:24 11:21:58 INFO - PROCESS | 25386 | Browser inner width/height: 1024/697 11:21:58 INFO - PROCESS | 25386 | __metrics 11:21:58 INFO - PROCESS | 25386 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:21:58 INFO - PROCESS | 25386 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:21:59 INFO - TEST-INFO | 25386: exit 0 11:21:59 INFO - Browser initialized. 11:21:59 INFO - Running cycle 1/1 for v8_7 test... 11:21:59 INFO - TEST-INFO | started process 25468 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpD5IZFZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:22:11 INFO - PROCESS | 25468 | RSS: Main: 149417984 11:22:11 INFO - PROCESS | 25468 | 11:22:33 INFO - PROCESS | 25468 | Cycle 1(1): loaded http://localhost:45419/tests/v8_7/run.html (next: http://localhost:45419/tests/v8_7/run.html) 11:22:33 INFO - PROCESS | 25468 | RSS: Main: 574939136 11:22:33 INFO - PROCESS | 25468 | 11:22:33 INFO - PROCESS | 25468 | __start_tp_report 11:22:33 INFO - PROCESS | 25468 | _x_x_mozilla_page_load 11:22:33 INFO - PROCESS | 25468 | _x_x_mozilla_page_load_details 11:22:33 INFO - PROCESS | 25468 | |i|pagename|runs| 11:22:33 INFO - PROCESS | 25468 | |0;Richards;167.7570877369569 11:22:33 INFO - PROCESS | 25468 | |1;DeltaBlue;187.44142455482663 11:22:33 INFO - PROCESS | 25468 | |2;Encrypt;280.2690582959641 11:22:33 INFO - PROCESS | 25468 | |3;Decrypt;5246.073298429319 11:22:33 INFO - PROCESS | 25468 | |4;RayTrace;1953.125 11:22:33 INFO - PROCESS | 25468 | |5;Earley;788.6435331230284 11:22:33 INFO - PROCESS | 25468 | |6;Boyer;12402.439024390244 11:22:33 INFO - PROCESS | 25468 | |7;RegExp;42312.5 11:22:33 INFO - PROCESS | 25468 | |8;Splay;625.2330640149161 11:22:33 INFO - PROCESS | 25468 | |9;NavierStokes;4830.917874396136 11:22:33 INFO - PROCESS | 25468 | __end_tp_report 11:22:33 INFO - PROCESS | 25468 | __startTimestamp1453144953954__endTimestamp 11:22:33 INFO - PROCESS | 25468 | 11:22:33 INFO - PROCESS | 25468 | ------- Summary: start ------- 11:22:33 INFO - PROCESS | 25468 | Number of tests: 10 11:22:33 INFO - PROCESS | 25468 | 11:22:33 INFO - PROCESS | 25468 | [#0] Richards Cycles:1 Average:167.76 Median:167.76 stddev:0.00 (0.0%) 11:22:33 INFO - PROCESS | 25468 | Values: 167.8 11:22:33 INFO - PROCESS | 25468 | 11:22:33 INFO - PROCESS | 25468 | [#1] DeltaBlue Cycles:1 Average:187.44 Median:187.44 stddev:0.00 (0.0%) 11:22:33 INFO - PROCESS | 25468 | Values: 187.4 11:22:33 INFO - PROCESS | 25468 | 11:22:33 INFO - PROCESS | 25468 | [#2] Encrypt Cycles:1 Average:280.27 Median:280.27 stddev:0.00 (0.0%) 11:22:33 INFO - PROCESS | 25468 | Values: 280.3 11:22:33 INFO - PROCESS | 25468 | 11:22:33 INFO - PROCESS | 25468 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 11:22:33 INFO - PROCESS | 25468 | Values: 5246.1 11:22:33 INFO - PROCESS | 25468 | 11:22:33 INFO - PROCESS | 25468 | [#4] RayTrace Cycles:1 Average:1953.13 Median:1953.13 stddev:0.00 (0.0%) 11:22:33 INFO - PROCESS | 25468 | Values: 1953.1 11:22:33 INFO - PROCESS | 25468 | 11:22:33 INFO - PROCESS | 25468 | [#5] Earley Cycles:1 Average:788.64 Median:788.64 stddev:0.00 (0.0%) 11:22:33 INFO - PROCESS | 25468 | Values: 788.6 11:22:33 INFO - PROCESS | 25468 | 11:22:33 INFO - PROCESS | 25468 | [#6] Boyer Cycles:1 Average:12402.44 Median:12402.44 stddev:0.00 (0.0%) 11:22:33 INFO - PROCESS | 25468 | Values: 12402.4 11:22:33 INFO - PROCESS | 25468 | 11:22:33 INFO - PROCESS | 25468 | [#7] RegExp Cycles:1 Average:42312.50 Median:42312.50 stddev:0.00 (0.0%) 11:22:33 INFO - PROCESS | 25468 | Values: 42312.5 11:22:33 INFO - PROCESS | 25468 | 11:22:33 INFO - PROCESS | 25468 | [#8] Splay Cycles:1 Average:625.23 Median:625.23 stddev:0.00 (0.0%) 11:22:33 INFO - PROCESS | 25468 | Values: 625.2 11:22:33 INFO - PROCESS | 25468 | 11:22:33 INFO - PROCESS | 25468 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 11:22:33 INFO - PROCESS | 25468 | Values: 4830.9 11:22:33 INFO - PROCESS | 25468 | -------- Summary: end -------- 11:22:33 INFO - PROCESS | 25468 | 11:22:34 INFO - TEST-INFO | 25468: exit 0 11:22:34 INFO - TEST-OK | v8_7 | took 41089ms 11:22:34 INFO - SUITE-END | took 1213s 11:22:34 INFO - Completed test suite (00:20:13) 11:22:34 INFO - Working with test: dromaeo_css 11:22:34 INFO - Generating results file: dromaeo_css 11:22:34 INFO - Working with test: kraken 11:22:34 INFO - Generating results file: kraken 11:22:34 INFO - javascript benchmark 11:22:34 INFO - Working with test: v8_7 11:22:34 INFO - Generating results file: v8_7 11:22:34 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:22:34 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 11:22:34 INFO - process_Request line: dromaeo_css 6743.98 graph.html#tests=[[72,64,35]] 11:22:34 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:22:34 INFO - process_Request line: kraken 1495.20 graph.html#tests=[[232,64,35]] 11:22:34 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:22:34 INFO - process_Request line: v8_7 18827.91 graph.html#tests=[[230,64,35]] 11:22:34 INFO - RETURN: dromaeo_css: 6743.98 11:22:34 INFO - RETURN: kraken: 1495.20 11:22:34 INFO - RETURN: v8_7: 18827.91 11:22:34 INFO - javascript benchmark 11:22:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3085.737712294455, 3108.9378212435768, 3149.2126968257935, 3151.43274210642, 3176.34884848606, 4899.657024008312, 4983.103041452537, 5025.773840177191, 5038.269450929618, 5070.391553013639, 4953.752312384385, 4979.950200497994, 5041.445441001496, 5107.412647545533, 5110.974445127769, 4548.0, 4554.886127846806, 4600.217962946307, 4673.135469938055, 4697.318888761128, 4580.175568397687, 4696.506866778973, 4701.036287561059, 4719.976400117995, 4728.881777955561, 4582.633389328846, 4628.282616194495, 4658.906821863544, 4705.741184234866, 4750.3349531065505, 4562.498125206224, 4584.289435137559, 4604.37840891482, 4622.121796858586, 4630.930536041962, 4590.3344015117955, 4591.885202869921, 4593.356930029765, 4610.608098311614, 4634.3048542718525, 4807.831725889577, 4860.270959356089, 4862.927056094161, 4887.218045112765, 4922.409310882717, 5336.91994620081, 5378.058839703036, 5379.112446446332, 5381.48875856793, 5428.212909128154, 5429.837104886859, 5444.564434845203, 5448.182772584105, 5451.454854514556, 5461.15352120422, 4956.504349565051, 5054.69671819692, 5072.34059572257, 5105.999999999963, 5165.070287348313, 5482.80810171642, 5497.5601951843755, 5501.0, 5507.201455788968, 5519.116941289455, 5287.788488460418, 5295.973520132375, 5296.09966305729, 5296.867578310496, 5350.705711185844, 5264.947350526522, 5331.386890507563, 5360.222767698662, 5377.677339359573, 5418.91871621926, 5286.62993590445, 5338.252644629755, 5340.706261155674, 5344.198370244494, 5344.3853956795465, 5336.146216605324, 5336.386315573759, 5345.572354211654, 5349.1976203569, 5385.165299378603, 4166.7708276045105, 4210.179015092028, 4243.8090285937205, 4265.253580623441, 4266.957330426656, 3751.5685696144747, 3784.394496880486, 3790.6967442604528, 3823.655870971626, 3823.713221508398, 5033.874153146201, 5034.572061374751, 5040.243963405518, 5041.949580504222, 5045.192769156917, 5313.203019547099, 5364.329458817648, 5399.676019438846, 5428.077226871442, 5477.4796394342475, 4999.850004499871, 5006.224035274538, 5021.046001259822, 5023.547880690755, 5067.721275329893, 4571.131485017836, 4626.722396656144, 4633.0039041606215, 4638.814447422133, 4675.158471475167, 5553.389127196006, 5609.551235901118, 5620.241267428926, 5643.5203007743985, 5707.942920570824, 5399.730013499231, 5407.78368865241, 5412.43169467216, 5417.83746487606, 5418.485243901823, 5461.590380721541, 5557.221988921473, 5616.747246373841, 5630.19197901339, 5665.065264231355, 5275.419703832498, 5288.312519372457, 5327.520523152934, 5357.383900851296, 5376.086065368819, 5397.217403476396, 5413.7834486620095, 5433.809816656398, 5459.4540545946675, 5469.0, 5245.475452454724, 5320.574354051744, 5336.039512887717, 5336.17289320156, 5364.168553874156, 5198.532132108128, 5229.660072095302, 5237.292965449616, 5257.684538927677, 5266.473352664703, 5134.998675258289, 5144.562712169508, 5147.9227811582105, 5153.0466863630345, 5159.0, 5193.636445448933, 5236.633435659467, 5242.16125419931, 5247.081760691787, 5339.572834173335, 5111.923321150261, 5150.4592017837585, 5172.508611681884, 5185.585153187661, 5215.843524694265], "unit": "score", "name": "dojo.html", "value": 4985.642912754414}, {"lowerIsBetter": false, "replicates": [543.9156930675745, 552.8313864271397, 561.4750208555, 566.5241197394188, 568.5820921622607, 28416.289592760193, 29083.0, 35512.0, 36212.45681314776, 36221.456678149785, 42388.364174537404, 42903.138717515416, 42924.0, 42936.78531607338, 42939.785301073454, 8561.486310821356, 8698.91263592051, 8758.211760941515, 8762.079981601935, 8770.780730481758, 8528.061913189544, 8655.69705060323, 8656.394052416334, 8670.783230419227, 8682.218600325969, 8624.956875215616, 8626.784330391727, 8683.435576687527, 8713.825723485526, 8725.0, 8578.0, 8637.827243455096, 8664.436811607226, 8668.8699669505, 8671.696490622799, 8468.195521425454, 8563.100874408223, 8607.784805379853, 8622.180892815235, 8623.870641940375, 38976.61023389787, 39378.21243575141, 39581.20837583232, 39633.0, 39642.80178599089, 3196.8881089162, 3255.96744032559, 3302.554155189043, 3338.7162091222276, 3859.1702783901596, 30047.69952300471, 30155.547666785016, 30313.393732125456, 30410.695893041007, 31053.534196987064, 3740.9064773380883, 3818.4081467372603, 3891.630295121959, 3908.468679219103, 3951.822168002418, 277818.0, 280700.0, 281861.0, 282773.0, 283225.0, 49165.0, 50360.49639503558, 54880.72559637176, 56374.43625563774, 57624.0, 51762.741186293824, 51848.481515184365, 52211.0, 52225.7388713054, 52248.0, 12500.68748281282, 12657.240565566095, 12687.809682854764, 12709.110362274738, 12715.173513721578, 9728.075832795874, 9763.560639771227, 10197.694069177936, 10299.742506437398, 10578.788424231472, 17873.910630447026, 17989.640207195782, 18013.369532066314, 18021.27914883416, 18096.18567164481, 7301.707931682673, 7392.926070739331, 7518.473706840578, 7538.0, 7543.660535275926, 888.9066648001996, 972.8686627305365, 983.5623147699205, 1014.5992333028413, 1063.361982810323, 28227.0, 28546.571801422997, 28670.71329286722, 29028.709712903023, 29029.41941161207, 1007.8185926533148, 1012.2357619997002, 1038.3925403638955, 1105.8949399807007, 1119.9496022678836, 14798.186099764616, 14881.553553393416, 14921.328540215716, 15143.772843407358, 15159.09045457254, 324457.0, 330321.0, 330840.0, 330946.0, 331285.0, 50736.49263507391, 50953.23570146451, 51016.0, 51048.489515104375, 51064.74467627638, 1277.0932637827248, 1288.2141893444991, 1289.1040726694857, 1289.4390939941156, 1314.80277958307, 26759.464810704067, 27552.58671119975, 28198.71801282043, 28308.85845570759, 30025.5496167562, 47175.292370615156, 47316.52683473121, 47504.2874356878, 47578.76210618925, 47750.0, 245005.0, 385874.0, 388050.0, 390522.0, 398674.0, 30735.2316192097, 30832.53751193689, 30926.536101958038, 30959.845200773852, 31282.843585781924, 42643.3603495954, 43219.78390108029, 43398.78300608477, 44018.33972490351, 44536.77731611321, 35371.82314088413, 35905.0, 36348.818255908554, 36545.634543654225, 36793.26413471662, 32614.34771304608, 35186.64813351936, 35237.94286171419, 36192.457113142795, 36520.26959460849, 34121.48817767785, 34246.657533424346, 35095.47356789599, 35100.64899351076, 35108.0, 29777.0, 32125.35749285048, 32148.196295091875, 32236.677633224306, 32545.674543254263, 24247.757522425254, 24430.63354049655, 24476.877615611807, 24912.37719057038, 24913.50172996566], "unit": "score", "name": "ext.html", "value": 18070.670720603815}, {"lowerIsBetter": false, "replicates": [343.4950622584801, 345.6111874141591, 347.93563190809687, 347.94432890737477, 351.37806083232664, 13208.471661133568, 13662.726745465085, 15449.227538623067, 15697.450589229366, 17417.564560885985, 10004.59981600735, 10091.69724908254, 10316.535755890984, 13343.733125337487, 13723.0, 4425.468943726749, 4960.33035540201, 4962.6526143169995, 4969.652124351297, 5176.378834539842, 3793.279276937387, 3859.4982652255308, 5287.41838397776, 5304.310439642841, 5528.806491772789, 5270.235815806705, 5486.972565137189, 5497.780088796443, 5508.862278443051, 5530.308711411074, 5567.777288908439, 5574.331080270353, 5585.3297604287545, 5604.915926261109, 5615.634983726065, 5262.394824595182, 5290.100682883881, 5370.865728356823, 5392.91910621341, 5395.163749618815, 19536.902315488333, 19772.0, 20104.095315710827, 20395.79604203954, 20404.387868363974, 2092.7593326767465, 2121.9151233950624, 2138.561594873063, 2173.793489618484, 2262.8868556572106, 9382.577783999737, 9905.257105717028, 11457.484413201342, 12805.743885122245, 12972.416241269166, 1759.4545690835882, 1831.8076601956868, 1864.9160787764583, 1934.9226030958744, 1968.5767559974531, 54599.727001364736, 57630.7118464405, 57961.0, 58328.12507812386, 58534.414655853325, 9707.223422126213, 9912.702618921443, 10078.244131690153, 10098.545565449573, 10183.54174062169, 13402.262875541745, 13458.596242112557, 13472.5284615038, 13497.055206135672, 13498.59504214875, 7265.745698900513, 7270.054892863894, 7271.3455788979245, 7326.67029983652, 7330.193678695339, 6986.9650651746415, 7000.0, 7048.118985126859, 7056.6118863463, 7078.964605177044, 3771.981140094282, 4346.47842258931, 4411.647068234533, 4428.446444194476, 4459.1973444779605, 1719.552916241761, 1720.1657196259805, 1781.732740088971, 1796.514940965958, 1803.73845792362, 841.8532741509127, 884.4560595233885, 886.9512176830336, 948.9098535639104, 987.7728122531714, 12842.9357853212, 15169.469068582546, 15929.68140637204, 16216.59458513523, 16354.918225408797, 913.4747520175792, 921.9953900230456, 922.7599181759803, 928.5635751196927, 940.8494640857567, 9290.349675522648, 9389.38968967015, 9394.718158455258, 9566.952165239269, 9578.233741300679, 543143.0, 544950.0, 545148.0, 566025.0, 567402.4889626659, 70617.0, 71901.0, 72636.63681681664, 73357.26642733612, 75254.24745752582, 1070.5824728355947, 1077.956881724738, 1084.6095405653957, 1087.8259478483405, 1092.7432053467428, 14689.41242350294, 14753.336099875745, 14756.63108422298, 14772.0, 15011.174385408907, 33305.83347083249, 33662.18863699964, 33932.98201053972, 34154.48768268528, 34168.82915585406, 43372.56627433685, 44393.778031109636, 44646.553534465536, 46527.0, 47496.287555687384, 6811.659417029228, 6908.585484870924, 6923.688434020381, 6965.47758918073, 7025.859482810418, 9000.63997440095, 10203.285769996326, 10300.484975751033, 10334.86316505199, 10462.110720588835, 8791.472511649321, 8932.017478077276, 8949.418287811272, 9164.95417522908, 9310.487923164292, 7344.669489872862, 9295.860562091439, 9659.178969787366, 9724.222062235145, 9826.754331141492, 9196.26429885621, 9520.66677666306, 9770.658026969022, 9905.405675659484, 9911.405315681082, 7231.0, 7325.890111648223, 7326.0, 7390.778276651709, 7409.851802963803, 7836.0, 9580.23358131334, 9662.951685241529, 9696.660616878375, 9796.510174491104], "unit": "score", "name": "jquery.html", "value": 7974.444841009209}, {"lowerIsBetter": false, "replicates": [1334.7864341705317, 1477.3573495529445, 1500.7973923520321, 1633.9918300408497, 1787.3565516414096, 7069.752558660448, 7558.546487210771, 7576.204498527658, 7667.1182813976475, 7673.155952845196, 7609.657565409556, 7794.688212471508, 7798.259165379294, 7799.025121859768, 7815.257550532705, 1974.3583335416047, 2017.2334512885157, 2256.4810093678466, 2315.444293369596, 2335.32275640065, 2317.895694693743, 2321.210788331967, 2323.94190145246, 2326.0463210083867, 2326.581215381231, 2266.2974477911816, 2341.95316093678, 2342.847714898535, 2344.765523447659, 2346.5893468643003, 2282.8173746100356, 2315.849469784467, 2341.180586794608, 2346.049849810821, 2347.1784875293683, 2259.7740225977436, 2279.384566167142, 2285.223024171773, 2299.057386471555, 2348.295511346589, 7975.481593696391, 8024.799380015488, 8037.437379383446, 8046.959765201195, 8049.959750201211, 4640.2343613303765, 4740.431148262196, 4747.35910652061, 4752.097101550694, 4769.308450274725, 3171.9841400792848, 3241.594800649919, 3269.378818024568, 3286.720628746559, 3297.159224397787, 1005.4671024357102, 1010.2563848104272, 1043.4834756795358, 1057.1859668055554, 1072.088724584105, 10977.670669879917, 10994.725131871688, 11025.61410350634, 11042.282251653698, 11043.503042363112, 4449.421575195204, 4450.399196108484, 4456.732596044248, 4464.531224221475, 4472.105578884236, 9363.859542106873, 9378.202852757455, 9378.390404623678, 9396.90603093974, 9404.811903762024, 4656.930146047812, 4667.8599642010795, 4695.248760198352, 4702.952970470252, 4704.0, 4247.49030116388, 4302.419173411612, 4307.784610769449, 4312.849050283287, 4320.43834301545, 3434.759566830348, 3496.5804103507235, 3664.2488289900507, 3700.16746232101, 3735.8505659773305, 1191.4519321112386, 1193.6836738264367, 1194.2297218294152, 1199.9760004799855, 1202.1765090912752, 983.2871168402851, 994.7712026234007, 1002.2633364477103, 1102.685734565661, 1319.228251472899, 7353.963230183922, 7381.077365329334, 7382.741604043833, 7388.630568471555, 7393.9260607393235, 1187.9524819007315, 1192.65413030222, 1194.0984556659666, 1198.2930071257824, 1203.7652657731833, 5649.06790379591, 5678.233438485834, 5731.684757338303, 5751.884962300731, 5757.481826635623, 9426.858597121049, 9539.284553658503, 9659.420434773936, 9826.950865245628, 9838.852417213748, 9396.812063758687, 9481.4785186814, 9607.0, 9615.51922403877, 9618.0, 7316.195218525958, 7422.888656670154, 7493.475456718086, 7497.437692173109, 7525.2098529654695, 7123.501354905107, 7154.570725756471, 7193.3166349196745, 7218.133823941161, 7221.891671624825, 8229.053658829072, 8652.956735216536, 8730.257928075931, 8743.737687869374, 8755.693550725695, 8521.616527256412, 8591.226789588967, 8597.484150950713, 8600.569971501525, 8615.439996400213, 6230.719617617127, 7012.894806578008, 7150.213476517683, 7152.070230869954, 7156.785296441115, 6955.095837541087, 7323.816904577215, 7511.0, 7513.511621744788, 7519.924800751923, 6864.519483636098, 7056.0, 7154.105736782903, 7252.746153884589, 7277.599732014578, 6684.16447944007, 6817.761378351734, 6822.147231596051, 6940.271271516418, 7061.152661680631, 7017.157941047107, 7074.115735533059, 7078.646067696492, 7119.145702515524, 7123.7506687265695, 6693.397594216543, 6759.966200169164, 6760.93239067603, 6767.25560188369, 6771.559848609824, 6614.570052946543, 6636.966815165893, 6650.866982660223, 6655.101561289358, 6656.134702488645], "unit": "score", "name": "mootools.html", "value": 4542.8153659726095}, {"lowerIsBetter": false, "replicates": [323.9352129574085, 328.57449602764416, 334.2145957001047, 348.0758585954292, 355.4526029913931, 5692.0, 5800.274965629296, 5826.504747096491, 5890.676012819298, 5901.763929442823, 5660.60375773695, 5794.217780599628, 5841.445062719045, 5847.8245652630385, 5870.798450581032, 4489.820407183725, 4529.614982726455, 4530.093981203772, 4531.68278220523, 4532.365468834366, 4358.084802191528, 4470.910581788362, 4472.3515090311885, 4479.148961697283, 4527.0, 4366.759828209447, 4438.689291749579, 4471.0, 4484.394606728099, 4491.371208030879, 4437.245668236407, 4447.599716025541, 4451.710638808483, 4455.353973673831, 4464.843730469451, 3926.096997690547, 3926.332523471017, 3928.351821949375, 3929.2337994091163, 3930.744501607386, 5458.263134476834, 5566.359868615121, 5592.7762889484375, 5594.104943209108, 5640.520555752766, 5227.242049902781, 5227.693076730818, 5228.529432351107, 5231.110711179109, 5231.163013917755, 5935.73289201987, 6243.1883855099, 6244.687765611701, 6248.3751624837605, 6251.0, 4155.729877557949, 4265.957340426587, 4272.594103560157, 4274.380214868826, 4278.058827058042, 6417.93582064178, 6448.419642232175, 6477.028445733131, 6480.578762380477, 6505.0, 4374.300111982067, 4419.0940857124215, 4421.602055814992, 4438.045820148684, 4440.511543730187, 4322.8703138905885, 4460.888477788081, 4501.414816073955, 4503.144402563503, 4503.144402563503, 5129.256257842667, 5129.666571672829, 5132.666376685504, 5134.640575159778, 5135.717535535507, 6171.166892469549, 6245.0, 6286.057091436322, 6292.119103325538, 6334.714937827809, 1546.8917175797585, 1561.851624095709, 1562.5078100398339, 1563.5309407177801, 1564.608847788053, 1020.3112898793433, 1020.974475638115, 1025.7128004158847, 1053.3048188195753, 1065.760203954104, 5930.436608522184, 5932.762689492372, 5937.317208521075, 5938.584299099108, 5946.316173640001, 6364.236291645032, 6365.586236894587, 6367.299597044322, 6374.458171055419, 6406.4554512866, 5909.704514774244, 5925.614835035709, 5929.881402371929, 5930.525557955353, 5931.525477961839, 3361.6302206757236, 3443.9655603443643, 3447.1899103710607, 3447.4828775683345, 3449.913752156166, 6611.074449577063, 6647.966760166265, 6652.600843949282, 6657.300983396771, 6659.433948114368, 6613.404793568602, 6661.467082633378, 6679.56582822115, 6680.0981867448245, 6681.76613818514, 6576.80269591913, 6734.326567343324, 6756.594604323658, 6759.831004224835, 6765.188177418643, 6189.412005859436, 6299.464545513682, 6389.520785941166, 6394.200724909387, 6414.069959855888, 6118.143459915526, 6187.412195841388, 6274.215723034621, 6390.872182556416, 6394.90407643895, 6720.8319792005595, 6731.495137864582, 6739.797806065826, 6740.0, 6744.0895479109695, 4302.268614335633, 4477.776111194362, 4523.2988886722615, 4526.434195725535, 4528.977355113203, 6368.140301059298, 6407.16706828128, 6446.323136070832, 6449.355064493513, 6450.9354906450335, 6264.34224406449, 6279.089532017923, 6282.748690052346, 6289.182406287154, 6293.779717709858, 6170.660613666112, 6236.469900058364, 6266.498680105672, 6266.874662506633, 6273.215848018997, 6129.478994285536, 6133.527953291267, 6144.78493252734, 6145.6927153641245, 6154.292256390393, 6276.435120839146, 6276.497880169667, 6280.371962803683, 6285.1515045470105, 6294.905576416449, 5972.0, 6111.174991376285, 6130.417610327012, 6130.846728831815, 6157.4458298753325], "unit": "score", "name": "prototype.html", "value": 4692.690133026956}, {"lowerIsBetter": false, "replicates": [744.5160645580369, 815.714499925026, 821.4044817507304, 829.5561874397197, 843.6288033265363, 12569.560065397713, 12688.30214338211, 12802.0, 12805.039622028338, 13024.739505209891, 12719.109662323617, 12771.936140319309, 12795.168314059603, 12845.22928624281, 12868.549600763976, 670.6546128743701, 679.6771533521562, 801.8436404901047, 818.2267756969666, 818.3289702443998, 795.6379847169553, 811.6712731343815, 816.995915020427, 817.995910020452, 818.7625588579305, 846.4498076250425, 848.9702860399888, 849.4054162086534, 849.7790574450626, 850.158343240194, 682.3347236444476, 693.8646963842078, 834.0616806093145, 843.0894633795517, 849.129642116829, 624.4598422364668, 624.6127401011356, 624.684534310175, 625.2559454249474, 625.3152797686525, 12663.93668031654, 12719.30043847588, 12763.553275635308, 12805.48778048877, 12813.87186128136, 12480.188787728768, 12847.357632118357, 12858.678533036655, 12870.48518059286, 13275.203487790763, 10355.637552685695, 10456.163506919504, 10522.894771052344, 10546.314489558154, 10553.525091370906, 3538.2039041215776, 3574.803385813779, 3595.227026189356, 3599.4960705501253, 3732.794696291703, 46553.5344646556, 46755.0, 46779.298310525366, 46923.5307646926, 46980.0, 9386.624535018524, 9412.482313472688, 9654.662086826927, 9811.116999470081, 10065.993400659876, 18283.908580457013, 18416.447506574823, 18527.0736463179, 18530.16614252362, 18537.81462185388, 7490.962545187239, 7615.923840761632, 7727.0, 7789.454738168387, 8080.8383832323025, 4443.311286750559, 4453.864264612503, 4517.254652982287, 4518.819247230074, 4632.745199014086, 3061.8162910225456, 3079.8614062367246, 3106.5806116174026, 3106.6116735408073, 3110.828904410279, 537.0601447466933, 555.0730280431688, 561.0714267886655, 564.0749171358974, 572.2960758267354, 518.8443466959897, 608.2305883057935, 634.4860662863003, 641.5861769158867, 655.3381085104079, 7983.8403231935035, 8128.309093727099, 8291.917080829235, 8303.252707256375, 9188.540572971324, 429.2509570798976, 582.4292193650161, 635.3487675132933, 636.277824669004, 647.0843756085087, 3771.321162190832, 4016.2971479990883, 4079.3676980068135, 4105.220008198433, 4170.562654911919, 54569.727151363986, 56028.0, 56080.15879761807, 56336.436635633116, 56378.43621563814, 49313.26030109551, 49430.25854612112, 49710.75144624254, 51415.0, 51738.0, 44389.55610443919, 44710.32934505985, 44919.55080449219, 44995.325070123974, 45191.32213016741, 7991.200879912195, 8336.291415229773, 8411.242988131098, 8715.172058654418, 8795.25240354577, 32985.83507082449, 33185.50221746627, 34067.14832129217, 34314.82842585771, 34384.82807585946, 41685.58314416817, 42231.0, 44881.55118448774, 45282.0, 45656.77171614121, 10299.227557933034, 10342.172626190037, 10570.894291056991, 10596.933597948326, 10889.128869690247, 10456.0, 10878.510467028844, 11336.376499292619, 11355.54577816878, 11375.488103035548, 10672.359658420519, 10796.460176991277, 10905.672829815117, 11048.226624136234, 11505.022073123879, 10586.0, 10676.519556619816, 10680.252382333161, 10697.197710171613, 11008.554816863647, 7545.924540754741, 10085.949570252102, 10467.319624224401, 10893.291936024134, 11113.555457781598, 8699.608517616596, 9000.0, 9281.071892810665, 9546.474943878153, 9567.856482152634, 8767.517786521803, 8912.0, 9100.317476189444, 9563.474008929297, 9770.169535589555], "unit": "score", "name": "yui.html", "value": 6142.122993827382}], "name": "dromaeo_css", "value": 6743.984645320705}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 110.0, 105.0, 111.0, 109.0, 110.0, 111.0, 111.0, 103.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.1}, {"lowerIsBetter": true, "replicates": [159.0, 129.0, 146.0, 166.0, 125.0, 154.0, 147.0, 122.0, 167.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 144.3}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 160.0, 162.0, 161.0, 163.0, 163.0, 161.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 72.0, 152.0, 74.0, 74.0, 73.0, 76.0, 154.0, 74.0], "unit": "score", "name": "audio-fft", "value": 89.3}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 151.0, 96.0, 97.0, 96.0, 144.0, 96.0, 97.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 110.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 56.0, 56.0, 56.0, 56.0, 58.0, 57.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 69.0, 69.0, 68.0, 68.0, 69.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 81.0, 82.0, 82.0, 84.0, 82.0, 83.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.2}, {"lowerIsBetter": true, "replicates": [115.0, 115.0, 115.0, 116.0, 111.0, 124.0, 117.0, 115.0, 114.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.3}, {"lowerIsBetter": true, "replicates": [140.0, 139.0, 140.0, 144.0, 142.0, 129.0, 149.0, 140.0, 139.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.1}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 65.0, 67.0, 64.0, 65.0, 66.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.6}], "name": "kraken", "value": 1495.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.7570877369569], "unit": "score", "name": "Richards", "value": 210.43522200000004}, {"lowerIsBetter": false, "replicates": [187.44142455482663], "unit": "score", "name": "DeltaBlue", "value": 352.7395299999999}, {"lowerIsBetter": false, "replicates": [280.2690582959641], "unit": "score", "name": "Encrypt", "value": 949.7338080000005}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [1953.125], "unit": "score", "name": "RayTrace", "value": 378.87436799999995}, {"lowerIsBetter": false, "replicates": [788.6435331230284], "unit": "score", "name": "Earley", "value": 845.075084}, {"lowerIsBetter": false, "replicates": [12402.439024390244], "unit": "score", "name": "Boyer", "value": 53.7364464110128}, {"lowerIsBetter": false, "replicates": [42312.5], "unit": "score", "name": "RegExp", "value": 21.52992614475626}, {"lowerIsBetter": false, "replicates": [625.2330640149161], "unit": "score", "name": "Splay", "value": 130.33699701789263}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 18827.910543726128}]} 11:22:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "18827.91"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1495.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6743.98"}}} 11:22:35 INFO - Return code: 0 11:22:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:22:35 INFO - # TBPL SUCCESS # 11:22:35 INFO - Running post-action listener: _resource_record_post_action 11:22:35 INFO - Running post-run listener: _resource_record_post_run 11:22:36 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 540401664; Read time: 0; Write time: 515060 11:22:36 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 236601344; Read time: 0; Write time: 222528 11:22:36 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 0; Write bytes: 302297088; Read time: 0; Write time: 292488 11:22:36 INFO - Running post-run listener: _upload_blobber_files 11:22:36 INFO - Blob upload gear active. 11:22:36 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:22:36 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 11:22:36 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 11:22:36 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 11:22:36 INFO - (blobuploader) - INFO - Open directory for files ... 11:22:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:22:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:22:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:22:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:22:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:22:37 INFO - (blobuploader) - INFO - Done attempting. 11:22:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 11:22:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:22:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:22:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:22:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:22:38 INFO - (blobuploader) - INFO - Done attempting. 11:22:38 INFO - (blobuploader) - INFO - Iteration through files over. 11:22:38 INFO - Return code: 0 11:22:38 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:22:38 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:22:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6fc2c88744ff3ab925c83892884fa885d6ee00570cd4d23fb2a8cc4343aea3d8497bc90c8200e0f34898a464fc0fd58e019c7b2227c2f76de4af977eaf0fbda1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/87b9ffeab86b1bf1b4e40edffc2955ee56fb60f26af25f73248c65cebc5fdef85a446b1868c3dfff06157d38e067251b86fdf4dc2499dde1057d579df83d64af"} 11:22:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:22:38 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:22:38 INFO - Contents: 11:22:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6fc2c88744ff3ab925c83892884fa885d6ee00570cd4d23fb2a8cc4343aea3d8497bc90c8200e0f34898a464fc0fd58e019c7b2227c2f76de4af977eaf0fbda1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/87b9ffeab86b1bf1b4e40edffc2955ee56fb60f26af25f73248c65cebc5fdef85a446b1868c3dfff06157d38e067251b86fdf4dc2499dde1057d579df83d64af"} 11:22:38 INFO - Running post-run listener: copy_logs_to_upload_dir 11:22:38 INFO - Copying logs to upload dir... 11:22:38 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 11:22:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.227559 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-18 11:22:36.339738) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-18 11:22:36.343984) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6fc2c88744ff3ab925c83892884fa885d6ee00570cd4d23fb2a8cc4343aea3d8497bc90c8200e0f34898a464fc0fd58e019c7b2227c2f76de4af977eaf0fbda1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/87b9ffeab86b1bf1b4e40edffc2955ee56fb60f26af25f73248c65cebc5fdef85a446b1868c3dfff06157d38e067251b86fdf4dc2499dde1057d579df83d64af"} build_url:https://queue.taskcluster.net/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011381 build_url: 'https://queue.taskcluster.net/v1/task/Yr2p_IDiTQ2tWJ2KZZMxiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6fc2c88744ff3ab925c83892884fa885d6ee00570cd4d23fb2a8cc4343aea3d8497bc90c8200e0f34898a464fc0fd58e019c7b2227c2f76de4af977eaf0fbda1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/87b9ffeab86b1bf1b4e40edffc2955ee56fb60f26af25f73248c65cebc5fdef85a446b1868c3dfff06157d38e067251b86fdf4dc2499dde1057d579df83d64af"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-18 11:22:36.369176) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 11:22:36.369548) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1453143317.987421-1492609295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 11:22:36.454150) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-18 11:22:36.454603) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-18 11:22:36.454928) ========= ========= Total master_lag: 0.26 =========