builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1452066749.11 results: success (0) buildid: 20160105173008 builduid: 199a45c9033d4ac187d4cf395be87ee5 revision: d68306ac604b0820b0ed22bc43115e0218f9e21e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 23:52:29.114774) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 23:52:29.115177) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 23:52:29.115467) ========= 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=df17445c3590ff7897617a0e00000225-1452064427.577279-410307445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006454 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 23:52:29.139770) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 23:52:29.140119) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 23:52:29.188208) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 23:52:29.188475) ========= 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=df17445c3590ff7897617a0e00000225-1452064427.577279-410307445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004580 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 23:52:29.237852) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 23:52:29.238143) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 23:52:29.238524) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 23:52:29.238797) ========= 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=df17445c3590ff7897617a0e00000225-1452064427.577279-410307445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-05 23:52:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.8M=0s 2016-01-05 23:52:29 (43.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158056 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 23:52:29.409116) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 23:52:29.409435) ========= 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=df17445c3590ff7897617a0e00000225-1452064427.577279-410307445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021805 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 23:52:29.459030) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 23:52:29.459361) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev d68306ac604b0820b0ed22bc43115e0218f9e21e --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 d68306ac604b0820b0ed22bc43115e0218f9e21e --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=df17445c3590ff7897617a0e00000225-1452064427.577279-410307445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-05 23:52:29,681 truncating revision to first 12 chars 2016-01-05 23:52:29,681 Setting DEBUG logging. 2016-01-05 23:52:29,681 attempt 1/10 2016-01-05 23:52:29,681 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/d68306ac604b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-05 23:52:29,916 unpacking tar archive at: b2g-inbound-d68306ac604b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.516124 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 23:52:29.987969) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 23:52:29.988269) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 23:52:29.995370) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 23:52:29.995645) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 23:52:29.996073) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-05 23:52:29.996367) ========= /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=df17445c3590ff7897617a0e00000225-1452064427.577279-410307445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:52:30 INFO - MultiFileLogger online at 20160105 23:52:30 in /builds/slave/test-pgo 23:52:30 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 23:52:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 23:52:30 INFO - {'append_to_log': False, 23:52:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 23:52:30 INFO - 'blob_upload_branch': 'B2G-Inbound', 23:52:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 23:52:30 INFO - 'branch': 'B2G-Inbound', 23:52:30 INFO - 'buildbot_json_path': 'buildprops.json', 23:52:30 INFO - 'config_files': ('talos/linux_config.py',), 23:52:30 INFO - 'default_actions': ('clobber', 23:52:30 INFO - 'read-buildbot-config', 23:52:30 INFO - 'download-and-extract', 23:52:30 INFO - 'populate-webroot', 23:52:30 INFO - 'create-virtualenv', 23:52:30 INFO - 'install', 23:52:30 INFO - 'run-tests'), 23:52:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:52:30 INFO - 'download_minidump_stackwalk': True, 23:52:30 INFO - 'download_symbols': 'ondemand', 23:52:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:52:30 INFO - 'tooltool.py': '/tools/tooltool.py', 23:52:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:52:30 INFO - '/tools/misc-python/virtualenv.py')}, 23:52:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:52:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:52:30 INFO - 'installer_path': 'installer.exe', 23:52:30 INFO - 'log_level': 'info', 23:52:30 INFO - 'log_name': 'talos', 23:52:30 INFO - 'log_to_console': True, 23:52:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:52:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:52:30 INFO - 'opt_config_files': (), 23:52:30 INFO - 'pip_index': False, 23:52:30 INFO - 'sps_profile': False, 23:52:30 INFO - 'sps_profile_interval': 0, 23:52:30 INFO - 'suite': 'dromaeojs', 23:52:30 INFO - 'system_bits': '32', 23:52:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:52:30 INFO - 'title': 'talos-linux64-ix-021', 23:52:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:52:30 INFO - 'use_talos_json': True, 23:52:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 23:52:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:52:30 INFO - 'work_dir': 'build'} 23:52:30 INFO - ##### 23:52:30 INFO - ##### Running clobber step. 23:52:30 INFO - ##### 23:52:30 INFO - Running pre-action listener: _resource_record_pre_action 23:52:30 INFO - Running main action method: clobber 23:52:30 INFO - rmtree: /builds/slave/test-pgo/build 23:52:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 23:52:30 INFO - Running post-action listener: _resource_record_post_action 23:52:30 INFO - ##### 23:52:30 INFO - ##### Running read-buildbot-config step. 23:52:30 INFO - ##### 23:52:30 INFO - Running pre-action listener: _resource_record_pre_action 23:52:30 INFO - Running main action method: read_buildbot_config 23:52:30 INFO - Using buildbot properties: 23:52:30 INFO - { 23:52:30 INFO - "project": "", 23:52:30 INFO - "product": "firefox", 23:52:30 INFO - "script_repo_revision": "production", 23:52:30 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 23:52:30 INFO - "repository": "", 23:52:30 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 23:52:30 INFO - "buildid": "20160105173008", 23:52:30 INFO - "pgo_build": "True", 23:52:30 INFO - "basedir": "/builds/slave/test-pgo", 23:52:30 INFO - "buildnumber": 185, 23:52:30 INFO - "slavename": "talos-linux64-ix-021", 23:52:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:52:30 INFO - "platform": "ubuntu64_hw", 23:52:30 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 23:52:30 INFO - "branch": "b2g-inbound", 23:52:30 INFO - "repo_path": "integration/b2g-inbound", 23:52:30 INFO - "revision": "d68306ac604b0820b0ed22bc43115e0218f9e21e", 23:52:30 INFO - "stage_platform": "linux64-pgo", 23:52:30 INFO - "builduid": "199a45c9033d4ac187d4cf395be87ee5", 23:52:30 INFO - "slavebuilddir": "test" 23:52:30 INFO - } 23:52:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/foMZbRa3RFq5ihBLI1UBQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 23:52:30 INFO - Running post-action listener: _resource_record_post_action 23:52:30 INFO - ##### 23:52:30 INFO - ##### Running download-and-extract step. 23:52:30 INFO - ##### 23:52:30 INFO - Running pre-action listener: _resource_record_pre_action 23:52:30 INFO - Running main action method: download_and_extract 23:52:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 23:52:30 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')]} 23:52:30 INFO - https://queue.taskcluster.net/v1/task/foMZbRa3RFq5ihBLI1UBQA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:52:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foMZbRa3RFq5ihBLI1UBQA/artifacts/public/build/test_packages.json 23:52:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foMZbRa3RFq5ihBLI1UBQA/artifacts/public/build/test_packages.json 23:52:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foMZbRa3RFq5ihBLI1UBQA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 23:52:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foMZbRa3RFq5ihBLI1UBQA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 23:52:32 INFO - Downloaded 1302 bytes. 23:52:32 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 23:52:32 INFO - Using the following test package requirements: 23:52:32 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:52:32 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:52:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:52:32 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:52:32 INFO - u'jsshell-linux-x86_64.zip'], 23:52:32 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:52:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:52:32 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:52:32 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:52:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:52:32 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:52:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:52:32 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:52:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:52:32 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:52:32 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:52:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:52:32 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:52:32 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')]} 23:52:32 INFO - https://queue.taskcluster.net/v1/task/foMZbRa3RFq5ihBLI1UBQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:52:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foMZbRa3RFq5ihBLI1UBQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:52:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foMZbRa3RFq5ihBLI1UBQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:52:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foMZbRa3RFq5ihBLI1UBQA/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 23:52:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foMZbRa3RFq5ihBLI1UBQA/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 23:52:33 INFO - Downloaded 24054411 bytes. 23:52:33 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 23:52:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:52:33 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 23:52:35 INFO - Return code: 0 23:52:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:35 INFO - https://queue.taskcluster.net/v1/task/foMZbRa3RFq5ihBLI1UBQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:52:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foMZbRa3RFq5ihBLI1UBQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:52:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foMZbRa3RFq5ihBLI1UBQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:52:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foMZbRa3RFq5ihBLI1UBQA/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 23:52:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foMZbRa3RFq5ihBLI1UBQA/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 23:52:40 INFO - Downloaded 24054411 bytes. 23:52:40 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 23:52:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:52:40 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 23:52:42 INFO - Return code: 0 23:52:42 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')]} 23:52:42 INFO - https://queue.taskcluster.net/v1/task/foMZbRa3RFq5ihBLI1UBQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:52:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foMZbRa3RFq5ihBLI1UBQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:52:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foMZbRa3RFq5ihBLI1UBQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:52:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foMZbRa3RFq5ihBLI1UBQA/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 23:52:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foMZbRa3RFq5ihBLI1UBQA/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 23:52:43 INFO - Downloaded 11132285 bytes. 23:52:43 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 23:52:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:52:43 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 23:52:43 INFO - Return code: 0 23:52: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')]} 23:52:43 INFO - https://queue.taskcluster.net/v1/task/foMZbRa3RFq5ihBLI1UBQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:52:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foMZbRa3RFq5ihBLI1UBQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:52:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foMZbRa3RFq5ihBLI1UBQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:52:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foMZbRa3RFq5ihBLI1UBQA/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 23:52:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foMZbRa3RFq5ihBLI1UBQA/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 23:52:44 INFO - Downloaded 55062989 bytes. 23:52:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/foMZbRa3RFq5ihBLI1UBQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:52:44 INFO - mkdir: /builds/slave/test-pgo/properties 23:52:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 23:52:44 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 23:52:44 INFO - Contents: 23:52:44 INFO - build_url:https://queue.taskcluster.net/v1/task/foMZbRa3RFq5ihBLI1UBQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:52:44 INFO - Running post-action listener: _resource_record_post_action 23:52:44 INFO - Running post-action listener: set_extra_try_arguments 23:52:44 INFO - ##### 23:52:44 INFO - ##### Running populate-webroot step. 23:52:44 INFO - ##### 23:52:44 INFO - Running pre-action listener: _resource_record_pre_action 23:52:44 INFO - Running main action method: populate_webroot 23:52:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:52:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:52:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:52:44 INFO - '--tppagecycles', 23:52:44 INFO - '7'], 23:52:44 INFO - 'tests': ['tsvgm']}}, 23:52:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:52:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:52:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:52:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:52:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:52:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:52:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:52:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:44 INFO - 'talos_options': ['--e10s'], 23:52:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:52:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:44 INFO - 'tests': ['damp', 'tps']}, 23:52:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:44 INFO - 'talos_options': ['--e10s'], 23:52:44 INFO - 'tests': ['damp', 'tps']}, 23:52:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:52:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:52:44 INFO - 'other': {'tests': ['a11yr', 23:52:44 INFO - 'ts_paint', 23:52:44 INFO - 'tpaint', 23:52:44 INFO - 'sessionrestore', 23:52:44 INFO - 'sessionrestore_no_auto_restore']}, 23:52:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:52:44 INFO - 'tests': ['a11yr', 23:52:44 INFO - 'ts_paint', 23:52:44 INFO - 'tpaint', 23:52:44 INFO - 'sessionrestore', 23:52:44 INFO - 'sessionrestore_no_auto_restore']}, 23:52:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:52:44 INFO - 'tests': ['a11yr', 23:52:44 INFO - 'ts_paint', 23:52:44 INFO - 'tpaint', 23:52:44 INFO - 'sessionrestore', 23:52:44 INFO - 'sessionrestore_no_auto_restore']}, 23:52:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:52:44 INFO - 'tests': ['a11yr', 23:52:44 INFO - 'ts_paint', 23:52:44 INFO - 'tpaint', 23:52:44 INFO - 'sessionrestore', 23:52:44 INFO - 'sessionrestore_no_auto_restore']}, 23:52:44 INFO - 'other_l64': {'tests': ['a11yr', 23:52:44 INFO - 'ts_paint', 23:52:44 INFO - 'tpaint', 23:52:44 INFO - 'sessionrestore', 23:52:44 INFO - 'sessionrestore_no_auto_restore']}, 23:52:44 INFO - 'other_nol64': {'tests': ['a11yr', 23:52:44 INFO - 'ts_paint', 23:52:44 INFO - 'tpaint', 23:52:44 INFO - 'sessionrestore', 23:52:44 INFO - 'sessionrestore_no_auto_restore']}, 23:52:44 INFO - 'svgr': {'tests': ['tsvgx', 23:52:44 INFO - 'tsvgr_opacity', 23:52:44 INFO - 'tart', 23:52:44 INFO - 'tscrollx', 23:52:44 INFO - 'cart']}, 23:52:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:52:44 INFO - 'tests': ['tsvgx', 23:52:44 INFO - 'tsvgr_opacity', 23:52:44 INFO - 'tart', 23:52:44 INFO - 'tscrollx', 23:52:44 INFO - 'cart']}, 23:52:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:44 INFO - 'tests': ['tp5o']}, 23:52:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:44 INFO - 'talos_options': ['--e10s'], 23:52:44 INFO - 'tests': ['tp5o']}, 23:52:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:44 INFO - 'talos_options': ['--xperf_path', 23:52:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:52:44 INFO - 'tests': ['tp5n']}, 23:52:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:44 INFO - 'talos_options': ['--e10s', 23:52:44 INFO - '--xperf_path', 23:52:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:52:44 INFO - 'tests': ['tp5n']}}, 23:52:44 INFO - 'talos.zip': {'path': '', 23:52:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:52:44 INFO - Running post-action listener: _resource_record_post_action 23:52:44 INFO - ##### 23:52:44 INFO - ##### Running create-virtualenv step. 23:52:44 INFO - ##### 23:52:44 INFO - Running pre-action listener: _resource_record_pre_action 23:52:44 INFO - Running main action method: create_virtualenv 23:52:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 23:52:44 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 23:52:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 23:52:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:52:44 INFO - Using real prefix '/usr' 23:52:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 23:52:45 INFO - Installing distribute.............................................................................................................................................................................................done. 23:52:47 INFO - Installing pip.................done. 23:52:47 INFO - Return code: 0 23:52:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 23:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f35ab500f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1633840>, '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 0x15a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a0b60>, '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': 'df17445c3590ff7897617a0e00000225-1452064427.577279-410307445', '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 23:52:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 23:52:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:52:47 INFO - Using env: {'DISPLAY': ':0', 23:52:47 INFO - 'HOME': '/home/cltbld', 23:52:47 INFO - 'LANG': 'en_US.UTF-8', 23:52:47 INFO - 'LANGUAGE': 'en_US:en', 23:52:47 INFO - 'LOGNAME': 'cltbld', 23:52:47 INFO - 'MAIL': '/var/mail/cltbld', 23:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:47 INFO - 'MOZ_NO_REMOTE': '1', 23:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:47 INFO - 'NO_EM_RESTART': '1', 23:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:52:47 INFO - 'PWD': '/builds/slave/test-pgo', 23:52:47 INFO - 'SHELL': '/bin/bash', 23:52:47 INFO - 'SHLVL': '1', 23:52:47 INFO - 'TERM': 'linux', 23:52:47 INFO - 'TMOUT': '86400', 23:52:47 INFO - 'USER': 'cltbld', 23:52:47 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452064427.577279-410307445', 23:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:47 INFO - '_': '/tools/buildbot/bin/python'} 23:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:52:47 INFO - Cleaning up... 23:52:47 INFO - Return code: 0 23:52:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 23:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f35ab500f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1633840>, '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 0x15a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a0b60>, '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': 'df17445c3590ff7897617a0e00000225-1452064427.577279-410307445', '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 23:52:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 23:52:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 23:52:47 INFO - Using env: {'DISPLAY': ':0', 23:52:47 INFO - 'HOME': '/home/cltbld', 23:52:47 INFO - 'LANG': 'en_US.UTF-8', 23:52:47 INFO - 'LANGUAGE': 'en_US:en', 23:52:47 INFO - 'LOGNAME': 'cltbld', 23:52:47 INFO - 'MAIL': '/var/mail/cltbld', 23:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:47 INFO - 'MOZ_NO_REMOTE': '1', 23:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:47 INFO - 'NO_EM_RESTART': '1', 23:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:52:47 INFO - 'PWD': '/builds/slave/test-pgo', 23:52:47 INFO - 'SHELL': '/bin/bash', 23:52:47 INFO - 'SHLVL': '1', 23:52:47 INFO - 'TERM': 'linux', 23:52:47 INFO - 'TMOUT': '86400', 23:52:47 INFO - 'USER': 'cltbld', 23:52:47 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452064427.577279-410307445', 23:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:47 INFO - '_': '/tools/buildbot/bin/python'} 23:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:47 INFO - Downloading/unpacking psutil>=0.7.1 23:52:47 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 23:52:47 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 23:52:47 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 23:52:47 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 23:52:47 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 23:52:47 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 23:52:49 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 23:52:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 23:52:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 23:52:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:52:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:52:49 INFO - Installing collected packages: psutil 23:52:49 INFO - Running setup.py install for psutil 23:52:49 INFO - building 'psutil._psutil_linux' extension 23:52:49 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 23:52:49 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 23:52:49 INFO - building 'psutil._psutil_posix' extension 23:52:49 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 23:52:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:52:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:52:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:52:50 INFO - Successfully installed psutil 23:52:50 INFO - Cleaning up... 23:52:50 INFO - Return code: 0 23:52:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 23:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f35ab500f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1633840>, '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 0x15a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a0b60>, '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': 'df17445c3590ff7897617a0e00000225-1452064427.577279-410307445', '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 23:52:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 23:52:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 23:52:50 INFO - Using env: {'DISPLAY': ':0', 23:52:50 INFO - 'HOME': '/home/cltbld', 23:52:50 INFO - 'LANG': 'en_US.UTF-8', 23:52:50 INFO - 'LANGUAGE': 'en_US:en', 23:52:50 INFO - 'LOGNAME': 'cltbld', 23:52:50 INFO - 'MAIL': '/var/mail/cltbld', 23:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:50 INFO - 'MOZ_NO_REMOTE': '1', 23:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:50 INFO - 'NO_EM_RESTART': '1', 23:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:52:50 INFO - 'PWD': '/builds/slave/test-pgo', 23:52:50 INFO - 'SHELL': '/bin/bash', 23:52:50 INFO - 'SHLVL': '1', 23:52:50 INFO - 'TERM': 'linux', 23:52:50 INFO - 'TMOUT': '86400', 23:52:50 INFO - 'USER': 'cltbld', 23:52:50 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452064427.577279-410307445', 23:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:50 INFO - '_': '/tools/buildbot/bin/python'} 23:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:52:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 23:52:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:52:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:52:52 INFO - Installing collected packages: mozsystemmonitor 23:52:52 INFO - Running setup.py install for mozsystemmonitor 23:52:52 INFO - Successfully installed mozsystemmonitor 23:52:52 INFO - Cleaning up... 23:52:52 INFO - Return code: 0 23:52:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 23:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f35ab500f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1633840>, '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 0x15a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a0b60>, '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': 'df17445c3590ff7897617a0e00000225-1452064427.577279-410307445', '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 23:52:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 23:52:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:52:52 INFO - Using env: {'DISPLAY': ':0', 23:52:52 INFO - 'HOME': '/home/cltbld', 23:52:52 INFO - 'LANG': 'en_US.UTF-8', 23:52:52 INFO - 'LANGUAGE': 'en_US:en', 23:52:52 INFO - 'LOGNAME': 'cltbld', 23:52:52 INFO - 'MAIL': '/var/mail/cltbld', 23:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:52 INFO - 'MOZ_NO_REMOTE': '1', 23:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:52 INFO - 'NO_EM_RESTART': '1', 23:52:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:52:52 INFO - 'PWD': '/builds/slave/test-pgo', 23:52:52 INFO - 'SHELL': '/bin/bash', 23:52:52 INFO - 'SHLVL': '1', 23:52:52 INFO - 'TERM': 'linux', 23:52:52 INFO - 'TMOUT': '86400', 23:52:52 INFO - 'USER': 'cltbld', 23:52:52 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452064427.577279-410307445', 23:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:52 INFO - '_': '/tools/buildbot/bin/python'} 23:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:52 INFO - Downloading/unpacking blobuploader==1.2.4 23:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:54 INFO - Downloading blobuploader-1.2.4.tar.gz 23:52:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 23:52:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:52:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 23:52:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 23:52:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:54 INFO - Downloading docopt-0.6.1.tar.gz 23:52:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 23:52:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 23:52:54 INFO - Installing collected packages: blobuploader, requests, docopt 23:52:54 INFO - Running setup.py install for blobuploader 23:52:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:52:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 23:52:55 INFO - Running setup.py install for requests 23:52:55 INFO - Running setup.py install for docopt 23:52:55 INFO - Successfully installed blobuploader requests docopt 23:52:55 INFO - Cleaning up... 23:52:55 INFO - Return code: 0 23:52:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f35ab500f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1633840>, '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 0x15a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a0b60>, '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': 'df17445c3590ff7897617a0e00000225-1452064427.577279-410307445', '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 23:52:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 23:52:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:52:55 INFO - Using env: {'DISPLAY': ':0', 23:52:55 INFO - 'HOME': '/home/cltbld', 23:52:55 INFO - 'LANG': 'en_US.UTF-8', 23:52:55 INFO - 'LANGUAGE': 'en_US:en', 23:52:55 INFO - 'LOGNAME': 'cltbld', 23:52:55 INFO - 'MAIL': '/var/mail/cltbld', 23:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:55 INFO - 'MOZ_NO_REMOTE': '1', 23:52:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:55 INFO - 'NO_EM_RESTART': '1', 23:52:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:52:55 INFO - 'PWD': '/builds/slave/test-pgo', 23:52:55 INFO - 'SHELL': '/bin/bash', 23:52:55 INFO - 'SHLVL': '1', 23:52:55 INFO - 'TERM': 'linux', 23:52:55 INFO - 'TMOUT': '86400', 23:52:55 INFO - 'USER': 'cltbld', 23:52:55 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452064427.577279-410307445', 23:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:55 INFO - '_': '/tools/buildbot/bin/python'} 23:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:52:55 INFO - Running setup.py (path:/tmp/pip-Q52HT9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:52:55 INFO - Running setup.py (path:/tmp/pip-ul0oYi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:52:55 INFO - Running setup.py (path:/tmp/pip-tl88CB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:52:55 INFO - Running setup.py (path:/tmp/pip-gRj1l2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:52:56 INFO - Running setup.py (path:/tmp/pip-1IyNoo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:52:56 INFO - Running setup.py (path:/tmp/pip-VQMXHN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:52:56 INFO - Running setup.py (path:/tmp/pip-yiolrX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:52:56 INFO - Running setup.py (path:/tmp/pip-tRHbo6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:52:56 INFO - Running setup.py (path:/tmp/pip-GC0htI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:52:56 INFO - Running setup.py (path:/tmp/pip-nb6yyI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:52:56 INFO - Running setup.py (path:/tmp/pip-d95I9V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:52:56 INFO - Running setup.py (path:/tmp/pip-5hBSLN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:52:56 INFO - Running setup.py (path:/tmp/pip-bi6l67-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:52:56 INFO - Running setup.py (path:/tmp/pip-Y4nl10-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:52:56 INFO - Running setup.py (path:/tmp/pip-rdT5kV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:52:56 INFO - Running setup.py (path:/tmp/pip-9T9Inu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:52:56 INFO - Running setup.py (path:/tmp/pip-PI16nW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:52:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:52:57 INFO - Running setup.py install for manifestparser 23:52:57 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 23:52:57 INFO - Running setup.py install for mozcrash 23:52:57 INFO - Running setup.py install for mozdebug 23:52:57 INFO - Running setup.py install for mozdevice 23:52:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 23:52:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 23:52:57 INFO - Running setup.py install for mozfile 23:52:57 INFO - Running setup.py install for mozhttpd 23:52:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 23:52:57 INFO - Running setup.py install for mozinfo 23:52:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 23:52:57 INFO - Running setup.py install for mozInstall 23:52:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 23:52:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 23:52:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 23:52:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 23:52:57 INFO - Running setup.py install for mozleak 23:52:57 INFO - Running setup.py install for mozlog 23:52:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 23:52:58 INFO - Running setup.py install for moznetwork 23:52:58 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 23:52:58 INFO - Running setup.py install for mozprocess 23:52:58 INFO - Running setup.py install for mozprofile 23:52:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 23:52:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 23:52:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 23:52:58 INFO - Running setup.py install for mozrunner 23:52:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 23:52:58 INFO - Running setup.py install for mozscreenshot 23:52:58 INFO - Running setup.py install for moztest 23:52:58 INFO - Running setup.py install for mozversion 23:52:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 23:52:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:52:58 INFO - Cleaning up... 23:52:58 INFO - Return code: 0 23:52:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f35ab500f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1633840>, '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 0x15a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a0b60>, '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': 'df17445c3590ff7897617a0e00000225-1452064427.577279-410307445', '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 23:52:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 23:52:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 23:52:58 INFO - Using env: {'DISPLAY': ':0', 23:52:58 INFO - 'HOME': '/home/cltbld', 23:52:58 INFO - 'LANG': 'en_US.UTF-8', 23:52:58 INFO - 'LANGUAGE': 'en_US:en', 23:52:58 INFO - 'LOGNAME': 'cltbld', 23:52:58 INFO - 'MAIL': '/var/mail/cltbld', 23:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:58 INFO - 'MOZ_NO_REMOTE': '1', 23:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:58 INFO - 'NO_EM_RESTART': '1', 23:52:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:52:58 INFO - 'PWD': '/builds/slave/test-pgo', 23:52:58 INFO - 'SHELL': '/bin/bash', 23:52:58 INFO - 'SHLVL': '1', 23:52:58 INFO - 'TERM': 'linux', 23:52:58 INFO - 'TMOUT': '86400', 23:52:58 INFO - 'USER': 'cltbld', 23:52:58 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452064427.577279-410307445', 23:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:58 INFO - '_': '/tools/buildbot/bin/python'} 23:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:52:59 INFO - Running setup.py (path:/tmp/pip-oZXOua-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 23:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:52:59 INFO - Running setup.py (path:/tmp/pip-8unZb_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 23:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:52:59 INFO - Running setup.py (path:/tmp/pip-knewJw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 23:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:52:59 INFO - Running setup.py (path:/tmp/pip-eLT2Hw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:52:59 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)) 23:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:52:59 INFO - Running setup.py (path:/tmp/pip-C3DfEx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 23:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:52:59 INFO - Running setup.py (path:/tmp/pip-hj_j7O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 23:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:52:59 INFO - Running setup.py (path:/tmp/pip-scAUkQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 23:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:52:59 INFO - Running setup.py (path:/tmp/pip-__y2gy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 23:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:52:59 INFO - Running setup.py (path:/tmp/pip-xXxeNr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 23:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:52:59 INFO - Running setup.py (path:/tmp/pip-63TccD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:52:59 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)) 23:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:52:59 INFO - Running setup.py (path:/tmp/pip-WMMJsL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:52:59 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)) 23:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:52:59 INFO - Running setup.py (path:/tmp/pip-z1GXs7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:52:59 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)) 23:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:52:59 INFO - Running setup.py (path:/tmp/pip-xLLh7J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:52:59 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)) 23:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:52:59 INFO - Running setup.py (path:/tmp/pip-qZ9Q83-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 23:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:53:00 INFO - Running setup.py (path:/tmp/pip-95gTmg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 23:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:53:00 INFO - Running setup.py (path:/tmp/pip-ks0Bf0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 23:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:53:00 INFO - Running setup.py (path:/tmp/pip-BvifLi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 23:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 23:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 23:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 23:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 23:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 23:53:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 23:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:01 INFO - Downloading blessings-1.5.1.tar.gz 23:53:01 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 23:53:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 23:53:02 INFO - Installing collected packages: blessings 23:53:02 INFO - Running setup.py install for blessings 23:53:02 INFO - Successfully installed blessings 23:53:02 INFO - Cleaning up... 23:53:02 INFO - Return code: 0 23:53:02 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 23:53:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:53:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:53:02 INFO - Reading from file tmpfile_stdout 23:53:02 INFO - Current package versions: 23:53:02 INFO - argparse == 1.2.1 23:53:02 INFO - blessings == 1.5.1 23:53:02 INFO - blobuploader == 1.2.4 23:53:02 INFO - docopt == 0.6.1 23:53:02 INFO - manifestparser == 1.1 23:53:02 INFO - mozInstall == 1.12 23:53:02 INFO - mozcrash == 0.16 23:53:02 INFO - mozdebug == 0.1 23:53:02 INFO - mozdevice == 0.47 23:53:02 INFO - mozfile == 1.2 23:53:02 INFO - mozhttpd == 0.7 23:53:02 INFO - mozinfo == 0.9 23:53:02 INFO - mozleak == 0.1 23:53:02 INFO - mozlog == 3.1 23:53:02 INFO - moznetwork == 0.27 23:53:02 INFO - mozprocess == 0.22 23:53:02 INFO - mozprofile == 0.28 23:53:02 INFO - mozrunner == 6.11 23:53:02 INFO - mozscreenshot == 0.1 23:53:02 INFO - mozsystemmonitor == 0.0 23:53:02 INFO - moztest == 0.7 23:53:02 INFO - mozversion == 1.4 23:53:02 INFO - psutil == 3.1.1 23:53:02 INFO - requests == 1.2.3 23:53:02 INFO - wsgiref == 0.1.2 23:53:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f35ab500f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1633840>, '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 0x15a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a0b60>, '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': 'df17445c3590ff7897617a0e00000225-1452064427.577279-410307445', '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 23:53:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 23:53:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:53:02 INFO - Using env: {'DISPLAY': ':0', 23:53:02 INFO - 'HOME': '/home/cltbld', 23:53:02 INFO - 'LANG': 'en_US.UTF-8', 23:53:02 INFO - 'LANGUAGE': 'en_US:en', 23:53:02 INFO - 'LOGNAME': 'cltbld', 23:53:02 INFO - 'MAIL': '/var/mail/cltbld', 23:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:53:02 INFO - 'MOZ_NO_REMOTE': '1', 23:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:53:02 INFO - 'NO_EM_RESTART': '1', 23:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:53:02 INFO - 'PWD': '/builds/slave/test-pgo', 23:53:02 INFO - 'SHELL': '/bin/bash', 23:53:02 INFO - 'SHLVL': '1', 23:53:02 INFO - 'TERM': 'linux', 23:53:02 INFO - 'TMOUT': '86400', 23:53:02 INFO - 'USER': 'cltbld', 23:53:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452064427.577279-410307445', 23:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:53:02 INFO - '_': '/tools/buildbot/bin/python'} 23:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 23:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 23:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 23:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 23:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 23:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 23:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 23:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 23:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 23:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 23:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 23:53:02 INFO - Cleaning up... 23:53:02 INFO - Return code: 0 23:53:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 23:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f35ab500f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1633840>, '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 0x15a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a0b60>, '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': 'df17445c3590ff7897617a0e00000225-1452064427.577279-410307445', '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 23:53:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 23:53:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:53:02 INFO - Using env: {'DISPLAY': ':0', 23:53:02 INFO - 'HOME': '/home/cltbld', 23:53:02 INFO - 'LANG': 'en_US.UTF-8', 23:53:02 INFO - 'LANGUAGE': 'en_US:en', 23:53:02 INFO - 'LOGNAME': 'cltbld', 23:53:02 INFO - 'MAIL': '/var/mail/cltbld', 23:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:53:02 INFO - 'MOZ_NO_REMOTE': '1', 23:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:53:02 INFO - 'NO_EM_RESTART': '1', 23:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:53:02 INFO - 'PWD': '/builds/slave/test-pgo', 23:53:02 INFO - 'SHELL': '/bin/bash', 23:53:02 INFO - 'SHLVL': '1', 23:53:02 INFO - 'TERM': 'linux', 23:53:02 INFO - 'TMOUT': '86400', 23:53:02 INFO - 'USER': 'cltbld', 23:53:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452064427.577279-410307445', 23:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:53:02 INFO - '_': '/tools/buildbot/bin/python'} 23:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:53:02 INFO - Downloading/unpacking jsonschema 23:53:02 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 23:53:02 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 23:53:02 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 23:53:02 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 23:53:02 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 23:53:02 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 23:53:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:53:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 23:53:04 INFO - Downloading/unpacking functools32 (from jsonschema) 23:53: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 23:53: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 23:53: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 23:53: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 23:53: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 23:53: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 23:53:04 INFO - Downloading functools32-3.2.3-2.tar.gz 23:53:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 23:53:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 23:53:04 INFO - warning: no files found matching '*.txt' 23:53:04 INFO - no previously-included directories found matching 'build' 23:53:04 INFO - no previously-included directories found matching 'dist' 23:53:04 INFO - no previously-included directories found matching '.git*' 23:53:04 INFO - Installing collected packages: jsonschema, functools32 23:53:04 INFO - Running setup.py install for functools32 23:53:04 INFO - warning: no files found matching '*.txt' 23:53:04 INFO - no previously-included directories found matching 'build' 23:53:04 INFO - no previously-included directories found matching 'dist' 23:53:04 INFO - no previously-included directories found matching '.git*' 23:53:04 INFO - Successfully installed jsonschema functools32 23:53:04 INFO - Cleaning up... 23:53:04 INFO - Return code: 0 23:53:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 23:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:53:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:53:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:04 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 0x7f35ab500f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1633840>, '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 0x15a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a0b60>, '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': 'df17445c3590ff7897617a0e00000225-1452064427.577279-410307445', '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 23:53:04 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 23:53:04 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 23:53:04 INFO - Using env: {'DISPLAY': ':0', 23:53:04 INFO - 'HOME': '/home/cltbld', 23:53:04 INFO - 'LANG': 'en_US.UTF-8', 23:53:04 INFO - 'LANGUAGE': 'en_US:en', 23:53:04 INFO - 'LOGNAME': 'cltbld', 23:53:04 INFO - 'MAIL': '/var/mail/cltbld', 23:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:53:04 INFO - 'MOZ_NO_REMOTE': '1', 23:53:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:53:04 INFO - 'NO_EM_RESTART': '1', 23:53:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:53:04 INFO - 'PWD': '/builds/slave/test-pgo', 23:53:04 INFO - 'SHELL': '/bin/bash', 23:53:04 INFO - 'SHLVL': '1', 23:53:04 INFO - 'TERM': 'linux', 23:53:04 INFO - 'TMOUT': '86400', 23:53:04 INFO - 'USER': 'cltbld', 23:53:04 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452064427.577279-410307445', 23:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:53:04 INFO - '_': '/tools/buildbot/bin/python'} 23:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:53:05 INFO - Downloading/unpacking flake8 23:53: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 23:53: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 23:53: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 23:53: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 23:53: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 23:53: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 23:53:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:53:06 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 23:53:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:53: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 23:53: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 23:53: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 23:53: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 23:53: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 23:53: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 23:53:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:53:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 23:53:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 23:53:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 23:53:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 23:53:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:53:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:53:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:53:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:53:07 INFO - no previously-included directories found matching 'docs/_build' 23:53:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:53:07 INFO - Running setup.py install for pep8 23:53:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:53:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:53:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:53:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:53:07 INFO - no previously-included directories found matching 'docs/_build' 23:53:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 23:53:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:53:07 INFO - Cleaning up... 23:53:07 INFO - Return code: 0 23:53:07 INFO - Running post-action listener: _resource_record_post_action 23:53:07 INFO - Running post-action listener: _start_resource_monitoring 23:53:07 INFO - Starting resource monitoring. 23:53:07 INFO - ##### 23:53:07 INFO - ##### Running install step. 23:53:07 INFO - ##### 23:53:07 INFO - Running pre-action listener: _resource_record_pre_action 23:53:07 INFO - Running main action method: install 23:53:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:53:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:53:08 INFO - Reading from file tmpfile_stdout 23:53:08 INFO - Detecting whether we're running mozinstall >=1.0... 23:53:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 23:53:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 23:53:08 INFO - Reading from file tmpfile_stdout 23:53:08 INFO - Output received: 23:53:08 INFO - Usage: mozinstall [options] installer 23:53:08 INFO - Options: 23:53:08 INFO - -h, --help show this help message and exit 23:53:08 INFO - -d DEST, --destination=DEST 23:53:08 INFO - Directory to install application into. [default: 23:53:08 INFO - "/builds/slave/test-pgo"] 23:53:08 INFO - --app=APP Application being installed. [default: firefox] 23:53:08 INFO - mkdir: /builds/slave/test-pgo/build/application 23:53:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 23:53:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 23:53:23 INFO - Reading from file tmpfile_stdout 23:53:23 INFO - Output received: 23:53:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 23:53:23 INFO - Running post-action listener: _resource_record_post_action 23:53:23 INFO - ##### 23:53:23 INFO - ##### Running run-tests step. 23:53:23 INFO - ##### 23:53:23 INFO - Running pre-action listener: _resource_record_pre_action 23:53:23 INFO - Running main action method: run_tests 23:53:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 23:53:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 23:53:23 INFO - Python 2.7.3 23:53:23 INFO - Return code: 0 23:53:23 INFO - grabbing minidump binary from tooltool 23:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:23 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 0x1633840>, '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 0x15a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a0b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 23:53:23 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 23:53:23 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 23:53:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:53:24 INFO - Return code: 0 23:53:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 23:53:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 23:53:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 23:53:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 23:53:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 23:53:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 23:53:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 23:53:24 INFO - Return code: 0 23:53:24 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/foMZbRa3RFq5ihBLI1UBQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 23:53:24 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/foMZbRa3RFq5ihBLI1UBQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 23:53:24 INFO - Using env: {'DISPLAY': ':0', 23:53:24 INFO - 'HOME': '/home/cltbld', 23:53:24 INFO - 'LANG': 'en_US.UTF-8', 23:53:24 INFO - 'LANGUAGE': 'en_US:en', 23:53:24 INFO - 'LOGNAME': 'cltbld', 23:53:24 INFO - 'MAIL': '/var/mail/cltbld', 23:53:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:53:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 23:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:53:24 INFO - 'MOZ_NO_REMOTE': '1', 23:53:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:53:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:53:24 INFO - 'NO_EM_RESTART': '1', 23:53:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:53:24 INFO - 'PWD': '/builds/slave/test-pgo', 23:53:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 23:53:24 INFO - 'SHELL': '/bin/bash', 23:53:24 INFO - 'SHLVL': '1', 23:53:24 INFO - 'TERM': 'linux', 23:53:24 INFO - 'TMOUT': '86400', 23:53:25 INFO - 'USER': 'cltbld', 23:53:25 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452064427.577279-410307445', 23:53:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:53:25 INFO - '_': '/tools/buildbot/bin/python'} 23:53:25 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/foMZbRa3RFq5ihBLI1UBQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 23:53:25 INFO - mozversion application_buildid: 20160105173008 23:53:25 INFO - mozversion application_changeset: d68306ac604b0820b0ed22bc43115e0218f9e21e 23:53:25 INFO - mozversion application_display_name: Nightly 23:53:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:53:25 INFO - mozversion application_name: Firefox 23:53:25 INFO - mozversion application_remotingname: firefox 23:53:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 23:53:25 INFO - mozversion application_vendor: Mozilla 23:53:25 INFO - mozversion application_version: 46.0a1 23:53:25 INFO - mozversion platform_buildid: 20160105173008 23:53:25 INFO - mozversion platform_changeset: d68306ac604b0820b0ed22bc43115e0218f9e21e 23:53:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 23:53:25 INFO - mozversion platform_version: 46.0a1 23:53:25 INFO - using testdate: 1452066805 23:53:25 INFO - actual date: 1452066805 23:53:25 INFO - starting webserver on 'localhost:41602' 23:53:25 INFO - SUITE-START | Running 3 tests 23:53:25 INFO - TEST-START | dromaeo_css 23:53:25 INFO - operating with platform_type : linux_ 23:53:25 INFO - Initialising browser for dromaeo_css test... 23:53:25 INFO - TEST-INFO | started process 14856 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpA43veK/profile http://localhost:41602/getInfo.html) 23:53:30 INFO - PROCESS | 14856 | __metrics Screen width/height:1600/1200 23:53:30 INFO - PROCESS | 14856 | colorDepth:24 23:53:30 INFO - PROCESS | 14856 | Browser inner width/height: 1024/697 23:53:30 INFO - PROCESS | 14856 | __metrics 23:53:30 INFO - PROCESS | 14856 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:53:30 INFO - PROCESS | 14856 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:53:31 INFO - TEST-INFO | 14856: exit 0 23:53:31 INFO - Browser initialized. 23:53:31 INFO - Running cycle 1/1 for dromaeo_css test... 23:53:31 INFO - TEST-INFO | started process 14951 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpA43veK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:53:43 INFO - PROCESS | 14951 | RSS: Main: 149663744 23:53:43 INFO - PROCESS | 14951 | 23:54:34 INFO - PROCESS | 14951 | 1452066874666 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] 23:56:42 INFO - PROCESS | 14951 | Cycle 1(1): loaded http://localhost:41602/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41602/tests/dromaeo/cssquery-ext.html) 23:56:44 INFO - PROCESS | 14951 | RSS: Main: 267390976 23:56:44 INFO - PROCESS | 14951 | 23:59:46 INFO - PROCESS | 14951 | Cycle 1(1): loaded http://localhost:41602/tests/dromaeo/cssquery-ext.html (next: http://localhost:41602/tests/dromaeo/cssquery-jquery.html) 23:59:46 INFO - PROCESS | 14951 | RSS: Main: 229822464 23:59:46 INFO - PROCESS | 14951 | 00:02:48 INFO - PROCESS | 14951 | Cycle 1(1): loaded http://localhost:41602/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41602/tests/dromaeo/cssquery-mootools.html) 00:02:49 INFO - PROCESS | 14951 | RSS: Main: 223318016 00:02:49 INFO - PROCESS | 14951 | 00:05:51 INFO - PROCESS | 14951 | Cycle 1(1): loaded http://localhost:41602/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41602/tests/dromaeo/cssquery-prototype.html) 00:05:52 INFO - PROCESS | 14951 | RSS: Main: 206295040 00:05:52 INFO - PROCESS | 14951 | 00:08:54 INFO - PROCESS | 14951 | Cycle 1(1): loaded http://localhost:41602/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41602/tests/dromaeo/cssquery-yui.html) 00:08:55 INFO - PROCESS | 14951 | RSS: Main: 213561344 00:08:55 INFO - PROCESS | 14951 | 00:11:57 INFO - PROCESS | 14951 | Cycle 1(1): loaded http://localhost:41602/tests/dromaeo/cssquery-yui.html (next: http://localhost:41602/tests/dromaeo/cssquery-dojo.html) 00:11:57 INFO - PROCESS | 14951 | RSS: Main: 238669824 00:11:57 INFO - PROCESS | 14951 | 00:11:57 INFO - PROCESS | 14951 | __start_tp_report 00:11:57 INFO - PROCESS | 14951 | _x_x_mozilla_page_load 00:11:57 INFO - PROCESS | 14951 | _x_x_mozilla_page_load_details 00:11:57 INFO - PROCESS | 14951 | |i|pagename|runs| 00:11:57 INFO - PROCESS | 14951 | |0;dojo.html;3055.6027716396866;3087.1818967973477;3127.0306205076427;3131.0137306748356;3158;5016.924746128801;5140.794368225271;5143.125668636331;5152.793888244466;5210.791568337267;5109.310243117178;5168.22476628506;5172.586193104552;5238.240455134013;5293.126634105368;4636.281376386657;4662.160811054009;4667.089917466095;4672.462666793328;4792.7124372537755;4784.091022705692;4786.664933454659;4823.855284341458;4836.637252206081;4871.1962526183315;4672.088942656166;4691.085238378518;4741.407324084489;4760.642951778613;4774.80900763969;4753.239481682914;4753.524647535253;4766.856994290177;4777.976110119427;4813.326134341195;4739.597134243559;4745.240761478147;4746.952530474686;4763.190257656207;4781.521847815191;4894.486078961693;4960.553550180501;4996.400431948153;5012.899742005139;5066.493350664904;5595.636283641591;5597.74810133545;5602.159676048625;5607.8878422431735;5610.663360198401;5602.327720673505;5616.550675945915;5617.915731264035;5619.044762390404;5621.8756248750005;5108.106081435771;5140.768665410065;5213.3743950725775;5213.687178769286;5268.81559145428;5685.260916080966;5718.942810571841;5719.5996280260815;5721.742521586455;5766.019776637898;5475.890482190334;5480.890382192334;5496.285482887279;5502;5508;5384.057789886754;5486.039943009957;5486.506214440719;5510;5644.040513112781;5513.173024046425;5516.889662206813;5525.696086715189;5527.419620939824;5528.668279903219;5544.500994910478;5544.833654990357;5547.140193270049;5548.0845660466375;5550.389457159709;4261.147770445923;4331.198728235287;4381.802818873159;4398.8020539075815;4428.269335559597;3892.9878231659404;3913.8434462621744;3915.197384536163;3944.6055394460323;3955.3275943089743;5191.402988656353;5222.817201397933;5236.607254455931;5238.319018527567;5284.233786100994;5461.344638643388;5503.972480137573;5570.610057296031;5577.6653400796085;5615.971920140373;5129.589632829365;5141.820036298712;5151.484851514819;5152.407473140562;5154.252633368141;4752.809887604457;4753.809847606126;4755.310479980383;4757.310190022427;4799.1601469743355;5641.887162256732;5726.284214473191;5756.94243057564;5768.221290125864;5814.5639077068545;5570.3315602128005;5590.329160500766;5595.328560572757;5597.3003374578175;5599.60802743804;5629.802956896489;5783.624064435799;5808.912866306924;5814.970925145516;5823.126531020381;5395.163749618815;5439.755211015593;5441.102218133963;5510.752016159202;5558.638688485397;5599.552035837205;5618.4662457066515;5619.943800561942;5620.100783874561;5637.661740295595;5261.921071184011;5441.428649991693;5501.422350653123;5502.202180683858;5564.026295398208;5414.160805075219;5437.619366644297;5475.397706252229;5488.588355873246;5533.418991005887;5354.277172581652;5359.732013399236;5362.865928351823;5367.114426119647;5372.892542149213;5389.380221274603;5437.4018857926385;5452.154915988028;5461.017016936989;5522.22688823557;5337.759800809051;5413.025655382069;5413.269208656781;5418.945810541844;5460.290162278879 00:11:57 INFO - PROCESS | 14951 | |1;ext.html;516.4293455731419;550.8677917299847;597.859503016791;601.2004034633936;602.4337123104282;28683.426331473358;36283.63716362836;37276.44085338722;37331.44002839959;37339.62660373395;39792.40311395331;40452;40528.79735601325;40600.79699601498;40680.18639627213;7445.925540744604;7544.547327160388;8498.490090594583;8730.51982140982;8752;10204.132648724868;10385.84421233682;10386.428746418944;10409.21930855185;10426.374417534973;10195.082442580166;10197.796044079114;10237;10321.793564128713;10325.296326106183;7651.6939322427315;7828.804279893048;7843.098043724987;10029.849552256723;10227.130693891027;9981.251406144569;10122;10122.29143959923;10129.594816207344;10130.797384052352;36970;37016.444753328724;37398.8130059348;37481.62518374809;37518.06204844901;3030.3030303030337;3168.413843438971;3389.7288216942834;3742.120601658635;3963.128111815396;28704;28920;31551.21121971969;31705;31730.841345793353;3905.1994341159993;3949.7630142191274;3992.5208974922903;4068.816903239361;4108.650764685005;271353;272651;274007;274500.999999998;275218;59363.70318148382;60094;60136;60155.39844601498;60270;49308.26037609439;56937.43062569404;57912.4208757907;65291.34708652853;66859.33140668628;14781.92609036948;14916.850831491764;14994.850051499563;15001.624959376102;15004.924975375054;11160.776784464428;11215.43922803873;11216.214864959375;11217;11223.326600404002;19388.321408750628;20277.79722202759;20286.69569956452;20328.796712032985;20412.285570004977;7306.525075870051;7517.436192285601;7564.50830696003;7577.5453472791805;7627.389808815282;893.3389291923929;934.5794392523255;993.5677980078689;1093.2511229807608;1145.381493993251;28824.42351152965;30109.849450752605;30731.692683073332;31381.372372552876;31585.210369740482;976.5019839881711;1030.701096681969;1037;1096.9067629251604;1104.9060829829393;13275.933620331836;13993.440262389595;14092.929535352463;14220;14258.215798130996;311049;315532;315626;315857;316137;53298;53564.196537051976;53598.46401536013;53612;53622.195667065025;1352.5333759852836;1358.8641135886332;1377.1117629129155;1379.5654368873772;1385.0512399006714;25563.23310300694;26657;26986.32534186661;27047.1885843425;27106.72893271121;43975.340369893835;44498;44533;44597.33104003378;44599.10801784011;285006;288319;292065;294079;296550;30140.547891781203;30260.69739302579;30431.391372172875;30434;30904;42762;43410.34884476672;43570.56429435665;44049;44684;36294.455583166804;36340;37059.81470092632;37125.25749485049;38992.80503597464;34572.19705832306;34766.30467390689;35472;35564.28871422609;35951.02269375209;34270;35306.823465883535;35377.82311088428;35379;35431.64568354283;29266.853665731534;32164.678353216168;32414;32706.672933271315;32745.34509309848;24083.298295946104;24583.754162458146;24711.62932555977;24851.87574062118;24880.75119248784 00:11:57 INFO - PROCESS | 14951 | |2;jquery.html;348.6966339284824;351.49033900843784;352.68434750897944;353.1013570463171;355.5200479352874;14011.159330440156;14450.710985780304;15968.76046859298;16229.513114606565;16721.832781672165;14534.709305813878;14789.482368117118;15479.92260038701;15517.689646207098;15546.06723596585;5219.660722053073;5298.337707786527;5327.547158491533;5338.119210330291;5342.893142137174;3427.0746898337434;3516.7186625069935;5282.683039017652;5299;5423.755930983115;5360.9463905361035;5387.515123638872;5388.030154572176;5411.756470958797;5414.214938833867;5268.394134674523;5391.16436952273;5407.432219616923;5411.567074634039;5420.430854760233;5154.896902061938;5181.559567436772;5194.0391027659625;5201.427842937273;5203.271541984125;13392.263425511594;13396.5311214108;13433.261170635611;14820.629484262872;15868.52394428169;2048.7848775878465;2090.571432856276;2100.8634438761433;2119.6608542633103;2152.9261846796057;9369.53152342387;9413.811723765486;9527.666531671359;11473.655790326304;13004.479820807252;1858.50749551369;1871.5040514263594;1885.5097674604565;1888.688366419553;1915.6839121544929;56613.71693141549;58857.41142588519;58973.70513147407;59005.11492327618;59981.7000914997;9835.360701554377;9918.652847150315;9962.750931226778;10022.198224142052;10036.397816131055;13051.738965220642;13094.803577946339;13095.476180952655;13111.475540978254;13128.737425251633;7490.6629201686055;7549.849003020019;7569.356604688553;7579.1662917079075;7605.543667379975;7312.926870731225;7372.373348265458;7415.777526674208;7419.332260096618;7433.293837085468;4319.3952846601505;4353.151135528541;4365.847195348148;4410.823567057346;4423.579759922803;1695.118538360046;1735.2104792319465;1743.1371471121877;1754.5262779049585;1768.8850224735352;820.8891799607096;907.9863802042975;938.4791440750449;997.571044450893;1032.6643840751785;15323.923380383027;15722.606934826721;16431;17154.914225429042;17431.215595298243;881.7046289493092;895.8163576466809;935.7941252924346;962.9374090684223;966.5602151021268;9097.49963752;9178.908210917938;9199.816003680024;9248.213901818286;9327.160555549897;546375;547773;552477;577505;580136;40840.79579602083;68550.62898741997;78308;79154.6042269785;81190.59404702939;1121.0919155484085;1127.565887133443;1152.1589239854786;1163.2962057954815;1166.0438440478895;14418.567442976728;14434.206118663154;14660.486882959472;14744.926275368554;14860.479883204036;32901.83549082239;33733;33785.83107084449;34051.65948340584;34395;46746.29880551862;47925.520744792106;48148;48321.51678483311;48755;9527.38072025316;9555.474448905377;9634.181094606756;9739.9026009739;9814.165795907427;11832.230904991147;11894.940525297317;12008.939955300168;13986.300684965914;17865.28538858431;11372.772544549229;11492.655220343404;11737.823932640846;13548.72902541924;14313.499027533986;14036.157830530201;14088.506902258372;14344.56966291013;14683.41266349334;14752.63118422005;11569.247998880046;13691.24698141572;14542.200178990257;14543.200123993282;14957.626059348604;9202.585883635118;9685.757856053655;9699.078587534173;9863.358881672668;9882.357646752938;10649.467526623794;10716.142708583138;13948.651283717989;14564.563063108124;15111.093334399971 00:11:57 INFO - PROCESS | 14951 | |3;mootools.html;1390.1033833177598;1403.4245959156747;1496.2668292536653;1686.3760408648802;1705.1474262868567;6349.39680730331;6425.9678701606545;7340.669669864856;7619.657115429805;7633.5038222515495;6740.427063699579;6779.084823548819;6860.622665753382;6864.9656751716175;6881.9311806881915;2151.4298710841676;2172.6306527890297;2181.454636340915;2182.181681869299;2182.9890850545803;1986.5728868293313;2025.7467816522935;2183.6287831068757;2208.205046183373;2228.9888550557225;2149.978500215001;2159.9352019439443;2173.0330003148606;2176.09691977829;2179.1065663078143;2171.967420488686;2193.846430749848;2195.747489038765;2196.53872686736;2199.802017818396;2183.355910006536;2196.527746534503;2240.7311122665383;2241.820654347648;2254.5265494246228;7366.484346095775;7466.738664146783;7523.0972283326355;7545.849083018364;7548.169701332849;4413.360062790877;4472.038511719996;4499.550044995474;4518.683692141552;4519.954800451987;2937.764978801712;2959.5708622249654;3005.1885990782584;3007.1429642551766;3026.394721055776;991.5736233419626;991.9057689519484;1003.413003393016;1017.8015287019034;1038.9740256493649;10167.661437869257;10210.591576336938;10241.385516868937;10264.89735102647;10274.434906080238;4142.275101857163;4223.303154979455;4268.957310426918;4273.1240095780295;4274.401583778274;8656.047834738174;8658.956705216433;8669.783255418664;8670.393072484865;8684.522351270614;4609.8156073757345;4624.352590637313;4626.629869610423;4630.953690463052;4652.930206046912;4187.330027195695;4234.894127646772;4234.9364759528635;4238.449001629769;4245.469316335458;3568.8572457101427;3648.616895226016;3658;3659.835307411173;3683.4658974448553;1038.4963292802984;1049.8267785815408;1150.2523359816187;1153.8903804138592;1167.8423412839159;992.0327680511443;1006.5571148694551;1006.8691070160978;1121.3496172220255;1332.9600111996656;6920.065791118235;6966;6987.406070483964;6992.54548454359;7003;1163.87197408285;1190.8213767934706;1216.2337727231788;1222.1872454817446;1222.9327386993623;5494.697791621499;5522.447755224445;5535.806246781424;5539.086050801653;5559.610827242135;8736.301095912311;8882.200601945857;8964.417312874642;8985.146411090936;9011.369204155646;8833.293336533063;8862.379633425728;8914;8928.330375221754;8940.955295223483;6928;7142.785716428515;7162.4628152888745;7182.784516464514;7202.459815513857;6956.686949087404;6998.475114366341;7036.050133231948;7043.36609705129;7147.606881621561;7455.142658594114;7643.656035478306;7812.218778122142;7816.53100813953;7828.099768526465;8417.957910210409;8536.317094632539;8559.871601926101;8577.614007369808;8580.742577722678;6542.574732642363;6693.799186024427;6740.595564266159;6742.93257067423;6760.459163266829;6443.226812782496;7317.963410182915;7336.889946650911;7341;7397.260273972775;6073.696315184135;6159.538034647509;6669.6665166740495;6689.26418094019;6765.492588055817;6487.059376390492;6554.8361290968105;6636.2700102987665;6659.300773418721;6770.8645827084165;6541.8691626166255;6607.636579988147;6614.966925165343;6619.304972977768;6622.536422450382;5959.7020148991505;5960.403959604005;6004.87990240184;6043.335233124265;6051.304100028553;6240.438360547572;6284.4972402206795;6296.968515157395;6299.811005669837;6305.40098690642 00:11:57 INFO - PROCESS | 14951 | |4;prototype.html;335.76999755167725;340.22768315922855;341.31736526946105;342.8679958216086;347.31578789784135;5706.315242170935;5765.567582431324;5766.567507436943;5778.191053252548;5818.709064546777;5608.46719561642;5772.3361813391475;5784.884302313962;5792.160136780164;5800.129980502927;4539.364488971547;4547.09058188362;4547.863564093066;4552.97723511382;4555.088982203556;4323.178596066738;4404.185225733249;4430.202563538562;4559.8404055858055;4588.334691469735;4502.032063106431;4508.752018638974;4513.526079761627;4526.909461810762;4552.248878934988;4527.818887244506;4531.682782205247;4534.886627834314;4535.274356103024;4545.272756359;4007.238624661305;4008.198360327946;4012.378081397388;4014.9397759033636;4023.114914718757;5393.19102134679;5527.806526771584;5532.474414930575;5537.197106419587;5561.5272701820395;5187.740612969336;5189.117849965515;5196.142636464979;5198.662086964335;5201.063808514466;5832.533397328246;6178.135061091451;6181.320054793969;6186.690665466754;6187.102870083858;4149.771762553059;4204.957950420488;4251.59609837065;4285.678574106923;4288.807003684841;6336.809895703136;6399.296077431479;6435.420812126931;6436.742530298782;6447.742090316382;4422.646188304928;4428.092241090569;4433.623142032963;4434.201843668106;4434.246178149722;4356.324769660708;4449.199144154083;4483.798229079699;4489.708168969072;4509.706869053501;5173.042987047408;5174.508421699932;5176.265950906413;5179.922301165486;5180;6188.566800324024;6217.285012223561;6220.377962203744;6225.875482490324;6231.532635052298;1570.4032467662216;1590.9124998124983;1591.013571585601;1592.4267263785027;1592.9362825487083;1052.3054783842626;1053.4522048534718;1061.9415932123807;1061.9893801062044;1076.1874784537624;5919.911201331984;5923.17075609415;5933.406659334119;5934.495567876779;5939.346671866091;6374.458171055512;6377.489800815923;6381.266154392211;6387.105805187278;6387.393197646216;5907.881842363128;5914.172015917775;5917.911231331534;5918.053111502139;5932.436418540232;3357.529945807589;3438.3123375325035;3440.8623655053516;3442.8106454145263;3444.5522082129164;6602.438792702674;6612.702428390734;6614.536982411185;6630.701618427182;6644.269130395653;6573.474122070223;6577.83555411109;6625.17185351831;6629.801105966829;6630.336966303331;6574.276829548746;6685.699143538553;6704.664766761643;6709.7651582194385;6710.966445167743;6159.384061593805;6326.936730632635;6357.586756860789;6407.967960160169;6427.903581446376;6208.937910620836;6278.215223097113;6376.872462550816;6377.7767778127545;6390.073439351361;6658.63377514222;6682.532222744361;6690.13028306317;6690.431313338421;6695.832604184934;4385.5175930646965;4423.756693381895;4464.977675111603;4466.218411777861;4467.374567560479;6450.677466126581;6453.225363025205;6457.5479716419395;6461.418472337512;6463.095166676575;6268.091126786499;6282.2147231596055;6286.119943207863;6286.497080233479;6290.119383286252;6137.96931015342;6256.937430625636;6269.96865015672;6273.592216505913;6274.811755647338;6139.785107521394;6149;6156.107364432043;6158;6170.691465426621;6298.0867774171575;6299.244090709144;6301.149344838388;6301.338359472189;6309.085182648582;6046.5767396281835;6147.84630384244;6151.907721384272;6157.84605384869;6171.290301615192 00:11:57 INFO - PROCESS | 14951 | |5;yui.html;789.490778447901;814.7555733280017;858.6350800909612;868.9478631282119;880.7930136417937;13207.537736179236;13533.932330338346;13551.322433878317;13594.456221751117;13596.388162532685;12108.93945530271;12215.450304736287;12219;12226;12233.755324893496;675.3179288918203;803.6704950970088;823.6993497373476;824.196408501709;824.9628766705513;582.141341521257;790.9604519774017;816.3061397811842;817.1134319263606;818.4761752478419;844.945078569894;859.1279850951289;861.4400639584289;865.3380164174412;867.6616119713317;705.1714235772972;713.3259070178683;851.476342049635;858.8582883824162;865.8744482050099;628.8647940692773;629.8803227386782;630.6373835044867;631.1006815288242;631.4853394483481;12878.227306361649;12937.223766573941;12937.288449135294;12938.87061129386;12971.41628626714;11209.887901121048;11501.482433290523;12555.246685198917;12592.811107833299;12855.678608034781;10163.260250216772;10315.123214526775;10384.94807525965;10524.210684198715;10662.413567253798;3512.3326567952263;3562.786232826039;3573.0710015396185;3586.3185994661194;3602.477640742104;44815.10369792586;44821.551784482064;44832;45007.099858002985;45087.09825803465;9825.557849896772;10206.183505319557;10265.692029239135;10549.103326217204;10583.788324233472;18426.262949481872;18441.262349506138;18457.5385615358;18541.258349665863;18551.72172417415;6931.792046238621;6960.408365288906;7169.7849064528145;7178.2103968563415;7181.389581885598;3485.4597537381746;3531.346700860349;3552.0764601203873;3909.159530700856;3942.6845852332317;2972.8810847566288;3004.7596192305;3005.248687828043;3011.1568760747027;3014.9397012059635;521.4368482039388;526.9420363759983;532.0609124894564;533.5358238332675;540.0710777462758;584.2696629213483;656.8620589676221;679.4700133895569;687.1342108942769;688.18793823288;7892.526448413114;7998.448062316327;8110.229528194812;8132.308753755879;8177.509349439053;499.8150684246779;657.0702456024671;688.370141320696;701.2080217404277;704.630069213667;3859.208862183246;3878.3212937735784;4054.959450405517;4096.815643296059;4144.44050053239;50334;56638.433615663314;57431.712841435525;57448.712756436784;57549;51251.711859764;52365;52599;52671.20993185105;52728.47271527236;45575.544244557794;46744.2988355175;47027.29459058117;47498.28752568714;48156.5184348152;8068.798280043045;8468.618912149092;8492.532910689724;8677.522736249566;8883.511406872683;32924.67075329216;33016.83491582623;33622.159446013065;33888.509011414506;34084.31831363408;45894.31158532558;46206.30690539712;46587.30119048149;46771.76614116908;46941.2958805625;10381.532831022772;10532.842007369742;10863.565457381615;11158.776824463628;11453.656390308304;12403.25580465175;12543.623691289276;12569.748605028031;12579.559715409916;12586.056045796418;10919.126469882549;11033.503492342703;11188.552457901593;11190.83213751778;11723.648290551297;10986.945065274622;11177.329360238411;11707.531698731955;11745.354005529778;11974.521019159136;10851.511681974487;10980.121590272918;11103.611373601885;11207.775844483227;11479.598214062467;9145.496997665192;9851.704448866545;9884.30809843304;10070.8489372658;10224.284300098921;7641.579713115832;7791.92208077912;8049.637766300413;8409.170371110433;9603.135717785433 00:11:57 INFO - PROCESS | 14951 | __end_tp_report 00:11:57 INFO - PROCESS | 14951 | __start_cc_report 00:11:57 INFO - PROCESS | 14951 | _x_x_mozilla_cycle_collect,947 00:11:57 INFO - PROCESS | 14951 | __end_cc_report 00:11:57 INFO - PROCESS | 14951 | __startTimestamp1452067917925__endTimestamp 00:11:57 INFO - PROCESS | 14951 | 00:11:57 INFO - PROCESS | 14951 | ------- Summary: start ------- 00:11:57 INFO - PROCESS | 14951 | Number of tests: 6 00:11:57 INFO - PROCESS | 14951 | 00:11:57 INFO - PROCESS | 14951 | [#0] dojo.html Cycles:165 Average:5172.71 Median:5384.06 stddev:563.42 (10.5%) stddev-sans-first:540.11 00:11:57 INFO - PROCESS | 14951 | Values: 3055.6 3087.2 3127.0 3131.0 3158.0 5016.9 5140.8 5143.1 5152.8 5210.8 5109.3 5168.2 5172.6 5238.2 5293.1 4636.3 4662.2 4667.1 4672.5 4792.7 4784.1 4786.7 4823.9 4836.6 4871.2 4672.1 4691.1 4741.4 4760.6 4774.8 4753.2 4753.5 4766.9 4778.0 4813.3 4739.6 4745.2 4747.0 4763.2 4781.5 4894.5 4960.6 4996.4 5012.9 5066.5 5595.6 5597.7 5602.2 5607.9 5610.7 5602.3 5616.6 5617.9 5619.0 5621.9 5108.1 5140.8 5213.4 5213.7 5268.8 5685.3 5718.9 5719.6 5721.7 5766.0 5475.9 5480.9 5496.3 5502.0 5508.0 5384.1 5486.0 5486.5 5510.0 5644.0 5513.2 5516.9 5525.7 5527.4 5528.7 5544.5 5544.8 5547.1 5548.1 5550.4 4261.1 4331.2 4381.8 4398.8 4428.3 3893.0 3913.8 3915.2 3944.6 3955.3 5191.4 5222.8 5236.6 5238.3 5284.2 5461.3 5504.0 5570.6 5577.7 5616.0 5129.6 5141.8 5151.5 5152.4 5154.3 4752.8 4753.8 4755.3 4757.3 4799.2 5641.9 5726.3 5756.9 5768.2 5814.6 5570.3 5590.3 5595.3 5597.3 5599.6 5629.8 5783.6 5808.9 5815.0 5823.1 5395.2 5439.8 5441.1 5510.8 5558.6 5599.6 5618.5 5619.9 5620.1 5637.7 5261.9 5441.4 5501.4 5502.2 5564.0 5414.2 5437.6 5475.4 5488.6 5533.4 5354.3 5359.7 5362.9 5367.1 5372.9 5389.4 5437.4 5452.2 5461.0 5522.2 5337.8 5413.0 5413.3 5418.9 5460.3 00:11:57 INFO - PROCESS | 14951 | 00:11:57 INFO - PROCESS | 14951 | [#1] ext.html Cycles:180 Average:46185.70 Median:31947.76 stddev:76709.35 (240.1%) stddev-sans-first:76847.90 00:11:57 INFO - PROCESS | 14951 | Values: 516.4 550.9 597.9 601.2 602.4 28683.4 36283.6 37276.4 37331.4 37339.6 39792.4 40452.0 40528.8 40600.8 40680.2 7445.9 7544.5 8498.5 8730.5 8752.0 10204.1 10385.8 10386.4 10409.2 10426.4 10195.1 10197.8 10237.0 10321.8 10325.3 7651.7 7828.8 7843.1 10029.8 10227.1 9981.3 10122.0 10122.3 10129.6 10130.8 36970.0 37016.4 37398.8 37481.6 37518.1 3030.3 3168.4 3389.7 3742.1 3963.1 28704.0 28920.0 31551.2 31705.0 31730.8 3905.2 3949.8 3992.5 4068.8 4108.7 271353.0 272651.0 274007.0 274501.0 275218.0 59363.7 60094.0 60136.0 60155.4 60270.0 49308.3 56937.4 57912.4 65291.3 66859.3 14781.9 14916.9 14994.9 15001.6 15004.9 11160.8 11215.4 11216.2 11217.0 11223.3 19388.3 20277.8 20286.7 20328.8 20412.3 7306.5 7517.4 7564.5 7577.5 7627.4 893.3 934.6 993.6 1093.3 1145.4 28824.4 30109.8 30731.7 31381.4 31585.2 976.5 1030.7 1037.0 1096.9 1104.9 13275.9 13993.4 14092.9 14220.0 14258.2 311049.0 315532.0 315626.0 315857.0 316137.0 53298.0 53564.2 53598.5 53612.0 53622.2 1352.5 1358.9 1377.1 1379.6 1385.1 25563.2 26657.0 26986.3 27047.2 27106.7 43975.3 44498.0 44533.0 44597.3 44599.1 285006.0 288319.0 292065.0 294079.0 296550.0 30140.5 30260.7 30431.4 30434.0 30904.0 42762.0 43410.3 43570.6 44049.0 44684.0 36294.5 36340.0 37059.8 37125.3 38992.8 34572.2 34766.3 35472.0 35564.3 35951.0 34270.0 35306.8 35377.8 35379.0 35431.6 29266.9 32164.7 32414.0 32706.7 32745.3 24083.3 24583.8 24711.6 24851.9 24880.8 00:11:57 INFO - PROCESS | 14951 | 00:11:57 INFO - PROCESS | 14951 | [#2] jquery.html Cycles:180 Average:28623.11 Median:354.31 stddev:91580.46 (25847.5%) stddev-sans-first:91812.75 00:11:57 INFO - PROCESS | 14951 | Values: 348.7 351.5 352.7 353.1 355.5 14011.2 14450.7 15968.8 16229.5 16721.8 14534.7 14789.5 15479.9 15517.7 15546.1 5219.7 5298.3 5327.5 5338.1 5342.9 3427.1 3516.7 5282.7 5299.0 5423.8 5360.9 5387.5 5388.0 5411.8 5414.2 5268.4 5391.2 5407.4 5411.6 5420.4 5154.9 5181.6 5194.0 5201.4 5203.3 13392.3 13396.5 13433.3 14820.6 15868.5 2048.8 2090.6 2100.9 2119.7 2152.9 9369.5 9413.8 9527.7 11473.7 13004.5 1858.5 1871.5 1885.5 1888.7 1915.7 56613.7 58857.4 58973.7 59005.1 59981.7 9835.4 9918.7 9962.8 10022.2 10036.4 13051.7 13094.8 13095.5 13111.5 13128.7 7490.7 7549.8 7569.4 7579.2 7605.5 7312.9 7372.4 7415.8 7419.3 7433.3 4319.4 4353.2 4365.8 4410.8 4423.6 1695.1 1735.2 1743.1 1754.5 1768.9 820.9 908.0 938.5 997.6 1032.7 15323.9 15722.6 16431.0 17154.9 17431.2 881.7 895.8 935.8 962.9 966.6 9097.5 9178.9 9199.8 9248.2 9327.2 546375.0 547773.0 552477.0 577505.0 580136.0 40840.8 68550.6 78308.0 79154.6 81190.6 1121.1 1127.6 1152.2 1163.3 1166.0 14418.6 14434.2 14660.5 14744.9 14860.5 32901.8 33733.0 33785.8 34051.7 34395.0 46746.3 47925.5 48148.0 48321.5 48755.0 9527.4 9555.5 9634.2 9739.9 9814.2 11832.2 11894.9 12008.9 13986.3 17865.3 11372.8 11492.7 11737.8 13548.7 14313.5 14036.2 14088.5 14344.6 14683.4 14752.6 11569.2 13691.2 14542.2 14543.2 14957.6 9202.6 9685.8 9699.1 9863.4 9882.4 10649.5 10716.1 13948.7 14564.6 15111.1 00:11:57 INFO - PROCESS | 14951 | 00:11:57 INFO - PROCESS | 14951 | [#3] mootools.html Cycles:180 Average:5219.52 Median:6047.32 stddev:2666.01 (44.1%) stddev-sans-first:2657.95 00:11:57 INFO - PROCESS | 14951 | Values: 1390.1 1403.4 1496.3 1686.4 1705.1 6349.4 6426.0 7340.7 7619.7 7633.5 6740.4 6779.1 6860.6 6865.0 6881.9 2151.4 2172.6 2181.5 2182.2 2183.0 1986.6 2025.7 2183.6 2208.2 2229.0 2150.0 2159.9 2173.0 2176.1 2179.1 2172.0 2193.8 2195.7 2196.5 2199.8 2183.4 2196.5 2240.7 2241.8 2254.5 7366.5 7466.7 7523.1 7545.8 7548.2 4413.4 4472.0 4499.6 4518.7 4520.0 2937.8 2959.6 3005.2 3007.1 3026.4 991.6 991.9 1003.4 1017.8 1039.0 10167.7 10210.6 10241.4 10264.9 10274.4 4142.3 4223.3 4269.0 4273.1 4274.4 8656.0 8659.0 8669.8 8670.4 8684.5 4609.8 4624.4 4626.6 4631.0 4652.9 4187.3 4234.9 4234.9 4238.4 4245.5 3568.9 3648.6 3658.0 3659.8 3683.5 1038.5 1049.8 1150.3 1153.9 1167.8 992.0 1006.6 1006.9 1121.3 1333.0 6920.1 6966.0 6987.4 6992.5 7003.0 1163.9 1190.8 1216.2 1222.2 1222.9 5494.7 5522.4 5535.8 5539.1 5559.6 8736.3 8882.2 8964.4 8985.1 9011.4 8833.3 8862.4 8914.0 8928.3 8941.0 6928.0 7142.8 7162.5 7182.8 7202.5 6956.7 6998.5 7036.1 7043.4 7147.6 7455.1 7643.7 7812.2 7816.5 7828.1 8418.0 8536.3 8559.9 8577.6 8580.7 6542.6 6693.8 6740.6 6742.9 6760.5 6443.2 7318.0 7336.9 7341.0 7397.3 6073.7 6159.5 6669.7 6689.3 6765.5 6487.1 6554.8 6636.3 6659.3 6770.9 6541.9 6607.6 6615.0 6619.3 6622.5 5959.7 5960.4 6004.9 6043.3 6051.3 6240.4 6284.5 6297.0 6299.8 6305.4 00:11:57 INFO - PROCESS | 14951 | 00:11:57 INFO - PROCESS | 14951 | [#4] prototype.html Cycles:180 Average:5201.55 Median:5870.21 stddev:1560.88 (26.6%) stddev-sans-first:1521.94 00:11:57 INFO - PROCESS | 14951 | Values: 335.8 340.2 341.3 342.9 347.3 5706.3 5765.6 5766.6 5778.2 5818.7 5608.5 5772.3 5784.9 5792.2 5800.1 4539.4 4547.1 4547.9 4553.0 4555.1 4323.2 4404.2 4430.2 4559.8 4588.3 4502.0 4508.8 4513.5 4526.9 4552.2 4527.8 4531.7 4534.9 4535.3 4545.3 4007.2 4008.2 4012.4 4014.9 4023.1 5393.2 5527.8 5532.5 5537.2 5561.5 5187.7 5189.1 5196.1 5198.7 5201.1 5832.5 6178.1 6181.3 6186.7 6187.1 4149.8 4205.0 4251.6 4285.7 4288.8 6336.8 6399.3 6435.4 6436.7 6447.7 4422.6 4428.1 4433.6 4434.2 4434.2 4356.3 4449.2 4483.8 4489.7 4509.7 5173.0 5174.5 5176.3 5179.9 5180.0 6188.6 6217.3 6220.4 6225.9 6231.5 1570.4 1590.9 1591.0 1592.4 1592.9 1052.3 1053.5 1061.9 1062.0 1076.2 5919.9 5923.2 5933.4 5934.5 5939.3 6374.5 6377.5 6381.3 6387.1 6387.4 5907.9 5914.2 5917.9 5918.1 5932.4 3357.5 3438.3 3440.9 3442.8 3444.6 6602.4 6612.7 6614.5 6630.7 6644.3 6573.5 6577.8 6625.2 6629.8 6630.3 6574.3 6685.7 6704.7 6709.8 6711.0 6159.4 6326.9 6357.6 6408.0 6427.9 6208.9 6278.2 6376.9 6377.8 6390.1 6658.6 6682.5 6690.1 6690.4 6695.8 4385.5 4423.8 4465.0 4466.2 4467.4 6450.7 6453.2 6457.5 6461.4 6463.1 6268.1 6282.2 6286.1 6286.5 6290.1 6138.0 6256.9 6270.0 6273.6 6274.8 6139.8 6149.0 6156.1 6158.0 6170.7 6298.1 6299.2 6301.1 6301.3 6309.1 6046.6 6147.8 6151.9 6157.8 6171.3 00:11:57 INFO - PROCESS | 14951 | 00:11:57 INFO - PROCESS | 14951 | [#5] yui.html Cycles:180 Average:13608.65 Median:45331.32 stddev:15839.90 (34.9%) stddev-sans-first:15855.09 00:11:57 INFO - PROCESS | 14951 | Values: 789.5 814.8 858.6 868.9 880.8 13207.5 13533.9 13551.3 13594.5 13596.4 12108.9 12215.5 12219.0 12226.0 12233.8 675.3 803.7 823.7 824.2 825.0 582.1 791.0 816.3 817.1 818.5 844.9 859.1 861.4 865.3 867.7 705.2 713.3 851.5 858.9 865.9 628.9 629.9 630.6 631.1 631.5 12878.2 12937.2 12937.3 12938.9 12971.4 11209.9 11501.5 12555.2 12592.8 12855.7 10163.3 10315.1 10384.9 10524.2 10662.4 3512.3 3562.8 3573.1 3586.3 3602.5 44815.1 44821.6 44832.0 45007.1 45087.1 9825.6 10206.2 10265.7 10549.1 10583.8 18426.3 18441.3 18457.5 18541.3 18551.7 6931.8 6960.4 7169.8 7178.2 7181.4 3485.5 3531.3 3552.1 3909.2 3942.7 2972.9 3004.8 3005.2 3011.2 3014.9 521.4 526.9 532.1 533.5 540.1 584.3 656.9 679.5 687.1 688.2 7892.5 7998.4 8110.2 8132.3 8177.5 499.8 657.1 688.4 701.2 704.6 3859.2 3878.3 4055.0 4096.8 4144.4 50334.0 56638.4 57431.7 57448.7 57549.0 51251.7 52365.0 52599.0 52671.2 52728.5 45575.5 46744.3 47027.3 47498.3 48156.5 8068.8 8468.6 8492.5 8677.5 8883.5 32924.7 33016.8 33622.2 33888.5 34084.3 45894.3 46206.3 46587.3 46771.8 46941.3 10381.5 10532.8 10863.6 11158.8 11453.7 12403.3 12543.6 12569.7 12579.6 12586.1 10919.1 11033.5 11188.6 11190.8 11723.6 10986.9 11177.3 11707.5 11745.4 11974.5 10851.5 10980.1 11103.6 11207.8 11479.6 9145.5 9851.7 9884.3 10070.8 10224.3 7641.6 7791.9 8049.6 8409.2 9603.1 00:11:57 INFO - PROCESS | 14951 | -------- Summary: end -------- 00:11:57 INFO - PROCESS | 14951 | 00:11:58 INFO - TEST-INFO | 14951: exit 0 00:11:58 INFO - TEST-OK | dromaeo_css | took 1113510ms 00:11:58 INFO - TEST-START | kraken 00:11:58 INFO - operating with platform_type : linux_ 00:11:58 INFO - Initialising browser for kraken test... 00:11:58 INFO - TEST-INFO | started process 15135 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH8OU3z/profile http://localhost:41602/getInfo.html) 00:12:02 INFO - PROCESS | 15135 | __metrics Screen width/height:1600/1200 00:12:02 INFO - PROCESS | 15135 | colorDepth:24 00:12:02 INFO - PROCESS | 15135 | Browser inner width/height: 1024/697 00:12:02 INFO - PROCESS | 15135 | __metrics 00:12:02 INFO - PROCESS | 15135 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 00:12:03 INFO - PROCESS | 15135 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:12:04 INFO - TEST-INFO | 15135: exit 0 00:12:04 INFO - Browser initialized. 00:12:04 INFO - Running cycle 1/1 for kraken test... 00:12:04 INFO - TEST-INFO | started process 15218 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH8OU3z/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:12:16 INFO - PROCESS | 15218 | RSS: Main: 150515712 00:12:16 INFO - PROCESS | 15218 | 00:12:18 INFO - PROCESS | 15218 | Cycle 1(1): loaded http://localhost:41602/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41602/tests/kraken/driver.html?testName=audio-beat-detection) 00:12:19 INFO - PROCESS | 15218 | RSS: Main: 186494976 00:12:19 INFO - PROCESS | 15218 | 00:12:21 INFO - PROCESS | 15218 | Cycle 1(1): loaded http://localhost:41602/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41602/tests/kraken/driver.html?testName=audio-dft) 00:12:22 INFO - PROCESS | 15218 | RSS: Main: 175669248 00:12:22 INFO - PROCESS | 15218 | 00:12:25 INFO - PROCESS | 15218 | Cycle 1(1): loaded http://localhost:41602/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41602/tests/kraken/driver.html?testName=audio-fft) 00:12:25 INFO - PROCESS | 15218 | RSS: Main: 159969280 00:12:25 INFO - PROCESS | 15218 | 00:12:27 INFO - PROCESS | 15218 | Cycle 1(1): loaded http://localhost:41602/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41602/tests/kraken/driver.html?testName=audio-oscillator) 00:12:28 INFO - PROCESS | 15218 | RSS: Main: 162549760 00:12:28 INFO - PROCESS | 15218 | 00:12:30 INFO - PROCESS | 15218 | Cycle 1(1): loaded http://localhost:41602/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41602/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:12:31 INFO - PROCESS | 15218 | RSS: Main: 163725312 00:12:31 INFO - PROCESS | 15218 | 00:12:33 INFO - PROCESS | 15218 | Cycle 1(1): loaded http://localhost:41602/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41602/tests/kraken/driver.html?testName=imaging-darkroom) 00:12:34 INFO - PROCESS | 15218 | RSS: Main: 165847040 00:12:34 INFO - PROCESS | 15218 | 00:12:37 INFO - PROCESS | 15218 | Cycle 1(1): loaded http://localhost:41602/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41602/tests/kraken/driver.html?testName=imaging-desaturate) 00:12:38 INFO - PROCESS | 15218 | RSS: Main: 164446208 00:12:38 INFO - PROCESS | 15218 | 00:12:41 INFO - PROCESS | 15218 | Cycle 1(1): loaded http://localhost:41602/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41602/tests/kraken/driver.html?testName=json-parse-financial) 00:12:41 INFO - PROCESS | 15218 | RSS: Main: 164954112 00:12:41 INFO - PROCESS | 15218 | 00:12:43 INFO - PROCESS | 15218 | Cycle 1(1): loaded http://localhost:41602/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41602/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:12:43 INFO - PROCESS | 15218 | RSS: Main: 179134464 00:12:43 INFO - PROCESS | 15218 | 00:12:45 INFO - PROCESS | 15218 | Cycle 1(1): loaded http://localhost:41602/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41602/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:12:46 INFO - PROCESS | 15218 | RSS: Main: 176451584 00:12:46 INFO - PROCESS | 15218 | 00:12:48 INFO - PROCESS | 15218 | Cycle 1(1): loaded http://localhost:41602/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41602/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:12:48 INFO - PROCESS | 15218 | RSS: Main: 181530624 00:12:48 INFO - PROCESS | 15218 | 00:12:51 INFO - PROCESS | 15218 | Cycle 1(1): loaded http://localhost:41602/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41602/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:12:51 INFO - PROCESS | 15218 | RSS: Main: 189583360 00:12:51 INFO - PROCESS | 15218 | 00:12:54 INFO - PROCESS | 15218 | Cycle 1(1): loaded http://localhost:41602/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41602/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:12:55 INFO - PROCESS | 15218 | RSS: Main: 187641856 00:12:55 INFO - PROCESS | 15218 | 00:12:56 INFO - PROCESS | 15218 | Cycle 1(1): loaded http://localhost:41602/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41602/tests/kraken/driver.html?testName=ai-astar) 00:12:57 INFO - PROCESS | 15218 | RSS: Main: 246743040 00:12:57 INFO - PROCESS | 15218 | 00:12:57 INFO - PROCESS | 15218 | __start_tp_report 00:12:57 INFO - PROCESS | 15218 | _x_x_mozilla_page_load 00:12:57 INFO - PROCESS | 15218 | _x_x_mozilla_page_load_details 00:12:57 INFO - PROCESS | 15218 | |i|pagename|runs| 00:12:57 INFO - PROCESS | 15218 | |0;ai-astar;110;110;105;109;110;111;100;110;109;109 00:12:57 INFO - PROCESS | 15218 | |1;audio-beat-detection;151;125;147;168;123;156;152;127;173;123 00:12:57 INFO - PROCESS | 15218 | |2;audio-dft;159;161;160;160;159;161;162;163;161;162 00:12:57 INFO - PROCESS | 15218 | |3;audio-fft;71;71;77;92;70;71;71;106;96;72 00:12:57 INFO - PROCESS | 15218 | |4;audio-oscillator;96;97;142;96;98;97;149;97;97;148 00:12:57 INFO - PROCESS | 15218 | |5;imaging-gaussian-blur;109;109;109;109;110;110;109;109;109;109 00:12:57 INFO - PROCESS | 15218 | |6;imaging-darkroom;145;147;145;145;144;146;145;148;146;146 00:12:57 INFO - PROCESS | 15218 | |7;imaging-desaturate;96;96;96;96;95;95;96;95;96;95 00:12:57 INFO - PROCESS | 15218 | |8;json-parse-financial;61;60;60;59;60;60;58;60;59;58 00:12:57 INFO - PROCESS | 15218 | |9;json-stringify-tinderbox;68;68;69;67;68;67;68;75;68;69 00:12:57 INFO - PROCESS | 15218 | |10;stanford-crypto-aes;85;85;85;92;86;93;85;86;86;87 00:12:57 INFO - PROCESS | 15218 | |11;stanford-crypto-ccm;117;119;119;122;123;128;119;116;126;116 00:12:57 INFO - PROCESS | 15218 | |12;stanford-crypto-pbkdf2;150;145;158;158;155;144;165;154;163;142 00:12:57 INFO - PROCESS | 15218 | |13;stanford-crypto-sha256-iterative;72;73;71;71;72;71;73;72;72;70 00:12:57 INFO - PROCESS | 15218 | __end_tp_report 00:12:57 INFO - PROCESS | 15218 | __start_cc_report 00:12:57 INFO - PROCESS | 15218 | _x_x_mozilla_cycle_collect,932 00:12:57 INFO - PROCESS | 15218 | __end_cc_report 00:12:57 INFO - PROCESS | 15218 | __startTimestamp1452067977102__endTimestamp 00:12:57 INFO - PROCESS | 15218 | 00:12:57 INFO - PROCESS | 15218 | ------- Summary: start ------- 00:12:57 INFO - PROCESS | 15218 | Number of tests: 14 00:12:57 INFO - PROCESS | 15218 | 00:12:57 INFO - PROCESS | 15218 | [#0] ai-astar Cycles:10 Average:108.30 Median:110.00 stddev:3.33 (3.0%) stddev-sans-first:3.48 00:12:57 INFO - PROCESS | 15218 | Values: 110.0 110.0 105.0 109.0 110.0 111.0 100.0 110.0 109.0 109.0 00:12:57 INFO - PROCESS | 15218 | 00:12:57 INFO - PROCESS | 15218 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:151.50 stddev:18.89 (12.5%) stddev-sans-first:19.89 00:12:57 INFO - PROCESS | 15218 | Values: 151.0 125.0 147.0 168.0 123.0 156.0 152.0 127.0 173.0 123.0 00:12:57 INFO - PROCESS | 15218 | 00:12:57 INFO - PROCESS | 15218 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.32 (0.8%) stddev-sans-first:1.22 00:12:57 INFO - PROCESS | 15218 | Values: 159.0 161.0 160.0 160.0 159.0 161.0 162.0 163.0 161.0 162.0 00:12:57 INFO - PROCESS | 15218 | 00:12:57 INFO - PROCESS | 15218 | [#3] audio-fft Cycles:10 Average:79.70 Median:71.50 stddev:13.22 (18.5%) stddev-sans-first:13.64 00:12:57 INFO - PROCESS | 15218 | Values: 71.0 71.0 77.0 92.0 70.0 71.0 71.0 106.0 96.0 72.0 00:12:57 INFO - PROCESS | 15218 | 00:12:57 INFO - PROCESS | 15218 | [#4] audio-oscillator Cycles:10 Average:111.70 Median:97.00 stddev:23.97 (24.7%) stddev-sans-first:24.74 00:12:57 INFO - PROCESS | 15218 | Values: 96.0 97.0 142.0 96.0 98.0 97.0 149.0 97.0 97.0 148.0 00:12:57 INFO - PROCESS | 15218 | 00:12:57 INFO - PROCESS | 15218 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 00:12:57 INFO - PROCESS | 15218 | Values: 109.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 109.0 109.0 00:12:57 INFO - PROCESS | 15218 | 00:12:57 INFO - PROCESS | 15218 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:1.16 (0.8%) stddev-sans-first:1.20 00:12:57 INFO - PROCESS | 15218 | Values: 145.0 147.0 145.0 145.0 144.0 146.0 145.0 148.0 146.0 146.0 00:12:57 INFO - PROCESS | 15218 | 00:12:57 INFO - PROCESS | 15218 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 00:12:57 INFO - PROCESS | 15218 | Values: 96.0 96.0 96.0 96.0 95.0 95.0 96.0 95.0 96.0 95.0 00:12:57 INFO - PROCESS | 15218 | 00:12:57 INFO - PROCESS | 15218 | [#8] json-parse-financial Cycles:10 Average:59.50 Median:60.00 stddev:0.97 (1.6%) stddev-sans-first:0.87 00:12:57 INFO - PROCESS | 15218 | Values: 61.0 60.0 60.0 59.0 60.0 60.0 58.0 60.0 59.0 58.0 00:12:57 INFO - PROCESS | 15218 | 00:12:57 INFO - PROCESS | 15218 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:68.00 stddev:2.31 (3.4%) stddev-sans-first:2.44 00:12:57 INFO - PROCESS | 15218 | Values: 68.0 68.0 69.0 67.0 68.0 67.0 68.0 75.0 68.0 69.0 00:12:57 INFO - PROCESS | 15218 | 00:12:57 INFO - PROCESS | 15218 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:86.00 stddev:2.98 (3.5%) stddev-sans-first:3.07 00:12:57 INFO - PROCESS | 15218 | Values: 85.0 85.0 85.0 92.0 86.0 93.0 85.0 86.0 86.0 87.0 00:12:57 INFO - PROCESS | 15218 | 00:12:57 INFO - PROCESS | 15218 | [#11] stanford-crypto-ccm Cycles:10 Average:120.50 Median:120.50 stddev:4.14 (3.4%) stddev-sans-first:4.20 00:12:57 INFO - PROCESS | 15218 | Values: 117.0 119.0 119.0 122.0 123.0 128.0 119.0 116.0 126.0 116.0 00:12:57 INFO - PROCESS | 15218 | 00:12:57 INFO - PROCESS | 15218 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.40 Median:156.50 stddev:7.97 (5.1%) stddev-sans-first:8.36 00:12:57 INFO - PROCESS | 15218 | Values: 150.0 145.0 158.0 158.0 155.0 144.0 165.0 154.0 163.0 142.0 00:12:57 INFO - PROCESS | 15218 | 00:12:57 INFO - PROCESS | 15218 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:72.00 stddev:0.95 (1.3%) stddev-sans-first:1.00 00:12:57 INFO - PROCESS | 15218 | Values: 72.0 73.0 71.0 71.0 72.0 71.0 73.0 72.0 72.0 70.0 00:12:57 INFO - PROCESS | 15218 | -------- Summary: end -------- 00:12:57 INFO - PROCESS | 15218 | 00:12:57 INFO - TEST-INFO | 15218: exit 0 00:12:58 INFO - TEST-OK | kraken | took 59312ms 00:12:58 INFO - TEST-START | v8_7 00:12:58 INFO - operating with platform_type : linux_ 00:12:58 INFO - Initialising browser for v8_7 test... 00:12:58 INFO - TEST-INFO | started process 15469 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFwfeCy/profile http://localhost:41602/getInfo.html) 00:13:02 INFO - PROCESS | 15469 | __metrics Screen width/height:1600/1200 00:13:02 INFO - PROCESS | 15469 | colorDepth:24 00:13:02 INFO - PROCESS | 15469 | Browser inner width/height: 1024/697 00:13:02 INFO - PROCESS | 15469 | __metrics 00:13:02 INFO - PROCESS | 15469 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 00:13:02 INFO - PROCESS | 15469 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:13:03 INFO - TEST-INFO | 15469: exit 0 00:13:03 INFO - Browser initialized. 00:13:03 INFO - Running cycle 1/1 for v8_7 test... 00:13:03 INFO - TEST-INFO | started process 15553 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFwfeCy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:13:15 INFO - PROCESS | 15553 | RSS: Main: 150847488 00:13:15 INFO - PROCESS | 15553 | 00:13:36 INFO - PROCESS | 15553 | Cycle 1(1): loaded http://localhost:41602/tests/v8_7/run.html (next: http://localhost:41602/tests/v8_7/run.html) 00:13:37 INFO - PROCESS | 15553 | RSS: Main: 177184768 00:13:37 INFO - PROCESS | 15553 | 00:13:37 INFO - PROCESS | 15553 | __start_tp_report 00:13:37 INFO - PROCESS | 15553 | _x_x_mozilla_page_load 00:13:37 INFO - PROCESS | 15553 | _x_x_mozilla_page_load_details 00:13:37 INFO - PROCESS | 15553 | |i|pagename|runs| 00:13:37 INFO - PROCESS | 15553 | |0;Richards;167.53224995811695 00:13:37 INFO - PROCESS | 15553 | |1;DeltaBlue;190.22256039566292 00:13:37 INFO - PROCESS | 15553 | |2;Encrypt;280.58361391694723 00:13:37 INFO - PROCESS | 15553 | |3;Decrypt;5218.75 00:13:37 INFO - PROCESS | 15553 | |4;RayTrace;1121.0762331838564 00:13:37 INFO - PROCESS | 15553 | |5;Earley;790.5138339920949 00:13:37 INFO - PROCESS | 15553 | |6;Boyer;12256.09756097561 00:13:37 INFO - PROCESS | 15553 | |7;RegExp;27162.162162162163 00:13:37 INFO - PROCESS | 15553 | |8;Splay;563.3802816901408 00:13:37 INFO - PROCESS | 15553 | |9;NavierStokes;4850.241545893719 00:13:37 INFO - PROCESS | 15553 | __end_tp_report 00:13:37 INFO - PROCESS | 15553 | __startTimestamp1452068017038__endTimestamp 00:13:37 INFO - PROCESS | 15553 | 00:13:37 INFO - PROCESS | 15553 | ------- Summary: start ------- 00:13:37 INFO - PROCESS | 15553 | Number of tests: 10 00:13:37 INFO - PROCESS | 15553 | 00:13:37 INFO - PROCESS | 15553 | [#0] Richards Cycles:1 Average:167.53 Median:167.53 stddev:0.00 (0.0%) 00:13:37 INFO - PROCESS | 15553 | Values: 167.5 00:13:37 INFO - PROCESS | 15553 | 00:13:37 INFO - PROCESS | 15553 | [#1] DeltaBlue Cycles:1 Average:190.22 Median:190.22 stddev:0.00 (0.0%) 00:13:37 INFO - PROCESS | 15553 | Values: 190.2 00:13:37 INFO - PROCESS | 15553 | 00:13:37 INFO - PROCESS | 15553 | [#2] Encrypt Cycles:1 Average:280.58 Median:280.58 stddev:0.00 (0.0%) 00:13:37 INFO - PROCESS | 15553 | Values: 280.6 00:13:37 INFO - PROCESS | 15553 | 00:13:37 INFO - PROCESS | 15553 | [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 00:13:37 INFO - PROCESS | 15553 | Values: 5218.8 00:13:37 INFO - PROCESS | 15553 | 00:13:37 INFO - PROCESS | 15553 | [#4] RayTrace Cycles:1 Average:1121.08 Median:1121.08 stddev:0.00 (0.0%) 00:13:37 INFO - PROCESS | 15553 | Values: 1121.1 00:13:37 INFO - PROCESS | 15553 | 00:13:37 INFO - PROCESS | 15553 | [#5] Earley Cycles:1 Average:790.51 Median:790.51 stddev:0.00 (0.0%) 00:13:37 INFO - PROCESS | 15553 | Values: 790.5 00:13:37 INFO - PROCESS | 15553 | 00:13:37 INFO - PROCESS | 15553 | [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 00:13:37 INFO - PROCESS | 15553 | Values: 12256.1 00:13:37 INFO - PROCESS | 15553 | 00:13:37 INFO - PROCESS | 15553 | [#7] RegExp Cycles:1 Average:27162.16 Median:27162.16 stddev:0.00 (0.0%) 00:13:37 INFO - PROCESS | 15553 | Values: 27162.2 00:13:37 INFO - PROCESS | 15553 | 00:13:37 INFO - PROCESS | 15553 | [#8] Splay Cycles:1 Average:563.38 Median:563.38 stddev:0.00 (0.0%) 00:13:37 INFO - PROCESS | 15553 | Values: 563.4 00:13:37 INFO - PROCESS | 15553 | 00:13:37 INFO - PROCESS | 15553 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 00:13:37 INFO - PROCESS | 15553 | Values: 4850.2 00:13:37 INFO - PROCESS | 15553 | -------- Summary: end -------- 00:13:37 INFO - PROCESS | 15553 | 00:13:37 INFO - TEST-INFO | 15553: exit 0 00:13:37 INFO - TEST-OK | v8_7 | took 39848ms 00:13:37 INFO - SUITE-END | took 1212s 00:13:38 INFO - Completed test suite (00:20:12) 00:13:38 INFO - Working with test: dromaeo_css 00:13:38 INFO - Generating results file: dromaeo_css 00:13:38 INFO - Working with test: kraken 00:13:38 INFO - Generating results file: kraken 00:13:38 INFO - javascript benchmark 00:13:38 INFO - Working with test: v8_7 00:13:38 INFO - Generating results file: v8_7 00:13:38 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:13:38 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 00:13:38 INFO - process_Request line: dromaeo_css 6834.08 graph.html#tests=[[72,201,35]] 00:13:38 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:13:38 INFO - process_Request line: kraken 1516.30 graph.html#tests=[[232,201,35]] 00:13:38 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:13:38 INFO - process_Request line: v8_7 20987.93 graph.html#tests=[[230,201,35]] 00:13:38 INFO - RETURN: dromaeo_css: 6834.08 00:13:38 INFO - RETURN: kraken: 1516.30 00:13:38 INFO - RETURN: v8_7: 20987.93 00:13:38 INFO - javascript benchmark 00:13:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3055.6027716396866, 3087.1818967973477, 3127.0306205076427, 3131.0137306748356, 3158.0, 5016.924746128801, 5140.794368225271, 5143.125668636331, 5152.793888244466, 5210.791568337267, 5109.310243117178, 5168.22476628506, 5172.586193104552, 5238.240455134013, 5293.126634105368, 4636.281376386657, 4662.160811054009, 4667.089917466095, 4672.462666793328, 4792.7124372537755, 4784.091022705692, 4786.664933454659, 4823.855284341458, 4836.637252206081, 4871.1962526183315, 4672.088942656166, 4691.085238378518, 4741.407324084489, 4760.642951778613, 4774.80900763969, 4753.239481682914, 4753.524647535253, 4766.856994290177, 4777.976110119427, 4813.326134341195, 4739.597134243559, 4745.240761478147, 4746.952530474686, 4763.190257656207, 4781.521847815191, 4894.486078961693, 4960.553550180501, 4996.400431948153, 5012.899742005139, 5066.493350664904, 5595.636283641591, 5597.74810133545, 5602.159676048625, 5607.8878422431735, 5610.663360198401, 5602.327720673505, 5616.550675945915, 5617.915731264035, 5619.044762390404, 5621.8756248750005, 5108.106081435771, 5140.768665410065, 5213.3743950725775, 5213.687178769286, 5268.81559145428, 5685.260916080966, 5718.942810571841, 5719.5996280260815, 5721.742521586455, 5766.019776637898, 5475.890482190334, 5480.890382192334, 5496.285482887279, 5502.0, 5508.0, 5384.057789886754, 5486.039943009957, 5486.506214440719, 5510.0, 5644.040513112781, 5513.173024046425, 5516.889662206813, 5525.696086715189, 5527.419620939824, 5528.668279903219, 5544.500994910478, 5544.833654990357, 5547.140193270049, 5548.0845660466375, 5550.389457159709, 4261.147770445923, 4331.198728235287, 4381.802818873159, 4398.8020539075815, 4428.269335559597, 3892.9878231659404, 3913.8434462621744, 3915.197384536163, 3944.6055394460323, 3955.3275943089743, 5191.402988656353, 5222.817201397933, 5236.607254455931, 5238.319018527567, 5284.233786100994, 5461.344638643388, 5503.972480137573, 5570.610057296031, 5577.6653400796085, 5615.971920140373, 5129.589632829365, 5141.820036298712, 5151.484851514819, 5152.407473140562, 5154.252633368141, 4752.809887604457, 4753.809847606126, 4755.310479980383, 4757.310190022427, 4799.1601469743355, 5641.887162256732, 5726.284214473191, 5756.94243057564, 5768.221290125864, 5814.5639077068545, 5570.3315602128005, 5590.329160500766, 5595.328560572757, 5597.3003374578175, 5599.60802743804, 5629.802956896489, 5783.624064435799, 5808.912866306924, 5814.970925145516, 5823.126531020381, 5395.163749618815, 5439.755211015593, 5441.102218133963, 5510.752016159202, 5558.638688485397, 5599.552035837205, 5618.4662457066515, 5619.943800561942, 5620.100783874561, 5637.661740295595, 5261.921071184011, 5441.428649991693, 5501.422350653123, 5502.202180683858, 5564.026295398208, 5414.160805075219, 5437.619366644297, 5475.397706252229, 5488.588355873246, 5533.418991005887, 5354.277172581652, 5359.732013399236, 5362.865928351823, 5367.114426119647, 5372.892542149213, 5389.380221274603, 5437.4018857926385, 5452.154915988028, 5461.017016936989, 5522.22688823557, 5337.759800809051, 5413.025655382069, 5413.269208656781, 5418.945810541844, 5460.290162278879], "unit": "score", "name": "dojo.html", "value": 5136.8969412473525}, {"lowerIsBetter": false, "replicates": [516.4293455731419, 550.8677917299847, 597.859503016791, 601.2004034633936, 602.4337123104282, 28683.426331473358, 36283.63716362836, 37276.44085338722, 37331.44002839959, 37339.62660373395, 39792.40311395331, 40452.0, 40528.79735601325, 40600.79699601498, 40680.18639627213, 7445.925540744604, 7544.547327160388, 8498.490090594583, 8730.51982140982, 8752.0, 10204.132648724868, 10385.84421233682, 10386.428746418944, 10409.21930855185, 10426.374417534973, 10195.082442580166, 10197.796044079114, 10237.0, 10321.793564128713, 10325.296326106183, 7651.6939322427315, 7828.804279893048, 7843.098043724987, 10029.849552256723, 10227.130693891027, 9981.251406144569, 10122.0, 10122.29143959923, 10129.594816207344, 10130.797384052352, 36970.0, 37016.444753328724, 37398.8130059348, 37481.62518374809, 37518.06204844901, 3030.3030303030337, 3168.413843438971, 3389.7288216942834, 3742.120601658635, 3963.128111815396, 28704.0, 28920.0, 31551.21121971969, 31705.0, 31730.841345793353, 3905.1994341159993, 3949.7630142191274, 3992.5208974922903, 4068.816903239361, 4108.650764685005, 271353.0, 272651.0, 274007.0, 274500.999999998, 275218.0, 59363.70318148382, 60094.0, 60136.0, 60155.39844601498, 60270.0, 49308.26037609439, 56937.43062569404, 57912.4208757907, 65291.34708652853, 66859.33140668628, 14781.92609036948, 14916.850831491764, 14994.850051499563, 15001.624959376102, 15004.924975375054, 11160.776784464428, 11215.43922803873, 11216.214864959375, 11217.0, 11223.326600404002, 19388.321408750628, 20277.79722202759, 20286.69569956452, 20328.796712032985, 20412.285570004977, 7306.525075870051, 7517.436192285601, 7564.50830696003, 7577.5453472791805, 7627.389808815282, 893.3389291923929, 934.5794392523255, 993.5677980078689, 1093.2511229807608, 1145.381493993251, 28824.42351152965, 30109.849450752605, 30731.692683073332, 31381.372372552876, 31585.210369740482, 976.5019839881711, 1030.701096681969, 1037.0, 1096.9067629251604, 1104.9060829829393, 13275.933620331836, 13993.440262389595, 14092.929535352463, 14220.0, 14258.215798130996, 311049.0, 315532.0, 315626.0, 315857.0, 316137.0, 53298.0, 53564.196537051976, 53598.46401536013, 53612.0, 53622.195667065025, 1352.5333759852836, 1358.8641135886332, 1377.1117629129155, 1379.5654368873772, 1385.0512399006714, 25563.23310300694, 26657.0, 26986.32534186661, 27047.1885843425, 27106.72893271121, 43975.340369893835, 44498.0, 44533.0, 44597.33104003378, 44599.10801784011, 285006.0, 288319.0, 292065.0, 294079.0, 296550.0, 30140.547891781203, 30260.69739302579, 30431.391372172875, 30434.0, 30904.0, 42762.0, 43410.34884476672, 43570.56429435665, 44049.0, 44684.0, 36294.455583166804, 36340.0, 37059.81470092632, 37125.25749485049, 38992.80503597464, 34572.19705832306, 34766.30467390689, 35472.0, 35564.28871422609, 35951.02269375209, 34270.0, 35306.823465883535, 35377.82311088428, 35379.0, 35431.64568354283, 29266.853665731534, 32164.678353216168, 32414.0, 32706.672933271315, 32745.34509309848, 24083.298295946104, 24583.754162458146, 24711.62932555977, 24851.87574062118, 24880.75119248784], "unit": "score", "name": "ext.html", "value": 18513.160491747236}, {"lowerIsBetter": false, "replicates": [348.6966339284824, 351.49033900843784, 352.68434750897944, 353.1013570463171, 355.5200479352874, 14011.159330440156, 14450.710985780304, 15968.76046859298, 16229.513114606565, 16721.832781672165, 14534.709305813878, 14789.482368117118, 15479.92260038701, 15517.689646207098, 15546.06723596585, 5219.660722053073, 5298.337707786527, 5327.547158491533, 5338.119210330291, 5342.893142137174, 3427.0746898337434, 3516.7186625069935, 5282.683039017652, 5299.0, 5423.755930983115, 5360.9463905361035, 5387.515123638872, 5388.030154572176, 5411.756470958797, 5414.214938833867, 5268.394134674523, 5391.16436952273, 5407.432219616923, 5411.567074634039, 5420.430854760233, 5154.896902061938, 5181.559567436772, 5194.0391027659625, 5201.427842937273, 5203.271541984125, 13392.263425511594, 13396.5311214108, 13433.261170635611, 14820.629484262872, 15868.52394428169, 2048.7848775878465, 2090.571432856276, 2100.8634438761433, 2119.6608542633103, 2152.9261846796057, 9369.53152342387, 9413.811723765486, 9527.666531671359, 11473.655790326304, 13004.479820807252, 1858.50749551369, 1871.5040514263594, 1885.5097674604565, 1888.688366419553, 1915.6839121544929, 56613.71693141549, 58857.41142588519, 58973.70513147407, 59005.11492327618, 59981.7000914997, 9835.360701554377, 9918.652847150315, 9962.750931226778, 10022.198224142052, 10036.397816131055, 13051.738965220642, 13094.803577946339, 13095.476180952655, 13111.475540978254, 13128.737425251633, 7490.6629201686055, 7549.849003020019, 7569.356604688553, 7579.1662917079075, 7605.543667379975, 7312.926870731225, 7372.373348265458, 7415.777526674208, 7419.332260096618, 7433.293837085468, 4319.3952846601505, 4353.151135528541, 4365.847195348148, 4410.823567057346, 4423.579759922803, 1695.118538360046, 1735.2104792319465, 1743.1371471121877, 1754.5262779049585, 1768.8850224735352, 820.8891799607096, 907.9863802042975, 938.4791440750449, 997.571044450893, 1032.6643840751785, 15323.923380383027, 15722.606934826721, 16431.0, 17154.914225429042, 17431.215595298243, 881.7046289493092, 895.8163576466809, 935.7941252924346, 962.9374090684223, 966.5602151021268, 9097.49963752, 9178.908210917938, 9199.816003680024, 9248.213901818286, 9327.160555549897, 546375.0, 547773.0, 552477.0, 577505.0, 580136.0, 40840.79579602083, 68550.62898741997, 78308.0, 79154.6042269785, 81190.59404702939, 1121.0919155484085, 1127.565887133443, 1152.1589239854786, 1163.2962057954815, 1166.0438440478895, 14418.567442976728, 14434.206118663154, 14660.486882959472, 14744.926275368554, 14860.479883204036, 32901.83549082239, 33733.0, 33785.83107084449, 34051.65948340584, 34395.0, 46746.29880551862, 47925.520744792106, 48148.0, 48321.51678483311, 48755.0, 9527.38072025316, 9555.474448905377, 9634.181094606756, 9739.9026009739, 9814.165795907427, 11832.230904991147, 11894.940525297317, 12008.939955300168, 13986.300684965914, 17865.28538858431, 11372.772544549229, 11492.655220343404, 11737.823932640846, 13548.72902541924, 14313.499027533986, 14036.157830530201, 14088.506902258372, 14344.56966291013, 14683.41266349334, 14752.63118422005, 11569.247998880046, 13691.24698141572, 14542.200178990257, 14543.200123993282, 14957.626059348604, 9202.585883635118, 9685.757856053655, 9699.078587534173, 9863.358881672668, 9882.357646752938, 10649.467526623794, 10716.142708583138, 13948.651283717989, 14564.563063108124, 15111.093334399971], "unit": "score", "name": "jquery.html", "value": 8536.577693208317}, {"lowerIsBetter": false, "replicates": [1390.1033833177598, 1403.4245959156747, 1496.2668292536653, 1686.3760408648802, 1705.1474262868567, 6349.39680730331, 6425.9678701606545, 7340.669669864856, 7619.657115429805, 7633.5038222515495, 6740.427063699579, 6779.084823548819, 6860.622665753382, 6864.9656751716175, 6881.9311806881915, 2151.4298710841676, 2172.6306527890297, 2181.454636340915, 2182.181681869299, 2182.9890850545803, 1986.5728868293313, 2025.7467816522935, 2183.6287831068757, 2208.205046183373, 2228.9888550557225, 2149.978500215001, 2159.9352019439443, 2173.0330003148606, 2176.09691977829, 2179.1065663078143, 2171.967420488686, 2193.846430749848, 2195.747489038765, 2196.53872686736, 2199.802017818396, 2183.355910006536, 2196.527746534503, 2240.7311122665383, 2241.820654347648, 2254.5265494246228, 7366.484346095775, 7466.738664146783, 7523.0972283326355, 7545.849083018364, 7548.169701332849, 4413.360062790877, 4472.038511719996, 4499.550044995474, 4518.683692141552, 4519.954800451987, 2937.764978801712, 2959.5708622249654, 3005.1885990782584, 3007.1429642551766, 3026.394721055776, 991.5736233419626, 991.9057689519484, 1003.413003393016, 1017.8015287019034, 1038.9740256493649, 10167.661437869257, 10210.591576336938, 10241.385516868937, 10264.89735102647, 10274.434906080238, 4142.275101857163, 4223.303154979455, 4268.957310426918, 4273.1240095780295, 4274.401583778274, 8656.047834738174, 8658.956705216433, 8669.783255418664, 8670.393072484865, 8684.522351270614, 4609.8156073757345, 4624.352590637313, 4626.629869610423, 4630.953690463052, 4652.930206046912, 4187.330027195695, 4234.894127646772, 4234.9364759528635, 4238.449001629769, 4245.469316335458, 3568.8572457101427, 3648.616895226016, 3658.0, 3659.835307411173, 3683.4658974448553, 1038.4963292802984, 1049.8267785815408, 1150.2523359816187, 1153.8903804138592, 1167.8423412839159, 992.0327680511443, 1006.5571148694551, 1006.8691070160978, 1121.3496172220255, 1332.9600111996656, 6920.065791118235, 6966.0, 6987.406070483964, 6992.54548454359, 7003.0, 1163.87197408285, 1190.8213767934706, 1216.2337727231788, 1222.1872454817446, 1222.9327386993623, 5494.697791621499, 5522.447755224445, 5535.806246781424, 5539.086050801653, 5559.610827242135, 8736.301095912311, 8882.200601945857, 8964.417312874642, 8985.146411090936, 9011.369204155646, 8833.293336533063, 8862.379633425728, 8914.0, 8928.330375221754, 8940.955295223483, 6928.0, 7142.785716428515, 7162.4628152888745, 7182.784516464514, 7202.459815513857, 6956.686949087404, 6998.475114366341, 7036.050133231948, 7043.36609705129, 7147.606881621561, 7455.142658594114, 7643.656035478306, 7812.218778122142, 7816.53100813953, 7828.099768526465, 8417.957910210409, 8536.317094632539, 8559.871601926101, 8577.614007369808, 8580.742577722678, 6542.574732642363, 6693.799186024427, 6740.595564266159, 6742.93257067423, 6760.459163266829, 6443.226812782496, 7317.963410182915, 7336.889946650911, 7341.0, 7397.260273972775, 6073.696315184135, 6159.538034647509, 6669.6665166740495, 6689.26418094019, 6765.492588055817, 6487.059376390492, 6554.8361290968105, 6636.2700102987665, 6659.300773418721, 6770.8645827084165, 6541.8691626166255, 6607.636579988147, 6614.966925165343, 6619.304972977768, 6622.536422450382, 5959.7020148991505, 5960.403959604005, 6004.87990240184, 6043.335233124265, 6051.304100028553, 6240.438360547572, 6284.4972402206795, 6296.968515157395, 6299.811005669837, 6305.40098690642], "unit": "score", "name": "mootools.html", "value": 4318.381374746894}, {"lowerIsBetter": false, "replicates": [335.76999755167725, 340.22768315922855, 341.31736526946105, 342.8679958216086, 347.31578789784135, 5706.315242170935, 5765.567582431324, 5766.567507436943, 5778.191053252548, 5818.709064546777, 5608.46719561642, 5772.3361813391475, 5784.884302313962, 5792.160136780164, 5800.129980502927, 4539.364488971547, 4547.09058188362, 4547.863564093066, 4552.97723511382, 4555.088982203556, 4323.178596066738, 4404.185225733249, 4430.202563538562, 4559.8404055858055, 4588.334691469735, 4502.032063106431, 4508.752018638974, 4513.526079761627, 4526.909461810762, 4552.248878934988, 4527.818887244506, 4531.682782205247, 4534.886627834314, 4535.274356103024, 4545.272756359, 4007.238624661305, 4008.198360327946, 4012.378081397388, 4014.9397759033636, 4023.114914718757, 5393.19102134679, 5527.806526771584, 5532.474414930575, 5537.197106419587, 5561.5272701820395, 5187.740612969336, 5189.117849965515, 5196.142636464979, 5198.662086964335, 5201.063808514466, 5832.533397328246, 6178.135061091451, 6181.320054793969, 6186.690665466754, 6187.102870083858, 4149.771762553059, 4204.957950420488, 4251.59609837065, 4285.678574106923, 4288.807003684841, 6336.809895703136, 6399.296077431479, 6435.420812126931, 6436.742530298782, 6447.742090316382, 4422.646188304928, 4428.092241090569, 4433.623142032963, 4434.201843668106, 4434.246178149722, 4356.324769660708, 4449.199144154083, 4483.798229079699, 4489.708168969072, 4509.706869053501, 5173.042987047408, 5174.508421699932, 5176.265950906413, 5179.922301165486, 5180.0, 6188.566800324024, 6217.285012223561, 6220.377962203744, 6225.875482490324, 6231.532635052298, 1570.4032467662216, 1590.9124998124983, 1591.013571585601, 1592.4267263785027, 1592.9362825487083, 1052.3054783842626, 1053.4522048534718, 1061.9415932123807, 1061.9893801062044, 1076.1874784537624, 5919.911201331984, 5923.17075609415, 5933.406659334119, 5934.495567876779, 5939.346671866091, 6374.458171055512, 6377.489800815923, 6381.266154392211, 6387.105805187278, 6387.393197646216, 5907.881842363128, 5914.172015917775, 5917.911231331534, 5918.053111502139, 5932.436418540232, 3357.529945807589, 3438.3123375325035, 3440.8623655053516, 3442.8106454145263, 3444.5522082129164, 6602.438792702674, 6612.702428390734, 6614.536982411185, 6630.701618427182, 6644.269130395653, 6573.474122070223, 6577.83555411109, 6625.17185351831, 6629.801105966829, 6630.336966303331, 6574.276829548746, 6685.699143538553, 6704.664766761643, 6709.7651582194385, 6710.966445167743, 6159.384061593805, 6326.936730632635, 6357.586756860789, 6407.967960160169, 6427.903581446376, 6208.937910620836, 6278.215223097113, 6376.872462550816, 6377.7767778127545, 6390.073439351361, 6658.63377514222, 6682.532222744361, 6690.13028306317, 6690.431313338421, 6695.832604184934, 4385.5175930646965, 4423.756693381895, 4464.977675111603, 4466.218411777861, 4467.374567560479, 6450.677466126581, 6453.225363025205, 6457.5479716419395, 6461.418472337512, 6463.095166676575, 6268.091126786499, 6282.2147231596055, 6286.119943207863, 6286.497080233479, 6290.119383286252, 6137.96931015342, 6256.937430625636, 6269.96865015672, 6273.592216505913, 6274.811755647338, 6139.785107521394, 6149.0, 6156.107364432043, 6158.0, 6170.691465426621, 6298.0867774171575, 6299.244090709144, 6301.149344838388, 6301.338359472189, 6309.085182648582, 6046.5767396281835, 6147.84630384244, 6151.907721384272, 6157.84605384869, 6171.290301615192], "unit": "score", "name": "prototype.html", "value": 4698.488981168881}, {"lowerIsBetter": false, "replicates": [789.490778447901, 814.7555733280017, 858.6350800909612, 868.9478631282119, 880.7930136417937, 13207.537736179236, 13533.932330338346, 13551.322433878317, 13594.456221751117, 13596.388162532685, 12108.93945530271, 12215.450304736287, 12219.0, 12226.0, 12233.755324893496, 675.3179288918203, 803.6704950970088, 823.6993497373476, 824.196408501709, 824.9628766705513, 582.141341521257, 790.9604519774017, 816.3061397811842, 817.1134319263606, 818.4761752478419, 844.945078569894, 859.1279850951289, 861.4400639584289, 865.3380164174412, 867.6616119713317, 705.1714235772972, 713.3259070178683, 851.476342049635, 858.8582883824162, 865.8744482050099, 628.8647940692773, 629.8803227386782, 630.6373835044867, 631.1006815288242, 631.4853394483481, 12878.227306361649, 12937.223766573941, 12937.288449135294, 12938.87061129386, 12971.41628626714, 11209.887901121048, 11501.482433290523, 12555.246685198917, 12592.811107833299, 12855.678608034781, 10163.260250216772, 10315.123214526775, 10384.94807525965, 10524.210684198715, 10662.413567253798, 3512.3326567952263, 3562.786232826039, 3573.0710015396185, 3586.3185994661194, 3602.477640742104, 44815.10369792586, 44821.551784482064, 44832.0, 45007.099858002985, 45087.09825803465, 9825.557849896772, 10206.183505319557, 10265.692029239135, 10549.103326217204, 10583.788324233472, 18426.262949481872, 18441.262349506138, 18457.5385615358, 18541.258349665863, 18551.72172417415, 6931.792046238621, 6960.408365288906, 7169.7849064528145, 7178.2103968563415, 7181.389581885598, 3485.4597537381746, 3531.346700860349, 3552.0764601203873, 3909.159530700856, 3942.6845852332317, 2972.8810847566288, 3004.7596192305, 3005.248687828043, 3011.1568760747027, 3014.9397012059635, 521.4368482039388, 526.9420363759983, 532.0609124894564, 533.5358238332675, 540.0710777462758, 584.2696629213483, 656.8620589676221, 679.4700133895569, 687.1342108942769, 688.18793823288, 7892.526448413114, 7998.448062316327, 8110.229528194812, 8132.308753755879, 8177.509349439053, 499.8150684246779, 657.0702456024671, 688.370141320696, 701.2080217404277, 704.630069213667, 3859.208862183246, 3878.3212937735784, 4054.959450405517, 4096.815643296059, 4144.44050053239, 50334.0, 56638.433615663314, 57431.712841435525, 57448.712756436784, 57549.0, 51251.711859764, 52365.0, 52599.0, 52671.20993185105, 52728.47271527236, 45575.544244557794, 46744.2988355175, 47027.29459058117, 47498.28752568714, 48156.5184348152, 8068.798280043045, 8468.618912149092, 8492.532910689724, 8677.522736249566, 8883.511406872683, 32924.67075329216, 33016.83491582623, 33622.159446013065, 33888.509011414506, 34084.31831363408, 45894.31158532558, 46206.30690539712, 46587.30119048149, 46771.76614116908, 46941.2958805625, 10381.532831022772, 10532.842007369742, 10863.565457381615, 11158.776824463628, 11453.656390308304, 12403.25580465175, 12543.623691289276, 12569.748605028031, 12579.559715409916, 12586.056045796418, 10919.126469882549, 11033.503492342703, 11188.552457901593, 11190.83213751778, 11723.648290551297, 10986.945065274622, 11177.329360238411, 11707.531698731955, 11745.354005529778, 11974.521019159136, 10851.511681974487, 10980.121590272918, 11103.611373601885, 11207.775844483227, 11479.598214062467, 9145.496997665192, 9851.704448866545, 9884.30809843304, 10070.8489372658, 10224.284300098921, 7641.579713115832, 7791.92208077912, 8049.637766300413, 8409.170371110433, 9603.135717785433], "unit": "score", "name": "yui.html", "value": 6184.336231566279}], "name": "dromaeo_css", "value": 6834.074672258303}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 105.0, 109.0, 110.0, 111.0, 100.0, 110.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.3}, {"lowerIsBetter": true, "replicates": [151.0, 125.0, 147.0, 168.0, 123.0, 156.0, 152.0, 127.0, 173.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 144.5}, {"lowerIsBetter": true, "replicates": [159.0, 161.0, 160.0, 160.0, 159.0, 161.0, 162.0, 163.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 77.0, 92.0, 70.0, 71.0, 71.0, 106.0, 96.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 142.0, 96.0, 98.0, 97.0, 149.0, 97.0, 97.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 111.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 145.0, 145.0, 144.0, 146.0, 145.0, 148.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [61.0, 60.0, 60.0, 59.0, 60.0, 60.0, 58.0, 60.0, 59.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 59.5}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 67.0, 68.0, 67.0, 68.0, 75.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 85.0, 92.0, 86.0, 93.0, 85.0, 86.0, 86.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.0}, {"lowerIsBetter": true, "replicates": [117.0, 119.0, 119.0, 122.0, 123.0, 128.0, 119.0, 116.0, 126.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.5}, {"lowerIsBetter": true, "replicates": [150.0, 145.0, 158.0, 158.0, 155.0, 144.0, 165.0, 154.0, 163.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.4}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 71.0, 71.0, 72.0, 71.0, 73.0, 72.0, 72.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.7}], "name": "kraken", "value": 1516.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.53224995811695], "unit": "score", "name": "Richards", "value": 210.71763800000005}, {"lowerIsBetter": false, "replicates": [190.22256039566292], "unit": "score", "name": "DeltaBlue", "value": 347.58232600000014}, {"lowerIsBetter": false, "replicates": [280.58361391694723], "unit": "score", "name": "Encrypt", "value": 948.6690839999999}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1121.0762331838564], "unit": "score", "name": "RayTrace", "value": 660.070188}, {"lowerIsBetter": false, "replicates": [790.5138339920949], "unit": "score", "name": "Earley", "value": 843.0756950000003}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [27162.162162162163], "unit": "score", "name": "RegExp", "value": 33.538751243781114}, {"lowerIsBetter": false, "replicates": [563.3802816901408], "unit": "score", "name": "Splay", "value": 144.64652499999997}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 20987.926968236265}]} 00:13:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20987.93"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1516.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6834.08"}}} 00:13:38 INFO - Return code: 0 00:13:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 00:13:38 INFO - # TBPL SUCCESS # 00:13:38 INFO - Running post-action listener: _resource_record_post_action 00:13:38 INFO - Running post-run listener: _resource_record_post_run 00:13:39 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 8192; Write bytes: 570896384; Read time: 376; Write time: 852924 00:13:39 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 250433536; Read time: 0; Write time: 543252 00:13:39 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 8192; Write bytes: 320303104; Read time: 376; Write time: 309644 00:13:39 INFO - Running post-run listener: _upload_blobber_files 00:13:39 INFO - Blob upload gear active. 00:13:39 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 00:13:39 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 00:13:39 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'] 00:13:39 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 00:13:39 INFO - (blobuploader) - INFO - Open directory for files ... 00:13:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 00:13:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:13:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:13:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:13:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:13:40 INFO - (blobuploader) - INFO - Done attempting. 00:13:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:13:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:13:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:13:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:13:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:13:41 INFO - (blobuploader) - INFO - Done attempting. 00:13:41 INFO - (blobuploader) - INFO - Iteration through files over. 00:13:41 INFO - Return code: 0 00:13:41 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 00:13:41 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 00:13:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/b1a1f937a9e04961717750bea757761d9c2658a930964d231c7176a0e690e70c053e4e663876b316f731f030fe876f16388d350e3237edbe84305d0b237a2ea2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/9abdf9be4cdfc7c2decebb341022165b6ca342e6fa0ea1ad06aa8f12352d1466d7edc2cc73dc54e139844461730df168b25b5b68b989f67bc956ef06b147bd91"} 00:13:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 00:13:41 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 00:13:41 INFO - Contents: 00:13:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/b1a1f937a9e04961717750bea757761d9c2658a930964d231c7176a0e690e70c053e4e663876b316f731f030fe876f16388d350e3237edbe84305d0b237a2ea2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/9abdf9be4cdfc7c2decebb341022165b6ca342e6fa0ea1ad06aa8f12352d1466d7edc2cc73dc54e139844461730df168b25b5b68b989f67bc956ef06b147bd91"} 00:13:41 INFO - Copying logs to upload dir... 00:13:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1271.371014 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-06 00:13:41.384923) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 00:13:41.388804) ========= 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=df17445c3590ff7897617a0e00000225-1452064427.577279-410307445 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/b1a1f937a9e04961717750bea757761d9c2658a930964d231c7176a0e690e70c053e4e663876b316f731f030fe876f16388d350e3237edbe84305d0b237a2ea2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/9abdf9be4cdfc7c2decebb341022165b6ca342e6fa0ea1ad06aa8f12352d1466d7edc2cc73dc54e139844461730df168b25b5b68b989f67bc956ef06b147bd91"} build_url:https://queue.taskcluster.net/v1/task/foMZbRa3RFq5ihBLI1UBQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011155 build_url: 'https://queue.taskcluster.net/v1/task/foMZbRa3RFq5ihBLI1UBQA/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/b1a1f937a9e04961717750bea757761d9c2658a930964d231c7176a0e690e70c053e4e663876b316f731f030fe876f16388d350e3237edbe84305d0b237a2ea2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/9abdf9be4cdfc7c2decebb341022165b6ca342e6fa0ea1ad06aa8f12352d1466d7edc2cc73dc54e139844461730df168b25b5b68b989f67bc956ef06b147bd91"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 00:13:41.413857) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 00:13:41.414198) ========= 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=df17445c3590ff7897617a0e00000225-1452064427.577279-410307445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 00:13:41.497315) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 00:13:41.497645) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 00:13:41.497980) ========= ========= Total master_lag: 0.23 =========