builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1451945435.19 results: success (0) buildid: 20160104113010 builduid: 276e47d592c14821a0dc5f5b6513353a revision: e2dc2bcbefb8181a48980d1af4809f3ca2368bef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 14:10:35.190030) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 14:10:35.190486) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 14:10:35.190783) ========= 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=14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006228 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 14:10:35.214054) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 14:10:35.214469) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 14:10:35.228617) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 14:10:35.229048) ========= 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=14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004592 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 14:10:35.279161) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 14:10:35.279518) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 14:10:35.279896) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 14:10:35.280223) ========= 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=14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-04 14:10:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-01-04 14:10:35 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173070 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 14:10:35.466027) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 14:10:35.466363) ========= 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=14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018502 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 14:10:35.517018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-04 14:10:35.517399) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev e2dc2bcbefb8181a48980d1af4809f3ca2368bef --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/b2g-inbound --rev e2dc2bcbefb8181a48980d1af4809f3ca2368bef --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=14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-04 14:10:35,822 truncating revision to first 12 chars 2016-01-04 14:10:35,822 Setting DEBUG logging. 2016-01-04 14:10:35,822 attempt 1/10 2016-01-04 14:10:35,822 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/e2dc2bcbefb8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-04 14:10:37,083 unpacking tar archive at: b2g-inbound-e2dc2bcbefb8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.554494 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-04 14:10:37.085459) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 14:10:37.085776) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 14:10:37.095280) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 14:10:37.095533) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 14:10:37.095906) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-01-04 14:10:37.096219) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:10:37 INFO - MultiFileLogger online at 20160104 14:10:37 in /builds/slave/test-pgo 14:10:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 14:10:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:10:37 INFO - {'append_to_log': False, 14:10:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:10:37 INFO - 'blob_upload_branch': 'B2G-Inbound', 14:10:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:10:37 INFO - 'branch': 'B2G-Inbound', 14:10:37 INFO - 'buildbot_json_path': 'buildprops.json', 14:10:37 INFO - 'config_files': ('talos/linux_config.py',), 14:10:37 INFO - 'default_actions': ('clobber', 14:10:37 INFO - 'read-buildbot-config', 14:10:37 INFO - 'download-and-extract', 14:10:37 INFO - 'populate-webroot', 14:10:37 INFO - 'create-virtualenv', 14:10:37 INFO - 'install', 14:10:37 INFO - 'run-tests'), 14:10:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:10:37 INFO - 'download_minidump_stackwalk': True, 14:10:37 INFO - 'download_symbols': 'ondemand', 14:10:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:10:37 INFO - 'tooltool.py': '/tools/tooltool.py', 14:10:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:10:37 INFO - '/tools/misc-python/virtualenv.py')}, 14:10:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:10:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:10:37 INFO - 'installer_path': 'installer.exe', 14:10:37 INFO - 'log_level': 'info', 14:10:37 INFO - 'log_name': 'talos', 14:10:37 INFO - 'log_to_console': True, 14:10:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:10:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:10:37 INFO - 'opt_config_files': (), 14:10:37 INFO - 'pip_index': False, 14:10:37 INFO - 'sps_profile': False, 14:10:37 INFO - 'sps_profile_interval': 0, 14:10:37 INFO - 'suite': 'dromaeojs', 14:10:37 INFO - 'system_bits': '32', 14:10:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:10:37 INFO - 'title': 'talos-linux64-ix-036', 14:10:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:10:37 INFO - 'use_talos_json': True, 14:10:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:10:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:10:37 INFO - 'work_dir': 'build'} 14:10:37 INFO - ##### 14:10:37 INFO - ##### Running clobber step. 14:10:37 INFO - ##### 14:10:37 INFO - Running pre-action listener: _resource_record_pre_action 14:10:37 INFO - Running main action method: clobber 14:10:37 INFO - rmtree: /builds/slave/test-pgo/build 14:10:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:10:37 INFO - Running post-action listener: _resource_record_post_action 14:10:37 INFO - ##### 14:10:37 INFO - ##### Running read-buildbot-config step. 14:10:37 INFO - ##### 14:10:37 INFO - Running pre-action listener: _resource_record_pre_action 14:10:37 INFO - Running main action method: read_buildbot_config 14:10:37 INFO - Using buildbot properties: 14:10:37 INFO - { 14:10:37 INFO - "project": "", 14:10:37 INFO - "product": "firefox", 14:10:37 INFO - "script_repo_revision": "production", 14:10:37 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 14:10:37 INFO - "repository": "", 14:10:37 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 14:10:37 INFO - "buildid": "20160104113010", 14:10:37 INFO - "pgo_build": "True", 14:10:37 INFO - "basedir": "/builds/slave/test-pgo", 14:10:37 INFO - "buildnumber": 1088, 14:10:37 INFO - "slavename": "talos-linux64-ix-036", 14:10:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:10:37 INFO - "platform": "ubuntu64_hw", 14:10:37 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 14:10:37 INFO - "branch": "b2g-inbound", 14:10:37 INFO - "repo_path": "integration/b2g-inbound", 14:10:37 INFO - "revision": "e2dc2bcbefb8181a48980d1af4809f3ca2368bef", 14:10:37 INFO - "stage_platform": "linux64-pgo", 14:10:37 INFO - "builduid": "276e47d592c14821a0dc5f5b6513353a", 14:10:37 INFO - "slavebuilddir": "test" 14:10:37 INFO - } 14:10:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/D-UK3LkBTxeScJaHIDNJSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 14:10:37 INFO - Running post-action listener: _resource_record_post_action 14:10:37 INFO - ##### 14:10:37 INFO - ##### Running download-and-extract step. 14:10:37 INFO - ##### 14:10:37 INFO - Running pre-action listener: _resource_record_pre_action 14:10:37 INFO - Running main action method: download_and_extract 14:10:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:10: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')]} 14:10:37 INFO - https://queue.taskcluster.net/v1/task/D-UK3LkBTxeScJaHIDNJSw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:10:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-UK3LkBTxeScJaHIDNJSw/artifacts/public/build/test_packages.json 14:10:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-UK3LkBTxeScJaHIDNJSw/artifacts/public/build/test_packages.json 14:10:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-UK3LkBTxeScJaHIDNJSw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:10:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-UK3LkBTxeScJaHIDNJSw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:10:38 INFO - Downloaded 1302 bytes. 14:10:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:10:38 INFO - Using the following test package requirements: 14:10:38 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:10:38 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:10:38 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:38 INFO - u'jsshell-linux-x86_64.zip'], 14:10:38 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:10:38 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:10:38 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:10:38 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:10:38 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:10:38 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:10:38 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:10:38 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:10:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:38 INFO - https://queue.taskcluster.net/v1/task/D-UK3LkBTxeScJaHIDNJSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:10:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-UK3LkBTxeScJaHIDNJSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:10:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-UK3LkBTxeScJaHIDNJSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:10:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-UK3LkBTxeScJaHIDNJSw/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 14:10:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-UK3LkBTxeScJaHIDNJSw/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 14:10:39 INFO - Downloaded 23197957 bytes. 14:10:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 14:10:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:10:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:10:40 INFO - Return code: 0 14:10:40 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 14:10:40 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')]} 14:10:40 INFO - https://queue.taskcluster.net/v1/task/D-UK3LkBTxeScJaHIDNJSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:10:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-UK3LkBTxeScJaHIDNJSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:10:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-UK3LkBTxeScJaHIDNJSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:10:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-UK3LkBTxeScJaHIDNJSw/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 14:10:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-UK3LkBTxeScJaHIDNJSw/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 14:10:41 INFO - Downloaded 23197957 bytes. 14:10:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 14:10:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:10:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:10:43 INFO - Return code: 0 14:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:43 INFO - https://queue.taskcluster.net/v1/task/D-UK3LkBTxeScJaHIDNJSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:10:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-UK3LkBTxeScJaHIDNJSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:10:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-UK3LkBTxeScJaHIDNJSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:10:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-UK3LkBTxeScJaHIDNJSw/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 14:10:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-UK3LkBTxeScJaHIDNJSw/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 14:10:44 INFO - Downloaded 11132285 bytes. 14:10:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 14:10:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:10:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 14:10:44 INFO - Return code: 0 14:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:44 INFO - https://queue.taskcluster.net/v1/task/D-UK3LkBTxeScJaHIDNJSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:10:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-UK3LkBTxeScJaHIDNJSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:10:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-UK3LkBTxeScJaHIDNJSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:10:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-UK3LkBTxeScJaHIDNJSw/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 14:10:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-UK3LkBTxeScJaHIDNJSw/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 14:10:45 INFO - Downloaded 54986767 bytes. 14:10:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D-UK3LkBTxeScJaHIDNJSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:10:45 INFO - mkdir: /builds/slave/test-pgo/properties 14:10:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:10:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:10:45 INFO - Contents: 14:10:45 INFO - build_url:https://queue.taskcluster.net/v1/task/D-UK3LkBTxeScJaHIDNJSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:10:46 INFO - Running post-action listener: _resource_record_post_action 14:10:46 INFO - Running post-action listener: set_extra_try_arguments 14:10:46 INFO - ##### 14:10:46 INFO - ##### Running populate-webroot step. 14:10:46 INFO - ##### 14:10:46 INFO - Running pre-action listener: _resource_record_pre_action 14:10:46 INFO - Running main action method: populate_webroot 14:10:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:10:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:10:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:10:46 INFO - '--tppagecycles', 14:10:46 INFO - '7'], 14:10:46 INFO - 'tests': ['tsvgm']}}, 14:10:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:10:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:10:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:10:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:10:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:10:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:10:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:10:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:46 INFO - 'talos_options': ['--e10s'], 14:10:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:10:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:46 INFO - 'tests': ['damp', 'tps']}, 14:10:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:46 INFO - 'talos_options': ['--e10s'], 14:10:46 INFO - 'tests': ['damp', 'tps']}, 14:10:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:10:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:10:46 INFO - 'other': {'tests': ['a11yr', 14:10:46 INFO - 'ts_paint', 14:10:46 INFO - 'tpaint', 14:10:46 INFO - 'sessionrestore', 14:10:46 INFO - 'sessionrestore_no_auto_restore']}, 14:10:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:10:46 INFO - 'tests': ['a11yr', 14:10:46 INFO - 'ts_paint', 14:10:46 INFO - 'tpaint', 14:10:46 INFO - 'sessionrestore', 14:10:46 INFO - 'sessionrestore_no_auto_restore']}, 14:10:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:10:46 INFO - 'tests': ['a11yr', 14:10:46 INFO - 'ts_paint', 14:10:46 INFO - 'tpaint', 14:10:46 INFO - 'sessionrestore', 14:10:46 INFO - 'sessionrestore_no_auto_restore']}, 14:10:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:10:46 INFO - 'tests': ['a11yr', 14:10:46 INFO - 'ts_paint', 14:10:46 INFO - 'tpaint', 14:10:46 INFO - 'sessionrestore', 14:10:46 INFO - 'sessionrestore_no_auto_restore']}, 14:10:46 INFO - 'other_l64': {'tests': ['a11yr', 14:10:46 INFO - 'ts_paint', 14:10:46 INFO - 'tpaint', 14:10:46 INFO - 'sessionrestore', 14:10:46 INFO - 'sessionrestore_no_auto_restore']}, 14:10:46 INFO - 'other_nol64': {'tests': ['a11yr', 14:10:46 INFO - 'ts_paint', 14:10:46 INFO - 'tpaint', 14:10:46 INFO - 'sessionrestore', 14:10:46 INFO - 'sessionrestore_no_auto_restore']}, 14:10:46 INFO - 'svgr': {'tests': ['tsvgx', 14:10:46 INFO - 'tsvgr_opacity', 14:10:46 INFO - 'tart', 14:10:46 INFO - 'tscrollx', 14:10:46 INFO - 'cart']}, 14:10:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:10:46 INFO - 'tests': ['tsvgx', 14:10:46 INFO - 'tsvgr_opacity', 14:10:46 INFO - 'tart', 14:10:46 INFO - 'tscrollx', 14:10:46 INFO - 'cart']}, 14:10:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:46 INFO - 'tests': ['tp5o']}, 14:10:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:46 INFO - 'talos_options': ['--e10s'], 14:10:46 INFO - 'tests': ['tp5o']}, 14:10:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:46 INFO - 'talos_options': ['--xperf_path', 14:10:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:10:46 INFO - 'tests': ['tp5n']}, 14:10:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:46 INFO - 'talos_options': ['--e10s', 14:10:46 INFO - '--xperf_path', 14:10:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:10:46 INFO - 'tests': ['tp5n']}}, 14:10:46 INFO - 'talos.zip': {'path': '', 14:10:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:10:46 INFO - Running post-action listener: _resource_record_post_action 14:10:46 INFO - ##### 14:10:46 INFO - ##### Running create-virtualenv step. 14:10:46 INFO - ##### 14:10:46 INFO - Running pre-action listener: _resource_record_pre_action 14:10:46 INFO - Running main action method: create_virtualenv 14:10:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:10:46 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 14:10:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:10:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:10:46 INFO - Using real prefix '/usr' 14:10:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:10:46 INFO - Installing distribute.............................................................................................................................................................................................done. 14:10:48 INFO - Installing pip.................done. 14:10:48 INFO - Return code: 0 14:10:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:10: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')]} 14:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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')]} 14:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f45b6d33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f89630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201a840>, '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 0x1f876b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f87b60>, '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': '14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803', '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 14:10:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 14:10:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:10:48 INFO - Using env: {'DISPLAY': ':0', 14:10:48 INFO - 'HOME': '/home/cltbld', 14:10:48 INFO - 'LANG': 'en_US.UTF-8', 14:10:48 INFO - 'LANGUAGE': 'en_US:en', 14:10:48 INFO - 'LOGNAME': 'cltbld', 14:10:48 INFO - 'MAIL': '/var/mail/cltbld', 14:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:48 INFO - 'MOZ_NO_REMOTE': '1', 14:10:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:48 INFO - 'NO_EM_RESTART': '1', 14:10:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:10:48 INFO - 'PWD': '/builds/slave/test-pgo', 14:10:48 INFO - 'SHELL': '/bin/bash', 14:10:48 INFO - 'SHLVL': '1', 14:10:48 INFO - 'TERM': 'linux', 14:10:48 INFO - 'TMOUT': '86400', 14:10:48 INFO - 'USER': 'cltbld', 14:10:48 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803', 14:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:48 INFO - '_': '/tools/buildbot/bin/python'} 14:10:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:48 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 14:10:48 INFO - Cleaning up... 14:10:48 INFO - Return code: 0 14:10:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:10: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')]} 14:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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')]} 14:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f45b6d33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f89630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201a840>, '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 0x1f876b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f87b60>, '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': '14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803', '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 14:10:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 14:10:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:10:48 INFO - Using env: {'DISPLAY': ':0', 14:10:48 INFO - 'HOME': '/home/cltbld', 14:10:48 INFO - 'LANG': 'en_US.UTF-8', 14:10:48 INFO - 'LANGUAGE': 'en_US:en', 14:10:48 INFO - 'LOGNAME': 'cltbld', 14:10:48 INFO - 'MAIL': '/var/mail/cltbld', 14:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:48 INFO - 'MOZ_NO_REMOTE': '1', 14:10:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:48 INFO - 'NO_EM_RESTART': '1', 14:10:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:10:48 INFO - 'PWD': '/builds/slave/test-pgo', 14:10:48 INFO - 'SHELL': '/bin/bash', 14:10:48 INFO - 'SHLVL': '1', 14:10:48 INFO - 'TERM': 'linux', 14:10:48 INFO - 'TMOUT': '86400', 14:10:48 INFO - 'USER': 'cltbld', 14:10:48 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803', 14:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:48 INFO - '_': '/tools/buildbot/bin/python'} 14:10:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:49 INFO - Downloading/unpacking psutil>=0.7.1 14:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:50 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 14:10:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:10:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:10:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:50 INFO - Installing collected packages: psutil 14:10:50 INFO - Running setup.py install for psutil 14:10:51 INFO - building 'psutil._psutil_linux' extension 14:10:51 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 14:10:51 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 14:10:51 INFO - building 'psutil._psutil_posix' extension 14:10:51 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 14:10:51 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 14:10:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:51 INFO - Successfully installed psutil 14:10:51 INFO - Cleaning up... 14:10:51 INFO - Return code: 0 14:10:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:10: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')]} 14:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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')]} 14:10:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f45b6d33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f89630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201a840>, '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 0x1f876b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f87b60>, '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': '14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803', '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 14:10:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 14:10:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:10:51 INFO - Using env: {'DISPLAY': ':0', 14:10:51 INFO - 'HOME': '/home/cltbld', 14:10:51 INFO - 'LANG': 'en_US.UTF-8', 14:10:51 INFO - 'LANGUAGE': 'en_US:en', 14:10:51 INFO - 'LOGNAME': 'cltbld', 14:10:51 INFO - 'MAIL': '/var/mail/cltbld', 14:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:51 INFO - 'MOZ_NO_REMOTE': '1', 14:10:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:51 INFO - 'NO_EM_RESTART': '1', 14:10:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:10:51 INFO - 'PWD': '/builds/slave/test-pgo', 14:10:51 INFO - 'SHELL': '/bin/bash', 14:10:51 INFO - 'SHLVL': '1', 14:10:51 INFO - 'TERM': 'linux', 14:10:51 INFO - 'TMOUT': '86400', 14:10:51 INFO - 'USER': 'cltbld', 14:10:51 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803', 14:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:51 INFO - '_': '/tools/buildbot/bin/python'} 14:10:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:10:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:10:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:10:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:10:53 INFO - Installing collected packages: mozsystemmonitor 14:10:53 INFO - Running setup.py install for mozsystemmonitor 14:10:53 INFO - Successfully installed mozsystemmonitor 14:10:53 INFO - Cleaning up... 14:10:53 INFO - Return code: 0 14:10:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:10:53 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')]} 14:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:53 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')]} 14:10:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f45b6d33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f89630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201a840>, '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 0x1f876b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f87b60>, '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': '14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803', '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 14:10:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 14:10:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:10:53 INFO - Using env: {'DISPLAY': ':0', 14:10:53 INFO - 'HOME': '/home/cltbld', 14:10:53 INFO - 'LANG': 'en_US.UTF-8', 14:10:53 INFO - 'LANGUAGE': 'en_US:en', 14:10:53 INFO - 'LOGNAME': 'cltbld', 14:10:53 INFO - 'MAIL': '/var/mail/cltbld', 14:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:53 INFO - 'MOZ_NO_REMOTE': '1', 14:10:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:53 INFO - 'NO_EM_RESTART': '1', 14:10:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:10:53 INFO - 'PWD': '/builds/slave/test-pgo', 14:10:53 INFO - 'SHELL': '/bin/bash', 14:10:53 INFO - 'SHLVL': '1', 14:10:53 INFO - 'TERM': 'linux', 14:10:53 INFO - 'TMOUT': '86400', 14:10:53 INFO - 'USER': 'cltbld', 14:10:53 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803', 14:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:53 INFO - '_': '/tools/buildbot/bin/python'} 14:10:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:53 INFO - Downloading/unpacking blobuploader==1.2.4 14:10:53 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 14:10:53 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 14:10:53 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 14:10:53 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 14:10:53 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 14:10:53 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 14:10:55 INFO - Downloading blobuploader-1.2.4.tar.gz 14:10:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:10:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:10:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:10:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:10:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:56 INFO - Downloading docopt-0.6.1.tar.gz 14:10:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:10:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:10:56 INFO - Installing collected packages: blobuploader, requests, docopt 14:10:56 INFO - Running setup.py install for blobuploader 14:10:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:10:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:10:56 INFO - Running setup.py install for requests 14:10:56 INFO - Running setup.py install for docopt 14:10:56 INFO - Successfully installed blobuploader requests docopt 14:10:56 INFO - Cleaning up... 14:10:56 INFO - Return code: 0 14:10:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:10: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')]} 14:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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')]} 14:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f45b6d33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f89630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201a840>, '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 0x1f876b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f87b60>, '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': '14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803', '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 14:10:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:10:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:10:56 INFO - Using env: {'DISPLAY': ':0', 14:10:56 INFO - 'HOME': '/home/cltbld', 14:10:56 INFO - 'LANG': 'en_US.UTF-8', 14:10:56 INFO - 'LANGUAGE': 'en_US:en', 14:10:56 INFO - 'LOGNAME': 'cltbld', 14:10:56 INFO - 'MAIL': '/var/mail/cltbld', 14:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:56 INFO - 'MOZ_NO_REMOTE': '1', 14:10:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:56 INFO - 'NO_EM_RESTART': '1', 14:10:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:10:56 INFO - 'PWD': '/builds/slave/test-pgo', 14:10:56 INFO - 'SHELL': '/bin/bash', 14:10:56 INFO - 'SHLVL': '1', 14:10:56 INFO - 'TERM': 'linux', 14:10:56 INFO - 'TMOUT': '86400', 14:10:56 INFO - 'USER': 'cltbld', 14:10:56 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803', 14:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:56 INFO - '_': '/tools/buildbot/bin/python'} 14:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:10:57 INFO - Running setup.py (path:/tmp/pip-AQT2sX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:10:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:10:57 INFO - Running setup.py (path:/tmp/pip-7xSMbC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:10:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:10:57 INFO - Running setup.py (path:/tmp/pip-pWGSyu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:10:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:10:57 INFO - Running setup.py (path:/tmp/pip-judMNC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:10:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:10:57 INFO - Running setup.py (path:/tmp/pip-RhHPTp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:10:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:10:57 INFO - Running setup.py (path:/tmp/pip-AcR6S8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:10:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:10:57 INFO - Running setup.py (path:/tmp/pip-Mj3y3F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:10:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:10:57 INFO - Running setup.py (path:/tmp/pip-hPqZPa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:10:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:10:57 INFO - Running setup.py (path:/tmp/pip-OipNr_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:10:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:10:57 INFO - Running setup.py (path:/tmp/pip-UGfC_k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:10:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:10:57 INFO - Running setup.py (path:/tmp/pip-PtPVf4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:10:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:10:57 INFO - Running setup.py (path:/tmp/pip-jnL7M_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:10:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:10:57 INFO - Running setup.py (path:/tmp/pip-e0EQHx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:10:58 INFO - Running setup.py (path:/tmp/pip-wcBg9U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:10:58 INFO - Running setup.py (path:/tmp/pip-usYPi6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:10:58 INFO - Running setup.py (path:/tmp/pip-dKumsp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:10:58 INFO - Running setup.py (path:/tmp/pip-WDCmEZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:10:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:10:58 INFO - Running setup.py install for manifestparser 14:10:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:10:58 INFO - Running setup.py install for mozcrash 14:10:58 INFO - Running setup.py install for mozdebug 14:10:58 INFO - Running setup.py install for mozdevice 14:10:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:10:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:10:58 INFO - Running setup.py install for mozfile 14:10:58 INFO - Running setup.py install for mozhttpd 14:10:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:10:58 INFO - Running setup.py install for mozinfo 14:10:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:10:59 INFO - Running setup.py install for mozInstall 14:10:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:10:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:10:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:10:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:10:59 INFO - Running setup.py install for mozleak 14:10:59 INFO - Running setup.py install for mozlog 14:10:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:10:59 INFO - Running setup.py install for moznetwork 14:10:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:10:59 INFO - Running setup.py install for mozprocess 14:10:59 INFO - Running setup.py install for mozprofile 14:10:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:10:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:10:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:10:59 INFO - Running setup.py install for mozrunner 14:10:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:10:59 INFO - Running setup.py install for mozscreenshot 14:10:59 INFO - Running setup.py install for moztest 14:10:59 INFO - Running setup.py install for mozversion 14:11:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:11:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:11:00 INFO - Cleaning up... 14:11:00 INFO - Return code: 0 14:11:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:11: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')]} 14:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f45b6d33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f89630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201a840>, '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 0x1f876b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f87b60>, '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': '14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803', '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 14:11:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:11:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:11:00 INFO - Using env: {'DISPLAY': ':0', 14:11:00 INFO - 'HOME': '/home/cltbld', 14:11:00 INFO - 'LANG': 'en_US.UTF-8', 14:11:00 INFO - 'LANGUAGE': 'en_US:en', 14:11:00 INFO - 'LOGNAME': 'cltbld', 14:11:00 INFO - 'MAIL': '/var/mail/cltbld', 14:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:00 INFO - 'MOZ_NO_REMOTE': '1', 14:11:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:00 INFO - 'NO_EM_RESTART': '1', 14:11:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:11:00 INFO - 'PWD': '/builds/slave/test-pgo', 14:11:00 INFO - 'SHELL': '/bin/bash', 14:11:00 INFO - 'SHLVL': '1', 14:11:00 INFO - 'TERM': 'linux', 14:11:00 INFO - 'TMOUT': '86400', 14:11:00 INFO - 'USER': 'cltbld', 14:11:00 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803', 14:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:00 INFO - '_': '/tools/buildbot/bin/python'} 14:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:11:00 INFO - Running setup.py (path:/tmp/pip-bxfeCt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:11:00 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)) 14:11:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:11:00 INFO - Running setup.py (path:/tmp/pip-1nLUsp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:11:00 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)) 14:11:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:11:00 INFO - Running setup.py (path:/tmp/pip-QTzlzt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:11:00 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)) 14:11:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:11:00 INFO - Running setup.py (path:/tmp/pip-EQiSw5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:11:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 14:11:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:11:00 INFO - Running setup.py (path:/tmp/pip-V27A0s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:11:00 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)) 14:11:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:11:00 INFO - Running setup.py (path:/tmp/pip-rlivhd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:11:00 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)) 14:11:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:11:00 INFO - Running setup.py (path:/tmp/pip-b7VXBG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:11:00 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)) 14:11:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:11:00 INFO - Running setup.py (path:/tmp/pip-9vk66g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:11:00 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)) 14:11:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:11:00 INFO - Running setup.py (path:/tmp/pip-FdqDgi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:11:00 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)) 14:11:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:11:00 INFO - Running setup.py (path:/tmp/pip-1wdXYu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:11:01 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)) 14:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:11:01 INFO - Running setup.py (path:/tmp/pip-4HNAXO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:11:01 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)) 14:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:11:01 INFO - Running setup.py (path:/tmp/pip-k3opTy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:11:01 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)) 14:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:11:01 INFO - Running setup.py (path:/tmp/pip-LktzdT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:11:01 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)) 14:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:11:01 INFO - Running setup.py (path:/tmp/pip-GDLOze-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:11:01 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)) 14:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:11:01 INFO - Running setup.py (path:/tmp/pip-25OrkT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:11:01 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)) 14:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:11:01 INFO - Running setup.py (path:/tmp/pip-YoBD7e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:11:01 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)) 14:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:11:01 INFO - Running setup.py (path:/tmp/pip-MkmTfQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:11:01 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)) 14:11:01 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)) 14:11:01 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)) 14:11:01 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)) 14:11:01 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:11:01 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:11:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:03 INFO - Downloading blessings-1.5.1.tar.gz 14:11:03 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 14:11:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:11:03 INFO - Installing collected packages: blessings 14:11:03 INFO - Running setup.py install for blessings 14:11:03 INFO - Successfully installed blessings 14:11:03 INFO - Cleaning up... 14:11:03 INFO - Return code: 0 14:11:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:11:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:11:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:11:03 INFO - Reading from file tmpfile_stdout 14:11:03 INFO - Current package versions: 14:11:03 INFO - argparse == 1.2.1 14:11:03 INFO - blessings == 1.5.1 14:11:03 INFO - blobuploader == 1.2.4 14:11:03 INFO - docopt == 0.6.1 14:11:03 INFO - manifestparser == 1.1 14:11:03 INFO - mozInstall == 1.12 14:11:03 INFO - mozcrash == 0.16 14:11:03 INFO - mozdebug == 0.1 14:11:03 INFO - mozdevice == 0.47 14:11:03 INFO - mozfile == 1.2 14:11:03 INFO - mozhttpd == 0.7 14:11:03 INFO - mozinfo == 0.9 14:11:03 INFO - mozleak == 0.1 14:11:03 INFO - mozlog == 3.1 14:11:03 INFO - moznetwork == 0.27 14:11:03 INFO - mozprocess == 0.22 14:11:03 INFO - mozprofile == 0.28 14:11:03 INFO - mozrunner == 6.11 14:11:03 INFO - mozscreenshot == 0.1 14:11:03 INFO - mozsystemmonitor == 0.0 14:11:03 INFO - moztest == 0.7 14:11:03 INFO - mozversion == 1.4 14:11:03 INFO - psutil == 3.1.1 14:11:03 INFO - requests == 1.2.3 14:11:03 INFO - wsgiref == 0.1.2 14:11:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:11: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')]} 14:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f45b6d33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f89630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201a840>, '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 0x1f876b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f87b60>, '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': '14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803', '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 14:11:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 14:11:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:11:03 INFO - Using env: {'DISPLAY': ':0', 14:11:03 INFO - 'HOME': '/home/cltbld', 14:11:03 INFO - 'LANG': 'en_US.UTF-8', 14:11:03 INFO - 'LANGUAGE': 'en_US:en', 14:11:03 INFO - 'LOGNAME': 'cltbld', 14:11:03 INFO - 'MAIL': '/var/mail/cltbld', 14:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:03 INFO - 'MOZ_NO_REMOTE': '1', 14:11:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:03 INFO - 'NO_EM_RESTART': '1', 14:11:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:11:03 INFO - 'PWD': '/builds/slave/test-pgo', 14:11:03 INFO - 'SHELL': '/bin/bash', 14:11:03 INFO - 'SHLVL': '1', 14:11:03 INFO - 'TERM': 'linux', 14:11:03 INFO - 'TMOUT': '86400', 14:11:03 INFO - 'USER': 'cltbld', 14:11:03 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803', 14:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:03 INFO - '_': '/tools/buildbot/bin/python'} 14:11:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:03 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)) 14:11:03 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)) 14:11:03 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)) 14:11:03 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)) 14:11:03 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)) 14:11:03 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)) 14:11:03 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)) 14:11:03 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)) 14:11:03 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)) 14:11:03 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)) 14:11:03 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)) 14:11:03 INFO - Cleaning up... 14:11:03 INFO - Return code: 0 14:11:03 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:11: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')]} 14:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f45b6d33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f89630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201a840>, '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 0x1f876b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f87b60>, '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': '14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803', '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 14:11:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 14:11:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:11:03 INFO - Using env: {'DISPLAY': ':0', 14:11:03 INFO - 'HOME': '/home/cltbld', 14:11:03 INFO - 'LANG': 'en_US.UTF-8', 14:11:03 INFO - 'LANGUAGE': 'en_US:en', 14:11:03 INFO - 'LOGNAME': 'cltbld', 14:11:03 INFO - 'MAIL': '/var/mail/cltbld', 14:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:03 INFO - 'MOZ_NO_REMOTE': '1', 14:11:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:03 INFO - 'NO_EM_RESTART': '1', 14:11:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:11:03 INFO - 'PWD': '/builds/slave/test-pgo', 14:11:03 INFO - 'SHELL': '/bin/bash', 14:11:03 INFO - 'SHLVL': '1', 14:11:03 INFO - 'TERM': 'linux', 14:11:03 INFO - 'TMOUT': '86400', 14:11:03 INFO - 'USER': 'cltbld', 14:11:03 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803', 14:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:03 INFO - '_': '/tools/buildbot/bin/python'} 14:11:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:04 INFO - Downloading/unpacking jsonschema 14:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:11:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 14:11:05 INFO - Downloading/unpacking functools32 (from jsonschema) 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:06 INFO - Downloading functools32-3.2.3-2.tar.gz 14:11:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:11:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:11:06 INFO - warning: no files found matching '*.txt' 14:11:06 INFO - no previously-included directories found matching 'build' 14:11:06 INFO - no previously-included directories found matching 'dist' 14:11:06 INFO - no previously-included directories found matching '.git*' 14:11:06 INFO - Installing collected packages: jsonschema, functools32 14:11:06 INFO - Running setup.py install for functools32 14:11:06 INFO - warning: no files found matching '*.txt' 14:11:06 INFO - no previously-included directories found matching 'build' 14:11:06 INFO - no previously-included directories found matching 'dist' 14:11:06 INFO - no previously-included directories found matching '.git*' 14:11:06 INFO - Successfully installed jsonschema functools32 14:11:06 INFO - Cleaning up... 14:11:06 INFO - Return code: 0 14:11:06 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:11:06 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')]} 14:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:06 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')]} 14:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f45b6d33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f89630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201a840>, '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 0x1f876b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f87b60>, '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': '14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803', '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 14:11:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 14:11:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:11:06 INFO - Using env: {'DISPLAY': ':0', 14:11:06 INFO - 'HOME': '/home/cltbld', 14:11:06 INFO - 'LANG': 'en_US.UTF-8', 14:11:06 INFO - 'LANGUAGE': 'en_US:en', 14:11:06 INFO - 'LOGNAME': 'cltbld', 14:11:06 INFO - 'MAIL': '/var/mail/cltbld', 14:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:06 INFO - 'MOZ_NO_REMOTE': '1', 14:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:06 INFO - 'NO_EM_RESTART': '1', 14:11:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:11:06 INFO - 'PWD': '/builds/slave/test-pgo', 14:11:06 INFO - 'SHELL': '/bin/bash', 14:11:06 INFO - 'SHLVL': '1', 14:11:06 INFO - 'TERM': 'linux', 14:11:06 INFO - 'TMOUT': '86400', 14:11:06 INFO - 'USER': 'cltbld', 14:11:06 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803', 14:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:06 INFO - '_': '/tools/buildbot/bin/python'} 14:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:06 INFO - Downloading/unpacking flake8 14:11:06 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 14:11:06 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 14:11:06 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 14:11:06 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 14:11:06 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 14:11:06 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 14:11:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:11:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 14:11:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:11:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 14:11:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 14:11:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:11:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:11:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:11:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:11:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:11:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:11:08 INFO - no previously-included directories found matching 'docs/_build' 14:11:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:11:08 INFO - Running setup.py install for pep8 14:11:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:11:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:11:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:11:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:11:08 INFO - no previously-included directories found matching 'docs/_build' 14:11:08 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:11:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:11:09 INFO - Cleaning up... 14:11:09 INFO - Return code: 0 14:11:09 INFO - Running post-action listener: _resource_record_post_action 14:11:09 INFO - Running post-action listener: _start_resource_monitoring 14:11:09 INFO - Starting resource monitoring. 14:11:09 INFO - ##### 14:11:09 INFO - ##### Running install step. 14:11:09 INFO - ##### 14:11:09 INFO - Running pre-action listener: _resource_record_pre_action 14:11:09 INFO - Running main action method: install 14:11:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:11:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:11:09 INFO - Reading from file tmpfile_stdout 14:11:09 INFO - Detecting whether we're running mozinstall >=1.0... 14:11:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:11:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:11:09 INFO - Reading from file tmpfile_stdout 14:11:09 INFO - Output received: 14:11:09 INFO - Usage: mozinstall [options] installer 14:11:09 INFO - Options: 14:11:09 INFO - -h, --help show this help message and exit 14:11:09 INFO - -d DEST, --destination=DEST 14:11:09 INFO - Directory to install application into. [default: 14:11:09 INFO - "/builds/slave/test-pgo"] 14:11:09 INFO - --app=APP Application being installed. [default: firefox] 14:11:09 INFO - mkdir: /builds/slave/test-pgo/build/application 14:11:09 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'] 14:11:09 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 14:11:25 INFO - Reading from file tmpfile_stdout 14:11:25 INFO - Output received: 14:11:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:11:25 INFO - Running post-action listener: _resource_record_post_action 14:11:25 INFO - ##### 14:11:25 INFO - ##### Running run-tests step. 14:11:25 INFO - ##### 14:11:25 INFO - Running pre-action listener: _resource_record_pre_action 14:11:25 INFO - Running main action method: run_tests 14:11:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:11:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:11:25 INFO - Python 2.7.3 14:11:25 INFO - Return code: 0 14:11:25 INFO - grabbing minidump binary from tooltool 14:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:25 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 0x201a840>, '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 0x1f876b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f87b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:11:25 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 14:11:25 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 14:11:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:11:25 INFO - Return code: 0 14:11:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:11:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:11:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:11:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:11:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:11:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:11:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:11:26 INFO - Return code: 0 14:11:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D-UK3LkBTxeScJaHIDNJSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 14:11:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D-UK3LkBTxeScJaHIDNJSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 14:11:26 INFO - Using env: {'DISPLAY': ':0', 14:11:26 INFO - 'HOME': '/home/cltbld', 14:11:26 INFO - 'LANG': 'en_US.UTF-8', 14:11:26 INFO - 'LANGUAGE': 'en_US:en', 14:11:26 INFO - 'LOGNAME': 'cltbld', 14:11:26 INFO - 'MAIL': '/var/mail/cltbld', 14:11:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:11:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:26 INFO - 'MOZ_NO_REMOTE': '1', 14:11:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:26 INFO - 'NO_EM_RESTART': '1', 14:11:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:11:26 INFO - 'PWD': '/builds/slave/test-pgo', 14:11:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:11:26 INFO - 'SHELL': '/bin/bash', 14:11:26 INFO - 'SHLVL': '1', 14:11:26 INFO - 'TERM': 'linux', 14:11:26 INFO - 'TMOUT': '86400', 14:11:26 INFO - 'USER': 'cltbld', 14:11:26 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803', 14:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:26 INFO - '_': '/tools/buildbot/bin/python'} 14:11:26 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D-UK3LkBTxeScJaHIDNJSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:11:26 INFO - mozversion application_buildid: 20160104113010 14:11:26 INFO - mozversion application_changeset: e2dc2bcbefb8181a48980d1af4809f3ca2368bef 14:11:26 INFO - mozversion application_display_name: Nightly 14:11:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:11:26 INFO - mozversion application_name: Firefox 14:11:26 INFO - mozversion application_remotingname: firefox 14:11:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 14:11:26 INFO - mozversion application_vendor: Mozilla 14:11:26 INFO - mozversion application_version: 46.0a1 14:11:26 INFO - mozversion platform_buildid: 20160104113010 14:11:26 INFO - mozversion platform_changeset: e2dc2bcbefb8181a48980d1af4809f3ca2368bef 14:11:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 14:11:26 INFO - mozversion platform_version: 46.0a1 14:11:26 INFO - using testdate: 1451945486 14:11:26 INFO - actual date: 1451945486 14:11:26 INFO - starting webserver on 'localhost:42332' 14:11:26 INFO - SUITE-START | Running 3 tests 14:11:26 INFO - TEST-START | dromaeo_css 14:11:26 INFO - operating with platform_type : linux_ 14:11:26 INFO - Initialising browser for dromaeo_css test... 14:11:26 INFO - TEST-INFO | started process 5451 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpB3GN4E/profile http://localhost:42332/getInfo.html) 14:11:30 INFO - PROCESS | 5451 | __metrics Screen width/height:1600/1200 14:11:30 INFO - PROCESS | 5451 | colorDepth:24 14:11:30 INFO - PROCESS | 5451 | Browser inner width/height: 1024/697 14:11:30 INFO - PROCESS | 5451 | __metrics 14:11:30 INFO - PROCESS | 5451 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:11:30 INFO - PROCESS | 5451 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:11:31 INFO - TEST-INFO | 5451: exit 0 14:11:31 INFO - Browser initialized. 14:11:31 INFO - Running cycle 1/1 for dromaeo_css test... 14:11:31 INFO - TEST-INFO | started process 5546 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpB3GN4E/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:11:43 INFO - PROCESS | 5546 | RSS: Main: 150523904 14:11:43 INFO - PROCESS | 5546 | 14:12:35 INFO - PROCESS | 5546 | 1451945555343 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] 14:14:44 INFO - PROCESS | 5546 | Cycle 1(1): loaded http://localhost:42332/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42332/tests/dromaeo/cssquery-ext.html) 14:14:45 INFO - PROCESS | 5546 | RSS: Main: 269471744 14:14:45 INFO - PROCESS | 5546 | 14:17:47 INFO - PROCESS | 5546 | Cycle 1(1): loaded http://localhost:42332/tests/dromaeo/cssquery-ext.html (next: http://localhost:42332/tests/dromaeo/cssquery-jquery.html) 14:17:48 INFO - PROCESS | 5546 | RSS: Main: 235290624 14:17:48 INFO - PROCESS | 5546 | 14:20:50 INFO - PROCESS | 5546 | Cycle 1(1): loaded http://localhost:42332/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42332/tests/dromaeo/cssquery-mootools.html) 14:20:50 INFO - PROCESS | 5546 | RSS: Main: 226402304 14:20:50 INFO - PROCESS | 5546 | 14:23:52 INFO - PROCESS | 5546 | Cycle 1(1): loaded http://localhost:42332/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42332/tests/dromaeo/cssquery-prototype.html) 14:23:53 INFO - PROCESS | 5546 | RSS: Main: 214323200 14:23:53 INFO - PROCESS | 5546 | 14:26:55 INFO - PROCESS | 5546 | Cycle 1(1): loaded http://localhost:42332/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42332/tests/dromaeo/cssquery-yui.html) 14:26:56 INFO - PROCESS | 5546 | RSS: Main: 217636864 14:26:56 INFO - PROCESS | 5546 | 14:29:58 INFO - PROCESS | 5546 | Cycle 1(1): loaded http://localhost:42332/tests/dromaeo/cssquery-yui.html (next: http://localhost:42332/tests/dromaeo/cssquery-dojo.html) 14:29:59 INFO - PROCESS | 5546 | RSS: Main: 275128320 14:29:59 INFO - PROCESS | 5546 | 14:29:59 INFO - PROCESS | 5546 | __start_tp_report 14:29:59 INFO - PROCESS | 5546 | _x_x_mozilla_page_load 14:29:59 INFO - PROCESS | 5546 | _x_x_mozilla_page_load_details 14:29:59 INFO - PROCESS | 5546 | |i|pagename|runs| 14:29:59 INFO - PROCESS | 5546 | |0;dojo.html;3124.45322068638;3140.932083091748;3189.2824114574223;3217.774755767096;3248.496483045129;5094.210397388401;5150.3047088643025;5168.457311982244;5205.401378841434;5273.024490469256;5216.9478305216935;5241.8951620967555;5324.094903866342;5347.786088556453;5347.839564813052;4604.1252162089095;4694.248920172773;4711.199096153654;4793.3768610080815;4904.06822703687;4646.395968524087;4837.588804951566;4867.561919427251;4903.8774030649165;4926.852194434155;4793.32893394925;4794.49657785931;4891.388576427947;4899.363082799213;4920.212765957465;4815.614750819961;4823.710577365334;4824.228123500223;4833;4865.732384718839;4767.737774422405;4799.760011999386;4807;4843.0313937212695;4884.755762211875;5009.44896061433;5032.4212715537815;5099.617528685327;5106.489351064901;5118.744062796883;5621.156826476062;5664.037113690682;5665.5467562594895;5671.886562268773;5678.063119585264;5682.971585142048;5691.971540142273;5696.145578163268;5701.230333904911;5728;5212.765425555859;5214.634975551751;5319.521243088063;5341.545968592635;5344.0915044442145;5786.971065144648;5824.242848429677;5824.388439213906;5836.2412886325355;5852.941470585325;5606.411326810708;5607.915881261784;5623.268975033301;5625.128105143709;5637.23897273871;5402.135658294654;5548.250986116904;5600.747966341524;5602.411746766612;5631.662100273997;5613.775448982076;5623.8594035149445;5632.690202038845;5634.802781902614;5644.633098848643;5594.049011668027;5615.494605485526;5619.719014049281;5627.915581266284;5630.042892708249;4290.957090429056;4381.364702118175;4393.209222339946;4425.955740442619;4458.041521072985;3937.645611894943;3947.5657677655436;3950.3284441644414;3973.960260397359;3980.86066987654;5278.366596008504;5281.15501519755;5289.523942845162;5291.444398338119;5325.4940780625775;5560.36055853582;5588.552915766729;5663.405342439067;5663.971680141655;5723.055695810144;5260.342457192851;5292.2326262691695;5293.391260005072;5304.761285742151;5305.098133317345;4839;4866.853994380103;4886.780094895738;4886.92669609949;4933.753312334369;5668.0647693130995;5722.027255366681;5735.1684005818925;5777.104548794943;5850.912236316373;5619.213310136666;5620.325560932714;5625.353084395347;5629.605927585029;5631.2960879890015;5742.59801813869;5789.710514474344;5799.797007104731;5811.302643682616;5812.9709351452975;5433.538149257357;5523.171524271392;5531.529819965348;5551.444855514416;5648.039833228278;5605.691686957257;5635.605507614591;5641.9435805641415;5647.491725744702;5660.688662123623;5478.726063696719;5507;5521.3926468087675;5523.8895222096135;5525.889482210253;5299.44355842631;5344.599155063308;5432.2123292123215;5517.034518959246;5540.7783688652;5362.839114826562;5365.812196573102;5376.677399356051;5384.273123128328;5386.165144402624;5287.814926477555;5488.7530061148145;5488.982606742631;5514.145307477347;5558.082916318762;5382.085045542189;5410.161424979135;5455.045367060669;5483.616146869681;5527.695976721319 14:29:59 INFO - PROCESS | 5546 | |1;ext.html;522.0707141288506;523.0297797585479;524.6222719641856;547.6659237864902;552.9060059789836;27475.587866182;28305.433891322187;36158.27683446329;36757;36765.448518272184;39620.60379396205;39720.20559588807;40081.799591002;40175.196496070064;40194;8425.452345597547;8504.192101750325;8507.766373875784;8513.446625969293;8562.058173600899;7456.925430745704;7644.694212231504;10103.494825258744;10277.383356998567;10291.125254353352;10018.098371146596;10109.342892711988;10111;10113.747156321077;10115.393076415401;7423.851522969564;7620.314171724572;9940.90059099407;10014.999999999964;10094.242931780072;7337.3763230125505;10074.848877266846;10286.639967601173;10293.845592316122;10297.639582614647;31487.212819679462;31772.364552708816;31784.841075794706;31801.840990795128;31813.52279715806;3123.765717571191;3249.5775549178693;3426.2633533790104;3500.894973150784;3706.1846393793594;27619.447611047868;27729;27793.305167370774;28078.438431231465;28393.148205553865;3826.693864490834;3835.673967712748;3864.420336949452;3892.630200130983;4035.112275299459;263407;264012;265259;266043;266724;52558.73720631372;53081.73459132679;58244;58726;58773;68452.657736711;69269;69348;69541;69628;12580.308083055337;12713.682157946125;12728.80906786399;12736.23582585048;12751;11424.543018279343;11550.364729939934;11558.537658493735;11559.537618495335;11573.958343749104;19272.743603946157;19908.800911990984;19920.800791991893;19940.3020894268;19999.700004499944;7724.686803243462;7784.455088143775;7902.525848449111;7942.801429964297;7946.205379462123;856.6444925356033;955.345588272022;1002.9699109026595;1022.325265324882;1056.144522936424;28613.57079643807;28646.570301445496;28671.705724356372;28860.134195974155;29092.236237557398;1030.2479190191202;1031.5718976624767;1036.7097212780434;1041.4844651897358;1098.522142867855;14944.626384340261;14949.476768313058;15005.849941500664;15194.240287985778;15276.923615382075;304473;309686;311077;311152;311584;51419.228711569354;51965.22052169221;51969;52088.739556301975;52125.7393713029;1282.1025282302426;1284.1588759362446;1290.1613950931783;1290.741851629659;1303.9332657737402;27137.321566960985;28206.294842629097;28408.85795571009;30219;31099.533506996962;49475;50333.49666503288;50414.2437863425;50492.49507505025;50497.747511262205;277806;281722;296389;413636;425377;34249.315013700085;35131.47302790409;35188.64811351854;35348;35664;43328.350074748276;44251.778741106085;44396.55603444053;44509.77745111254;44708.77645611751;37418.62581374151;37420.25159496849;38244.426333605574;39003.60996390113;39645;37577.81211093927;38364.849054527294;38777.806110969264;38999.415008774326;39304.606953930095;33315.500267495525;38247.80876095602;38694.6130538691;38758.61241387663;38864.80567597144;27776.888924442796;30841.537376939814;31072.68927310698;31121.68878311188;31215.531767023967;24621;24733;24759.62860557057;25090.37274068163;25227.74772252254 14:29:59 INFO - PROCESS | 5546 | |2;jquery.html;354.5196259068961;354.75876404045255;356.662953508934;356.8697425439714;357.47272772660347;14139.575812725609;14544.345504452298;15924.601884952883;16340.264688089035;17255.654886902255;14499.5650130496;14588.343524541395;14590.343434545444;15510.991785533932;16218.675626487464;4990.1516742153735;5140.8971820563565;5142.588592912577;5149.098907691157;5181.481851814817;3754.793486358249;3880.592537783534;4243.978780106095;5298.125809241471;5466.508014278734;5398.78404863805;5404.189371594253;5409.918851217235;5428.185772134192;5439.972800135994;5271.130263506517;5274.472552744734;5298.867528311785;5322.361316641989;5331.866703332428;5152.407473140599;5153.742312884378;5169.715665638389;5178.637495375326;5181.300524429229;12363.567275145417;12722.236665799988;12738.044646651539;12742.171758835739;14644.97485176038;2101.338078505266;2108.536122053146;2118.226847200776;2120.989395053015;2304.781045800646;9240.353175277733;9488.620455181785;9710.271729620235;12402.379881006003;12797.104202705814;1760;1791.7491551182845;1827.6344731053841;1830.7528483654803;1858.6933156029238;61271.69364153151;64666.67666661683;64830;65261.67369163124;65460.345396545905;9353.579088941015;9597.088276613711;9896.901030989742;9940.80118397628;9962.551685174185;12823.230606163661;12838.48646054166;12840.55058072963;12852.164609300366;12857.807132893015;6764.695588698422;6864.485163612749;6892.448604111759;6928.896066559006;6929.41100006495;6388.7125079371535;6411.935880641134;6434.292227854932;6450.580712253689;6493.5454518184215;4170;4213.599708027732;4246;4260.914781704349;4303.849365272201;1691.0952640337362;1708.265445858268;1723.612187257857;1728.9308427662752;1822.662807380639;393.8030984507746;804.6057431858347;850.2008112374348;910.2399496420563;943.6697155995347;9542;10321.63874264397;10482.318649287772;10627.256092073636;10856.674299771019;422.4782393743724;434.8217230935301;436.4958472963732;882.8940527136656;905.7192270396198;8645.783855403664;9034.412763170372;9055.732197492356;9124.315676324302;9172.816543669089;393241;397814;399160;414339;491773;79305.60347198343;79971.20028799753;81246.59376703079;81747.59126204331;82587.58706206431;1086.2124959404368;1093.294824837991;1103.0734183285917;1116.542217690743;1120.960766373173;13542.729145417234;14694;16303.836961630232;16355.754663679816;16675.33298668088;32840.67159328376;34146.31707365889;34778;35865.46201807027;36398.09004774902;39547.604523955546;41751.791241043604;41999.58000419957;44788;45012;9646.662366817127;9784;9794.65718699842;9802.803943921224;9902.653407130716;17717.379891703727;17890.194941227935;18284.268629254682;18646.254149834396;18812.52968675794;11517.712057198301;11816.113791465503;13755.449782009007;14445.422183112558;14677.779833302722;13846.238456884565;14027.56324700455;14063.367148478139;14179.787303190255;14465.204413757345;12277.938610306892;12330.445129969352;13189.670258243621;14184.858151418353;14468.421263149356;9505.714828555154;9787;9817.607295708092;12716.554920577735;13238.669033274246;15531.767023494882;15736.370545178064;15970.520884373487;16512.091834949195;16660.58348541296 14:29:59 INFO - PROCESS | 5546 | |3;mootools.html;1190.9464074116663;1333.3133436280314;1374.7456720506705;1456;1731.705610046292;6501.642409667473;7145.606991615459;7299.744508942182;7310.086239220098;7311.670974806133;7102.360787529121;7276.599787011713;7287.781366558998;7296.087989001375;7297.854042919138;2175.1408193763455;2208.1719355241785;2215.7673444288357;2216.0249490224332;2217.434554188688;2182.9235976740815;2215.102883332253;2243.955120897581;2245.2253972379503;2246.7753224677485;2187.136081247906;2191.5726433345503;2233.6761169630395;2234.519578290667;2240.977590224093;2172.576347612216;2172.7935846094597;2192.7587965323883;2195.1658369819525;2197.4726065744267;2234.6089434348924;2255.515064261175;2256.638937769949;2257.164849005862;2258.3450799268194;7353.338199562012;7415.851682966364;7426.665800039012;7433.256674332523;7441;4442.666799990014;4478.57453541913;4502;4502.392177056088;4510.774461276956;2862.842543660098;3051.1304278280804;3055.052933590594;3072.554479600468;3076.4769989101683;909.0182602788972;914.1909410171979;925.8379783537854;953.4851180362596;984.0503913723292;9969.850452243221;9984.95007524965;9994.10053095225;9998.200143988464;9999.500024998793;4054.2094291612852;4089.26393249218;4097.180563887235;4120.814563344657;4174.686898482626;8561.82876342482;8567.74296771098;8589.52757598338;8605.827883442296;8615.784605384915;4524.321351797191;4533.9319910201375;4546.659000574904;4560.3843481129625;4562.110388474282;3718;3741.0460332615007;4036.6770658347264;4161.646260067928;4170.895727606834;3458.9654103458643;3483.6516348365467;3488.7906725596545;3508.614052454228;3513.4554144107706;1127.9097672186206;1140.5551834784442;1141.4920360439692;1146.6297774159966;1151.5393842463081;1268.9175203611735;1270.3775150176348;1290.1871820752865;1293.9158954668105;1296.863829297929;6864.965675171592;6932.7226910923;6990;7071.787846364515;7076.893846592306;1083.1497274639528;1083.4203701019917;1086.788076325109;1092.470151976291;1113.9443027848574;5514.696691681916;5568.832935011957;5569.331680198402;5570.805021824217;5583.692896890629;8375.874361884577;8411.579421028924;8569.657213711382;8626.78433039179;8676.392652514389;8689.17452841979;8817.603207855662;8820.955895220482;8824.735257942271;8835.646574136963;6722.563033402813;6860.862782744317;6883.1396075489565;6896.27589103137;6936.826579335557;6789.11741473625;6853.109095817512;6867.141607299088;6869.416099631588;6870.828229294308;7505.624718764149;7746.264104910025;7812.765617031499;7874.409419293462;7877.6455059523605;7747.147813740371;7918.9208107920485;7970.681172753025;7981.321587665114;8029.197080291924;5713.885722285614;5778.711064446677;6402.327755585597;6579.342065793382;6711.597304161766;6913.585184888721;6932.826679333057;6938.653067346511;6954.165500139813;6959.8956015660815;6391.2330520337855;6470.741170353322;6477.546571739933;6489.3510648934725;6553.311902250386;6386.872262554816;6457.838554036187;6472.935270647234;6509.088727578238;6577.769778057745;6487.091807146909;6502.837429064311;6518.771842985473;6520.706568204537;6524.575902566318;6112.32764395925;6154.353792851686;6184.134221208944;6211.875762484635;6221.253449586078;6301;6341.302456729663;6341.460975817107;6344.302126766144;6365.586236894587 14:29:59 INFO - PROCESS | 5546 | |4;prototype.html;325.2016299983539;331.8423748719359;335.3059167523228;339.97110245629113;342.75493022488916;5647.181158731992;5786.913196302048;5844.422006058367;5857.26784151981;5863.648181109136;5656.406077361879;5797.043487824514;5804.796832110877;5845.327787304462;5846.093855452412;4524;4554.635629149669;4555;4555.521670224628;4564.109998550284;4319.546447623002;4414;4447.132809102226;4551.180787458256;4552.658550608701;4484.282514797633;4486.484054333744;4486.506484286726;4492.640588752892;4516.322551617251;4469.843555475575;4481.350204220386;4504.707194032378;4506.7070640408265;4507.422402159251;4007.2586571484076;4013.418054382098;4017.0760725033115;4031.9395209071595;4036.1322315702264;5438.755256013489;5539.058360078796;5551.139573366135;5585.692786896719;5609.1305847593685;5232.1628539433505;5246.711430871301;5280.075986702312;5283.260343551868;5284.894302113975;5904.084866845646;6189.288231853349;6190.690465476709;6195.31851496335;6202.162708034402;4305.74165550068;4322.697411181219;4424.889377765581;4425.380446737459;4427.535108813592;6296.433321001086;6446.161998940154;6453.2256129264315;6453.967365221542;6459.677016149174;4490.079533695584;4506.797194126272;4518.570735780096;4519.231730605805;4523.932141017887;4505.7521836298665;4588;4588.220002599566;4605.562471565196;4619.122366750306;5202.401723801736;5212;5215.322008138917;5217.7912883485;5219.321488206585;6196.318404975449;6200.038993955944;6200.534959878028;6207.410296021871;6209.068639704081;1611.8791090668246;1628.552148159242;1630.1767607358208;1632.7632493288406;1634.5586691593203;1107.4905543450104;1115.9330440173615;1116.0569318925657;1119.356370087203;1140.6749076513154;5870.7945221917025;5873.236479257669;5874.060150375919;5878.2358293421585;5878.441548052928;6332.95506241465;6335.271443784024;6344.080108384351;6344.143540621957;6350.841228969312;5766.8269951900675;5768.855778605568;5781;5782.88434231313;5783.88432231353;3315.353506066294;3423.5207071010077;3426.0578340956436;3427.9143021424666;3430.142464383904;6591.274959754423;6592.80221593353;6597.373249541286;6605.009248612747;6605.405513503808;6462.547621666532;6464.22429308486;6466.159399278158;6468.029795530708;6471.2234531856475;6426.710798014101;6576.177977752781;6583.893154190709;6595.340465953366;6679.632620205935;6165.537584681257;6285.277193122849;6381.234251889803;6393.808185754435;6403.871922561616;6167.814965551041;6275.403836635513;6286.654234017173;6311.147995020613;6326.778562750282;6585.176852893388;6618.338166183343;6633.834154146185;6642.169728783902;6642.5018123641885;4249.532551419279;4382.912341753084;4426.203283409017;4430;4436.0240747035605;6325.240971083499;6361.173047503795;6373.808785736435;6385.265694445198;6393.776217832354;6191.288001879841;6198.907016394848;6210.906836397367;6213.409726076015;6217.502599792097;6035.849103772441;6184;6188.659623720739;6197.566170368031;6199.16311297969;6091.390860914051;6151.384861513813;6154.107654390178;6156.569040167145;6159.476444502267;6274.341194174546;6278.529110316653;6287.46556542699;6288.937110628835;6289.96855015722;5956.583039187215;6084.209052823105;6130.417610327012;6140.969295153495;6141.263048434216 14:29:59 INFO - PROCESS | 5546 | |5;yui.html;653.5457856789527;687.9174499060114;732.6007326007325;782.4092809928507;809.2433574607742;15265.542033738991;15458.690826183469;15543.611409714762;15564.533064008083;15578;12247.877521224786;12267.693307667312;12278.877211227886;12307.07696922732;12321;672.5057083043959;679.6533767778444;799.6081919859271;816.3142959913671;818.5293456262673;788.0818846044351;808.7169490678245;811.4441607498882;813.8860559521672;814.4176913506841;848.0586548930683;848.4612271207797;850.9829803403928;851.974440766778;853.5476197615274;698.3261152987366;705.3193668110247;824.282873899711;842.0695131879246;843.6035063520136;617.213053356969;620.1380081686459;620.6245221640933;621.0559948877726;622.1290193728771;13742.93128534351;13782;13823.585292441143;13926.651833704138;13936.860631393658;11149.554017839277;11411.600593979254;11614.825777613258;11765.529378824836;12451.813222801666;9913.959034301439;9954.502274886227;10174.186065114773;10221.64224252155;10359.067683908484;3498.8425520851624;3551.875684351061;3552.2540266544056;3558.131558409907;3573.1424458129864;48077;48709.75645121787;48857.755711221216;48859.755701221264;49002.26496602554;8521.701740439055;9041.638334466548;9186.494742789211;9224;9302.302327325478;15430.768538471932;15462.9226853865;15479.922600386926;15480.845191548166;15508.224588770516;6839.179298484214;6854.383105520427;6949.89575156373;7095.254998225112;7149.213586505481;4111.116110036297;4132.690048246333;4206;4217.1776503581505;4222.176675548239;2866.5986761853355;2898.594196812448;2899;2899.9710002900124;2902.6516817981556;498.3795175007139;503.5141088849278;510.03094121169335;511.76203065574686;519.6414474012919;497.9128652485873;538.2948337677655;559.4571486465744;579.1746760865749;602.0457574743992;8255.711050113217;8286.295664868434;8414.032386275656;8431.28334091609;8501.362397820189;561.7584438691401;564.9180868774087;591.6006695480534;591.9674417907056;644.7331933605349;3849.412421382065;3852.325842977468;3877.689784817208;3975.2447035063246;4147.709660323809;54007.18989215165;54037.72981135069;54132.188017179775;54401;54494.727526362905;50760.74619626878;50792;51153.23270150951;51196.74401628043;51219.48780512147;45067.999999999345;45100;46346.5365346349;47411;47572.5242747575;7972;8000.719974800854;8179.509229446252;8553.700620478254;8787.472751634923;33402.16494587558;33423.33153336968;33743.49384759182;33952.83023584866;34262;39875;40663.18673626452;41476.1704765909;42102.578974209864;42531.36202956896;10154.136898363722;10923.180761442765;11001.504932278227;11016.724581885517;11490.425478726198;11289.774204516028;11482.827757583476;11556.768864622492;11676.94161529187;11699.356535390636;10552.731162800035;10589.788204236027;11017.779644407226;11295;11490.080793536665;10848.891511084788;11011.119110471303;11194.048505876766;11273.154513411362;11540.82688759686;10720.303180293567;10879;11084.833727494255;11279.041281490838;11418.828717569077;8843.204111629984;8901.376903616685;9009.54952252398;9108.681196158368;9179.44923304577;8614.396992210735;8729.388942773945;9012.63949442015;9116.4074335168;9147.679831206142 14:29:59 INFO - PROCESS | 5546 | __end_tp_report 14:29:59 INFO - PROCESS | 5546 | __start_cc_report 14:29:59 INFO - PROCESS | 5546 | _x_x_mozilla_cycle_collect,940 14:29:59 INFO - PROCESS | 5546 | __end_cc_report 14:29:59 INFO - PROCESS | 5546 | __startTimestamp1451946599185__endTimestamp 14:29:59 INFO - PROCESS | 5546 | 14:29:59 INFO - PROCESS | 5546 | ------- Summary: start ------- 14:29:59 INFO - PROCESS | 5546 | Number of tests: 6 14:29:59 INFO - PROCESS | 5546 | 14:29:59 INFO - PROCESS | 5546 | [#0] dojo.html Cycles:165 Average:5234.81 Median:5384.27 stddev:561.98 (10.4%) stddev-sans-first:538.77 14:29:59 INFO - PROCESS | 5546 | Values: 3124.5 3140.9 3189.3 3217.8 3248.5 5094.2 5150.3 5168.5 5205.4 5273.0 5216.9 5241.9 5324.1 5347.8 5347.8 4604.1 4694.2 4711.2 4793.4 4904.1 4646.4 4837.6 4867.6 4903.9 4926.9 4793.3 4794.5 4891.4 4899.4 4920.2 4815.6 4823.7 4824.2 4833.0 4865.7 4767.7 4799.8 4807.0 4843.0 4884.8 5009.4 5032.4 5099.6 5106.5 5118.7 5621.2 5664.0 5665.5 5671.9 5678.1 5683.0 5692.0 5696.1 5701.2 5728.0 5212.8 5214.6 5319.5 5341.5 5344.1 5787.0 5824.2 5824.4 5836.2 5852.9 5606.4 5607.9 5623.3 5625.1 5637.2 5402.1 5548.3 5600.7 5602.4 5631.7 5613.8 5623.9 5632.7 5634.8 5644.6 5594.0 5615.5 5619.7 5627.9 5630.0 4291.0 4381.4 4393.2 4426.0 4458.0 3937.6 3947.6 3950.3 3974.0 3980.9 5278.4 5281.2 5289.5 5291.4 5325.5 5560.4 5588.6 5663.4 5664.0 5723.1 5260.3 5292.2 5293.4 5304.8 5305.1 4839.0 4866.9 4886.8 4886.9 4933.8 5668.1 5722.0 5735.2 5777.1 5850.9 5619.2 5620.3 5625.4 5629.6 5631.3 5742.6 5789.7 5799.8 5811.3 5813.0 5433.5 5523.2 5531.5 5551.4 5648.0 5605.7 5635.6 5641.9 5647.5 5660.7 5478.7 5507.0 5521.4 5523.9 5525.9 5299.4 5344.6 5432.2 5517.0 5540.8 5362.8 5365.8 5376.7 5384.3 5386.2 5287.8 5488.8 5489.0 5514.1 5558.1 5382.1 5410.2 5455.0 5483.6 5527.7 14:29:59 INFO - PROCESS | 5546 | 14:29:59 INFO - PROCESS | 5546 | [#1] ext.html Cycles:180 Average:47376.95 Median:31793.34 stddev:80938.64 (254.6%) stddev-sans-first:81089.24 14:29:59 INFO - PROCESS | 5546 | Values: 522.1 523.0 524.6 547.7 552.9 27475.6 28305.4 36158.3 36757.0 36765.4 39620.6 39720.2 40081.8 40175.2 40194.0 8425.5 8504.2 8507.8 8513.4 8562.1 7456.9 7644.7 10103.5 10277.4 10291.1 10018.1 10109.3 10111.0 10113.7 10115.4 7423.9 7620.3 9940.9 10015.0 10094.2 7337.4 10074.8 10286.6 10293.8 10297.6 31487.2 31772.4 31784.8 31801.8 31813.5 3123.8 3249.6 3426.3 3500.9 3706.2 27619.4 27729.0 27793.3 28078.4 28393.1 3826.7 3835.7 3864.4 3892.6 4035.1 263407.0 264012.0 265259.0 266043.0 266724.0 52558.7 53081.7 58244.0 58726.0 58773.0 68452.7 69269.0 69348.0 69541.0 69628.0 12580.3 12713.7 12728.8 12736.2 12751.0 11424.5 11550.4 11558.5 11559.5 11574.0 19272.7 19908.8 19920.8 19940.3 19999.7 7724.7 7784.5 7902.5 7942.8 7946.2 856.6 955.3 1003.0 1022.3 1056.1 28613.6 28646.6 28671.7 28860.1 29092.2 1030.2 1031.6 1036.7 1041.5 1098.5 14944.6 14949.5 15005.8 15194.2 15276.9 304473.0 309686.0 311077.0 311152.0 311584.0 51419.2 51965.2 51969.0 52088.7 52125.7 1282.1 1284.2 1290.2 1290.7 1303.9 27137.3 28206.3 28408.9 30219.0 31099.5 49475.0 50333.5 50414.2 50492.5 50497.7 277806.0 281722.0 296389.0 413636.0 425377.0 34249.3 35131.5 35188.6 35348.0 35664.0 43328.4 44251.8 44396.6 44509.8 44708.8 37418.6 37420.3 38244.4 39003.6 39645.0 37577.8 38364.8 38777.8 38999.4 39304.6 33315.5 38247.8 38694.6 38758.6 38864.8 27776.9 30841.5 31072.7 31121.7 31215.5 24621.0 24733.0 24759.6 25090.4 25227.7 14:29:59 INFO - PROCESS | 5546 | 14:29:59 INFO - PROCESS | 5546 | [#2] jquery.html Cycles:180 Average:25038.15 Median:196817.40 stddev:69188.92 (35.2%) stddev-sans-first:69358.19 14:29:59 INFO - PROCESS | 5546 | Values: 354.5 354.8 356.7 356.9 357.5 14139.6 14544.3 15924.6 16340.3 17255.7 14499.6 14588.3 14590.3 15511.0 16218.7 4990.2 5140.9 5142.6 5149.1 5181.5 3754.8 3880.6 4244.0 5298.1 5466.5 5398.8 5404.2 5409.9 5428.2 5440.0 5271.1 5274.5 5298.9 5322.4 5331.9 5152.4 5153.7 5169.7 5178.6 5181.3 12363.6 12722.2 12738.0 12742.2 14645.0 2101.3 2108.5 2118.2 2121.0 2304.8 9240.4 9488.6 9710.3 12402.4 12797.1 1760.0 1791.7 1827.6 1830.8 1858.7 61271.7 64666.7 64830.0 65261.7 65460.3 9353.6 9597.1 9896.9 9940.8 9962.6 12823.2 12838.5 12840.6 12852.2 12857.8 6764.7 6864.5 6892.4 6928.9 6929.4 6388.7 6411.9 6434.3 6450.6 6493.5 4170.0 4213.6 4246.0 4260.9 4303.8 1691.1 1708.3 1723.6 1728.9 1822.7 393.8 804.6 850.2 910.2 943.7 9542.0 10321.6 10482.3 10627.3 10856.7 422.5 434.8 436.5 882.9 905.7 8645.8 9034.4 9055.7 9124.3 9172.8 393241.0 397814.0 399160.0 414339.0 491773.0 79305.6 79971.2 81246.6 81747.6 82587.6 1086.2 1093.3 1103.1 1116.5 1121.0 13542.7 14694.0 16303.8 16355.8 16675.3 32840.7 34146.3 34778.0 35865.5 36398.1 39547.6 41751.8 41999.6 44788.0 45012.0 9646.7 9784.0 9794.7 9802.8 9902.7 17717.4 17890.2 18284.3 18646.3 18812.5 11517.7 11816.1 13755.4 14445.4 14677.8 13846.2 14027.6 14063.4 14179.8 14465.2 12277.9 12330.4 13189.7 14184.9 14468.4 9505.7 9787.0 9817.6 12716.6 13238.7 15531.8 15736.4 15970.5 16512.1 16660.6 14:29:59 INFO - PROCESS | 5546 | 14:29:59 INFO - PROCESS | 5546 | [#3] mootools.html Cycles:180 Average:5149.47 Median:6354.94 stddev:2603.60 (41.0%) stddev-sans-first:2593.89 14:29:59 INFO - PROCESS | 5546 | Values: 1190.9 1333.3 1374.7 1456.0 1731.7 6501.6 7145.6 7299.7 7310.1 7311.7 7102.4 7276.6 7287.8 7296.1 7297.9 2175.1 2208.2 2215.8 2216.0 2217.4 2182.9 2215.1 2244.0 2245.2 2246.8 2187.1 2191.6 2233.7 2234.5 2241.0 2172.6 2172.8 2192.8 2195.2 2197.5 2234.6 2255.5 2256.6 2257.2 2258.3 7353.3 7415.9 7426.7 7433.3 7441.0 4442.7 4478.6 4502.0 4502.4 4510.8 2862.8 3051.1 3055.1 3072.6 3076.5 909.0 914.2 925.8 953.5 984.1 9969.9 9985.0 9994.1 9998.2 9999.5 4054.2 4089.3 4097.2 4120.8 4174.7 8561.8 8567.7 8589.5 8605.8 8615.8 4524.3 4533.9 4546.7 4560.4 4562.1 3718.0 3741.0 4036.7 4161.6 4170.9 3459.0 3483.7 3488.8 3508.6 3513.5 1127.9 1140.6 1141.5 1146.6 1151.5 1268.9 1270.4 1290.2 1293.9 1296.9 6865.0 6932.7 6990.0 7071.8 7076.9 1083.1 1083.4 1086.8 1092.5 1113.9 5514.7 5568.8 5569.3 5570.8 5583.7 8375.9 8411.6 8569.7 8626.8 8676.4 8689.2 8817.6 8821.0 8824.7 8835.6 6722.6 6860.9 6883.1 6896.3 6936.8 6789.1 6853.1 6867.1 6869.4 6870.8 7505.6 7746.3 7812.8 7874.4 7877.6 7747.1 7918.9 7970.7 7981.3 8029.2 5713.9 5778.7 6402.3 6579.3 6711.6 6913.6 6932.8 6938.7 6954.2 6959.9 6391.2 6470.7 6477.5 6489.4 6553.3 6386.9 6457.8 6472.9 6509.1 6577.8 6487.1 6502.8 6518.8 6520.7 6524.6 6112.3 6154.4 6184.1 6211.9 6221.3 6301.0 6341.3 6341.5 6344.3 6365.6 14:29:59 INFO - PROCESS | 5546 | 14:29:59 INFO - PROCESS | 5546 | [#4] prototype.html Cycles:180 Average:5190.09 Median:5844.87 stddev:1534.32 (26.3%) stddev-sans-first:1494.54 14:29:59 INFO - PROCESS | 5546 | Values: 325.2 331.8 335.3 340.0 342.8 5647.2 5786.9 5844.4 5857.3 5863.6 5656.4 5797.0 5804.8 5845.3 5846.1 4524.0 4554.6 4555.0 4555.5 4564.1 4319.5 4414.0 4447.1 4551.2 4552.7 4484.3 4486.5 4486.5 4492.6 4516.3 4469.8 4481.4 4504.7 4506.7 4507.4 4007.3 4013.4 4017.1 4031.9 4036.1 5438.8 5539.1 5551.1 5585.7 5609.1 5232.2 5246.7 5280.1 5283.3 5284.9 5904.1 6189.3 6190.7 6195.3 6202.2 4305.7 4322.7 4424.9 4425.4 4427.5 6296.4 6446.2 6453.2 6454.0 6459.7 4490.1 4506.8 4518.6 4519.2 4523.9 4505.8 4588.0 4588.2 4605.6 4619.1 5202.4 5212.0 5215.3 5217.8 5219.3 6196.3 6200.0 6200.5 6207.4 6209.1 1611.9 1628.6 1630.2 1632.8 1634.6 1107.5 1115.9 1116.1 1119.4 1140.7 5870.8 5873.2 5874.1 5878.2 5878.4 6333.0 6335.3 6344.1 6344.1 6350.8 5766.8 5768.9 5781.0 5782.9 5783.9 3315.4 3423.5 3426.1 3427.9 3430.1 6591.3 6592.8 6597.4 6605.0 6605.4 6462.5 6464.2 6466.2 6468.0 6471.2 6426.7 6576.2 6583.9 6595.3 6679.6 6165.5 6285.3 6381.2 6393.8 6403.9 6167.8 6275.4 6286.7 6311.1 6326.8 6585.2 6618.3 6633.8 6642.2 6642.5 4249.5 4382.9 4426.2 4430.0 4436.0 6325.2 6361.2 6373.8 6385.3 6393.8 6191.3 6198.9 6210.9 6213.4 6217.5 6035.8 6184.0 6188.7 6197.6 6199.2 6091.4 6151.4 6154.1 6156.6 6159.5 6274.3 6278.5 6287.5 6288.9 6290.0 5956.6 6084.2 6130.4 6141.0 6141.3 14:29:59 INFO - PROCESS | 5546 | 14:29:59 INFO - PROCESS | 5546 | [#5] yui.html Cycles:180 Average:13369.87 Median:48858.76 stddev:15538.89 (31.8%) stddev-sans-first:15553.14 14:29:59 INFO - PROCESS | 5546 | Values: 653.5 687.9 732.6 782.4 809.2 15265.5 15458.7 15543.6 15564.5 15578.0 12247.9 12267.7 12278.9 12307.1 12321.0 672.5 679.7 799.6 816.3 818.5 788.1 808.7 811.4 813.9 814.4 848.1 848.5 851.0 852.0 853.5 698.3 705.3 824.3 842.1 843.6 617.2 620.1 620.6 621.1 622.1 13742.9 13782.0 13823.6 13926.7 13936.9 11149.6 11411.6 11614.8 11765.5 12451.8 9914.0 9954.5 10174.2 10221.6 10359.1 3498.8 3551.9 3552.3 3558.1 3573.1 48077.0 48709.8 48857.8 48859.8 49002.3 8521.7 9041.6 9186.5 9224.0 9302.3 15430.8 15462.9 15479.9 15480.8 15508.2 6839.2 6854.4 6949.9 7095.3 7149.2 4111.1 4132.7 4206.0 4217.2 4222.2 2866.6 2898.6 2899.0 2900.0 2902.7 498.4 503.5 510.0 511.8 519.6 497.9 538.3 559.5 579.2 602.0 8255.7 8286.3 8414.0 8431.3 8501.4 561.8 564.9 591.6 592.0 644.7 3849.4 3852.3 3877.7 3975.2 4147.7 54007.2 54037.7 54132.2 54401.0 54494.7 50760.7 50792.0 51153.2 51196.7 51219.5 45068.0 45100.0 46346.5 47411.0 47572.5 7972.0 8000.7 8179.5 8553.7 8787.5 33402.2 33423.3 33743.5 33952.8 34262.0 39875.0 40663.2 41476.2 42102.6 42531.4 10154.1 10923.2 11001.5 11016.7 11490.4 11289.8 11482.8 11556.8 11676.9 11699.4 10552.7 10589.8 11017.8 11295.0 11490.1 10848.9 11011.1 11194.0 11273.2 11540.8 10720.3 10879.0 11084.8 11279.0 11418.8 8843.2 8901.4 9009.5 9108.7 9179.4 8614.4 8729.4 9012.6 9116.4 9147.7 14:29:59 INFO - PROCESS | 5546 | -------- Summary: end -------- 14:29:59 INFO - PROCESS | 5546 | 14:29:59 INFO - TEST-INFO | 5546: exit 0 14:29:59 INFO - TEST-OK | dromaeo_css | took 1113414ms 14:29:59 INFO - TEST-START | kraken 14:29:59 INFO - operating with platform_type : linux_ 14:29:59 INFO - Initialising browser for kraken test... 14:29:59 INFO - TEST-INFO | started process 5736 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptwwh3n/profile http://localhost:42332/getInfo.html) 14:30:04 INFO - PROCESS | 5736 | __metrics Screen width/height:1600/1200 14:30:04 INFO - PROCESS | 5736 | colorDepth:24 14:30:04 INFO - PROCESS | 5736 | Browser inner width/height: 1024/697 14:30:04 INFO - PROCESS | 5736 | __metrics 14:30:04 INFO - PROCESS | 5736 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:30:04 INFO - PROCESS | 5736 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:30:05 INFO - TEST-INFO | 5736: exit 0 14:30:05 INFO - Browser initialized. 14:30:05 INFO - Running cycle 1/1 for kraken test... 14:30:05 INFO - TEST-INFO | started process 5819 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptwwh3n/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:30:17 INFO - PROCESS | 5819 | RSS: Main: 150122496 14:30:17 INFO - PROCESS | 5819 | 14:30:19 INFO - PROCESS | 5819 | Cycle 1(1): loaded http://localhost:42332/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42332/tests/kraken/driver.html?testName=audio-beat-detection) 14:30:20 INFO - PROCESS | 5819 | RSS: Main: 183488512 14:30:20 INFO - PROCESS | 5819 | 14:30:22 INFO - PROCESS | 5819 | Cycle 1(1): loaded http://localhost:42332/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42332/tests/kraken/driver.html?testName=audio-dft) 14:30:23 INFO - PROCESS | 5819 | RSS: Main: 173518848 14:30:23 INFO - PROCESS | 5819 | 14:30:26 INFO - PROCESS | 5819 | Cycle 1(1): loaded http://localhost:42332/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42332/tests/kraken/driver.html?testName=audio-fft) 14:30:26 INFO - PROCESS | 5819 | RSS: Main: 159129600 14:30:26 INFO - PROCESS | 5819 | 14:30:28 INFO - PROCESS | 5819 | Cycle 1(1): loaded http://localhost:42332/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42332/tests/kraken/driver.html?testName=audio-oscillator) 14:30:29 INFO - PROCESS | 5819 | RSS: Main: 163131392 14:30:29 INFO - PROCESS | 5819 | 14:30:31 INFO - PROCESS | 5819 | Cycle 1(1): loaded http://localhost:42332/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42332/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:30:32 INFO - PROCESS | 5819 | RSS: Main: 164962304 14:30:32 INFO - PROCESS | 5819 | 14:30:35 INFO - PROCESS | 5819 | Cycle 1(1): loaded http://localhost:42332/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42332/tests/kraken/driver.html?testName=imaging-darkroom) 14:30:35 INFO - PROCESS | 5819 | RSS: Main: 164294656 14:30:35 INFO - PROCESS | 5819 | 14:30:38 INFO - PROCESS | 5819 | Cycle 1(1): loaded http://localhost:42332/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42332/tests/kraken/driver.html?testName=imaging-desaturate) 14:30:39 INFO - PROCESS | 5819 | RSS: Main: 163758080 14:30:39 INFO - PROCESS | 5819 | 14:30:42 INFO - PROCESS | 5819 | Cycle 1(1): loaded http://localhost:42332/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42332/tests/kraken/driver.html?testName=json-parse-financial) 14:30:42 INFO - PROCESS | 5819 | RSS: Main: 163827712 14:30:42 INFO - PROCESS | 5819 | 14:30:44 INFO - PROCESS | 5819 | Cycle 1(1): loaded http://localhost:42332/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42332/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:30:44 INFO - PROCESS | 5819 | RSS: Main: 175656960 14:30:44 INFO - PROCESS | 5819 | 14:30:46 INFO - PROCESS | 5819 | Cycle 1(1): loaded http://localhost:42332/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42332/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:30:47 INFO - PROCESS | 5819 | RSS: Main: 173551616 14:30:47 INFO - PROCESS | 5819 | 14:30:49 INFO - PROCESS | 5819 | Cycle 1(1): loaded http://localhost:42332/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42332/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:30:50 INFO - PROCESS | 5819 | RSS: Main: 179421184 14:30:50 INFO - PROCESS | 5819 | 14:30:52 INFO - PROCESS | 5819 | Cycle 1(1): loaded http://localhost:42332/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42332/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:30:53 INFO - PROCESS | 5819 | RSS: Main: 187420672 14:30:53 INFO - PROCESS | 5819 | 14:30:55 INFO - PROCESS | 5819 | Cycle 1(1): loaded http://localhost:42332/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42332/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:30:56 INFO - PROCESS | 5819 | RSS: Main: 187518976 14:30:56 INFO - PROCESS | 5819 | 14:30:57 INFO - PROCESS | 5819 | Cycle 1(1): loaded http://localhost:42332/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42332/tests/kraken/driver.html?testName=ai-astar) 14:30:58 INFO - PROCESS | 5819 | RSS: Main: 244805632 14:30:58 INFO - PROCESS | 5819 | 14:30:58 INFO - PROCESS | 5819 | __start_tp_report 14:30:58 INFO - PROCESS | 5819 | _x_x_mozilla_page_load 14:30:58 INFO - PROCESS | 5819 | _x_x_mozilla_page_load_details 14:30:58 INFO - PROCESS | 5819 | |i|pagename|runs| 14:30:58 INFO - PROCESS | 5819 | |0;ai-astar;111;110;105;112;111;112;102;112;111;111 14:30:58 INFO - PROCESS | 5819 | |1;audio-beat-detection;153;124;151;163;126;159;160;129;168;131 14:30:58 INFO - PROCESS | 5819 | |2;audio-dft;161;162;162;163;161;162;160;164;162;163 14:30:58 INFO - PROCESS | 5819 | |3;audio-fft;74;72;84;94;72;73;72;98;91;72 14:30:58 INFO - PROCESS | 5819 | |4;audio-oscillator;99;96;138;96;96;97;137;97;96;143 14:30:58 INFO - PROCESS | 5819 | |5;imaging-gaussian-blur;110;111;111;109;108;109;109;110;109;108 14:30:58 INFO - PROCESS | 5819 | |6;imaging-darkroom;146;145;145;145;145;145;146;145;146;145 14:30:58 INFO - PROCESS | 5819 | |7;imaging-desaturate;95;96;96;97;95;96;96;95;96;96 14:30:58 INFO - PROCESS | 5819 | |8;json-parse-financial;57;56;57;56;56;57;57;56;56;55 14:30:58 INFO - PROCESS | 5819 | |9;json-stringify-tinderbox;67;68;68;69;70;68;69;68;68;68 14:30:58 INFO - PROCESS | 5819 | |10;stanford-crypto-aes;85;86;87;86;85;86;86;85;87;86 14:30:58 INFO - PROCESS | 5819 | |11;stanford-crypto-ccm;117;122;115;119;117;132;117;133;123;118 14:30:58 INFO - PROCESS | 5819 | |12;stanford-crypto-pbkdf2;143;143;152;150;164;141;152;149;152;144 14:30:58 INFO - PROCESS | 5819 | |13;stanford-crypto-sha256-iterative;69;71;70;68;70;69;67;68;68;67 14:30:58 INFO - PROCESS | 5819 | __end_tp_report 14:30:58 INFO - PROCESS | 5819 | __start_cc_report 14:30:58 INFO - PROCESS | 5819 | _x_x_mozilla_cycle_collect,948 14:30:58 INFO - PROCESS | 5819 | __end_cc_report 14:30:58 INFO - PROCESS | 5819 | __startTimestamp1451946658143__endTimestamp 14:30:58 INFO - PROCESS | 5819 | 14:30:58 INFO - PROCESS | 5819 | ------- Summary: start ------- 14:30:58 INFO - PROCESS | 5819 | Number of tests: 14 14:30:58 INFO - PROCESS | 5819 | 14:30:58 INFO - PROCESS | 5819 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.40 (3.1%) stddev-sans-first:3.57 14:30:58 INFO - PROCESS | 5819 | Values: 111.0 110.0 105.0 112.0 111.0 112.0 102.0 112.0 111.0 111.0 14:30:58 INFO - PROCESS | 5819 | 14:30:58 INFO - PROCESS | 5819 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:156.00 stddev:17.02 (10.9%) stddev-sans-first:17.89 14:30:58 INFO - PROCESS | 5819 | Values: 153.0 124.0 151.0 163.0 126.0 159.0 160.0 129.0 168.0 131.0 14:30:58 INFO - PROCESS | 5819 | 14:30:58 INFO - PROCESS | 5819 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.15 (0.7%) stddev-sans-first:1.17 14:30:58 INFO - PROCESS | 5819 | Values: 161.0 162.0 162.0 163.0 161.0 162.0 160.0 164.0 162.0 163.0 14:30:58 INFO - PROCESS | 5819 | 14:30:58 INFO - PROCESS | 5819 | [#3] audio-fft Cycles:10 Average:80.20 Median:79.00 stddev:10.53 (13.3%) stddev-sans-first:10.93 14:30:58 INFO - PROCESS | 5819 | Values: 74.0 72.0 84.0 94.0 72.0 73.0 72.0 98.0 91.0 72.0 14:30:58 INFO - PROCESS | 5819 | 14:30:58 INFO - PROCESS | 5819 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:96.00 stddev:20.66 (21.5%) stddev-sans-first:21.56 14:30:58 INFO - PROCESS | 5819 | Values: 99.0 96.0 138.0 96.0 96.0 97.0 137.0 97.0 96.0 143.0 14:30:58 INFO - PROCESS | 5819 | 14:30:58 INFO - PROCESS | 5819 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:1.07 (1.0%) stddev-sans-first:1.12 14:30:58 INFO - PROCESS | 5819 | Values: 110.0 111.0 111.0 109.0 108.0 109.0 109.0 110.0 109.0 108.0 14:30:58 INFO - PROCESS | 5819 | 14:30:58 INFO - PROCESS | 5819 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 14:30:58 INFO - PROCESS | 5819 | Values: 146.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 14:30:58 INFO - PROCESS | 5819 | 14:30:58 INFO - PROCESS | 5819 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 14:30:58 INFO - PROCESS | 5819 | Values: 95.0 96.0 96.0 97.0 95.0 96.0 96.0 95.0 96.0 96.0 14:30:58 INFO - PROCESS | 5819 | 14:30:58 INFO - PROCESS | 5819 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.50 stddev:0.67 (1.2%) stddev-sans-first:0.67 14:30:58 INFO - PROCESS | 5819 | Values: 57.0 56.0 57.0 56.0 56.0 57.0 57.0 56.0 56.0 55.0 14:30:58 INFO - PROCESS | 5819 | 14:30:58 INFO - PROCESS | 5819 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.73 14:30:58 INFO - PROCESS | 5819 | Values: 67.0 68.0 68.0 69.0 70.0 68.0 69.0 68.0 68.0 68.0 14:30:58 INFO - PROCESS | 5819 | 14:30:58 INFO - PROCESS | 5819 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.00 stddev:0.74 (0.9%) stddev-sans-first:0.71 14:30:58 INFO - PROCESS | 5819 | Values: 85.0 86.0 87.0 86.0 85.0 86.0 86.0 85.0 87.0 86.0 14:30:58 INFO - PROCESS | 5819 | 14:30:58 INFO - PROCESS | 5819 | [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:120.50 stddev:6.38 (5.3%) stddev-sans-first:6.57 14:30:58 INFO - PROCESS | 5819 | Values: 117.0 122.0 115.0 119.0 117.0 132.0 117.0 133.0 123.0 118.0 14:30:58 INFO - PROCESS | 5819 | 14:30:58 INFO - PROCESS | 5819 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.00 Median:151.00 stddev:6.78 (4.5%) stddev-sans-first:6.84 14:30:58 INFO - PROCESS | 5819 | Values: 143.0 143.0 152.0 150.0 164.0 141.0 152.0 149.0 152.0 144.0 14:30:58 INFO - PROCESS | 5819 | 14:30:58 INFO - PROCESS | 5819 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.34 (1.9%) stddev-sans-first:1.41 14:30:58 INFO - PROCESS | 5819 | Values: 69.0 71.0 70.0 68.0 70.0 69.0 67.0 68.0 68.0 67.0 14:30:58 INFO - PROCESS | 5819 | -------- Summary: end -------- 14:30:58 INFO - PROCESS | 5819 | 14:30:58 INFO - TEST-INFO | 5819: exit 0 14:30:59 INFO - TEST-OK | kraken | took 59260ms 14:30:59 INFO - TEST-START | v8_7 14:30:59 INFO - operating with platform_type : linux_ 14:30:59 INFO - Initialising browser for v8_7 test... 14:30:59 INFO - TEST-INFO | started process 6070 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpszpHTl/profile http://localhost:42332/getInfo.html) 14:31:03 INFO - PROCESS | 6070 | __metrics Screen width/height:1600/1200 14:31:03 INFO - PROCESS | 6070 | colorDepth:24 14:31:03 INFO - PROCESS | 6070 | Browser inner width/height: 1024/697 14:31:03 INFO - PROCESS | 6070 | __metrics 14:31:03 INFO - PROCESS | 6070 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:31:03 INFO - PROCESS | 6070 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:31:04 INFO - TEST-INFO | 6070: exit 0 14:31:04 INFO - Browser initialized. 14:31:04 INFO - Running cycle 1/1 for v8_7 test... 14:31:04 INFO - TEST-INFO | started process 6154 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpszpHTl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:31:16 INFO - PROCESS | 6154 | RSS: Main: 150032384 14:31:16 INFO - PROCESS | 6154 | 14:31:37 INFO - PROCESS | 6154 | Cycle 1(1): loaded http://localhost:42332/tests/v8_7/run.html (next: http://localhost:42332/tests/v8_7/run.html) 14:31:38 INFO - PROCESS | 6154 | RSS: Main: 613941248 14:31:38 INFO - PROCESS | 6154 | 14:31:38 INFO - PROCESS | 6154 | __start_tp_report 14:31:38 INFO - PROCESS | 6154 | _x_x_mozilla_page_load 14:31:38 INFO - PROCESS | 6154 | _x_x_mozilla_page_load_details 14:31:38 INFO - PROCESS | 6154 | |i|pagename|runs| 14:31:38 INFO - PROCESS | 6154 | |0;Richards;167.61649346295675 14:31:38 INFO - PROCESS | 6154 | |1;DeltaBlue;191.20458891013385 14:31:38 INFO - PROCESS | 6154 | |2;Encrypt;281.37310073157005 14:31:38 INFO - PROCESS | 6154 | |3;Decrypt;5170.103092783505 14:31:38 INFO - PROCESS | 6154 | |4;RayTrace;1945.5252918287938 14:31:38 INFO - PROCESS | 6154 | |5;Earley;792.3930269413629 14:31:38 INFO - PROCESS | 6154 | |6;Boyer;12132.530120481928 14:31:38 INFO - PROCESS | 6154 | |7;RegExp;25500 14:31:38 INFO - PROCESS | 6154 | |8;Splay;635.7323232323232 14:31:38 INFO - PROCESS | 6154 | |9;NavierStokes;4840.579710144928 14:31:38 INFO - PROCESS | 6154 | __end_tp_report 14:31:38 INFO - PROCESS | 6154 | __startTimestamp1451946698069__endTimestamp 14:31:38 INFO - PROCESS | 6154 | 14:31:38 INFO - PROCESS | 6154 | ------- Summary: start ------- 14:31:38 INFO - PROCESS | 6154 | Number of tests: 10 14:31:38 INFO - PROCESS | 6154 | 14:31:38 INFO - PROCESS | 6154 | [#0] Richards Cycles:1 Average:167.62 Median:167.62 stddev:0.00 (0.0%) 14:31:38 INFO - PROCESS | 6154 | Values: 167.6 14:31:38 INFO - PROCESS | 6154 | 14:31:38 INFO - PROCESS | 6154 | [#1] DeltaBlue Cycles:1 Average:191.20 Median:191.20 stddev:0.00 (0.0%) 14:31:38 INFO - PROCESS | 6154 | Values: 191.2 14:31:38 INFO - PROCESS | 6154 | 14:31:38 INFO - PROCESS | 6154 | [#2] Encrypt Cycles:1 Average:281.37 Median:281.37 stddev:0.00 (0.0%) 14:31:38 INFO - PROCESS | 6154 | Values: 281.4 14:31:38 INFO - PROCESS | 6154 | 14:31:38 INFO - PROCESS | 6154 | [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 14:31:38 INFO - PROCESS | 6154 | Values: 5170.1 14:31:38 INFO - PROCESS | 6154 | 14:31:38 INFO - PROCESS | 6154 | [#4] RayTrace Cycles:1 Average:1945.53 Median:1945.53 stddev:0.00 (0.0%) 14:31:38 INFO - PROCESS | 6154 | Values: 1945.5 14:31:38 INFO - PROCESS | 6154 | 14:31:38 INFO - PROCESS | 6154 | [#5] Earley Cycles:1 Average:792.39 Median:792.39 stddev:0.00 (0.0%) 14:31:38 INFO - PROCESS | 6154 | Values: 792.4 14:31:38 INFO - PROCESS | 6154 | 14:31:38 INFO - PROCESS | 6154 | [#6] Boyer Cycles:1 Average:12132.53 Median:12132.53 stddev:0.00 (0.0%) 14:31:38 INFO - PROCESS | 6154 | Values: 12132.5 14:31:38 INFO - PROCESS | 6154 | 14:31:38 INFO - PROCESS | 6154 | [#7] RegExp Cycles:1 Average:25500.00 Median:25500.00 stddev:0.00 (0.0%) 14:31:38 INFO - PROCESS | 6154 | Values: 25500.0 14:31:38 INFO - PROCESS | 6154 | 14:31:38 INFO - PROCESS | 6154 | [#8] Splay Cycles:1 Average:635.73 Median:635.73 stddev:0.00 (0.0%) 14:31:38 INFO - PROCESS | 6154 | Values: 635.7 14:31:38 INFO - PROCESS | 6154 | 14:31:38 INFO - PROCESS | 6154 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 14:31:38 INFO - PROCESS | 6154 | Values: 4840.6 14:31:38 INFO - PROCESS | 6154 | -------- Summary: end -------- 14:31:38 INFO - PROCESS | 6154 | 14:31:38 INFO - TEST-INFO | 6154: exit 0 14:31:38 INFO - TEST-OK | v8_7 | took 39816ms 14:31:38 INFO - SUITE-END | took 1212s 14:31:38 INFO - Completed test suite (00:20:12) 14:31:38 INFO - Working with test: dromaeo_css 14:31:38 INFO - Generating results file: dromaeo_css 14:31:38 INFO - Working with test: kraken 14:31:38 INFO - Generating results file: kraken 14:31:38 INFO - javascript benchmark 14:31:38 INFO - Working with test: v8_7 14:31:38 INFO - Generating results file: v8_7 14:31:38 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:31:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 14:31:39 INFO - process_Request line: dromaeo_css 6777.35 graph.html#tests=[[72,201,35]] 14:31:39 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:31:39 INFO - process_Request line: kraken 1507.80 graph.html#tests=[[232,201,35]] 14:31:39 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:31:39 INFO - process_Request line: v8_7 19763.06 graph.html#tests=[[230,201,35]] 14:31:39 INFO - RETURN: dromaeo_css: 6777.35 14:31:39 INFO - RETURN: kraken: 1507.80 14:31:39 INFO - RETURN: v8_7: 19763.06 14:31:39 INFO - javascript benchmark 14:31:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3124.45322068638, 3140.932083091748, 3189.2824114574223, 3217.774755767096, 3248.496483045129, 5094.210397388401, 5150.3047088643025, 5168.457311982244, 5205.401378841434, 5273.024490469256, 5216.9478305216935, 5241.8951620967555, 5324.094903866342, 5347.786088556453, 5347.839564813052, 4604.1252162089095, 4694.248920172773, 4711.199096153654, 4793.3768610080815, 4904.06822703687, 4646.395968524087, 4837.588804951566, 4867.561919427251, 4903.8774030649165, 4926.852194434155, 4793.32893394925, 4794.49657785931, 4891.388576427947, 4899.363082799213, 4920.212765957465, 4815.614750819961, 4823.710577365334, 4824.228123500223, 4833.0, 4865.732384718839, 4767.737774422405, 4799.760011999386, 4807.0, 4843.0313937212695, 4884.755762211875, 5009.44896061433, 5032.4212715537815, 5099.617528685327, 5106.489351064901, 5118.744062796883, 5621.156826476062, 5664.037113690682, 5665.5467562594895, 5671.886562268773, 5678.063119585264, 5682.971585142048, 5691.971540142273, 5696.145578163268, 5701.230333904911, 5728.0, 5212.765425555859, 5214.634975551751, 5319.521243088063, 5341.545968592635, 5344.0915044442145, 5786.971065144648, 5824.242848429677, 5824.388439213906, 5836.2412886325355, 5852.941470585325, 5606.411326810708, 5607.915881261784, 5623.268975033301, 5625.128105143709, 5637.23897273871, 5402.135658294654, 5548.250986116904, 5600.747966341524, 5602.411746766612, 5631.662100273997, 5613.775448982076, 5623.8594035149445, 5632.690202038845, 5634.802781902614, 5644.633098848643, 5594.049011668027, 5615.494605485526, 5619.719014049281, 5627.915581266284, 5630.042892708249, 4290.957090429056, 4381.364702118175, 4393.209222339946, 4425.955740442619, 4458.041521072985, 3937.645611894943, 3947.5657677655436, 3950.3284441644414, 3973.960260397359, 3980.86066987654, 5278.366596008504, 5281.15501519755, 5289.523942845162, 5291.444398338119, 5325.4940780625775, 5560.36055853582, 5588.552915766729, 5663.405342439067, 5663.971680141655, 5723.055695810144, 5260.342457192851, 5292.2326262691695, 5293.391260005072, 5304.761285742151, 5305.098133317345, 4839.0, 4866.853994380103, 4886.780094895738, 4886.92669609949, 4933.753312334369, 5668.0647693130995, 5722.027255366681, 5735.1684005818925, 5777.104548794943, 5850.912236316373, 5619.213310136666, 5620.325560932714, 5625.353084395347, 5629.605927585029, 5631.2960879890015, 5742.59801813869, 5789.710514474344, 5799.797007104731, 5811.302643682616, 5812.9709351452975, 5433.538149257357, 5523.171524271392, 5531.529819965348, 5551.444855514416, 5648.039833228278, 5605.691686957257, 5635.605507614591, 5641.9435805641415, 5647.491725744702, 5660.688662123623, 5478.726063696719, 5507.0, 5521.3926468087675, 5523.8895222096135, 5525.889482210253, 5299.44355842631, 5344.599155063308, 5432.2123292123215, 5517.034518959246, 5540.7783688652, 5362.839114826562, 5365.812196573102, 5376.677399356051, 5384.273123128328, 5386.165144402624, 5287.814926477555, 5488.7530061148145, 5488.982606742631, 5514.145307477347, 5558.082916318762, 5382.085045542189, 5410.161424979135, 5455.045367060669, 5483.616146869681, 5527.695976721319], "unit": "score", "name": "dojo.html", "value": 5199.694903335673}, {"lowerIsBetter": false, "replicates": [522.0707141288506, 523.0297797585479, 524.6222719641856, 547.6659237864902, 552.9060059789836, 27475.587866182, 28305.433891322187, 36158.27683446329, 36757.0, 36765.448518272184, 39620.60379396205, 39720.20559588807, 40081.799591002, 40175.196496070064, 40194.0, 8425.452345597547, 8504.192101750325, 8507.766373875784, 8513.446625969293, 8562.058173600899, 7456.925430745704, 7644.694212231504, 10103.494825258744, 10277.383356998567, 10291.125254353352, 10018.098371146596, 10109.342892711988, 10111.0, 10113.747156321077, 10115.393076415401, 7423.851522969564, 7620.314171724572, 9940.90059099407, 10014.999999999964, 10094.242931780072, 7337.3763230125505, 10074.848877266846, 10286.639967601173, 10293.845592316122, 10297.639582614647, 31487.212819679462, 31772.364552708816, 31784.841075794706, 31801.840990795128, 31813.52279715806, 3123.765717571191, 3249.5775549178693, 3426.2633533790104, 3500.894973150784, 3706.1846393793594, 27619.447611047868, 27729.0, 27793.305167370774, 28078.438431231465, 28393.148205553865, 3826.693864490834, 3835.673967712748, 3864.420336949452, 3892.630200130983, 4035.112275299459, 263407.0, 264012.0, 265259.0, 266043.0, 266724.0, 52558.73720631372, 53081.73459132679, 58244.0, 58726.0, 58773.0, 68452.657736711, 69269.0, 69348.0, 69541.0, 69628.0, 12580.308083055337, 12713.682157946125, 12728.80906786399, 12736.23582585048, 12751.0, 11424.543018279343, 11550.364729939934, 11558.537658493735, 11559.537618495335, 11573.958343749104, 19272.743603946157, 19908.800911990984, 19920.800791991893, 19940.3020894268, 19999.700004499944, 7724.686803243462, 7784.455088143775, 7902.525848449111, 7942.801429964297, 7946.205379462123, 856.6444925356033, 955.345588272022, 1002.9699109026595, 1022.325265324882, 1056.144522936424, 28613.57079643807, 28646.570301445496, 28671.705724356372, 28860.134195974155, 29092.236237557398, 1030.2479190191202, 1031.5718976624767, 1036.7097212780434, 1041.4844651897358, 1098.522142867855, 14944.626384340261, 14949.476768313058, 15005.849941500664, 15194.240287985778, 15276.923615382075, 304473.0, 309686.0, 311077.0, 311152.0, 311584.0, 51419.228711569354, 51965.22052169221, 51969.0, 52088.739556301975, 52125.7393713029, 1282.1025282302426, 1284.1588759362446, 1290.1613950931783, 1290.741851629659, 1303.9332657737402, 27137.321566960985, 28206.294842629097, 28408.85795571009, 30219.0, 31099.533506996962, 49475.0, 50333.49666503288, 50414.2437863425, 50492.49507505025, 50497.747511262205, 277806.0, 281722.0, 296389.0, 413636.0, 425377.0, 34249.315013700085, 35131.47302790409, 35188.64811351854, 35348.0, 35664.0, 43328.350074748276, 44251.778741106085, 44396.55603444053, 44509.77745111254, 44708.77645611751, 37418.62581374151, 37420.25159496849, 38244.426333605574, 39003.60996390113, 39645.0, 37577.81211093927, 38364.849054527294, 38777.806110969264, 38999.415008774326, 39304.606953930095, 33315.500267495525, 38247.80876095602, 38694.6130538691, 38758.61241387663, 38864.80567597144, 27776.888924442796, 30841.537376939814, 31072.68927310698, 31121.68878311188, 31215.531767023967, 24621.0, 24733.0, 24759.62860557057, 25090.37274068163, 25227.74772252254], "unit": "score", "name": "ext.html", "value": 18480.73047381381}, {"lowerIsBetter": false, "replicates": [354.5196259068961, 354.75876404045255, 356.662953508934, 356.8697425439714, 357.47272772660347, 14139.575812725609, 14544.345504452298, 15924.601884952883, 16340.264688089035, 17255.654886902255, 14499.5650130496, 14588.343524541395, 14590.343434545444, 15510.991785533932, 16218.675626487464, 4990.1516742153735, 5140.8971820563565, 5142.588592912577, 5149.098907691157, 5181.481851814817, 3754.793486358249, 3880.592537783534, 4243.978780106095, 5298.125809241471, 5466.508014278734, 5398.78404863805, 5404.189371594253, 5409.918851217235, 5428.185772134192, 5439.972800135994, 5271.130263506517, 5274.472552744734, 5298.867528311785, 5322.361316641989, 5331.866703332428, 5152.407473140599, 5153.742312884378, 5169.715665638389, 5178.637495375326, 5181.300524429229, 12363.567275145417, 12722.236665799988, 12738.044646651539, 12742.171758835739, 14644.97485176038, 2101.338078505266, 2108.536122053146, 2118.226847200776, 2120.989395053015, 2304.781045800646, 9240.353175277733, 9488.620455181785, 9710.271729620235, 12402.379881006003, 12797.104202705814, 1760.0, 1791.7491551182845, 1827.6344731053841, 1830.7528483654803, 1858.6933156029238, 61271.69364153151, 64666.67666661683, 64830.0, 65261.67369163124, 65460.345396545905, 9353.579088941015, 9597.088276613711, 9896.901030989742, 9940.80118397628, 9962.551685174185, 12823.230606163661, 12838.48646054166, 12840.55058072963, 12852.164609300366, 12857.807132893015, 6764.695588698422, 6864.485163612749, 6892.448604111759, 6928.896066559006, 6929.41100006495, 6388.7125079371535, 6411.935880641134, 6434.292227854932, 6450.580712253689, 6493.5454518184215, 4170.0, 4213.599708027732, 4246.0, 4260.914781704349, 4303.849365272201, 1691.0952640337362, 1708.265445858268, 1723.612187257857, 1728.9308427662752, 1822.662807380639, 393.8030984507746, 804.6057431858347, 850.2008112374348, 910.2399496420563, 943.6697155995347, 9542.0, 10321.63874264397, 10482.318649287772, 10627.256092073636, 10856.674299771019, 422.4782393743724, 434.8217230935301, 436.4958472963732, 882.8940527136656, 905.7192270396198, 8645.783855403664, 9034.412763170372, 9055.732197492356, 9124.315676324302, 9172.816543669089, 393241.0, 397814.0, 399160.0, 414339.0, 491773.0, 79305.60347198343, 79971.20028799753, 81246.59376703079, 81747.59126204331, 82587.58706206431, 1086.2124959404368, 1093.294824837991, 1103.0734183285917, 1116.542217690743, 1120.960766373173, 13542.729145417234, 14694.0, 16303.836961630232, 16355.754663679816, 16675.33298668088, 32840.67159328376, 34146.31707365889, 34778.0, 35865.46201807027, 36398.09004774902, 39547.604523955546, 41751.791241043604, 41999.58000419957, 44788.0, 45012.0, 9646.662366817127, 9784.0, 9794.65718699842, 9802.803943921224, 9902.653407130716, 17717.379891703727, 17890.194941227935, 18284.268629254682, 18646.254149834396, 18812.52968675794, 11517.712057198301, 11816.113791465503, 13755.449782009007, 14445.422183112558, 14677.779833302722, 13846.238456884565, 14027.56324700455, 14063.367148478139, 14179.787303190255, 14465.204413757345, 12277.938610306892, 12330.445129969352, 13189.670258243621, 14184.858151418353, 14468.421263149356, 9505.714828555154, 9787.0, 9817.607295708092, 12716.554920577735, 13238.669033274246, 15531.767023494882, 15736.370545178064, 15970.520884373487, 16512.091834949195, 16660.58348541296], "unit": "score", "name": "jquery.html", "value": 8308.677600127441}, {"lowerIsBetter": false, "replicates": [1190.9464074116663, 1333.3133436280314, 1374.7456720506705, 1456.0, 1731.705610046292, 6501.642409667473, 7145.606991615459, 7299.744508942182, 7310.086239220098, 7311.670974806133, 7102.360787529121, 7276.599787011713, 7287.781366558998, 7296.087989001375, 7297.854042919138, 2175.1408193763455, 2208.1719355241785, 2215.7673444288357, 2216.0249490224332, 2217.434554188688, 2182.9235976740815, 2215.102883332253, 2243.955120897581, 2245.2253972379503, 2246.7753224677485, 2187.136081247906, 2191.5726433345503, 2233.6761169630395, 2234.519578290667, 2240.977590224093, 2172.576347612216, 2172.7935846094597, 2192.7587965323883, 2195.1658369819525, 2197.4726065744267, 2234.6089434348924, 2255.515064261175, 2256.638937769949, 2257.164849005862, 2258.3450799268194, 7353.338199562012, 7415.851682966364, 7426.665800039012, 7433.256674332523, 7441.0, 4442.666799990014, 4478.57453541913, 4502.0, 4502.392177056088, 4510.774461276956, 2862.842543660098, 3051.1304278280804, 3055.052933590594, 3072.554479600468, 3076.4769989101683, 909.0182602788972, 914.1909410171979, 925.8379783537854, 953.4851180362596, 984.0503913723292, 9969.850452243221, 9984.95007524965, 9994.10053095225, 9998.200143988464, 9999.500024998793, 4054.2094291612852, 4089.26393249218, 4097.180563887235, 4120.814563344657, 4174.686898482626, 8561.82876342482, 8567.74296771098, 8589.52757598338, 8605.827883442296, 8615.784605384915, 4524.321351797191, 4533.9319910201375, 4546.659000574904, 4560.3843481129625, 4562.110388474282, 3718.0, 3741.0460332615007, 4036.6770658347264, 4161.646260067928, 4170.895727606834, 3458.9654103458643, 3483.6516348365467, 3488.7906725596545, 3508.614052454228, 3513.4554144107706, 1127.9097672186206, 1140.5551834784442, 1141.4920360439692, 1146.6297774159966, 1151.5393842463081, 1268.9175203611735, 1270.3775150176348, 1290.1871820752865, 1293.9158954668105, 1296.863829297929, 6864.965675171592, 6932.7226910923, 6990.0, 7071.787846364515, 7076.893846592306, 1083.1497274639528, 1083.4203701019917, 1086.788076325109, 1092.470151976291, 1113.9443027848574, 5514.696691681916, 5568.832935011957, 5569.331680198402, 5570.805021824217, 5583.692896890629, 8375.874361884577, 8411.579421028924, 8569.657213711382, 8626.78433039179, 8676.392652514389, 8689.17452841979, 8817.603207855662, 8820.955895220482, 8824.735257942271, 8835.646574136963, 6722.563033402813, 6860.862782744317, 6883.1396075489565, 6896.27589103137, 6936.826579335557, 6789.11741473625, 6853.109095817512, 6867.141607299088, 6869.416099631588, 6870.828229294308, 7505.624718764149, 7746.264104910025, 7812.765617031499, 7874.409419293462, 7877.6455059523605, 7747.147813740371, 7918.9208107920485, 7970.681172753025, 7981.321587665114, 8029.197080291924, 5713.885722285614, 5778.711064446677, 6402.327755585597, 6579.342065793382, 6711.597304161766, 6913.585184888721, 6932.826679333057, 6938.653067346511, 6954.165500139813, 6959.8956015660815, 6391.2330520337855, 6470.741170353322, 6477.546571739933, 6489.3510648934725, 6553.311902250386, 6386.872262554816, 6457.838554036187, 6472.935270647234, 6509.088727578238, 6577.769778057745, 6487.091807146909, 6502.837429064311, 6518.771842985473, 6520.706568204537, 6524.575902566318, 6112.32764395925, 6154.353792851686, 6184.134221208944, 6211.875762484635, 6221.253449586078, 6301.0, 6341.302456729663, 6341.460975817107, 6344.302126766144, 6365.586236894587], "unit": "score", "name": "mootools.html", "value": 4274.321483103131}, {"lowerIsBetter": false, "replicates": [325.2016299983539, 331.8423748719359, 335.3059167523228, 339.97110245629113, 342.75493022488916, 5647.181158731992, 5786.913196302048, 5844.422006058367, 5857.26784151981, 5863.648181109136, 5656.406077361879, 5797.043487824514, 5804.796832110877, 5845.327787304462, 5846.093855452412, 4524.0, 4554.635629149669, 4555.0, 4555.521670224628, 4564.109998550284, 4319.546447623002, 4414.0, 4447.132809102226, 4551.180787458256, 4552.658550608701, 4484.282514797633, 4486.484054333744, 4486.506484286726, 4492.640588752892, 4516.322551617251, 4469.843555475575, 4481.350204220386, 4504.707194032378, 4506.7070640408265, 4507.422402159251, 4007.2586571484076, 4013.418054382098, 4017.0760725033115, 4031.9395209071595, 4036.1322315702264, 5438.755256013489, 5539.058360078796, 5551.139573366135, 5585.692786896719, 5609.1305847593685, 5232.1628539433505, 5246.711430871301, 5280.075986702312, 5283.260343551868, 5284.894302113975, 5904.084866845646, 6189.288231853349, 6190.690465476709, 6195.31851496335, 6202.162708034402, 4305.74165550068, 4322.697411181219, 4424.889377765581, 4425.380446737459, 4427.535108813592, 6296.433321001086, 6446.161998940154, 6453.2256129264315, 6453.967365221542, 6459.677016149174, 4490.079533695584, 4506.797194126272, 4518.570735780096, 4519.231730605805, 4523.932141017887, 4505.7521836298665, 4588.0, 4588.220002599566, 4605.562471565196, 4619.122366750306, 5202.401723801736, 5212.0, 5215.322008138917, 5217.7912883485, 5219.321488206585, 6196.318404975449, 6200.038993955944, 6200.534959878028, 6207.410296021871, 6209.068639704081, 1611.8791090668246, 1628.552148159242, 1630.1767607358208, 1632.7632493288406, 1634.5586691593203, 1107.4905543450104, 1115.9330440173615, 1116.0569318925657, 1119.356370087203, 1140.6749076513154, 5870.7945221917025, 5873.236479257669, 5874.060150375919, 5878.2358293421585, 5878.441548052928, 6332.95506241465, 6335.271443784024, 6344.080108384351, 6344.143540621957, 6350.841228969312, 5766.8269951900675, 5768.855778605568, 5781.0, 5782.88434231313, 5783.88432231353, 3315.353506066294, 3423.5207071010077, 3426.0578340956436, 3427.9143021424666, 3430.142464383904, 6591.274959754423, 6592.80221593353, 6597.373249541286, 6605.009248612747, 6605.405513503808, 6462.547621666532, 6464.22429308486, 6466.159399278158, 6468.029795530708, 6471.2234531856475, 6426.710798014101, 6576.177977752781, 6583.893154190709, 6595.340465953366, 6679.632620205935, 6165.537584681257, 6285.277193122849, 6381.234251889803, 6393.808185754435, 6403.871922561616, 6167.814965551041, 6275.403836635513, 6286.654234017173, 6311.147995020613, 6326.778562750282, 6585.176852893388, 6618.338166183343, 6633.834154146185, 6642.169728783902, 6642.5018123641885, 4249.532551419279, 4382.912341753084, 4426.203283409017, 4430.0, 4436.0240747035605, 6325.240971083499, 6361.173047503795, 6373.808785736435, 6385.265694445198, 6393.776217832354, 6191.288001879841, 6198.907016394848, 6210.906836397367, 6213.409726076015, 6217.502599792097, 6035.849103772441, 6184.0, 6188.659623720739, 6197.566170368031, 6199.16311297969, 6091.390860914051, 6151.384861513813, 6154.107654390178, 6156.569040167145, 6159.476444502267, 6274.341194174546, 6278.529110316653, 6287.46556542699, 6288.937110628835, 6289.96855015722, 5956.583039187215, 6084.209052823105, 6130.417610327012, 6140.969295153495, 6141.263048434216], "unit": "score", "name": "prototype.html", "value": 4698.209430618175}, {"lowerIsBetter": false, "replicates": [653.5457856789527, 687.9174499060114, 732.6007326007325, 782.4092809928507, 809.2433574607742, 15265.542033738991, 15458.690826183469, 15543.611409714762, 15564.533064008083, 15578.0, 12247.877521224786, 12267.693307667312, 12278.877211227886, 12307.07696922732, 12321.0, 672.5057083043959, 679.6533767778444, 799.6081919859271, 816.3142959913671, 818.5293456262673, 788.0818846044351, 808.7169490678245, 811.4441607498882, 813.8860559521672, 814.4176913506841, 848.0586548930683, 848.4612271207797, 850.9829803403928, 851.974440766778, 853.5476197615274, 698.3261152987366, 705.3193668110247, 824.282873899711, 842.0695131879246, 843.6035063520136, 617.213053356969, 620.1380081686459, 620.6245221640933, 621.0559948877726, 622.1290193728771, 13742.93128534351, 13782.0, 13823.585292441143, 13926.651833704138, 13936.860631393658, 11149.554017839277, 11411.600593979254, 11614.825777613258, 11765.529378824836, 12451.813222801666, 9913.959034301439, 9954.502274886227, 10174.186065114773, 10221.64224252155, 10359.067683908484, 3498.8425520851624, 3551.875684351061, 3552.2540266544056, 3558.131558409907, 3573.1424458129864, 48077.0, 48709.75645121787, 48857.755711221216, 48859.755701221264, 49002.26496602554, 8521.701740439055, 9041.638334466548, 9186.494742789211, 9224.0, 9302.302327325478, 15430.768538471932, 15462.9226853865, 15479.922600386926, 15480.845191548166, 15508.224588770516, 6839.179298484214, 6854.383105520427, 6949.89575156373, 7095.254998225112, 7149.213586505481, 4111.116110036297, 4132.690048246333, 4206.0, 4217.1776503581505, 4222.176675548239, 2866.5986761853355, 2898.594196812448, 2899.0, 2899.9710002900124, 2902.6516817981556, 498.3795175007139, 503.5141088849278, 510.03094121169335, 511.76203065574686, 519.6414474012919, 497.9128652485873, 538.2948337677655, 559.4571486465744, 579.1746760865749, 602.0457574743992, 8255.711050113217, 8286.295664868434, 8414.032386275656, 8431.28334091609, 8501.362397820189, 561.7584438691401, 564.9180868774087, 591.6006695480534, 591.9674417907056, 644.7331933605349, 3849.412421382065, 3852.325842977468, 3877.689784817208, 3975.2447035063246, 4147.709660323809, 54007.18989215165, 54037.72981135069, 54132.188017179775, 54401.0, 54494.727526362905, 50760.74619626878, 50792.0, 51153.23270150951, 51196.74401628043, 51219.48780512147, 45067.999999999345, 45100.0, 46346.5365346349, 47411.0, 47572.5242747575, 7972.0, 8000.719974800854, 8179.509229446252, 8553.700620478254, 8787.472751634923, 33402.16494587558, 33423.33153336968, 33743.49384759182, 33952.83023584866, 34262.0, 39875.0, 40663.18673626452, 41476.1704765909, 42102.578974209864, 42531.36202956896, 10154.136898363722, 10923.180761442765, 11001.504932278227, 11016.724581885517, 11490.425478726198, 11289.774204516028, 11482.827757583476, 11556.768864622492, 11676.94161529187, 11699.356535390636, 10552.731162800035, 10589.788204236027, 11017.779644407226, 11295.0, 11490.080793536665, 10848.891511084788, 11011.119110471303, 11194.048505876766, 11273.154513411362, 11540.82688759686, 10720.303180293567, 10879.0, 11084.833727494255, 11279.041281490838, 11418.828717569077, 8843.204111629984, 8901.376903616685, 9009.54952252398, 9108.681196158368, 9179.44923304577, 8614.396992210735, 8729.388942773945, 9012.63949442015, 9116.4074335168, 9147.679831206142], "unit": "score", "name": "yui.html", "value": 6043.538964414099}], "name": "dromaeo_css", "value": 6777.352610893543}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 105.0, 112.0, 111.0, 112.0, 102.0, 112.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.7}, {"lowerIsBetter": true, "replicates": [153.0, 124.0, 151.0, 163.0, 126.0, 159.0, 160.0, 129.0, 168.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 146.4}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 163.0, 161.0, 162.0, 160.0, 164.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 84.0, 94.0, 72.0, 73.0, 72.0, 98.0, 91.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [99.0, 96.0, 138.0, 96.0, 96.0, 97.0, 137.0, 97.0, 96.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 111.0, 109.0, 108.0, 109.0, 109.0, 110.0, 109.0, 108.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 97.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 57.0, 56.0, 56.0, 57.0, 57.0, 56.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.3}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 69.0, 70.0, 68.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 87.0, 86.0, 85.0, 86.0, 86.0, 85.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [117.0, 122.0, 115.0, 119.0, 117.0, 132.0, 117.0, 133.0, 123.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.3}, {"lowerIsBetter": true, "replicates": [143.0, 143.0, 152.0, 150.0, 164.0, 141.0, 152.0, 149.0, 152.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.0}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 70.0, 68.0, 70.0, 69.0, 67.0, 68.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1507.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.61649346295675], "unit": "score", "name": "Richards", "value": 210.61173199999993}, {"lowerIsBetter": false, "replicates": [191.20458891013385], "unit": "score", "name": "DeltaBlue", "value": 345.79713999999984}, {"lowerIsBetter": false, "replicates": [281.37310073157005], "unit": "score", "name": "Encrypt", "value": 946.0072739999998}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1945.5252918287938], "unit": "score", "name": "RayTrace", "value": 380.354346}, {"lowerIsBetter": false, "replicates": [792.3930269413629], "unit": "score", "name": "Earley", "value": 841.0763060000003}, {"lowerIsBetter": false, "replicates": [12132.530120481928], "unit": "score", "name": "Boyer", "value": 54.93190566037737}, {"lowerIsBetter": false, "replicates": [25500.0], "unit": "score", "name": "RegExp", "value": 35.72490196078431}, {"lowerIsBetter": false, "replicates": [635.7323232323232], "unit": "score", "name": "Splay", "value": 128.18445283018863}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19763.064061627527}]} 14:31:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19763.06"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1507.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6777.35"}}} 14:31:39 INFO - Return code: 0 14:31:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:31:39 INFO - # TBPL SUCCESS # 14:31:39 INFO - Running post-action listener: _resource_record_post_action 14:31:39 INFO - Running post-run listener: _resource_record_post_run 14:31:40 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 571576320; Read time: 0; Write time: 629748 14:31:40 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 250691584; Read time: 0; Write time: 326508 14:31:40 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 320610304; Read time: 0; Write time: 303188 14:31:40 INFO - Running post-run listener: _upload_blobber_files 14:31:40 INFO - Blob upload gear active. 14:31:40 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:31:40 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 14:31:40 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 14:31:40 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 14:31:40 INFO - (blobuploader) - INFO - Open directory for files ... 14:31:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:31:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:31:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:41 INFO - (blobuploader) - INFO - Done attempting. 14:31:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:31:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:31:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:42 INFO - (blobuploader) - INFO - Done attempting. 14:31:42 INFO - (blobuploader) - INFO - Iteration through files over. 14:31:42 INFO - Return code: 0 14:31:42 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:31:42 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:31:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/99375e5b88c1f038330906df6fac492d64c7b9abbef798f44afefc2c23ac62354d264b6e112f01ce40267b37cdfc7be56db8ef2a11e9dd747ee1363ac912319d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/935903bf37070b9f1f93385e8ba0ef828b270cc8f5831316dab8ee92b896301fe36e73b2bc50fc054f6c07b0437c645d67c14daa1a63db60587445310ba5316a"} 14:31:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:31:42 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:31:42 INFO - Contents: 14:31:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/99375e5b88c1f038330906df6fac492d64c7b9abbef798f44afefc2c23ac62354d264b6e112f01ce40267b37cdfc7be56db8ef2a11e9dd747ee1363ac912319d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/935903bf37070b9f1f93385e8ba0ef828b270cc8f5831316dab8ee92b896301fe36e73b2bc50fc054f6c07b0437c645d67c14daa1a63db60587445310ba5316a"} 14:31:42 INFO - Copying logs to upload dir... 14:31:42 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1265.035307 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-01-04 14:31:42.153687) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 14:31:42.157405) ========= 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=14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/99375e5b88c1f038330906df6fac492d64c7b9abbef798f44afefc2c23ac62354d264b6e112f01ce40267b37cdfc7be56db8ef2a11e9dd747ee1363ac912319d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/935903bf37070b9f1f93385e8ba0ef828b270cc8f5831316dab8ee92b896301fe36e73b2bc50fc054f6c07b0437c645d67c14daa1a63db60587445310ba5316a"} build_url:https://queue.taskcluster.net/v1/task/D-UK3LkBTxeScJaHIDNJSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011420 build_url: 'https://queue.taskcluster.net/v1/task/D-UK3LkBTxeScJaHIDNJSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/99375e5b88c1f038330906df6fac492d64c7b9abbef798f44afefc2c23ac62354d264b6e112f01ce40267b37cdfc7be56db8ef2a11e9dd747ee1363ac912319d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/935903bf37070b9f1f93385e8ba0ef828b270cc8f5831316dab8ee92b896301fe36e73b2bc50fc054f6c07b0437c645d67c14daa1a63db60587445310ba5316a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 14:31:42.181565) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 14:31:42.181885) ========= 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=14ef55db36f7623abb31b9cf000001d5-1451945434.714674-1737702803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 14:31:42.265860) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 14:31:42.266185) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 14:31:42.266468) ========= ========= Total master_lag: 0.24 =========