builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1453402893.78 results: success (0) buildid: 20160121083240 builduid: aa56c606236c45d294d314e4957ef846 revision: f36a4a4ff73f1184f569fd9152b98fe8d8d3866a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 11:01:33.779509) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 11:01:33.779946) ========= ========= Started set props: basedir (results: 0, elapsed: 8 secs) (at 2016-01-21 11:01:33.780278) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006362 basedir: '/builds/slave/test-pgo' ========= master_lag: 8.78 ========= ========= Finished set props: basedir (results: 0, elapsed: 8 secs) (at 2016-01-21 11:01:42.567548) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-01-21 11:01:42.567914) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-01-21 11:01:43.933247) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:01:43.933579) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.012905 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:01:43.962328) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 11:01:43.962632) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 11:01:43.963031) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:01:43.963354) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-21 11:01:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.1M=0s 2016-01-21 11:01:44 (35.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162934 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:01:44.141454) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:01:44.141820) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.061533 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:01:44.215979) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-21 11:01:44.216391) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f36a4a4ff73f1184f569fd9152b98fe8d8d3866a --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 f36a4a4ff73f1184f569fd9152b98fe8d8d3866a --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=e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-21 11:01:44,351 truncating revision to first 12 chars 2016-01-21 11:01:44,351 Setting DEBUG logging. 2016-01-21 11:01:44,351 attempt 1/10 2016-01-21 11:01:44,351 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f36a4a4ff73f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-21 11:01:45,215 unpacking tar archive at: fx-team-f36a4a4ff73f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.155786 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-21 11:01:45.386016) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 11:01:45.386604) ========= echo f36a4a4ff73f1184f569fd9152b98fe8d8d3866a in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f36a4a4ff73f1184f569fd9152b98fe8d8d3866a'] 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=e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False f36a4a4ff73f1184f569fd9152b98fe8d8d3866a program finished with exit code 0 elapsedTime=0.003761 script_repo_revision: 'f36a4a4ff73f1184f569fd9152b98fe8d8d3866a' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 11:01:45.436467) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 11:01:45.436843) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 11:01:45.446981) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-01-21 11:01:45.447414) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:01:45 INFO - MultiFileLogger online at 20160121 11:01:45 in /builds/slave/test-pgo 11:01:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:45 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:01:45 INFO - {'append_to_log': False, 11:01:45 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:01:45 INFO - 'blob_upload_branch': 'Fx-Team', 11:01:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:01:45 INFO - 'branch': 'Fx-Team', 11:01:45 INFO - 'buildbot_json_path': 'buildprops.json', 11:01:45 INFO - 'config_files': ('talos/linux_config.py',), 11:01:45 INFO - 'default_actions': ('clobber', 11:01:45 INFO - 'read-buildbot-config', 11:01:45 INFO - 'download-and-extract', 11:01:45 INFO - 'populate-webroot', 11:01:45 INFO - 'create-virtualenv', 11:01:45 INFO - 'install', 11:01:45 INFO - 'run-tests'), 11:01:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:01:45 INFO - 'download_minidump_stackwalk': True, 11:01:45 INFO - 'download_symbols': 'ondemand', 11:01:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:01:45 INFO - 'tooltool.py': '/tools/tooltool.py', 11:01:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:01:45 INFO - '/tools/misc-python/virtualenv.py')}, 11:01:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:01:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:01:45 INFO - 'installer_path': 'installer.exe', 11:01:45 INFO - 'log_level': 'info', 11:01:45 INFO - 'log_name': 'talos', 11:01:45 INFO - 'log_to_console': True, 11:01:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:01:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:01:45 INFO - 'opt_config_files': (), 11:01:45 INFO - 'pip_index': False, 11:01:45 INFO - 'sps_profile': False, 11:01:45 INFO - 'sps_profile_interval': 0, 11:01:45 INFO - 'suite': 'dromaeojs-e10s', 11:01:45 INFO - 'system_bits': '32', 11:01:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:01:45 INFO - 'title': 'talos-linux64-ix-067', 11:01:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:01:45 INFO - 'use_talos_json': True, 11:01:45 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:01:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:01:45 INFO - 'work_dir': 'build'} 11:01:45 INFO - ##### 11:01:45 INFO - ##### Running clobber step. 11:01:45 INFO - ##### 11:01:45 INFO - Running pre-action listener: _resource_record_pre_action 11:01:45 INFO - Running main action method: clobber 11:01:45 INFO - rmtree: /builds/slave/test-pgo/build 11:01:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:01:46 INFO - Running post-action listener: _resource_record_post_action 11:01:46 INFO - ##### 11:01:46 INFO - ##### Running read-buildbot-config step. 11:01:46 INFO - ##### 11:01:46 INFO - Running pre-action listener: _resource_record_pre_action 11:01:46 INFO - Running main action method: read_buildbot_config 11:01:46 INFO - Using buildbot properties: 11:01:46 INFO - { 11:01:46 INFO - "project": "", 11:01:46 INFO - "product": "firefox", 11:01:46 INFO - "script_repo_revision": "production", 11:01:46 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:01:46 INFO - "repository": "", 11:01:46 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:01:46 INFO - "buildid": "20160121083240", 11:01:46 INFO - "pgo_build": "True", 11:01:46 INFO - "basedir": "/builds/slave/test-pgo", 11:01:46 INFO - "buildnumber": 457, 11:01:46 INFO - "slavename": "talos-linux64-ix-067", 11:01:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:01:46 INFO - "platform": "ubuntu64_hw", 11:01:46 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:01:46 INFO - "branch": "fx-team", 11:01:46 INFO - "repo_path": "integration/fx-team", 11:01:46 INFO - "revision": "f36a4a4ff73f1184f569fd9152b98fe8d8d3866a", 11:01:46 INFO - "stage_platform": "linux64-pgo", 11:01:46 INFO - "builduid": "aa56c606236c45d294d314e4957ef846", 11:01:46 INFO - "slavebuilddir": "test" 11:01:46 INFO - } 11:01:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/T308CCqFR36efovtyE08Ug/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 11:01:46 INFO - Running post-action listener: _resource_record_post_action 11:01:46 INFO - ##### 11:01:46 INFO - ##### Running download-and-extract step. 11:01:46 INFO - ##### 11:01:46 INFO - Running pre-action listener: _resource_record_pre_action 11:01:46 INFO - Running main action method: download_and_extract 11:01:46 INFO - mkdir: /builds/slave/test-pgo/build/tests 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 - https://queue.taskcluster.net/v1/task/T308CCqFR36efovtyE08Ug/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:01:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T308CCqFR36efovtyE08Ug/artifacts/public/build/test_packages.json 11:01:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T308CCqFR36efovtyE08Ug/artifacts/public/build/test_packages.json 11:01:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T308CCqFR36efovtyE08Ug/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:01:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T308CCqFR36efovtyE08Ug/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:01:48 INFO - Downloaded 1448 bytes. 11:01:48 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:01:48 INFO - Using the following test package requirements: 11:01:48 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:01:48 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:01:48 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:01:48 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:48 INFO - u'jsshell-linux-x86_64.zip'], 11:01:48 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:01:48 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:01:48 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:01:48 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:01:48 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:01:48 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:01:48 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:01:48 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 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 - https://queue.taskcluster.net/v1/task/T308CCqFR36efovtyE08Ug/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:01:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T308CCqFR36efovtyE08Ug/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:01:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T308CCqFR36efovtyE08Ug/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:01:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T308CCqFR36efovtyE08Ug/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:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T308CCqFR36efovtyE08Ug/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:50 INFO - Downloaded 22486825 bytes. 11:01:50 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:50 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:51 INFO - Return code: 0 11:01:51 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: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 - https://queue.taskcluster.net/v1/task/T308CCqFR36efovtyE08Ug/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:01:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T308CCqFR36efovtyE08Ug/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:01:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T308CCqFR36efovtyE08Ug/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:01:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T308CCqFR36efovtyE08Ug/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:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T308CCqFR36efovtyE08Ug/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:53 INFO - Downloaded 22486825 bytes. 11:01:53 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:53 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:55 INFO - Return code: 0 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 - https://queue.taskcluster.net/v1/task/T308CCqFR36efovtyE08Ug/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:01:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T308CCqFR36efovtyE08Ug/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:01:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T308CCqFR36efovtyE08Ug/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:01:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T308CCqFR36efovtyE08Ug/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:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T308CCqFR36efovtyE08Ug/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:56 INFO - Downloaded 10706572 bytes. 11:01:56 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:56 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:56 INFO - Return code: 0 11:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:56 INFO - https://queue.taskcluster.net/v1/task/T308CCqFR36efovtyE08Ug/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:01:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T308CCqFR36efovtyE08Ug/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:01:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T308CCqFR36efovtyE08Ug/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:01:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T308CCqFR36efovtyE08Ug/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:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T308CCqFR36efovtyE08Ug/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:58 INFO - Downloaded 55964954 bytes. 11:01:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T308CCqFR36efovtyE08Ug/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:01:58 INFO - mkdir: /builds/slave/test-pgo/properties 11:01:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:01:58 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:01:58 INFO - Contents: 11:01:58 INFO - build_url:https://queue.taskcluster.net/v1/task/T308CCqFR36efovtyE08Ug/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:01:58 INFO - Running post-action listener: _resource_record_post_action 11:01:58 INFO - Running post-action listener: set_extra_try_arguments 11:01:58 INFO - ##### 11:01:58 INFO - ##### Running populate-webroot step. 11:01:58 INFO - ##### 11:01:58 INFO - Running pre-action listener: _resource_record_pre_action 11:01:58 INFO - Running main action method: populate_webroot 11:01:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:01:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:01:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:01:58 INFO - '--tppagecycles', 11:01:58 INFO - '7'], 11:01:58 INFO - 'tests': ['tsvgm']}}, 11:01:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:01:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:01:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:01:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:01:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:01:58 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:01:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:01:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:58 INFO - 'talos_options': ['--e10s'], 11:01:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:01:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:58 INFO - 'tests': ['damp', 'tps']}, 11:01:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:58 INFO - 'talos_options': ['--e10s'], 11:01:58 INFO - 'tests': ['damp', 'tps']}, 11:01:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:01:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:01:58 INFO - 'other': {'tests': ['a11yr', 11:01:58 INFO - 'ts_paint', 11:01:58 INFO - 'tpaint', 11:01:58 INFO - 'sessionrestore', 11:01:58 INFO - 'sessionrestore_no_auto_restore']}, 11:01:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:01:58 INFO - 'tests': ['a11yr', 11:01:58 INFO - 'ts_paint', 11:01:58 INFO - 'tpaint', 11:01:58 INFO - 'sessionrestore', 11:01:58 INFO - 'sessionrestore_no_auto_restore']}, 11:01:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:01:58 INFO - 'tests': ['a11yr', 11:01:58 INFO - 'ts_paint', 11:01:58 INFO - 'tpaint', 11:01:58 INFO - 'sessionrestore', 11:01:58 INFO - 'sessionrestore_no_auto_restore']}, 11:01:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:01:58 INFO - 'tests': ['a11yr', 11:01:58 INFO - 'ts_paint', 11:01:58 INFO - 'tpaint', 11:01:58 INFO - 'sessionrestore', 11:01:58 INFO - 'sessionrestore_no_auto_restore']}, 11:01:58 INFO - 'other_l64': {'tests': ['a11yr', 11:01:58 INFO - 'ts_paint', 11:01:58 INFO - 'tpaint', 11:01:58 INFO - 'sessionrestore', 11:01:58 INFO - 'sessionrestore_no_auto_restore']}, 11:01:58 INFO - 'other_nol64': {'tests': ['a11yr', 11:01:58 INFO - 'ts_paint', 11:01:58 INFO - 'tpaint', 11:01:58 INFO - 'sessionrestore', 11:01:58 INFO - 'sessionrestore_no_auto_restore']}, 11:01:58 INFO - 'svgr': {'tests': ['tsvgx', 11:01:58 INFO - 'tsvgr_opacity', 11:01:58 INFO - 'tart', 11:01:58 INFO - 'tscrollx', 11:01:58 INFO - 'cart']}, 11:01:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:01:58 INFO - 'tests': ['tsvgx', 11:01:58 INFO - 'tsvgr_opacity', 11:01:58 INFO - 'tart', 11:01:58 INFO - 'tscrollx', 11:01:58 INFO - 'cart']}, 11:01:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:58 INFO - 'tests': ['tp5o']}, 11:01:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:58 INFO - 'talos_options': ['--e10s'], 11:01:58 INFO - 'tests': ['tp5o']}, 11:01:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:58 INFO - 'talos_options': ['--xperf_path', 11:01:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:01:58 INFO - 'tests': ['tp5n']}, 11:01:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:58 INFO - 'talos_options': ['--e10s', 11:01:58 INFO - '--xperf_path', 11:01:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:01:58 INFO - 'tests': ['tp5n']}}, 11:01:58 INFO - 'talos.zip': {'path': '', 11:01:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:01:58 INFO - Running post-action listener: _resource_record_post_action 11:01:58 INFO - ##### 11:01:58 INFO - ##### Running create-virtualenv step. 11:01:58 INFO - ##### 11:01:58 INFO - Running pre-action listener: _resource_record_pre_action 11:01:58 INFO - Running main action method: create_virtualenv 11:01:58 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:01:58 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:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:01:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:01:58 INFO - Using real prefix '/usr' 11:01:58 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:01:58 INFO - Installing distribute.............................................................................................................................................................................................done. 11:02:00 INFO - Installing pip.................done. 11:02:00 INFO - Return code: 0 11:02:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:02:00 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:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:00 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:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3225b2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0840>, '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 0xd4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4db60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172', '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:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 11:02:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:02:00 INFO - Using env: {'DISPLAY': ':0', 11:02:00 INFO - 'HOME': '/home/cltbld', 11:02:00 INFO - 'LANG': 'en_US.UTF-8', 11:02:00 INFO - 'LANGUAGE': 'en_US:en', 11:02:00 INFO - 'LOGNAME': 'cltbld', 11:02:00 INFO - 'MAIL': '/var/mail/cltbld', 11:02:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:00 INFO - 'MOZ_NO_REMOTE': '1', 11:02:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:00 INFO - 'NO_EM_RESTART': '1', 11:02:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:02:00 INFO - 'PWD': '/builds/slave/test-pgo', 11:02:00 INFO - 'SHELL': '/bin/bash', 11:02:00 INFO - 'SHLVL': '1', 11:02:00 INFO - 'TERM': 'linux', 11:02:00 INFO - 'TMOUT': '86400', 11:02:00 INFO - 'USER': 'cltbld', 11:02:00 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172', 11:02:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:00 INFO - '_': '/tools/buildbot/bin/python'} 11:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:00 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:02:00 INFO - Cleaning up... 11:02:01 INFO - Return code: 0 11:02:01 INFO - Installing psutil>=0.7.1 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', '--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 0x7f3225b2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0840>, '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 0xd4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4db60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172', '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', '--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:02:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 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': 'e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172', 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 psutil>=0.7.1 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 - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:02:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:02:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:02:03 INFO - Installing collected packages: psutil 11:02:03 INFO - Running setup.py install for psutil 11:02:03 INFO - building 'psutil._psutil_linux' extension 11:02:03 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:02:03 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:02:03 INFO - building 'psutil._psutil_posix' extension 11:02:03 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:02:03 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:02:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:02:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:02:03 INFO - Successfully installed psutil 11:02:03 INFO - Cleaning up... 11:02:03 INFO - Return code: 0 11:02:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:02:03 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:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:03 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:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3225b2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0840>, '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 0xd4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4db60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172', '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:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 11:02:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:02:03 INFO - Using env: {'DISPLAY': ':0', 11:02:03 INFO - 'HOME': '/home/cltbld', 11:02:03 INFO - 'LANG': 'en_US.UTF-8', 11:02:03 INFO - 'LANGUAGE': 'en_US:en', 11:02:03 INFO - 'LOGNAME': 'cltbld', 11:02:03 INFO - 'MAIL': '/var/mail/cltbld', 11:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:03 INFO - 'MOZ_NO_REMOTE': '1', 11:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:03 INFO - 'NO_EM_RESTART': '1', 11:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:02:03 INFO - 'PWD': '/builds/slave/test-pgo', 11:02:03 INFO - 'SHELL': '/bin/bash', 11:02:03 INFO - 'SHLVL': '1', 11:02:03 INFO - 'TERM': 'linux', 11:02:03 INFO - 'TMOUT': '86400', 11:02:03 INFO - 'USER': 'cltbld', 11:02:03 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172', 11:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:03 INFO - '_': '/tools/buildbot/bin/python'} 11:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 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:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:02:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:02:05 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:02:05 INFO - Installing collected packages: mozsystemmonitor 11:02:05 INFO - Running setup.py install for mozsystemmonitor 11:02:05 INFO - Successfully installed mozsystemmonitor 11:02:05 INFO - Cleaning up... 11:02:05 INFO - Return code: 0 11:02:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3225b2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0840>, '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 0xd4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4db60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172', '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:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 11:02:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:02:05 INFO - Using env: {'DISPLAY': ':0', 11:02:05 INFO - 'HOME': '/home/cltbld', 11:02:05 INFO - 'LANG': 'en_US.UTF-8', 11:02:05 INFO - 'LANGUAGE': 'en_US:en', 11:02:05 INFO - 'LOGNAME': 'cltbld', 11:02:05 INFO - 'MAIL': '/var/mail/cltbld', 11:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:05 INFO - 'MOZ_NO_REMOTE': '1', 11:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:05 INFO - 'NO_EM_RESTART': '1', 11:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:02:05 INFO - 'PWD': '/builds/slave/test-pgo', 11:02:05 INFO - 'SHELL': '/bin/bash', 11:02:05 INFO - 'SHLVL': '1', 11:02:05 INFO - 'TERM': 'linux', 11:02:05 INFO - 'TMOUT': '86400', 11:02:05 INFO - 'USER': 'cltbld', 11:02:05 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172', 11:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:05 INFO - '_': '/tools/buildbot/bin/python'} 11:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:05 INFO - Downloading/unpacking blobuploader==1.2.4 11:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:07 INFO - Downloading blobuploader-1.2.4.tar.gz 11:02:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:02:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:02:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:08 INFO - Downloading docopt-0.6.1.tar.gz 11:02:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:02:08 INFO - Installing collected packages: blobuploader, requests, docopt 11:02:08 INFO - Running setup.py install for blobuploader 11:02:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:02:08 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:02:08 INFO - Running setup.py install for requests 11:02:08 INFO - Running setup.py install for docopt 11:02:09 INFO - Successfully installed blobuploader requests docopt 11:02:09 INFO - Cleaning up... 11:02:09 INFO - Return code: 0 11:02:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:02:09 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:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:09 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:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3225b2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0840>, '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 0xd4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4db60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172', '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:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 11:02:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:02:09 INFO - Using env: {'DISPLAY': ':0', 11:02:09 INFO - 'HOME': '/home/cltbld', 11:02:09 INFO - 'LANG': 'en_US.UTF-8', 11:02:09 INFO - 'LANGUAGE': 'en_US:en', 11:02:09 INFO - 'LOGNAME': 'cltbld', 11:02:09 INFO - 'MAIL': '/var/mail/cltbld', 11:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:09 INFO - 'MOZ_NO_REMOTE': '1', 11:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:09 INFO - 'NO_EM_RESTART': '1', 11:02:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:02:09 INFO - 'PWD': '/builds/slave/test-pgo', 11:02:09 INFO - 'SHELL': '/bin/bash', 11:02:09 INFO - 'SHLVL': '1', 11:02:09 INFO - 'TERM': 'linux', 11:02:09 INFO - 'TMOUT': '86400', 11:02:09 INFO - 'USER': 'cltbld', 11:02:09 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172', 11:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:09 INFO - '_': '/tools/buildbot/bin/python'} 11:02:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:02:09 INFO - Running setup.py (path:/tmp/pip-HcTJKz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:02:09 INFO - Running setup.py (path:/tmp/pip-5cqvDh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:02:09 INFO - Running setup.py (path:/tmp/pip-1NYMj_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:02:09 INFO - Running setup.py (path:/tmp/pip-2Y4yzA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:02:09 INFO - Running setup.py (path:/tmp/pip-ha0sPy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:02:09 INFO - Running setup.py (path:/tmp/pip-y60jrm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:02:09 INFO - Running setup.py (path:/tmp/pip-0L7Ydn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:02:09 INFO - Running setup.py (path:/tmp/pip-ACqiCl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:02:09 INFO - Running setup.py (path:/tmp/pip-GIv2cE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:02:09 INFO - Running setup.py (path:/tmp/pip-yLvcFt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:02:10 INFO - Running setup.py (path:/tmp/pip-_neKr5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:02:10 INFO - Running setup.py (path:/tmp/pip-uJilhH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:02:10 INFO - Running setup.py (path:/tmp/pip-oLWMaA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:02:10 INFO - Running setup.py (path:/tmp/pip-xTZWhh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:02:10 INFO - Running setup.py (path:/tmp/pip-bTChLC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:02:10 INFO - Running setup.py (path:/tmp/pip-ywzRBg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:02:10 INFO - Running setup.py (path:/tmp/pip-wjxaXQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:02:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:02:10 INFO - Running setup.py install for manifestparser 11:02:10 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:02:10 INFO - Running setup.py install for mozcrash 11:02:10 INFO - Running setup.py install for mozdebug 11:02:10 INFO - Running setup.py install for mozdevice 11:02:10 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:02:10 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:02:10 INFO - Running setup.py install for mozfile 11:02:11 INFO - Running setup.py install for mozhttpd 11:02:11 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:02:11 INFO - Running setup.py install for mozinfo 11:02:11 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:02:11 INFO - Running setup.py install for mozInstall 11:02:11 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:02:11 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:02:11 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:02:11 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:02:11 INFO - Running setup.py install for mozleak 11:02:11 INFO - Running setup.py install for mozlog 11:02:11 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:02:11 INFO - Running setup.py install for moznetwork 11:02:11 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:02:11 INFO - Running setup.py install for mozprocess 11:02:11 INFO - Running setup.py install for mozprofile 11:02:11 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:02:11 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:02:11 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:02:11 INFO - Running setup.py install for mozrunner 11:02:11 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:02:11 INFO - Running setup.py install for mozscreenshot 11:02:12 INFO - Running setup.py install for moztest 11:02:12 INFO - Running setup.py install for mozversion 11:02:12 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:02:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:02:12 INFO - Cleaning up... 11:02:12 INFO - Return code: 0 11:02:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:02:12 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:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:12 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:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3225b2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0840>, '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 0xd4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4db60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172', '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:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 11:02:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:02:12 INFO - Using env: {'DISPLAY': ':0', 11:02:12 INFO - 'HOME': '/home/cltbld', 11:02:12 INFO - 'LANG': 'en_US.UTF-8', 11:02:12 INFO - 'LANGUAGE': 'en_US:en', 11:02:12 INFO - 'LOGNAME': 'cltbld', 11:02:12 INFO - 'MAIL': '/var/mail/cltbld', 11:02:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:12 INFO - 'MOZ_NO_REMOTE': '1', 11:02:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:12 INFO - 'NO_EM_RESTART': '1', 11:02:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:02:12 INFO - 'PWD': '/builds/slave/test-pgo', 11:02:12 INFO - 'SHELL': '/bin/bash', 11:02:12 INFO - 'SHLVL': '1', 11:02:12 INFO - 'TERM': 'linux', 11:02:12 INFO - 'TMOUT': '86400', 11:02:12 INFO - 'USER': 'cltbld', 11:02:12 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172', 11:02:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:12 INFO - '_': '/tools/buildbot/bin/python'} 11:02:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:02:12 INFO - Running setup.py (path:/tmp/pip-OoSpAV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:02:12 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:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:02:12 INFO - Running setup.py (path:/tmp/pip-LarIzv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:02:12 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:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:02:12 INFO - Running setup.py (path:/tmp/pip-UQtrm2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:02:12 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:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:02:12 INFO - Running setup.py (path:/tmp/pip-4Gt1JS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:02:12 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:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:02:12 INFO - Running setup.py (path:/tmp/pip-KLoIg1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:02:12 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:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:02:12 INFO - Running setup.py (path:/tmp/pip-SIP_RT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:02:12 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:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:02:12 INFO - Running setup.py (path:/tmp/pip-oNFZzc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:02:13 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:02:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:02:13 INFO - Running setup.py (path:/tmp/pip-2P_kkj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:02:13 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:02:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:02:13 INFO - Running setup.py (path:/tmp/pip-UpqIqx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:02:13 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:02:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:02:13 INFO - Running setup.py (path:/tmp/pip-XaRpgQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:02:13 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:02:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:02:13 INFO - Running setup.py (path:/tmp/pip-grtVXt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:02:13 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:02:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:02:13 INFO - Running setup.py (path:/tmp/pip-p3VqBF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:02:13 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:02:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:02:13 INFO - Running setup.py (path:/tmp/pip-w66hev-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:02:13 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:02:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:02:13 INFO - Running setup.py (path:/tmp/pip-D2rLWT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:02:13 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:02:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:02:13 INFO - Running setup.py (path:/tmp/pip-WPHZ1h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:02:13 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:02:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:02:13 INFO - Running setup.py (path:/tmp/pip-eQQBUa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:02:13 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:02:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:02:13 INFO - Running setup.py (path:/tmp/pip-OBt5FV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:02:13 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:02:13 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:02:13 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:02:13 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:02:13 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:02:13 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:02:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:15 INFO - Downloading blessings-1.6.tar.gz 11:02:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:02:15 INFO - Installing collected packages: blessings 11:02:15 INFO - Running setup.py install for blessings 11:02:15 INFO - Successfully installed blessings 11:02:15 INFO - Cleaning up... 11:02:15 INFO - Return code: 0 11:02:15 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:02:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:02:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:02:15 INFO - Reading from file tmpfile_stdout 11:02:15 INFO - Current package versions: 11:02:15 INFO - argparse == 1.2.1 11:02:15 INFO - blessings == 1.6 11:02:15 INFO - blobuploader == 1.2.4 11:02:15 INFO - docopt == 0.6.1 11:02:15 INFO - manifestparser == 1.1 11:02:15 INFO - mozInstall == 1.12 11:02:15 INFO - mozcrash == 0.16 11:02:15 INFO - mozdebug == 0.1 11:02:15 INFO - mozdevice == 0.48 11:02:15 INFO - mozfile == 1.2 11:02:15 INFO - mozhttpd == 0.7 11:02:15 INFO - mozinfo == 0.9 11:02:15 INFO - mozleak == 0.1 11:02:15 INFO - mozlog == 3.1 11:02:15 INFO - moznetwork == 0.27 11:02:15 INFO - mozprocess == 0.22 11:02:15 INFO - mozprofile == 0.28 11:02:15 INFO - mozrunner == 6.11 11:02:15 INFO - mozscreenshot == 0.1 11:02:15 INFO - mozsystemmonitor == 0.0 11:02:15 INFO - moztest == 0.7 11:02:15 INFO - mozversion == 1.4 11:02:15 INFO - psutil == 3.1.1 11:02:15 INFO - requests == 1.2.3 11:02:15 INFO - wsgiref == 0.1.2 11:02:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:02:15 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:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:15 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:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3225b2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0840>, '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 0xd4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4db60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172', '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:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 11:02:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:02:15 INFO - Using env: {'DISPLAY': ':0', 11:02:15 INFO - 'HOME': '/home/cltbld', 11:02:15 INFO - 'LANG': 'en_US.UTF-8', 11:02:15 INFO - 'LANGUAGE': 'en_US:en', 11:02:15 INFO - 'LOGNAME': 'cltbld', 11:02:15 INFO - 'MAIL': '/var/mail/cltbld', 11:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:15 INFO - 'MOZ_NO_REMOTE': '1', 11:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:15 INFO - 'NO_EM_RESTART': '1', 11:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:02:15 INFO - 'PWD': '/builds/slave/test-pgo', 11:02:15 INFO - 'SHELL': '/bin/bash', 11:02:15 INFO - 'SHLVL': '1', 11:02:15 INFO - 'TERM': 'linux', 11:02:15 INFO - 'TMOUT': '86400', 11:02:15 INFO - 'USER': 'cltbld', 11:02:15 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172', 11:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:15 INFO - '_': '/tools/buildbot/bin/python'} 11:02:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:16 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:02:16 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:02:16 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:02:16 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:02:16 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:02:16 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:02:16 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:02:16 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:02:16 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:02:16 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:02:16 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:02:16 INFO - Cleaning up... 11:02:16 INFO - Return code: 0 11:02:16 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:02: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:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02: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:02:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3225b2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0840>, '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 0xd4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4db60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172', '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:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 11:02:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:02:16 INFO - Using env: {'DISPLAY': ':0', 11:02:16 INFO - 'HOME': '/home/cltbld', 11:02:16 INFO - 'LANG': 'en_US.UTF-8', 11:02:16 INFO - 'LANGUAGE': 'en_US:en', 11:02:16 INFO - 'LOGNAME': 'cltbld', 11:02:16 INFO - 'MAIL': '/var/mail/cltbld', 11:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:16 INFO - 'MOZ_NO_REMOTE': '1', 11:02:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:16 INFO - 'NO_EM_RESTART': '1', 11:02:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:02:16 INFO - 'PWD': '/builds/slave/test-pgo', 11:02:16 INFO - 'SHELL': '/bin/bash', 11:02:16 INFO - 'SHLVL': '1', 11:02:16 INFO - 'TERM': 'linux', 11:02:16 INFO - 'TMOUT': '86400', 11:02:16 INFO - 'USER': 'cltbld', 11:02:16 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172', 11:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:16 INFO - '_': '/tools/buildbot/bin/python'} 11:02:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:16 INFO - Downloading/unpacking jsonschema 11:02:16 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:16 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:16 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:16 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:16 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:16 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:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:02:18 INFO - Downloading/unpacking functools32 (from jsonschema) 11:02:18 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:18 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:18 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:18 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:18 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:18 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:18 INFO - Downloading functools32-3.2.3-2.tar.gz 11:02:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:02:18 INFO - warning: no files found matching '*.txt' 11:02:18 INFO - no previously-included directories found matching 'build' 11:02:18 INFO - no previously-included directories found matching 'dist' 11:02:18 INFO - no previously-included directories found matching '.git*' 11:02:18 INFO - Installing collected packages: jsonschema, functools32 11:02:18 INFO - Running setup.py install for functools32 11:02:18 INFO - warning: no files found matching '*.txt' 11:02:18 INFO - no previously-included directories found matching 'build' 11:02:18 INFO - no previously-included directories found matching 'dist' 11:02:18 INFO - no previously-included directories found matching '.git*' 11:02:18 INFO - Successfully installed jsonschema functools32 11:02:18 INFO - Cleaning up... 11:02:18 INFO - Return code: 0 11:02:18 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3225b2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0840>, '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 0xd4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4db60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172', '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:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 11:02:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:02:18 INFO - Using env: {'DISPLAY': ':0', 11:02:18 INFO - 'HOME': '/home/cltbld', 11:02:18 INFO - 'LANG': 'en_US.UTF-8', 11:02:18 INFO - 'LANGUAGE': 'en_US:en', 11:02:18 INFO - 'LOGNAME': 'cltbld', 11:02:18 INFO - 'MAIL': '/var/mail/cltbld', 11:02:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:18 INFO - 'MOZ_NO_REMOTE': '1', 11:02:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:18 INFO - 'NO_EM_RESTART': '1', 11:02:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:02:18 INFO - 'PWD': '/builds/slave/test-pgo', 11:02:18 INFO - 'SHELL': '/bin/bash', 11:02:18 INFO - 'SHLVL': '1', 11:02:18 INFO - 'TERM': 'linux', 11:02:18 INFO - 'TMOUT': '86400', 11:02:18 INFO - 'USER': 'cltbld', 11:02:18 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172', 11:02:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:18 INFO - '_': '/tools/buildbot/bin/python'} 11:02:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:18 INFO - Downloading/unpacking flake8 11:02:18 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:18 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:18 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:18 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:18 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:18 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:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:02:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:02:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:02:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:02:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:02:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:02:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:02:21 INFO - no previously-included directories found matching 'docs/_build' 11:02:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:02:21 INFO - Running setup.py install for pep8 11:02:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:02:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:02:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:02:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:02:21 INFO - no previously-included directories found matching 'docs/_build' 11:02:21 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:02:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:02:21 INFO - Cleaning up... 11:02:21 INFO - Return code: 0 11:02:21 INFO - Running post-action listener: _resource_record_post_action 11:02:21 INFO - Running post-action listener: _start_resource_monitoring 11:02:21 INFO - Starting resource monitoring. 11:02:21 INFO - ##### 11:02:21 INFO - ##### Running install step. 11:02:21 INFO - ##### 11:02:21 INFO - Running pre-action listener: _resource_record_pre_action 11:02:21 INFO - Running main action method: install 11:02:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:02:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:02:21 INFO - Reading from file tmpfile_stdout 11:02:21 INFO - Detecting whether we're running mozinstall >=1.0... 11:02:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:02:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:02:21 INFO - Reading from file tmpfile_stdout 11:02:21 INFO - Output received: 11:02:21 INFO - Usage: mozinstall [options] installer 11:02:21 INFO - Options: 11:02:21 INFO - -h, --help show this help message and exit 11:02:21 INFO - -d DEST, --destination=DEST 11:02:21 INFO - Directory to install application into. [default: 11:02:21 INFO - "/builds/slave/test-pgo"] 11:02:21 INFO - --app=APP Application being installed. [default: firefox] 11:02:21 INFO - mkdir: /builds/slave/test-pgo/build/application 11:02:21 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:21 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:37 INFO - Reading from file tmpfile_stdout 11:02:37 INFO - Output received: 11:02:37 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:02:37 INFO - Running post-action listener: _resource_record_post_action 11:02:37 INFO - ##### 11:02:37 INFO - ##### Running run-tests step. 11:02:37 INFO - ##### 11:02:37 INFO - Running pre-action listener: _resource_record_pre_action 11:02:37 INFO - Running main action method: run_tests 11:02:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:02:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:02:37 INFO - Python 2.7.3 11:02:37 INFO - Return code: 0 11:02:37 INFO - grabbing minidump binary from tooltool 11:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:37 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 0xde0840>, '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 0xd4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4db60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:02:37 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:37 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:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:02:37 INFO - Return code: 0 11:02:37 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:02:37 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:02:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:02:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:02:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:02:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:02:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:02:38 INFO - Return code: 0 11:02:38 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T308CCqFR36efovtyE08Ug/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 11:02:38 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T308CCqFR36efovtyE08Ug/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:02:38 INFO - Using env: {'DISPLAY': ':0', 11:02:38 INFO - 'HOME': '/home/cltbld', 11:02:38 INFO - 'LANG': 'en_US.UTF-8', 11:02:38 INFO - 'LANGUAGE': 'en_US:en', 11:02:38 INFO - 'LOGNAME': 'cltbld', 11:02:38 INFO - 'MAIL': '/var/mail/cltbld', 11:02:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:02:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:02:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:38 INFO - 'MOZ_NO_REMOTE': '1', 11:02:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:02:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:38 INFO - 'NO_EM_RESTART': '1', 11:02:38 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:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:02:38 INFO - 'PWD': '/builds/slave/test-pgo', 11:02:38 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:02:38 INFO - 'SHELL': '/bin/bash', 11:02:38 INFO - 'SHLVL': '1', 11:02:38 INFO - 'TERM': 'linux', 11:02:38 INFO - 'TMOUT': '86400', 11:02:38 INFO - 'USER': 'cltbld', 11:02:38 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172', 11:02:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:38 INFO - '_': '/tools/buildbot/bin/python'} 11:02:38 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T308CCqFR36efovtyE08Ug/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:02:39 INFO - mozversion application_buildid: 20160121083240 11:02:39 INFO - mozversion application_changeset: f36a4a4ff73f1184f569fd9152b98fe8d8d3866a 11:02:39 INFO - mozversion application_display_name: Nightly 11:02:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:02:39 INFO - mozversion application_name: Firefox 11:02:39 INFO - mozversion application_remotingname: firefox 11:02:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:02:39 INFO - mozversion application_vendor: Mozilla 11:02:39 INFO - mozversion application_version: 46.0a1 11:02:39 INFO - mozversion platform_buildid: 20160121083240 11:02:39 INFO - mozversion platform_changeset: f36a4a4ff73f1184f569fd9152b98fe8d8d3866a 11:02:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:02:39 INFO - mozversion platform_version: 46.0a1 11:02:39 INFO - using testdate: 1453402959 11:02:39 INFO - actual date: 1453402959 11:02:39 INFO - starting webserver on 'localhost:44033' 11:02:39 INFO - SUITE-START | Running 3 tests 11:02:39 INFO - TEST-START | dromaeo_css 11:02:39 INFO - operating with platform_type : linux_ 11:02:39 INFO - Initialising browser for dromaeo_css test... 11:02:39 INFO - TEST-INFO | started process 13290 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp19tmoa/profile http://localhost:44033/getInfo.html) 11:02:42 INFO - PROCESS | 13290 | 11:02:42 INFO - PROCESS | 13290 | (process:13373): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:02:43 INFO - PROCESS | 13290 | __metrics Screen width/height:1600/1200 11:02:43 INFO - PROCESS | 13290 | colorDepth:24 11:02:43 INFO - PROCESS | 13290 | Browser inner width/height: 1024/697 11:02:43 INFO - PROCESS | 13290 | __metrics 11:02:43 INFO - PROCESS | 13290 | 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:44 INFO - TEST-INFO | 13290: exit 0 11:02:44 INFO - Browser initialized. 11:02:44 INFO - Running cycle 1/1 for dromaeo_css test... 11:02:44 INFO - TEST-INFO | started process 13422 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp19tmoa/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:02:45 INFO - PROCESS | 13422 | 11:02:45 INFO - PROCESS | 13422 | (process:13481): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:02:55 INFO - PROCESS | 13422 | RSS: Main: 150380544 11:02:55 INFO - PROCESS | 13422 | 11:03:45 INFO - PROCESS | 13422 | 1453403025351 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:54 INFO - PROCESS | 13422 | Cycle 1(1): loaded http://localhost:44033/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44033/tests/dromaeo/cssquery-ext.html) 11:05:55 INFO - PROCESS | 13422 | RSS: Main: 154955776 11:05:55 INFO - PROCESS | 13422 | 11:08:57 INFO - PROCESS | 13422 | Cycle 1(1): loaded http://localhost:44033/tests/dromaeo/cssquery-ext.html (next: http://localhost:44033/tests/dromaeo/cssquery-jquery.html) 11:08:58 INFO - PROCESS | 13422 | RSS: Main: 151441408 11:08:58 INFO - PROCESS | 13422 | 11:11:59 INFO - PROCESS | 13422 | Cycle 1(1): loaded http://localhost:44033/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44033/tests/dromaeo/cssquery-mootools.html) 11:12:00 INFO - PROCESS | 13422 | RSS: Main: 152440832 11:12:00 INFO - PROCESS | 13422 | 11:15:01 INFO - PROCESS | 13422 | Cycle 1(1): loaded http://localhost:44033/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44033/tests/dromaeo/cssquery-prototype.html) 11:15:02 INFO - PROCESS | 13422 | RSS: Main: 150687744 11:15:02 INFO - PROCESS | 13422 | 11:18:04 INFO - PROCESS | 13422 | Cycle 1(1): loaded http://localhost:44033/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44033/tests/dromaeo/cssquery-yui.html) 11:18:05 INFO - PROCESS | 13422 | RSS: Main: 150863872 11:18:05 INFO - PROCESS | 13422 | 11:21:08 INFO - PROCESS | 13422 | Cycle 1(1): loaded http://localhost:44033/tests/dromaeo/cssquery-yui.html (next: http://localhost:44033/tests/dromaeo/cssquery-dojo.html) 11:21:08 INFO - PROCESS | 13422 | RSS: Main: 153919488 11:21:08 INFO - PROCESS | 13422 | 11:21:08 INFO - PROCESS | 13422 | __start_tp_report 11:21:08 INFO - PROCESS | 13422 | _x_x_mozilla_page_load 11:21:08 INFO - PROCESS | 13422 | _x_x_mozilla_page_load_details 11:21:08 INFO - PROCESS | 13422 | |i|pagename|runs| 11:21:08 INFO - PROCESS | 13422 | |0;dojo.html;3148.8897888573897;3197.056868223875;3205.0865503331556;3238.724708399786;3247.0583530776075;5280.234366016925;5317.388500322464;5335.33308336458;5335.772772262377;5346.839594812152;5355.437679043703;5371.650842695231;5392.757325920334;5405.540529055035;5405.756740946657;4599.195140850355;4881.170201065809;5044.066847633181;5053.317802096725;5064.949350506503;4849.296851956464;4951.975240123795;4979.278004689318;5050.444451110375;5060.0385926674;4856.68431551948;4913.164761990471;4981.626378021663;4986.202207646759;5017.623678224148;4897.926531102036;4919.188333924898;4923.80304787808;4932.8520144395725;4948.257761335793;4819.95180048202;4875.07373599015;4895.706257624518;4906.411230652309;4950.727709975949;5218.947810521922;5252.527272545451;5280.234366016906;5280.973595132;5295.417504074549;5772.855678608026;5792.015357389212;5792.304923409218;5793.942060579382;5806.738696758656;5755.251817263771;5785;5835.183074369549;5849.415058494159;5911.054231322968;5434.701091440009;5457.699826509541;5464.207689884985;5467.835964921059;5473.67157970519;5921.96365636012;5952.494038006731;5953.315368732651;5959.463648271676;5959.880802383928;5648.8870222595315;5717.885642287131;5726.656400615976;5736;5827.067669172912;5814.186013958049;5819.010768169422;5820.88358232833;5822.475977161991;5832.154337621106;5722.141678748221;5780.508656764138;5786.681732504669;5788.421157884178;5794.768209271666;5731.197632331477;5802.274715660543;5814.651120932757;5831.825045248649;5885.205497257901;4501.897035226325;4562.68061235717;4566.794494247767;4571.1543364477675;4573.771311434415;3982.3429134192534;3988.441618173458;4039.7374170678813;4041.3533834586324;4089;5446.972765136228;5448.83653490396;5473.042217611982;5506.394296627368;5533.695646739468;5823.301203855564;5826.941730582725;5829.47534721877;5832.154337621021;5838.562107841929;5408.13469844823;5454.59090568209;5460.426655201147;5460.945390546123;5472.671639701631;4972.651914366032;4979.975100124476;5028.044671512401;5038.748062596856;5072.416672082684;6067.635941843503;6090.056041313604;6105.145279660851;6112.969435152796;6127.724252408563;5740.971295143498;5793.710314484343;5843.883122337445;5850.970745146247;5871.236739224044;6061.36355682647;6074.574779765374;6076.51387888959;6081.878362432815;6134.447899689049;5719.456651618089;5737.5983681141915;5750.108733146369;5758.193852860687;5759.568032397503;5704.657720536781;5792.652440853562;5807.186993820784;5831.300243970751;5849.210356601804;5660.773569057192;5701.201831743642;5705;5713.314402271754;5750.079987202028;5575.888482230252;5651.208830763614;5680.11958146488;5680.602357834912;5684.573656975661;5489.286392768914;5515.4760297771645;5526.392096869422;5573.7770489179975;5590.273264475755;5634.2393776841245;5657.207990881362;5684.317881854204;5684.914726279027;5685.403032681675;5576.86057848557;5587.1339942309005;5589.5807814413265;5594.524465420485;5599.880023995136 11:21:08 INFO - PROCESS | 13422 | |1;ext.html;523.8323736404352;540.2895192821439;567.9918145292106;574.2563380422353;593.0629605223747;28203.717962820367;36342.63657363432;36446.27107457849;36693.63306366935;36794.99999999996;39516.80241598788;40257.59742402575;40467.59532404675;40473.59526404735;40481;8330.208630180123;8407.327413806881;8430.83138337233;8481.151884811501;8492.915070849274;8096.635651395702;8185.631646575918;8217.95891020547;8235.052968908592;8239.711610093647;8171;8242;8294.460860044108;8297.917020829806;8302.377321700866;8134.430589858713;8154.714584989527;8240.381971352113;8433.873491897626;8498.405111642187;8356.958215208884;8487;8500.064992850781;8518.488890666518;8522.105178956182;39665;39755.60244397577;39761.80119099415;39886.20227595432;39941.800290998646;2984.447877142714;3261.1521004538754;3380.459126539766;3430.382531144393;3506.281212351462;29666.70333296661;29737.25656858574;30149.09552713422;30997.535036974463;31087.689123108707;3818.980905095457;3835.884923452301;3859.4789703389965;3949.328614135604;4063.5326937402283;259454;259612;260337;260833;265737;54767;55073.72463137739;55414.16878746822;55456.72271638616;55577.72211138919;65974.67012664906;67147;67174;67181.32818671751;67235;14452.927735361256;14467.855321446861;14545.490907818386;14607.853921460863;14658.706825863423;10851.728706782395;10961.342319460859;11023.779524409467;11031.338119712844;11039.668809935714;19671.311504097575;20069.598608027758;20110.49723756918;20143.496412589804;20689.275875344592;8008.319292860056;8014.599270036475;8056;8137.715179968791;8161.428699991063;931.6785708930408;950.5294879034922;965.5461932891529;968.7335982604699;1007.8992100790009;30799;31673.683263167535;31893.202669932973;32067;32309.67690323114;1012.2458768217725;1029.6499190275342;1040.4693606260862;1042.5308611125024;1107.911367090647;14537.200453975132;14985.175815330262;15081.698366032619;15092.849071509145;15327.923360383127;381080;382673;384574;384919;386084;52586.211206831926;52797.7360113197;52861;52921.2061819073;53214.46785532172;1318.7098838255567;1325.516186591887;1335.1655215490318;1337.3914868734896;1346.3672074125145;27662.3084422883;28911.277218068873;28994.7100528992;29012.419751605274;29335.559966600944;49227.7538612319;49852.75073624609;50118.24822627591;50176.749116254185;50211.99576008532;296142;298085;298837;298913;300655;42871;43436.78281608572;43444;43815.56184438115;44569.331460027475;42682.78658606687;42880.35679464748;42920;43411.34882976695;43512.564874352116;35680.64319356877;35715.28569428649;35966;36146.45780313245;36294;36077.229176132336;36686.816565917;36717;36771;36799;34519.30961380809;35118.648813511536;35279.29441411209;35604.28791424105;35809;31054.22364440907;32745.67254327426;33232.335353292314;33367;33530.66469335275;25393;25400.364990875376;25526.617100743875;25703.871480643225;26109 11:21:08 INFO - PROCESS | 13422 | |2;jquery.html;359.5721091900638;363.30427231851024;366.5766040223541;367.81976831352637;368.5209228003595;14995.40018399264;16081.276342564583;16160.27278772455;16879;17076;11176.105911527078;11192.608258710947;16602.58493537662;16891;17108.82891171088;4766.189747742875;5107.514786095334;5113.744312784364;5119.462456442076;5122.129238029525;4626.467956185048;4983.103041452537;5083.440821509631;5089.033083714101;5093.79624815007;5133.768980395891;5339.332583427072;5352.304200453936;5590.217369568264;5595.300587426572;5252.868678283055;5294.126469132589;5330.92003619946;5626.774929002835;6041.275046994345;5364.383095943977;5365.946340536622;5367.892642147174;5368.516833484966;5392.649477783932;14977.475788347465;18825;19240.4227873164;19318;19512.024398780148;2036.2058797069155;2040.2858999350108;2051.3537536577796;2055.3628375203584;2141.742990841109;9514.666986655504;9617.90382096177;9817.116459518606;10785.62250321235;12282;1728.075479618398;1807.1867659553122;1810.1220907859677;1866.9626607467774;1881.3133206379573;55701.44298557003;55703.164452533245;57657.711711441596;58470.99999999958;58720.41279587192;9804.215662746963;10084.647037353658;10231.28381013322;10245.74385640365;10259.17926565873;13438.932805335911;13447.798283025762;13494.662633434047;13520.25638589887;13592.66018349549;7482.289182527651;7500;7506.361959233526;7558.206388329147;7561.7731468056045;7126.322999315057;7164.247753985756;7169.24722904098;7207.315305046012;7213.963930180315;4212;4341.261985462479;4384.386185933972;4432.445944256968;4453.287474004143;1812.7552780374745;1819.6633622779827;1840.6502764474974;1853.8331550160551;1910.961780764377;842.4271495383076;877.723517092114;932.9300302477342;960.6253561111172;981.4062492192121;13326.533571325152;14913.776293355608;15572.766408503881;15740.606484837741;16270.51188464348;871.5685735560938;872.829798189347;909.8908131024319;924.542351535994;959.6305422412282;9506.762330941781;9602.135807777195;9689.90310096904;9691.224702023821;9846;511113;537626;545064;547540;548642;70639.64680176669;70734;73383;73413;73822.26177738154;1120.5685810962839;1150.6433005768238;1154.8845115488552;1160.2400427719856;1162.0529268646196;15246.923765381101;15296.617584560476;15391.84608153904;15443.768343475082;15882;32357.676423235465;32399.51400728944;32546.349073018882;32667;33194.83402582972;41510;41543.169136617704;41671;41858.58141418547;44460.33309500425;7185.245549217466;7302.233265507045;7443.516171448839;7450.36671882896;8507.361947854059;10831.24181307301;10872.293300935415;11438;11671.12466565028;11790.469428875893;6724.29394913527;7270.527415717961;7291;7376.594287314249;7470.3276705096805;7470.439717021137;7509.061367329084;7712.5758083305955;7800.648970796215;7888.605569721376;7192.460565457507;7317.597532135784;7377.077865266841;7472.476926615303;7493.6253187339325;8750.387472876837;9199.540022998957;9393.906060939576;9419.246460283024;9429.669961551313;7939.651860684423;7965.92034079675;8784.385093043426;8864;9100.317476189444 11:21:08 INFO - PROCESS | 13422 | |3;mootools.html;1463.319556406271;1470.7352676518226;1620.6353570446652;1770.3361239535175;1795.7665503484545;7621.352185064269;7666.8849967250535;7807.336376408012;7826.92173078269;7848.489848159866;8071.15252898446;8092.352611791057;8149.837003259946;8154.714584989527;8183.877241841377;2345.26124270855;2346.108478778066;2377.91677291294;2381.7380088190284;2388.7611238876148;2367.6330168823774;2380.238323736405;2382.821288403368;2390.493988787062;2394.7006624171977;2232.3972527417586;2240.271911628719;2257.0858802185057;2337.7077865266842;2416.178499310234;2352.047420794572;2359.7404285528664;2372.5847976604027;2374.631932050535;2381.8570885746826;2341.8594884306995;2346.7066616672914;2371.6679664846934;2374.5013547155118;2375.0499800079933;7725.5364678119495;7762.029746281715;7787.961060194662;7790.727324543671;7804.882926756103;4797.568218860284;4938.703677779345;4947.678400903929;4962.4789397113145;4973.850784476472;3097.1018404662623;3147.751712849991;3197.71220590148;3226.1611980884904;3231.2729635831984;966.5747071288681;970.3207754571828;1008.5159123620704;1009.5103874620803;1010.4240582867768;11111.72220694481;11183.608573699963;11240.943795281053;11242.606508772236;11300.717482063013;4331.242032644274;4373.846915357947;4418.226810308183;4447.777611119431;4497.730136191839;9176.8623470648;9185.540722963826;9198.816023679488;9203.355765096512;9207.677731279373;5001.7499125043605;5027.949720502821;5028.924566131511;5033.874153146201;5033.899322013613;4523.84166554169;4567.588916997486;4618.607418369409;4630.398048253705;4631.3516107744945;3475.8877159309286;3535.2045789697113;3537.663921927413;3542.167590616203;3552.1119720069983;1029.4492446541065;1047.261680515235;1055.8785739640039;1060.931039482431;1067.3115840283128;1040.1834559870465;1046.4767616191905;1071.1591400750374;1191.166183671416;1368.6167872995577;7474;7479.439042071866;7503.887441688379;7507.549547027196;7525.736599219001;1090.574675876409;1091.5961094395125;1108.0802933565121;1117.6647005898199;1134.1210561814494;5931.822045338647;5946.613470124428;6112.083187521907;6117.418845209698;6130.203073600493;9519.00050494702;9664.420134791935;9702.126808587262;9767.951160244153;9772.21822254218;9413.529323533796;9742.464164471023;9742.707718768448;9769.609215631437;9810.705678829647;7593.772186834404;7635.847283054308;7656.119546252141;7662.578558179353;7683.923160768432;7286.344229019413;7410.851782964418;7433.219511951167;7437.181909989788;7483.176850546544;8519.148085191431;8668.826623467368;8754.25588824957;8801.207891289814;8820.955895220482;8886.066962969055;8965.103489650983;9089.272858171198;9102.817943641223;9166.037566055467;7221.494495385273;7228.132624085143;7238.855222895618;7351.8162045949275;7362.595057271901;7569.432292577969;7604.315611594983;7658.885116723142;7662.73180438682;7664.770056898302;7022.683979221049;7176.138863336224;7295.270472952662;7394.741184058532;7434.996275502738;6974.755883544254;7054.858902821812;7060.6116663584;7150.67821948024;7167.569945803269;7135.143782745896;7161.355478007004;7178.318059784312;7197.820054498679;7215.062041934515;6488.12410324619;6567.835804104936;6601.24085730128;6610.140681711347;6637.867242655217;6544.803655890331;6672.366125218096;6672.699728512326;6737.427318677967;6790.049393084873 11:21:08 INFO - PROCESS | 13422 | |4;prototype.html;336.47845838949627;342.43156360441674;343.35106648434464;348.2060901145389;348.87789273754174;6255.968720156404;6271;6322.620642761438;6326.367363263671;6342.397472240135;6080.63516189029;6247.843803904904;6285.088662143987;6305.779297724569;6324.652144132082;4780.880477988061;4804.855854324376;4806.014766972762;4808.422989241279;4822.397200349957;4796.90406191876;4804;4809.014152098812;4811.615070794345;4829.251466022772;4689.343491911135;4788.4732679405415;4789.042191561684;4794.88012799681;4795.640326975474;4767.76161191939;4778.402699662543;4785.545373189559;4788;4788.377510923558;4166.562510936338;4205.137946720945;4207.726497777635;4221.767802770846;4232.470941132358;5944.613600116022;5966.880662386771;5978.521718262528;5983.850403739942;5985.191999080112;5426.91859622102;5611.523020543259;5622.465865742748;5627.127795191752;5630.09918413056;6654.201495820533;6666.433353164938;6668.266490686021;6670;6672.899906501407;4678.415198100238;4688.859334219979;4691.061787642485;4691.460482044575;4691.7654117294;6742.696578653923;6951.374376306107;6963.955406688936;6980;7011.088558487364;4629.51390104041;4663.253879379283;4706.905861882743;4710.599599034052;4723.126221648938;4735.171345014609;4759.119562880878;4760.857174284708;4770.069836381872;4776.546228108324;5530.783227689902;5533.418991005887;5539.307586551681;5540.335159780852;5541.196526503634;6579.572327798774;6760.492963027793;6760.966195168992;6770.966145169243;6786.898196527056;1646.563660629934;1673.7740405045163;1683.7726906867415;1687.6455944251845;1689.7465380193069;1114.6210288501948;1127.1264769803468;1128.1760987551359;1132.813085840827;1140.766142940695;6209.9379006210265;6306.747730090745;6307.842303942346;6315.368463153648;6322.620642761449;6747.595144291358;6749.797506074826;6811.625360605115;6818.215905170969;6819.045333653293;6140.3114143610865;6254;6277.05844123376;6281.623102613767;6295.622262664255;3704.629537046274;3707.2770809692393;3727.2172843703124;3727.5154229949935;3728.366177749789;7148.320909513588;7153.749618763319;7164.283571642794;7180.389666878374;7201.991721159042;6947.617881016491;6966.895496567556;6969.128858892638;6973.476989225727;6994.930050699428;7321.670524826395;7324.780256592311;7375;7377.114746230487;7416.96291518539;7043.36609705129;7046.929530704628;7051.823704407431;7055.329743674342;7080.256573059754;6841.315868413119;6894.517383783087;6970.756023539152;6973.372396484341;6981.860362792614;7283.089613798275;7317.926820731725;7319.194888562361;7359.77920662381;7366.7053317866685;4697.295405689174;4739.810407583796;4756.143894099096;4758.714477131383;4769.809207631656;6806.727730890709;6886.69009894566;7036.155661320674;7038.542494737826;7074.752383666753;6813.1142951415995;6820.863582728219;6833.45332373399;6839.384455399038;6849.931500684929;6746.730130794714;6762.154730658668;6786.8642627148165;6796.116504854337;6809.978503224556;6477.546571740121;6580.440662543738;6601.53789234749;6675.232348279816;6684.83287917806;6748.7300507979135;6847.144106986627;6851.2121106071445;6860.3139686031;6862.245153033262;6573.276939536743;6603.867922641424;6618.569792963442;6667.299933507106;6679.82905555706 11:21:08 INFO - PROCESS | 13422 | |5;yui.html;705.7388766156521;718.8382613911867;745.2510227221642;767.93088622024;819.5369616166862;13424.664383390407;13492.93253533731;13503.59489215325;13508.05443618947;13522.391492382842;12671.936640316786;12727.299998500079;13297.800532992012;13344.466221351158;13349.065565410425;807.2169995104739;816.995915020424;827.4125370986607;828.2669837194067;828.8425199212161;820.7168526858225;822;824.7979245084932;827.4042689263721;828.8922440082781;868.7958329792493;870.4081224767156;871.4292138649195;873.0614589316478;874.0167311774254;863.6286396849353;867.1805144138791;867.2238346679686;868.7002983970551;870.2602787630527;630.1021045010887;634.9936500634981;638.1512588257606;638.8818068657313;640.6124294801671;13800.447982080705;13889.930550347284;13933.58199254024;13938.93030534851;13950.860491395159;11919.94040029803;12051.276923384625;12139.089568282414;12222.449989750483;12783;10500.107490863285;10573.682789516326;10646.201534884836;11145.888541114566;11234.494447749788;3659.7621154624862;3661.4141737322166;3671.632836716307;3782.8865134046023;3792.791396473193;46347.76826115882;46371.07257854824;46890.76554617239;47921.76039119782;48046.75976620129;9847.950760246153;9864.161546268648;9924.751881203028;9943.30396872212;9975.650852220137;17824.91087544554;18111.63776724458;18133.90933045326;18156;18161.45515634533;7245.5652660840515;7292.124945006527;7420.36926861212;7478.551286922693;7529.2470752925365;4062.8374865005067;4111.342185250345;4120.031792528754;4165.625093741578;4174.684974233107;3255.186203449138;3256.0394683568406;3274.3287626036604;3289.753268504872;3295.8022518648477;575.3757173466752;590.7075997381323;594.2037669522861;595.6188039654625;606.4057223920495;497.39069639691087;534.1187041381751;536.2733496112711;637.4422380417135;692.3837784371913;8262.940710911556;8445.873311900326;8450.915490845013;8579.742607721653;8708.912910870937;535.8553190638506;573.916782066598;586.4897539140975;635.6249812610582;671.3722669304216;3847.3651847445417;3921.9215615687526;3934.9803250983564;4055.9594404055583;4336.848210312624;48817.51182488201;48915;57050.714746426835;57902.42097579055;58442.707786461644;44577;45027.099458010656;45481.54518454773;47982.04035919262;48047;43829;44348.3347749784;44481.555184448385;44972.3254151188;45427.54572454299;8393.202645748644;8528.91471085306;8593.69922052725;8630.741077767678;8698.434601750865;32931.17672058122;33712.98861034173;33728.66271337255;33779.83110084434;34036.48945265872;42026.63786897102;42350.788246058575;42561.14877702366;43034.78482607567;43081.56918430776;10738.516766745359;10998.450077495932;11016.339019658846;11079.16906232052;11115.388653624128;11300.332654783904;11749.471273792871;12047.51809927593;12085.939570302093;12154.453049612965;10354.896451035393;10575.841362379417;10706.464676765974;10733;10822.242443028912;10086.193104551472;10105.292629515863;10111.86304348902;10580.41807700553;10812.621558245424;10888.40113793749;11129.443527823738;11294;11314;11482.885171148515;9046.84655186963;9291.397129898241;9291.907080929375;9440.716778496657;9603.231741460526;8742;8906.86639700418;9113.3165012623;9666.743323368199;9766.75583110428 11:21:08 INFO - PROCESS | 13422 | __end_tp_report 11:21:08 INFO - PROCESS | 13422 | __start_cc_report 11:21:08 INFO - PROCESS | 13422 | _x_x_mozilla_cycle_collect,290 11:21:08 INFO - PROCESS | 13422 | __end_cc_report 11:21:08 INFO - PROCESS | 13422 | __startTimestamp1453404068325__endTimestamp 11:21:08 INFO - PROCESS | 13422 | 11:21:08 INFO - PROCESS | 13422 | ------- Summary: start ------- 11:21:08 INFO - PROCESS | 13422 | Number of tests: 6 11:21:08 INFO - PROCESS | 13422 | 11:21:08 INFO - PROCESS | 13422 | [#0] dojo.html Cycles:165 Average:5396.80 Median:5589.58 stddev:601.50 (10.8%) stddev-sans-first:576.92 11:21:08 INFO - PROCESS | 13422 | Values: 3148.9 3197.1 3205.1 3238.7 3247.1 5280.2 5317.4 5335.3 5335.8 5346.8 5355.4 5371.7 5392.8 5405.5 5405.8 4599.2 4881.2 5044.1 5053.3 5064.9 4849.3 4952.0 4979.3 5050.4 5060.0 4856.7 4913.2 4981.6 4986.2 5017.6 4897.9 4919.2 4923.8 4932.9 4948.3 4820.0 4875.1 4895.7 4906.4 4950.7 5218.9 5252.5 5280.2 5281.0 5295.4 5772.9 5792.0 5792.3 5793.9 5806.7 5755.3 5785.0 5835.2 5849.4 5911.1 5434.7 5457.7 5464.2 5467.8 5473.7 5922.0 5952.5 5953.3 5959.5 5959.9 5648.9 5717.9 5726.7 5736.0 5827.1 5814.2 5819.0 5820.9 5822.5 5832.2 5722.1 5780.5 5786.7 5788.4 5794.8 5731.2 5802.3 5814.7 5831.8 5885.2 4501.9 4562.7 4566.8 4571.2 4573.8 3982.3 3988.4 4039.7 4041.4 4089.0 5447.0 5448.8 5473.0 5506.4 5533.7 5823.3 5826.9 5829.5 5832.2 5838.6 5408.1 5454.6 5460.4 5460.9 5472.7 4972.7 4980.0 5028.0 5038.7 5072.4 6067.6 6090.1 6105.1 6113.0 6127.7 5741.0 5793.7 5843.9 5851.0 5871.2 6061.4 6074.6 6076.5 6081.9 6134.4 5719.5 5737.6 5750.1 5758.2 5759.6 5704.7 5792.7 5807.2 5831.3 5849.2 5660.8 5701.2 5705.0 5713.3 5750.1 5575.9 5651.2 5680.1 5680.6 5684.6 5489.3 5515.5 5526.4 5573.8 5590.3 5634.2 5657.2 5684.3 5684.9 5685.4 5576.9 5587.1 5589.6 5594.5 5599.9 11:21:08 INFO - PROCESS | 13422 | 11:21:08 INFO - PROCESS | 13422 | [#1] ext.html Cycles:180 Average:48579.39 Median:208939.50 stddev:83655.00 (40.0%) stddev-sans-first:83811.86 11:21:08 INFO - PROCESS | 13422 | Values: 523.8 540.3 568.0 574.3 593.1 28203.7 36342.6 36446.3 36693.6 36795.0 39516.8 40257.6 40467.6 40473.6 40481.0 8330.2 8407.3 8430.8 8481.2 8492.9 8096.6 8185.6 8218.0 8235.1 8239.7 8171.0 8242.0 8294.5 8297.9 8302.4 8134.4 8154.7 8240.4 8433.9 8498.4 8357.0 8487.0 8500.1 8518.5 8522.1 39665.0 39755.6 39761.8 39886.2 39941.8 2984.4 3261.2 3380.5 3430.4 3506.3 29666.7 29737.3 30149.1 30997.5 31087.7 3819.0 3835.9 3859.5 3949.3 4063.5 259454.0 259612.0 260337.0 260833.0 265737.0 54767.0 55073.7 55414.2 55456.7 55577.7 65974.7 67147.0 67174.0 67181.3 67235.0 14452.9 14467.9 14545.5 14607.9 14658.7 10851.7 10961.3 11023.8 11031.3 11039.7 19671.3 20069.6 20110.5 20143.5 20689.3 8008.3 8014.6 8056.0 8137.7 8161.4 931.7 950.5 965.5 968.7 1007.9 30799.0 31673.7 31893.2 32067.0 32309.7 1012.2 1029.6 1040.5 1042.5 1107.9 14537.2 14985.2 15081.7 15092.8 15327.9 381080.0 382673.0 384574.0 384919.0 386084.0 52586.2 52797.7 52861.0 52921.2 53214.5 1318.7 1325.5 1335.2 1337.4 1346.4 27662.3 28911.3 28994.7 29012.4 29335.6 49227.8 49852.8 50118.2 50176.7 50212.0 296142.0 298085.0 298837.0 298913.0 300655.0 42871.0 43436.8 43444.0 43815.6 44569.3 42682.8 42880.4 42920.0 43411.3 43512.6 35680.6 35715.3 35966.0 36146.5 36294.0 36077.2 36686.8 36717.0 36771.0 36799.0 34519.3 35118.6 35279.3 35604.3 35809.0 31054.2 32745.7 33232.3 33367.0 33530.7 25393.0 25400.4 25526.6 25703.9 26109.0 11:21:08 INFO - PROCESS | 13422 | 11:21:08 INFO - PROCESS | 13422 | [#2] jquery.html Cycles:180 Average:27205.21 Median:5120.80 stddev:87952.41 (1717.6%) stddev-sans-first:88176.04 11:21:08 INFO - PROCESS | 13422 | Values: 359.6 363.3 366.6 367.8 368.5 14995.4 16081.3 16160.3 16879.0 17076.0 11176.1 11192.6 16602.6 16891.0 17108.8 4766.2 5107.5 5113.7 5119.5 5122.1 4626.5 4983.1 5083.4 5089.0 5093.8 5133.8 5339.3 5352.3 5590.2 5595.3 5252.9 5294.1 5330.9 5626.8 6041.3 5364.4 5365.9 5367.9 5368.5 5392.6 14977.5 18825.0 19240.4 19318.0 19512.0 2036.2 2040.3 2051.4 2055.4 2141.7 9514.7 9617.9 9817.1 10785.6 12282.0 1728.1 1807.2 1810.1 1867.0 1881.3 55701.4 55703.2 57657.7 58471.0 58720.4 9804.2 10084.6 10231.3 10245.7 10259.2 13438.9 13447.8 13494.7 13520.3 13592.7 7482.3 7500.0 7506.4 7558.2 7561.8 7126.3 7164.2 7169.2 7207.3 7214.0 4212.0 4341.3 4384.4 4432.4 4453.3 1812.8 1819.7 1840.7 1853.8 1911.0 842.4 877.7 932.9 960.6 981.4 13326.5 14913.8 15572.8 15740.6 16270.5 871.6 872.8 909.9 924.5 959.6 9506.8 9602.1 9689.9 9691.2 9846.0 511113.0 537626.0 545064.0 547540.0 548642.0 70639.6 70734.0 73383.0 73413.0 73822.3 1120.6 1150.6 1154.9 1160.2 1162.1 15246.9 15296.6 15391.8 15443.8 15882.0 32357.7 32399.5 32546.3 32667.0 33194.8 41510.0 41543.2 41671.0 41858.6 44460.3 7185.2 7302.2 7443.5 7450.4 8507.4 10831.2 10872.3 11438.0 11671.1 11790.5 6724.3 7270.5 7291.0 7376.6 7470.3 7470.4 7509.1 7712.6 7800.6 7888.6 7192.5 7317.6 7377.1 7472.5 7493.6 8750.4 9199.5 9393.9 9419.2 9429.7 7939.7 7965.9 8784.4 8864.0 9100.3 11:21:08 INFO - PROCESS | 13422 | 11:21:08 INFO - PROCESS | 13422 | [#3] mootools.html Cycles:180 Average:5635.38 Median:6584.54 stddev:2927.97 (44.5%) stddev-sans-first:2919.39 11:21:08 INFO - PROCESS | 13422 | Values: 1463.3 1470.7 1620.6 1770.3 1795.8 7621.4 7666.9 7807.3 7826.9 7848.5 8071.2 8092.4 8149.8 8154.7 8183.9 2345.3 2346.1 2377.9 2381.7 2388.8 2367.6 2380.2 2382.8 2390.5 2394.7 2232.4 2240.3 2257.1 2337.7 2416.2 2352.0 2359.7 2372.6 2374.6 2381.9 2341.9 2346.7 2371.7 2374.5 2375.0 7725.5 7762.0 7788.0 7790.7 7804.9 4797.6 4938.7 4947.7 4962.5 4973.9 3097.1 3147.8 3197.7 3226.2 3231.3 966.6 970.3 1008.5 1009.5 1010.4 11111.7 11183.6 11240.9 11242.6 11300.7 4331.2 4373.8 4418.2 4447.8 4497.7 9176.9 9185.5 9198.8 9203.4 9207.7 5001.7 5027.9 5028.9 5033.9 5033.9 4523.8 4567.6 4618.6 4630.4 4631.4 3475.9 3535.2 3537.7 3542.2 3552.1 1029.4 1047.3 1055.9 1060.9 1067.3 1040.2 1046.5 1071.2 1191.2 1368.6 7474.0 7479.4 7503.9 7507.5 7525.7 1090.6 1091.6 1108.1 1117.7 1134.1 5931.8 5946.6 6112.1 6117.4 6130.2 9519.0 9664.4 9702.1 9768.0 9772.2 9413.5 9742.5 9742.7 9769.6 9810.7 7593.8 7635.8 7656.1 7662.6 7683.9 7286.3 7410.9 7433.2 7437.2 7483.2 8519.1 8668.8 8754.3 8801.2 8821.0 8886.1 8965.1 9089.3 9102.8 9166.0 7221.5 7228.1 7238.9 7351.8 7362.6 7569.4 7604.3 7658.9 7662.7 7664.8 7022.7 7176.1 7295.3 7394.7 7435.0 6974.8 7054.9 7060.6 7150.7 7167.6 7135.1 7161.4 7178.3 7197.8 7215.1 6488.1 6567.8 6601.2 6610.1 6637.9 6544.8 6672.4 6672.7 6737.4 6790.0 11:21:08 INFO - PROCESS | 13422 | 11:21:08 INFO - PROCESS | 13422 | [#4] prototype.html Cycles:180 Average:5608.16 Median:6300.70 stddev:1708.85 (27.1%) stddev-sans-first:1667.21 11:21:08 INFO - PROCESS | 13422 | Values: 336.5 342.4 343.4 348.2 348.9 6256.0 6271.0 6322.6 6326.4 6342.4 6080.6 6247.8 6285.1 6305.8 6324.7 4780.9 4804.9 4806.0 4808.4 4822.4 4796.9 4804.0 4809.0 4811.6 4829.3 4689.3 4788.5 4789.0 4794.9 4795.6 4767.8 4778.4 4785.5 4788.0 4788.4 4166.6 4205.1 4207.7 4221.8 4232.5 5944.6 5966.9 5978.5 5983.9 5985.2 5426.9 5611.5 5622.5 5627.1 5630.1 6654.2 6666.4 6668.3 6670.0 6672.9 4678.4 4688.9 4691.1 4691.5 4691.8 6742.7 6951.4 6964.0 6980.0 7011.1 4629.5 4663.3 4706.9 4710.6 4723.1 4735.2 4759.1 4760.9 4770.1 4776.5 5530.8 5533.4 5539.3 5540.3 5541.2 6579.6 6760.5 6761.0 6771.0 6786.9 1646.6 1673.8 1683.8 1687.6 1689.7 1114.6 1127.1 1128.2 1132.8 1140.8 6209.9 6306.7 6307.8 6315.4 6322.6 6747.6 6749.8 6811.6 6818.2 6819.0 6140.3 6254.0 6277.1 6281.6 6295.6 3704.6 3707.3 3727.2 3727.5 3728.4 7148.3 7153.7 7164.3 7180.4 7202.0 6947.6 6966.9 6969.1 6973.5 6994.9 7321.7 7324.8 7375.0 7377.1 7417.0 7043.4 7046.9 7051.8 7055.3 7080.3 6841.3 6894.5 6970.8 6973.4 6981.9 7283.1 7317.9 7319.2 7359.8 7366.7 4697.3 4739.8 4756.1 4758.7 4769.8 6806.7 6886.7 7036.2 7038.5 7074.8 6813.1 6820.9 6833.5 6839.4 6849.9 6746.7 6762.2 6786.9 6796.1 6810.0 6477.5 6580.4 6601.5 6675.2 6684.8 6748.7 6847.1 6851.2 6860.3 6862.2 6573.3 6603.9 6618.6 6667.3 6679.8 11:21:08 INFO - PROCESS | 13422 | 11:21:08 INFO - PROCESS | 13422 | [#5] yui.html Cycles:180 Average:13324.74 Median:45227.32 stddev:15085.21 (33.4%) stddev-sans-first:15097.76 11:21:08 INFO - PROCESS | 13422 | Values: 705.7 718.8 745.3 767.9 819.5 13424.7 13492.9 13503.6 13508.1 13522.4 12671.9 12727.3 13297.8 13344.5 13349.1 807.2 817.0 827.4 828.3 828.8 820.7 822.0 824.8 827.4 828.9 868.8 870.4 871.4 873.1 874.0 863.6 867.2 867.2 868.7 870.3 630.1 635.0 638.2 638.9 640.6 13800.4 13889.9 13933.6 13938.9 13950.9 11919.9 12051.3 12139.1 12222.4 12783.0 10500.1 10573.7 10646.2 11145.9 11234.5 3659.8 3661.4 3671.6 3782.9 3792.8 46347.8 46371.1 46890.8 47921.8 48046.8 9848.0 9864.2 9924.8 9943.3 9975.7 17824.9 18111.6 18133.9 18156.0 18161.5 7245.6 7292.1 7420.4 7478.6 7529.2 4062.8 4111.3 4120.0 4165.6 4174.7 3255.2 3256.0 3274.3 3289.8 3295.8 575.4 590.7 594.2 595.6 606.4 497.4 534.1 536.3 637.4 692.4 8262.9 8445.9 8450.9 8579.7 8708.9 535.9 573.9 586.5 635.6 671.4 3847.4 3921.9 3935.0 4056.0 4336.8 48817.5 48915.0 57050.7 57902.4 58442.7 44577.0 45027.1 45481.5 47982.0 48047.0 43829.0 44348.3 44481.6 44972.3 45427.5 8393.2 8528.9 8593.7 8630.7 8698.4 32931.2 33713.0 33728.7 33779.8 34036.5 42026.6 42350.8 42561.1 43034.8 43081.6 10738.5 10998.5 11016.3 11079.2 11115.4 11300.3 11749.5 12047.5 12085.9 12154.5 10354.9 10575.8 10706.5 10733.0 10822.2 10086.2 10105.3 10111.9 10580.4 10812.6 10888.4 11129.4 11294.0 11314.0 11482.9 9046.8 9291.4 9291.9 9440.7 9603.2 8742.0 8906.9 9113.3 9666.7 9766.8 11:21:08 INFO - PROCESS | 13422 | -------- Summary: end -------- 11:21:08 INFO - PROCESS | 13422 | 11:21:08 INFO - TEST-INFO | 13422: exit 0 11:21:08 INFO - TEST-OK | dromaeo_css | took 1109788ms 11:21:08 INFO - TEST-START | kraken 11:21:08 INFO - operating with platform_type : linux_ 11:21:08 INFO - Initialising browser for kraken test... 11:21:08 INFO - TEST-INFO | started process 13667 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPVGIWA/profile http://localhost:44033/getInfo.html) 11:21:12 INFO - PROCESS | 13667 | 11:21:12 INFO - PROCESS | 13667 | (process:13743): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:21:12 INFO - PROCESS | 13667 | __metrics Screen width/height:1600/1200 11:21:12 INFO - PROCESS | 13667 | colorDepth:24 11:21:12 INFO - PROCESS | 13667 | Browser inner width/height: 1024/697 11:21:12 INFO - PROCESS | 13667 | __metrics 11:21:12 INFO - PROCESS | 13667 | 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:13 INFO - TEST-INFO | 13667: exit 0 11:21:13 INFO - Browser initialized. 11:21:13 INFO - Running cycle 1/1 for kraken test... 11:21:13 INFO - TEST-INFO | started process 13792 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPVGIWA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:15 INFO - PROCESS | 13792 | 11:21:15 INFO - PROCESS | 13792 | (process:13854): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:21:25 INFO - PROCESS | 13792 | RSS: Main: 150708224 11:21:25 INFO - PROCESS | 13792 | 11:21:27 INFO - PROCESS | 13792 | Cycle 1(1): loaded http://localhost:44033/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44033/tests/kraken/driver.html?testName=audio-beat-detection) 11:21:28 INFO - PROCESS | 13792 | RSS: Main: 150614016 11:21:28 INFO - PROCESS | 13792 | 11:21:31 INFO - PROCESS | 13792 | Cycle 1(1): loaded http://localhost:44033/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44033/tests/kraken/driver.html?testName=audio-dft) 11:21:31 INFO - PROCESS | 13792 | RSS: Main: 154193920 11:21:31 INFO - PROCESS | 13792 | 11:21:34 INFO - PROCESS | 13792 | Cycle 1(1): loaded http://localhost:44033/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44033/tests/kraken/driver.html?testName=audio-fft) 11:21:35 INFO - PROCESS | 13792 | RSS: Main: 148025344 11:21:35 INFO - PROCESS | 13792 | 11:21:37 INFO - PROCESS | 13792 | Cycle 1(1): loaded http://localhost:44033/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44033/tests/kraken/driver.html?testName=audio-oscillator) 11:21:37 INFO - PROCESS | 13792 | RSS: Main: 148275200 11:21:37 INFO - PROCESS | 13792 | 11:21:40 INFO - PROCESS | 13792 | Cycle 1(1): loaded http://localhost:44033/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44033/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:21:40 INFO - PROCESS | 13792 | RSS: Main: 149233664 11:21:40 INFO - PROCESS | 13792 | 11:21:43 INFO - PROCESS | 13792 | Cycle 1(1): loaded http://localhost:44033/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44033/tests/kraken/driver.html?testName=imaging-darkroom) 11:21:44 INFO - PROCESS | 13792 | RSS: Main: 148803584 11:21:44 INFO - PROCESS | 13792 | 11:21:47 INFO - PROCESS | 13792 | Cycle 1(1): loaded http://localhost:44033/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44033/tests/kraken/driver.html?testName=imaging-desaturate) 11:21:48 INFO - PROCESS | 13792 | RSS: Main: 148738048 11:21:48 INFO - PROCESS | 13792 | 11:21:51 INFO - PROCESS | 13792 | Cycle 1(1): loaded http://localhost:44033/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44033/tests/kraken/driver.html?testName=json-parse-financial) 11:21:51 INFO - PROCESS | 13792 | RSS: Main: 149524480 11:21:51 INFO - PROCESS | 13792 | 11:21:53 INFO - PROCESS | 13792 | Cycle 1(1): loaded http://localhost:44033/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44033/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:21:53 INFO - PROCESS | 13792 | RSS: Main: 149880832 11:21:53 INFO - PROCESS | 13792 | 11:21:55 INFO - PROCESS | 13792 | Cycle 1(1): loaded http://localhost:44033/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44033/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:21:56 INFO - PROCESS | 13792 | RSS: Main: 149626880 11:21:56 INFO - PROCESS | 13792 | 11:21:58 INFO - PROCESS | 13792 | Cycle 1(1): loaded http://localhost:44033/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44033/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:21:58 INFO - PROCESS | 13792 | RSS: Main: 149372928 11:21:58 INFO - PROCESS | 13792 | 11:22:01 INFO - PROCESS | 13792 | Cycle 1(1): loaded http://localhost:44033/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44033/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:22:01 INFO - PROCESS | 13792 | RSS: Main: 150065152 11:22:01 INFO - PROCESS | 13792 | 11:22:04 INFO - PROCESS | 13792 | Cycle 1(1): loaded http://localhost:44033/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44033/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:22:05 INFO - PROCESS | 13792 | RSS: Main: 148615168 11:22:05 INFO - PROCESS | 13792 | 11:22:06 INFO - PROCESS | 13792 | Cycle 1(1): loaded http://localhost:44033/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44033/tests/kraken/driver.html?testName=ai-astar) 11:22:07 INFO - PROCESS | 13792 | RSS: Main: 149413888 11:22:07 INFO - PROCESS | 13792 | 11:22:07 INFO - PROCESS | 13792 | __start_tp_report 11:22:07 INFO - PROCESS | 13792 | _x_x_mozilla_page_load 11:22:07 INFO - PROCESS | 13792 | _x_x_mozilla_page_load_details 11:22:07 INFO - PROCESS | 13792 | |i|pagename|runs| 11:22:07 INFO - PROCESS | 13792 | |0;ai-astar;112;106;112;112;112;123;111;110;110;110 11:22:07 INFO - PROCESS | 13792 | |1;audio-beat-detection;154;129;154;161;132;151;154;131;164;131 11:22:07 INFO - PROCESS | 13792 | |2;audio-dft;161;163;163;164;161;160;161;164;166;159 11:22:07 INFO - PROCESS | 13792 | |3;audio-fft;74;78;74;75;77;73;148;74;74;73 11:22:07 INFO - PROCESS | 13792 | |4;audio-oscillator;97;99;139;96;97;96;150;97;97;140 11:22:07 INFO - PROCESS | 13792 | |5;imaging-gaussian-blur;109;110;109;109;109;110;110;109;109;109 11:22:07 INFO - PROCESS | 13792 | |6;imaging-darkroom;148;147;147;147;146;147;146;146;147;147 11:22:07 INFO - PROCESS | 13792 | |7;imaging-desaturate;96;96;96;96;96;99;96;97;97;96 11:22:07 INFO - PROCESS | 13792 | |8;json-parse-financial;58;58;58;58;59;59;57;59;66;57 11:22:07 INFO - PROCESS | 13792 | |9;json-stringify-tinderbox;68;68;67;67;68;67;67;68;70;67 11:22:07 INFO - PROCESS | 13792 | |10;stanford-crypto-aes;84;81;83;84;84;83;90;83;83;83 11:22:07 INFO - PROCESS | 13792 | |11;stanford-crypto-ccm;124;119;120;126;115;133;117;116;129;119 11:22:07 INFO - PROCESS | 13792 | |12;stanford-crypto-pbkdf2;147;153;155;156;158;141;160;149;152;141 11:22:07 INFO - PROCESS | 13792 | |13;stanford-crypto-sha256-iterative;69;67;69;70;67;72;67;67;68;68 11:22:07 INFO - PROCESS | 13792 | __end_tp_report 11:22:07 INFO - PROCESS | 13792 | __start_cc_report 11:22:07 INFO - PROCESS | 13792 | _x_x_mozilla_cycle_collect,732 11:22:07 INFO - PROCESS | 13792 | __end_cc_report 11:22:07 INFO - PROCESS | 13792 | __startTimestamp1453404127022__endTimestamp 11:22:07 INFO - PROCESS | 13792 | 11:22:07 INFO - PROCESS | 13792 | ------- Summary: start ------- 11:22:07 INFO - PROCESS | 13792 | Number of tests: 14 11:22:07 INFO - PROCESS | 13792 | 11:22:07 INFO - PROCESS | 13792 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:4.34 (3.9%) stddev-sans-first:4.60 11:22:07 INFO - PROCESS | 13792 | Values: 112.0 106.0 112.0 112.0 112.0 123.0 111.0 110.0 110.0 110.0 11:22:07 INFO - PROCESS | 13792 | 11:22:07 INFO - PROCESS | 13792 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:154.00 stddev:13.75 (8.9%) stddev-sans-first:14.28 11:22:07 INFO - PROCESS | 13792 | Values: 154.0 129.0 154.0 161.0 132.0 151.0 154.0 131.0 164.0 131.0 11:22:07 INFO - PROCESS | 13792 | 11:22:07 INFO - PROCESS | 13792 | [#2] audio-dft Cycles:10 Average:162.20 Median:163.00 stddev:2.15 (1.3%) stddev-sans-first:2.24 11:22:07 INFO - PROCESS | 13792 | Values: 161.0 163.0 163.0 164.0 161.0 160.0 161.0 164.0 166.0 159.0 11:22:07 INFO - PROCESS | 13792 | 11:22:07 INFO - PROCESS | 13792 | [#3] audio-fft Cycles:10 Average:82.00 Median:74.00 stddev:23.25 (31.4%) stddev-sans-first:24.48 11:22:07 INFO - PROCESS | 13792 | Values: 74.0 78.0 74.0 75.0 77.0 73.0 148.0 74.0 74.0 73.0 11:22:07 INFO - PROCESS | 13792 | 11:22:07 INFO - PROCESS | 13792 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:97.00 stddev:22.42 (23.1%) stddev-sans-first:23.22 11:22:07 INFO - PROCESS | 13792 | Values: 97.0 99.0 139.0 96.0 97.0 96.0 150.0 97.0 97.0 140.0 11:22:07 INFO - PROCESS | 13792 | 11:22:07 INFO - PROCESS | 13792 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 11:22:07 INFO - PROCESS | 13792 | Values: 109.0 110.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 109.0 11:22:07 INFO - PROCESS | 13792 | 11:22:07 INFO - PROCESS | 13792 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 11:22:07 INFO - PROCESS | 13792 | Values: 148.0 147.0 147.0 147.0 146.0 147.0 146.0 146.0 147.0 147.0 11:22:07 INFO - PROCESS | 13792 | 11:22:07 INFO - PROCESS | 13792 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 11:22:07 INFO - PROCESS | 13792 | Values: 96.0 96.0 96.0 96.0 96.0 99.0 96.0 97.0 97.0 96.0 11:22:07 INFO - PROCESS | 13792 | 11:22:07 INFO - PROCESS | 13792 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:58.50 stddev:2.60 (4.4%) stddev-sans-first:2.74 11:22:07 INFO - PROCESS | 13792 | Values: 58.0 58.0 58.0 58.0 59.0 59.0 57.0 59.0 66.0 57.0 11:22:07 INFO - PROCESS | 13792 | 11:22:07 INFO - PROCESS | 13792 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.95 (1.4%) stddev-sans-first:1.00 11:22:07 INFO - PROCESS | 13792 | Values: 68.0 68.0 67.0 67.0 68.0 67.0 67.0 68.0 70.0 67.0 11:22:07 INFO - PROCESS | 13792 | 11:22:07 INFO - PROCESS | 13792 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.50 stddev:2.35 (2.8%) stddev-sans-first:2.49 11:22:07 INFO - PROCESS | 13792 | Values: 84.0 81.0 83.0 84.0 84.0 83.0 90.0 83.0 83.0 83.0 11:22:07 INFO - PROCESS | 13792 | 11:22:07 INFO - PROCESS | 13792 | [#11] stanford-crypto-ccm Cycles:10 Average:121.80 Median:122.00 stddev:5.98 (4.9%) stddev-sans-first:6.29 11:22:07 INFO - PROCESS | 13792 | Values: 124.0 119.0 120.0 126.0 115.0 133.0 117.0 116.0 129.0 119.0 11:22:07 INFO - PROCESS | 13792 | 11:22:07 INFO - PROCESS | 13792 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.20 Median:154.00 stddev:6.63 (4.3%) stddev-sans-first:6.86 11:22:07 INFO - PROCESS | 13792 | Values: 147.0 153.0 155.0 156.0 158.0 141.0 160.0 149.0 152.0 141.0 11:22:07 INFO - PROCESS | 13792 | 11:22:07 INFO - PROCESS | 13792 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.65 (2.4%) stddev-sans-first:1.73 11:22:07 INFO - PROCESS | 13792 | Values: 69.0 67.0 69.0 70.0 67.0 72.0 67.0 67.0 68.0 68.0 11:22:07 INFO - PROCESS | 13792 | -------- Summary: end -------- 11:22:07 INFO - PROCESS | 13792 | 11:22:07 INFO - TEST-INFO | 13792: exit 0 11:22:07 INFO - TEST-OK | kraken | took 58953ms 11:22:07 INFO - TEST-START | v8_7 11:22:07 INFO - operating with platform_type : linux_ 11:22:07 INFO - Initialising browser for v8_7 test... 11:22:07 INFO - TEST-INFO | started process 14082 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpk2g2nQ/profile http://localhost:44033/getInfo.html) 11:22:10 INFO - PROCESS | 14082 | 11:22:10 INFO - PROCESS | 14082 | (process:14154): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:22:11 INFO - PROCESS | 14082 | __metrics Screen width/height:1600/1200 11:22:11 INFO - PROCESS | 14082 | colorDepth:24 11:22:11 INFO - PROCESS | 14082 | Browser inner width/height: 1024/697 11:22:11 INFO - PROCESS | 14082 | __metrics 11:22:11 INFO - PROCESS | 14082 | 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:22:12 INFO - TEST-INFO | 14082: exit 0 11:22:12 INFO - Browser initialized. 11:22:12 INFO - Running cycle 1/1 for v8_7 test... 11:22:12 INFO - TEST-INFO | started process 14203 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpk2g2nQ/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:13 INFO - PROCESS | 14203 | 11:22:13 INFO - PROCESS | 14203 | (process:14260): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:22:24 INFO - PROCESS | 14203 | RSS: Main: 150425600 11:22:24 INFO - PROCESS | 14203 | 11:22:46 INFO - PROCESS | 14203 | Cycle 1(1): loaded http://localhost:44033/tests/v8_7/run.html (next: http://localhost:44033/tests/v8_7/run.html) 11:22:47 INFO - PROCESS | 14203 | RSS: Main: 146300928 11:22:47 INFO - PROCESS | 14203 | 11:22:47 INFO - PROCESS | 14203 | __start_tp_report 11:22:47 INFO - PROCESS | 14203 | _x_x_mozilla_page_load 11:22:47 INFO - PROCESS | 14203 | _x_x_mozilla_page_load_details 11:22:47 INFO - PROCESS | 14203 | |i|pagename|runs| 11:22:47 INFO - PROCESS | 14203 | |0;Richards;167.42005692281936 11:22:47 INFO - PROCESS | 14203 | |1;DeltaBlue;188.82175226586102 11:22:47 INFO - PROCESS | 14203 | |2;Encrypt;279.4857462269424 11:22:47 INFO - PROCESS | 14203 | |3;Decrypt;5208.333333333333 11:22:47 INFO - PROCESS | 14203 | |4;RayTrace;1067.2358591248667 11:22:47 INFO - PROCESS | 14203 | |5;Earley;716.3323782234957 11:22:47 INFO - PROCESS | 14203 | |6;Boyer;12395.061728395061 11:22:47 INFO - PROCESS | 14203 | |7;RegExp;41367.34693877551 11:22:47 INFO - PROCESS | 14203 | |8;Splay;587.1990604815032 11:22:47 INFO - PROCESS | 14203 | |9;NavierStokes;4850.241545893719 11:22:47 INFO - PROCESS | 14203 | __end_tp_report 11:22:47 INFO - PROCESS | 14203 | __startTimestamp1453404167120__endTimestamp 11:22:47 INFO - PROCESS | 14203 | 11:22:47 INFO - PROCESS | 14203 | ------- Summary: start ------- 11:22:47 INFO - PROCESS | 14203 | Number of tests: 10 11:22:47 INFO - PROCESS | 14203 | 11:22:47 INFO - PROCESS | 14203 | [#0] Richards Cycles:1 Average:167.42 Median:167.42 stddev:0.00 (0.0%) 11:22:47 INFO - PROCESS | 14203 | Values: 167.4 11:22:47 INFO - PROCESS | 14203 | 11:22:47 INFO - PROCESS | 14203 | [#1] DeltaBlue Cycles:1 Average:188.82 Median:188.82 stddev:0.00 (0.0%) 11:22:47 INFO - PROCESS | 14203 | Values: 188.8 11:22:47 INFO - PROCESS | 14203 | 11:22:47 INFO - PROCESS | 14203 | [#2] Encrypt Cycles:1 Average:279.49 Median:279.49 stddev:0.00 (0.0%) 11:22:47 INFO - PROCESS | 14203 | Values: 279.5 11:22:47 INFO - PROCESS | 14203 | 11:22:47 INFO - PROCESS | 14203 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 11:22:47 INFO - PROCESS | 14203 | Values: 5208.3 11:22:47 INFO - PROCESS | 14203 | 11:22:47 INFO - PROCESS | 14203 | [#4] RayTrace Cycles:1 Average:1067.24 Median:1067.24 stddev:0.00 (0.0%) 11:22:47 INFO - PROCESS | 14203 | Values: 1067.2 11:22:47 INFO - PROCESS | 14203 | 11:22:47 INFO - PROCESS | 14203 | [#5] Earley Cycles:1 Average:716.33 Median:716.33 stddev:0.00 (0.0%) 11:22:47 INFO - PROCESS | 14203 | Values: 716.3 11:22:47 INFO - PROCESS | 14203 | 11:22:47 INFO - PROCESS | 14203 | [#6] Boyer Cycles:1 Average:12395.06 Median:12395.06 stddev:0.00 (0.0%) 11:22:47 INFO - PROCESS | 14203 | Values: 12395.1 11:22:47 INFO - PROCESS | 14203 | 11:22:47 INFO - PROCESS | 14203 | [#7] RegExp Cycles:1 Average:41367.35 Median:41367.35 stddev:0.00 (0.0%) 11:22:47 INFO - PROCESS | 14203 | Values: 41367.3 11:22:47 INFO - PROCESS | 14203 | 11:22:47 INFO - PROCESS | 14203 | [#8] Splay Cycles:1 Average:587.20 Median:587.20 stddev:0.00 (0.0%) 11:22:47 INFO - PROCESS | 14203 | Values: 587.2 11:22:47 INFO - PROCESS | 14203 | 11:22:47 INFO - PROCESS | 14203 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 11:22:47 INFO - PROCESS | 14203 | Values: 4850.2 11:22:47 INFO - PROCESS | 14203 | -------- Summary: end -------- 11:22:47 INFO - PROCESS | 14203 | 11:22:47 INFO - TEST-INFO | 14203: exit 0 11:22:48 INFO - TEST-OK | v8_7 | took 40082ms 11:22:48 INFO - SUITE-END | took 1208s 11:22:48 INFO - Completed test suite (00:20:08) 11:22:48 INFO - Working with test: dromaeo_css 11:22:48 INFO - Generating results file: dromaeo_css 11:22:48 INFO - Working with test: kraken 11:22:48 INFO - Generating results file: kraken 11:22:48 INFO - javascript benchmark 11:22:48 INFO - Working with test: v8_7 11:22:48 INFO - Generating results file: v8_7 11:22:48 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:22:48 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 11:22:48 INFO - process_Request line: dromaeo_css 6968.14 graph.html#tests=[[72,64,43]] 11:22:48 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:22:48 INFO - process_Request line: kraken 1517.30 graph.html#tests=[[232,64,43]] 11:22:48 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:22:48 INFO - process_Request line: v8_7 20372.17 graph.html#tests=[[230,64,43]] 11:22:48 INFO - RETURN: dromaeo_css: 6968.14 11:22:48 INFO - RETURN: kraken: 1517.30 11:22:48 INFO - RETURN: v8_7: 20372.17 11:22:48 INFO - javascript benchmark 11:22:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3148.8897888573897, 3197.056868223875, 3205.0865503331556, 3238.724708399786, 3247.0583530776075, 5280.234366016925, 5317.388500322464, 5335.33308336458, 5335.772772262377, 5346.839594812152, 5355.437679043703, 5371.650842695231, 5392.757325920334, 5405.540529055035, 5405.756740946657, 4599.195140850355, 4881.170201065809, 5044.066847633181, 5053.317802096725, 5064.949350506503, 4849.296851956464, 4951.975240123795, 4979.278004689318, 5050.444451110375, 5060.0385926674, 4856.68431551948, 4913.164761990471, 4981.626378021663, 4986.202207646759, 5017.623678224148, 4897.926531102036, 4919.188333924898, 4923.80304787808, 4932.8520144395725, 4948.257761335793, 4819.95180048202, 4875.07373599015, 4895.706257624518, 4906.411230652309, 4950.727709975949, 5218.947810521922, 5252.527272545451, 5280.234366016906, 5280.973595132, 5295.417504074549, 5772.855678608026, 5792.015357389212, 5792.304923409218, 5793.942060579382, 5806.738696758656, 5755.251817263771, 5785.0, 5835.183074369549, 5849.415058494159, 5911.054231322968, 5434.701091440009, 5457.699826509541, 5464.207689884985, 5467.835964921059, 5473.67157970519, 5921.96365636012, 5952.494038006731, 5953.315368732651, 5959.463648271676, 5959.880802383928, 5648.8870222595315, 5717.885642287131, 5726.656400615976, 5736.0, 5827.067669172912, 5814.186013958049, 5819.010768169422, 5820.88358232833, 5822.475977161991, 5832.154337621106, 5722.141678748221, 5780.508656764138, 5786.681732504669, 5788.421157884178, 5794.768209271666, 5731.197632331477, 5802.274715660543, 5814.651120932757, 5831.825045248649, 5885.205497257901, 4501.897035226325, 4562.68061235717, 4566.794494247767, 4571.1543364477675, 4573.771311434415, 3982.3429134192534, 3988.441618173458, 4039.7374170678813, 4041.3533834586324, 4089.0, 5446.972765136228, 5448.83653490396, 5473.042217611982, 5506.394296627368, 5533.695646739468, 5823.301203855564, 5826.941730582725, 5829.47534721877, 5832.154337621021, 5838.562107841929, 5408.13469844823, 5454.59090568209, 5460.426655201147, 5460.945390546123, 5472.671639701631, 4972.651914366032, 4979.975100124476, 5028.044671512401, 5038.748062596856, 5072.416672082684, 6067.635941843503, 6090.056041313604, 6105.145279660851, 6112.969435152796, 6127.724252408563, 5740.971295143498, 5793.710314484343, 5843.883122337445, 5850.970745146247, 5871.236739224044, 6061.36355682647, 6074.574779765374, 6076.51387888959, 6081.878362432815, 6134.447899689049, 5719.456651618089, 5737.5983681141915, 5750.108733146369, 5758.193852860687, 5759.568032397503, 5704.657720536781, 5792.652440853562, 5807.186993820784, 5831.300243970751, 5849.210356601804, 5660.773569057192, 5701.201831743642, 5705.0, 5713.314402271754, 5750.079987202028, 5575.888482230252, 5651.208830763614, 5680.11958146488, 5680.602357834912, 5684.573656975661, 5489.286392768914, 5515.4760297771645, 5526.392096869422, 5573.7770489179975, 5590.273264475755, 5634.2393776841245, 5657.207990881362, 5684.317881854204, 5684.914726279027, 5685.403032681675, 5576.86057848557, 5587.1339942309005, 5589.5807814413265, 5594.524465420485, 5599.880023995136], "unit": "score", "name": "dojo.html", "value": 5357.509440682291}, {"lowerIsBetter": false, "replicates": [523.8323736404352, 540.2895192821439, 567.9918145292106, 574.2563380422353, 593.0629605223747, 28203.717962820367, 36342.63657363432, 36446.27107457849, 36693.63306366935, 36794.99999999996, 39516.80241598788, 40257.59742402575, 40467.59532404675, 40473.59526404735, 40481.0, 8330.208630180123, 8407.327413806881, 8430.83138337233, 8481.151884811501, 8492.915070849274, 8096.635651395702, 8185.631646575918, 8217.95891020547, 8235.052968908592, 8239.711610093647, 8171.0, 8242.0, 8294.460860044108, 8297.917020829806, 8302.377321700866, 8134.430589858713, 8154.714584989527, 8240.381971352113, 8433.873491897626, 8498.405111642187, 8356.958215208884, 8487.0, 8500.064992850781, 8518.488890666518, 8522.105178956182, 39665.0, 39755.60244397577, 39761.80119099415, 39886.20227595432, 39941.800290998646, 2984.447877142714, 3261.1521004538754, 3380.459126539766, 3430.382531144393, 3506.281212351462, 29666.70333296661, 29737.25656858574, 30149.09552713422, 30997.535036974463, 31087.689123108707, 3818.980905095457, 3835.884923452301, 3859.4789703389965, 3949.328614135604, 4063.5326937402283, 259454.0, 259612.0, 260337.0, 260833.0, 265737.0, 54767.0, 55073.72463137739, 55414.16878746822, 55456.72271638616, 55577.72211138919, 65974.67012664906, 67147.0, 67174.0, 67181.32818671751, 67235.0, 14452.927735361256, 14467.855321446861, 14545.490907818386, 14607.853921460863, 14658.706825863423, 10851.728706782395, 10961.342319460859, 11023.779524409467, 11031.338119712844, 11039.668809935714, 19671.311504097575, 20069.598608027758, 20110.49723756918, 20143.496412589804, 20689.275875344592, 8008.319292860056, 8014.599270036475, 8056.0, 8137.715179968791, 8161.428699991063, 931.6785708930408, 950.5294879034922, 965.5461932891529, 968.7335982604699, 1007.8992100790009, 30799.0, 31673.683263167535, 31893.202669932973, 32067.0, 32309.67690323114, 1012.2458768217725, 1029.6499190275342, 1040.4693606260862, 1042.5308611125024, 1107.911367090647, 14537.200453975132, 14985.175815330262, 15081.698366032619, 15092.849071509145, 15327.923360383127, 381080.0, 382673.0, 384574.0, 384919.0, 386084.0, 52586.211206831926, 52797.7360113197, 52861.0, 52921.2061819073, 53214.46785532172, 1318.7098838255567, 1325.516186591887, 1335.1655215490318, 1337.3914868734896, 1346.3672074125145, 27662.3084422883, 28911.277218068873, 28994.7100528992, 29012.419751605274, 29335.559966600944, 49227.7538612319, 49852.75073624609, 50118.24822627591, 50176.749116254185, 50211.99576008532, 296142.0, 298085.0, 298837.0, 298913.0, 300655.0, 42871.0, 43436.78281608572, 43444.0, 43815.56184438115, 44569.331460027475, 42682.78658606687, 42880.35679464748, 42920.0, 43411.34882976695, 43512.564874352116, 35680.64319356877, 35715.28569428649, 35966.0, 36146.45780313245, 36294.0, 36077.229176132336, 36686.816565917, 36717.0, 36771.0, 36799.0, 34519.30961380809, 35118.648813511536, 35279.29441411209, 35604.28791424105, 35809.0, 31054.22364440907, 32745.67254327426, 33232.335353292314, 33367.0, 33530.66469335275, 25393.0, 25400.364990875376, 25526.617100743875, 25703.871480643225, 26109.0], "unit": "score", "name": "ext.html", "value": 18604.165333474168}, {"lowerIsBetter": false, "replicates": [359.5721091900638, 363.30427231851024, 366.5766040223541, 367.81976831352637, 368.5209228003595, 14995.40018399264, 16081.276342564583, 16160.27278772455, 16879.0, 17076.0, 11176.105911527078, 11192.608258710947, 16602.58493537662, 16891.0, 17108.82891171088, 4766.189747742875, 5107.514786095334, 5113.744312784364, 5119.462456442076, 5122.129238029525, 4626.467956185048, 4983.103041452537, 5083.440821509631, 5089.033083714101, 5093.79624815007, 5133.768980395891, 5339.332583427072, 5352.304200453936, 5590.217369568264, 5595.300587426572, 5252.868678283055, 5294.126469132589, 5330.92003619946, 5626.774929002835, 6041.275046994345, 5364.383095943977, 5365.946340536622, 5367.892642147174, 5368.516833484966, 5392.649477783932, 14977.475788347465, 18825.0, 19240.4227873164, 19318.0, 19512.024398780148, 2036.2058797069155, 2040.2858999350108, 2051.3537536577796, 2055.3628375203584, 2141.742990841109, 9514.666986655504, 9617.90382096177, 9817.116459518606, 10785.62250321235, 12282.0, 1728.075479618398, 1807.1867659553122, 1810.1220907859677, 1866.9626607467774, 1881.3133206379573, 55701.44298557003, 55703.164452533245, 57657.711711441596, 58470.99999999958, 58720.41279587192, 9804.215662746963, 10084.647037353658, 10231.28381013322, 10245.74385640365, 10259.17926565873, 13438.932805335911, 13447.798283025762, 13494.662633434047, 13520.25638589887, 13592.66018349549, 7482.289182527651, 7500.0, 7506.361959233526, 7558.206388329147, 7561.7731468056045, 7126.322999315057, 7164.247753985756, 7169.24722904098, 7207.315305046012, 7213.963930180315, 4212.0, 4341.261985462479, 4384.386185933972, 4432.445944256968, 4453.287474004143, 1812.7552780374745, 1819.6633622779827, 1840.6502764474974, 1853.8331550160551, 1910.961780764377, 842.4271495383076, 877.723517092114, 932.9300302477342, 960.6253561111172, 981.4062492192121, 13326.533571325152, 14913.776293355608, 15572.766408503881, 15740.606484837741, 16270.51188464348, 871.5685735560938, 872.829798189347, 909.8908131024319, 924.542351535994, 959.6305422412282, 9506.762330941781, 9602.135807777195, 9689.90310096904, 9691.224702023821, 9846.0, 511113.0, 537626.0, 545064.0, 547540.0, 548642.0, 70639.64680176669, 70734.0, 73383.0, 73413.0, 73822.26177738154, 1120.5685810962839, 1150.6433005768238, 1154.8845115488552, 1160.2400427719856, 1162.0529268646196, 15246.923765381101, 15296.617584560476, 15391.84608153904, 15443.768343475082, 15882.0, 32357.676423235465, 32399.51400728944, 32546.349073018882, 32667.0, 33194.83402582972, 41510.0, 41543.169136617704, 41671.0, 41858.58141418547, 44460.33309500425, 7185.245549217466, 7302.233265507045, 7443.516171448839, 7450.36671882896, 8507.361947854059, 10831.24181307301, 10872.293300935415, 11438.0, 11671.12466565028, 11790.469428875893, 6724.29394913527, 7270.527415717961, 7291.0, 7376.594287314249, 7470.3276705096805, 7470.439717021137, 7509.061367329084, 7712.5758083305955, 7800.648970796215, 7888.605569721376, 7192.460565457507, 7317.597532135784, 7377.077865266841, 7472.476926615303, 7493.6253187339325, 8750.387472876837, 9199.540022998957, 9393.906060939576, 9419.246460283024, 9429.669961551313, 7939.651860684423, 7965.92034079675, 8784.385093043426, 8864.0, 9100.317476189444], "unit": "score", "name": "jquery.html", "value": 7963.50656969327}, {"lowerIsBetter": false, "replicates": [1463.319556406271, 1470.7352676518226, 1620.6353570446652, 1770.3361239535175, 1795.7665503484545, 7621.352185064269, 7666.8849967250535, 7807.336376408012, 7826.92173078269, 7848.489848159866, 8071.15252898446, 8092.352611791057, 8149.837003259946, 8154.714584989527, 8183.877241841377, 2345.26124270855, 2346.108478778066, 2377.91677291294, 2381.7380088190284, 2388.7611238876148, 2367.6330168823774, 2380.238323736405, 2382.821288403368, 2390.493988787062, 2394.7006624171977, 2232.3972527417586, 2240.271911628719, 2257.0858802185057, 2337.7077865266842, 2416.178499310234, 2352.047420794572, 2359.7404285528664, 2372.5847976604027, 2374.631932050535, 2381.8570885746826, 2341.8594884306995, 2346.7066616672914, 2371.6679664846934, 2374.5013547155118, 2375.0499800079933, 7725.5364678119495, 7762.029746281715, 7787.961060194662, 7790.727324543671, 7804.882926756103, 4797.568218860284, 4938.703677779345, 4947.678400903929, 4962.4789397113145, 4973.850784476472, 3097.1018404662623, 3147.751712849991, 3197.71220590148, 3226.1611980884904, 3231.2729635831984, 966.5747071288681, 970.3207754571828, 1008.5159123620704, 1009.5103874620803, 1010.4240582867768, 11111.72220694481, 11183.608573699963, 11240.943795281053, 11242.606508772236, 11300.717482063013, 4331.242032644274, 4373.846915357947, 4418.226810308183, 4447.777611119431, 4497.730136191839, 9176.8623470648, 9185.540722963826, 9198.816023679488, 9203.355765096512, 9207.677731279373, 5001.7499125043605, 5027.949720502821, 5028.924566131511, 5033.874153146201, 5033.899322013613, 4523.84166554169, 4567.588916997486, 4618.607418369409, 4630.398048253705, 4631.3516107744945, 3475.8877159309286, 3535.2045789697113, 3537.663921927413, 3542.167590616203, 3552.1119720069983, 1029.4492446541065, 1047.261680515235, 1055.8785739640039, 1060.931039482431, 1067.3115840283128, 1040.1834559870465, 1046.4767616191905, 1071.1591400750374, 1191.166183671416, 1368.6167872995577, 7474.0, 7479.439042071866, 7503.887441688379, 7507.549547027196, 7525.736599219001, 1090.574675876409, 1091.5961094395125, 1108.0802933565121, 1117.6647005898199, 1134.1210561814494, 5931.822045338647, 5946.613470124428, 6112.083187521907, 6117.418845209698, 6130.203073600493, 9519.00050494702, 9664.420134791935, 9702.126808587262, 9767.951160244153, 9772.21822254218, 9413.529323533796, 9742.464164471023, 9742.707718768448, 9769.609215631437, 9810.705678829647, 7593.772186834404, 7635.847283054308, 7656.119546252141, 7662.578558179353, 7683.923160768432, 7286.344229019413, 7410.851782964418, 7433.219511951167, 7437.181909989788, 7483.176850546544, 8519.148085191431, 8668.826623467368, 8754.25588824957, 8801.207891289814, 8820.955895220482, 8886.066962969055, 8965.103489650983, 9089.272858171198, 9102.817943641223, 9166.037566055467, 7221.494495385273, 7228.132624085143, 7238.855222895618, 7351.8162045949275, 7362.595057271901, 7569.432292577969, 7604.315611594983, 7658.885116723142, 7662.73180438682, 7664.770056898302, 7022.683979221049, 7176.138863336224, 7295.270472952662, 7394.741184058532, 7434.996275502738, 6974.755883544254, 7054.858902821812, 7060.6116663584, 7150.67821948024, 7167.569945803269, 7135.143782745896, 7161.355478007004, 7178.318059784312, 7197.820054498679, 7215.062041934515, 6488.12410324619, 6567.835804104936, 6601.24085730128, 6610.140681711347, 6637.867242655217, 6544.803655890331, 6672.366125218096, 6672.699728512326, 6737.427318677967, 6790.049393084873], "unit": "score", "name": "mootools.html", "value": 4606.895781284142}, {"lowerIsBetter": false, "replicates": [336.47845838949627, 342.43156360441674, 343.35106648434464, 348.2060901145389, 348.87789273754174, 6255.968720156404, 6271.0, 6322.620642761438, 6326.367363263671, 6342.397472240135, 6080.63516189029, 6247.843803904904, 6285.088662143987, 6305.779297724569, 6324.652144132082, 4780.880477988061, 4804.855854324376, 4806.014766972762, 4808.422989241279, 4822.397200349957, 4796.90406191876, 4804.0, 4809.014152098812, 4811.615070794345, 4829.251466022772, 4689.343491911135, 4788.4732679405415, 4789.042191561684, 4794.88012799681, 4795.640326975474, 4767.76161191939, 4778.402699662543, 4785.545373189559, 4788.0, 4788.377510923558, 4166.562510936338, 4205.137946720945, 4207.726497777635, 4221.767802770846, 4232.470941132358, 5944.613600116022, 5966.880662386771, 5978.521718262528, 5983.850403739942, 5985.191999080112, 5426.91859622102, 5611.523020543259, 5622.465865742748, 5627.127795191752, 5630.09918413056, 6654.201495820533, 6666.433353164938, 6668.266490686021, 6670.0, 6672.899906501407, 4678.415198100238, 4688.859334219979, 4691.061787642485, 4691.460482044575, 4691.7654117294, 6742.696578653923, 6951.374376306107, 6963.955406688936, 6980.0, 7011.088558487364, 4629.51390104041, 4663.253879379283, 4706.905861882743, 4710.599599034052, 4723.126221648938, 4735.171345014609, 4759.119562880878, 4760.857174284708, 4770.069836381872, 4776.546228108324, 5530.783227689902, 5533.418991005887, 5539.307586551681, 5540.335159780852, 5541.196526503634, 6579.572327798774, 6760.492963027793, 6760.966195168992, 6770.966145169243, 6786.898196527056, 1646.563660629934, 1673.7740405045163, 1683.7726906867415, 1687.6455944251845, 1689.7465380193069, 1114.6210288501948, 1127.1264769803468, 1128.1760987551359, 1132.813085840827, 1140.766142940695, 6209.9379006210265, 6306.747730090745, 6307.842303942346, 6315.368463153648, 6322.620642761449, 6747.595144291358, 6749.797506074826, 6811.625360605115, 6818.215905170969, 6819.045333653293, 6140.3114143610865, 6254.0, 6277.05844123376, 6281.623102613767, 6295.622262664255, 3704.629537046274, 3707.2770809692393, 3727.2172843703124, 3727.5154229949935, 3728.366177749789, 7148.320909513588, 7153.749618763319, 7164.283571642794, 7180.389666878374, 7201.991721159042, 6947.617881016491, 6966.895496567556, 6969.128858892638, 6973.476989225727, 6994.930050699428, 7321.670524826395, 7324.780256592311, 7375.0, 7377.114746230487, 7416.96291518539, 7043.36609705129, 7046.929530704628, 7051.823704407431, 7055.329743674342, 7080.256573059754, 6841.315868413119, 6894.517383783087, 6970.756023539152, 6973.372396484341, 6981.860362792614, 7283.089613798275, 7317.926820731725, 7319.194888562361, 7359.77920662381, 7366.7053317866685, 4697.295405689174, 4739.810407583796, 4756.143894099096, 4758.714477131383, 4769.809207631656, 6806.727730890709, 6886.69009894566, 7036.155661320674, 7038.542494737826, 7074.752383666753, 6813.1142951415995, 6820.863582728219, 6833.45332373399, 6839.384455399038, 6849.931500684929, 6746.730130794714, 6762.154730658668, 6786.8642627148165, 6796.116504854337, 6809.978503224556, 6477.546571740121, 6580.440662543738, 6601.53789234749, 6675.232348279816, 6684.83287917806, 6748.7300507979135, 6847.144106986627, 6851.2121106071445, 6860.3139686031, 6862.245153033262, 6573.276939536743, 6603.867922641424, 6618.569792963442, 6667.299933507106, 6679.82905555706], "unit": "score", "name": "prototype.html", "value": 5048.140063387693}, {"lowerIsBetter": false, "replicates": [705.7388766156521, 718.8382613911867, 745.2510227221642, 767.93088622024, 819.5369616166862, 13424.664383390407, 13492.93253533731, 13503.59489215325, 13508.05443618947, 13522.391492382842, 12671.936640316786, 12727.299998500079, 13297.800532992012, 13344.466221351158, 13349.065565410425, 807.2169995104739, 816.995915020424, 827.4125370986607, 828.2669837194067, 828.8425199212161, 820.7168526858225, 822.0, 824.7979245084932, 827.4042689263721, 828.8922440082781, 868.7958329792493, 870.4081224767156, 871.4292138649195, 873.0614589316478, 874.0167311774254, 863.6286396849353, 867.1805144138791, 867.2238346679686, 868.7002983970551, 870.2602787630527, 630.1021045010887, 634.9936500634981, 638.1512588257606, 638.8818068657313, 640.6124294801671, 13800.447982080705, 13889.930550347284, 13933.58199254024, 13938.93030534851, 13950.860491395159, 11919.94040029803, 12051.276923384625, 12139.089568282414, 12222.449989750483, 12783.0, 10500.107490863285, 10573.682789516326, 10646.201534884836, 11145.888541114566, 11234.494447749788, 3659.7621154624862, 3661.4141737322166, 3671.632836716307, 3782.8865134046023, 3792.791396473193, 46347.76826115882, 46371.07257854824, 46890.76554617239, 47921.76039119782, 48046.75976620129, 9847.950760246153, 9864.161546268648, 9924.751881203028, 9943.30396872212, 9975.650852220137, 17824.91087544554, 18111.63776724458, 18133.90933045326, 18156.0, 18161.45515634533, 7245.5652660840515, 7292.124945006527, 7420.36926861212, 7478.551286922693, 7529.2470752925365, 4062.8374865005067, 4111.342185250345, 4120.031792528754, 4165.625093741578, 4174.684974233107, 3255.186203449138, 3256.0394683568406, 3274.3287626036604, 3289.753268504872, 3295.8022518648477, 575.3757173466752, 590.7075997381323, 594.2037669522861, 595.6188039654625, 606.4057223920495, 497.39069639691087, 534.1187041381751, 536.2733496112711, 637.4422380417135, 692.3837784371913, 8262.940710911556, 8445.873311900326, 8450.915490845013, 8579.742607721653, 8708.912910870937, 535.8553190638506, 573.916782066598, 586.4897539140975, 635.6249812610582, 671.3722669304216, 3847.3651847445417, 3921.9215615687526, 3934.9803250983564, 4055.9594404055583, 4336.848210312624, 48817.51182488201, 48915.0, 57050.714746426835, 57902.42097579055, 58442.707786461644, 44577.0, 45027.099458010656, 45481.54518454773, 47982.04035919262, 48047.0, 43829.0, 44348.3347749784, 44481.555184448385, 44972.3254151188, 45427.54572454299, 8393.202645748644, 8528.91471085306, 8593.69922052725, 8630.741077767678, 8698.434601750865, 32931.17672058122, 33712.98861034173, 33728.66271337255, 33779.83110084434, 34036.48945265872, 42026.63786897102, 42350.788246058575, 42561.14877702366, 43034.78482607567, 43081.56918430776, 10738.516766745359, 10998.450077495932, 11016.339019658846, 11079.16906232052, 11115.388653624128, 11300.332654783904, 11749.471273792871, 12047.51809927593, 12085.939570302093, 12154.453049612965, 10354.896451035393, 10575.841362379417, 10706.464676765974, 10733.0, 10822.242443028912, 10086.193104551472, 10105.292629515863, 10111.86304348902, 10580.41807700553, 10812.621558245424, 10888.40113793749, 11129.443527823738, 11294.0, 11314.0, 11482.885171148515, 9046.84655186963, 9291.397129898241, 9291.907080929375, 9440.716778496657, 9603.231741460526, 8742.0, 8906.86639700418, 9113.3165012623, 9666.743323368199, 9766.75583110428], "unit": "score", "name": "yui.html", "value": 6200.7965277236635}], "name": "dromaeo_css", "value": 6968.13693672352}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 112.0, 112.0, 112.0, 123.0, 111.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [154.0, 129.0, 154.0, 161.0, 132.0, 151.0, 154.0, 131.0, 164.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 163.0, 164.0, 161.0, 160.0, 161.0, 164.0, 166.0, 159.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [74.0, 78.0, 74.0, 75.0, 77.0, 73.0, 148.0, 74.0, 74.0, 73.0], "unit": "score", "name": "audio-fft", "value": 82.0}, {"lowerIsBetter": true, "replicates": [97.0, 99.0, 139.0, 96.0, 97.0, 96.0, 150.0, 97.0, 97.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 110.8}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 99.0, 96.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 58.0, 58.0, 59.0, 59.0, 57.0, 59.0, 66.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 67.0, 68.0, 67.0, 67.0, 68.0, 70.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [84.0, 81.0, 83.0, 84.0, 84.0, 83.0, 90.0, 83.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [124.0, 119.0, 120.0, 126.0, 115.0, 133.0, 117.0, 116.0, 129.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.8}, {"lowerIsBetter": true, "replicates": [147.0, 153.0, 155.0, 156.0, 158.0, 141.0, 160.0, 149.0, 152.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.2}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 69.0, 70.0, 67.0, 72.0, 67.0, 67.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1517.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.42005692281936], "unit": "score", "name": "Richards", "value": 210.8588460000001}, {"lowerIsBetter": false, "replicates": [188.82175226586102], "unit": "score", "name": "DeltaBlue", "value": 350.16092799999996}, {"lowerIsBetter": false, "replicates": [279.4857462269424], "unit": "score", "name": "Encrypt", "value": 952.3956179999999}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1067.2358591248667], "unit": "score", "name": "RayTrace", "value": 693.3696929999998}, {"lowerIsBetter": false, "replicates": [716.3323782234957], "unit": "score", "name": "Earley", "value": 930.3823479999999}, {"lowerIsBetter": false, "replicates": [12395.061728395061], "unit": "score", "name": "Boyer", "value": 53.768429282868496}, {"lowerIsBetter": false, "replicates": [41367.34693877551], "unit": "score", "name": "RegExp", "value": 22.021837691169203}, {"lowerIsBetter": false, "replicates": [587.1990604815032], "unit": "score", "name": "Splay", "value": 138.77917300000004}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 20372.17141683164}]} 11:22:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20372.17"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1517.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6968.14"}}} 11:22:48 INFO - Return code: 0 11:22:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:22:48 INFO - # TBPL SUCCESS # 11:22:48 INFO - Running post-action listener: _resource_record_post_action 11:22:48 INFO - Running post-run listener: _resource_record_post_run 11:22:49 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 32768; Write bytes: 539910144; Read time: 508; Write time: 402900 11:22:49 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 236326912; Read time: 204; Write time: 233888 11:22:49 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 28672; Write bytes: 303583232; Read time: 304; Write time: 169012 11:22:49 INFO - Running post-run listener: _upload_blobber_files 11:22:49 INFO - Blob upload gear active. 11:22:49 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:22:49 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:49 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:49 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:49 INFO - (blobuploader) - INFO - Open directory for files ... 11:22:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:22:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:22:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:22:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:22:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:22:50 INFO - (blobuploader) - INFO - Done attempting. 11:22:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:22:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:22:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:22:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:22:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:22:51 INFO - (blobuploader) - INFO - Done attempting. 11:22:51 INFO - (blobuploader) - INFO - Iteration through files over. 11:22:51 INFO - Return code: 0 11:22:51 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:22:51 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:22:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45314dd10d88d1bf93f6c22a94818473365caa19e3b2546dcc3684d632fb7788fdbb969f1d9947915c4f07fdc7e69219c6b08c59407a884cce9ed118782d5b9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95f345ad13ecdadd06650e1c22ec6c3cd7d2029a40077a0b1a3520c88d20ab4cbf925ed9842c85ce73af5f986af5a3273806928f0a9633be64d7a981a073f0f0"} 11:22:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:22:51 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:22:51 INFO - Contents: 11:22:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45314dd10d88d1bf93f6c22a94818473365caa19e3b2546dcc3684d632fb7788fdbb969f1d9947915c4f07fdc7e69219c6b08c59407a884cce9ed118782d5b9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95f345ad13ecdadd06650e1c22ec6c3cd7d2029a40077a0b1a3520c88d20ab4cbf925ed9842c85ce73af5f986af5a3273806928f0a9633be64d7a981a073f0f0"} 11:22:51 INFO - Running post-run listener: copy_logs_to_upload_dir 11:22:51 INFO - Copying logs to upload dir... 11:22:51 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 11:22:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.329749 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-01-21 11:22:51.791648) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 11:22:51.795941) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45314dd10d88d1bf93f6c22a94818473365caa19e3b2546dcc3684d632fb7788fdbb969f1d9947915c4f07fdc7e69219c6b08c59407a884cce9ed118782d5b9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95f345ad13ecdadd06650e1c22ec6c3cd7d2029a40077a0b1a3520c88d20ab4cbf925ed9842c85ce73af5f986af5a3273806928f0a9633be64d7a981a073f0f0"} build_url:https://queue.taskcluster.net/v1/task/T308CCqFR36efovtyE08Ug/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011533 build_url: 'https://queue.taskcluster.net/v1/task/T308CCqFR36efovtyE08Ug/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45314dd10d88d1bf93f6c22a94818473365caa19e3b2546dcc3684d632fb7788fdbb969f1d9947915c4f07fdc7e69219c6b08c59407a884cce9ed118782d5b9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95f345ad13ecdadd06650e1c22ec6c3cd7d2029a40077a0b1a3520c88d20ab4cbf925ed9842c85ce73af5f986af5a3273806928f0a9633be64d7a981a073f0f0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 11:22:51.825777) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:22:51.826184) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1453401718.545518-1568382172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004587 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:22:51.910369) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 11:22:51.910721) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 11:22:51.911118) ========= ========= Total master_lag: 9.00 =========