builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1452764844.48 results: success (0) buildid: 20160113233019 builduid: e1afc642cacd4c20bbb2377bc91a36bc revision: 4ef045d1ebf84aec586c004bdd00bab4adc85710 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 01:47:24.476213) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 01:47:24.476671) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 01:47:24.476960) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006475 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 01:47:24.501966) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 01:47:24.502282) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 01:47:24.523883) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 01:47:24.524205) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004586 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 01:47:24.579488) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 01:47:24.579977) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 01:47:24.580363) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 01:47:24.580638) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 01:47:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 83.3M=0s 2016-01-14 01:47:24 (83.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178424 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 01:47:24.772175) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 01:47:24.772485) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018082 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 01:47:24.822507) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-14 01:47:24.822842) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 4ef045d1ebf84aec586c004bdd00bab4adc85710 --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 4ef045d1ebf84aec586c004bdd00bab4adc85710 --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=6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 01:47:24,951 truncating revision to first 12 chars 2016-01-14 01:47:24,951 Setting DEBUG logging. 2016-01-14 01:47:24,952 attempt 1/10 2016-01-14 01:47:24,952 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/4ef045d1ebf8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-14 01:47:25,943 unpacking tar archive at: b2g-inbound-4ef045d1ebf8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.297382 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-14 01:47:26.134197) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 01:47:26.134502) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 01:47:26.142794) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 01:47:26.143088) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 01:47:26.143493) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-14 01:47:26.143772) ========= /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=6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:47:26 INFO - MultiFileLogger online at 20160114 01:47:26 in /builds/slave/test-pgo 01:47:26 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 01:47:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:47:26 INFO - {'append_to_log': False, 01:47:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:47:26 INFO - 'blob_upload_branch': 'B2G-Inbound', 01:47:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:47:26 INFO - 'branch': 'B2G-Inbound', 01:47:26 INFO - 'buildbot_json_path': 'buildprops.json', 01:47:26 INFO - 'config_files': ('talos/linux_config.py',), 01:47:26 INFO - 'default_actions': ('clobber', 01:47:26 INFO - 'read-buildbot-config', 01:47:26 INFO - 'download-and-extract', 01:47:26 INFO - 'populate-webroot', 01:47:26 INFO - 'create-virtualenv', 01:47:26 INFO - 'install', 01:47:26 INFO - 'run-tests'), 01:47:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:47:26 INFO - 'download_minidump_stackwalk': True, 01:47:26 INFO - 'download_symbols': 'ondemand', 01:47:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:47:26 INFO - 'tooltool.py': '/tools/tooltool.py', 01:47:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:47:26 INFO - '/tools/misc-python/virtualenv.py')}, 01:47:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:47:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:47:26 INFO - 'installer_path': 'installer.exe', 01:47:26 INFO - 'log_level': 'info', 01:47:26 INFO - 'log_name': 'talos', 01:47:26 INFO - 'log_to_console': True, 01:47:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:47:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:47:26 INFO - 'opt_config_files': (), 01:47:26 INFO - 'pip_index': False, 01:47:26 INFO - 'sps_profile': False, 01:47:26 INFO - 'sps_profile_interval': 0, 01:47:26 INFO - 'suite': 'dromaeojs', 01:47:26 INFO - 'system_bits': '32', 01:47:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:47:26 INFO - 'title': 'talos-linux64-ix-023', 01:47:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:47:26 INFO - 'use_talos_json': True, 01:47:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:47:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:47:26 INFO - 'work_dir': 'build'} 01:47:26 INFO - ##### 01:47:26 INFO - ##### Running clobber step. 01:47:26 INFO - ##### 01:47:26 INFO - Running pre-action listener: _resource_record_pre_action 01:47:26 INFO - Running main action method: clobber 01:47:26 INFO - rmtree: /builds/slave/test-pgo/build 01:47:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:47:26 INFO - Running post-action listener: _resource_record_post_action 01:47:26 INFO - ##### 01:47:26 INFO - ##### Running read-buildbot-config step. 01:47:26 INFO - ##### 01:47:26 INFO - Running pre-action listener: _resource_record_pre_action 01:47:26 INFO - Running main action method: read_buildbot_config 01:47:26 INFO - Using buildbot properties: 01:47:26 INFO - { 01:47:26 INFO - "project": "", 01:47:26 INFO - "product": "firefox", 01:47:26 INFO - "script_repo_revision": "production", 01:47:26 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 01:47:26 INFO - "repository": "", 01:47:26 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 01:47:26 INFO - "buildid": "20160113233019", 01:47:26 INFO - "pgo_build": "True", 01:47:26 INFO - "basedir": "/builds/slave/test-pgo", 01:47:26 INFO - "buildnumber": 1108, 01:47:26 INFO - "slavename": "talos-linux64-ix-023", 01:47:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:47:26 INFO - "platform": "ubuntu64_hw", 01:47:26 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 01:47:26 INFO - "branch": "b2g-inbound", 01:47:26 INFO - "repo_path": "integration/b2g-inbound", 01:47:26 INFO - "revision": "4ef045d1ebf84aec586c004bdd00bab4adc85710", 01:47:26 INFO - "stage_platform": "linux64-pgo", 01:47:26 INFO - "builduid": "e1afc642cacd4c20bbb2377bc91a36bc", 01:47:26 INFO - "slavebuilddir": "test" 01:47:26 INFO - } 01:47:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/Km7NTMAWQKCHdAuF7N30_Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 01:47:26 INFO - Running post-action listener: _resource_record_post_action 01:47:26 INFO - ##### 01:47:26 INFO - ##### Running download-and-extract step. 01:47:26 INFO - ##### 01:47:26 INFO - Running pre-action listener: _resource_record_pre_action 01:47:26 INFO - Running main action method: download_and_extract 01:47:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:47:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:26 INFO - https://queue.taskcluster.net/v1/task/Km7NTMAWQKCHdAuF7N30_Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:47:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km7NTMAWQKCHdAuF7N30_Q/artifacts/public/build/test_packages.json 01:47:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km7NTMAWQKCHdAuF7N30_Q/artifacts/public/build/test_packages.json 01:47:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km7NTMAWQKCHdAuF7N30_Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:47:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km7NTMAWQKCHdAuF7N30_Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:47:30 INFO - Downloaded 1448 bytes. 01:47:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:47:30 INFO - Using the following test package requirements: 01:47:30 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:47:30 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:47:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:47:30 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:47:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:47:30 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:47:30 INFO - u'jsshell-linux-x86_64.zip'], 01:47:30 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:47:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:47:30 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:47:30 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:47:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:47:30 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:47:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:47:30 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:47:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:47:30 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:47:30 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:47:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:47:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:47: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')]} 01:47:30 INFO - https://queue.taskcluster.net/v1/task/Km7NTMAWQKCHdAuF7N30_Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:47:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km7NTMAWQKCHdAuF7N30_Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:47:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km7NTMAWQKCHdAuF7N30_Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:47:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km7NTMAWQKCHdAuF7N30_Q/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 01:47:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km7NTMAWQKCHdAuF7N30_Q/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 01:47:35 INFO - Downloaded 24031010 bytes. 01:47:35 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 01:47:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:47:35 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 01:47:36 INFO - Return code: 0 01:47:36 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 01:47:36 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')]} 01:47:36 INFO - https://queue.taskcluster.net/v1/task/Km7NTMAWQKCHdAuF7N30_Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:47:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km7NTMAWQKCHdAuF7N30_Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:47:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km7NTMAWQKCHdAuF7N30_Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:47:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km7NTMAWQKCHdAuF7N30_Q/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 01:47:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km7NTMAWQKCHdAuF7N30_Q/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 01:47:39 INFO - Downloaded 24031010 bytes. 01:47:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 01:47:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:47:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:47:40 INFO - Return code: 0 01:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:40 INFO - https://queue.taskcluster.net/v1/task/Km7NTMAWQKCHdAuF7N30_Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:47:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km7NTMAWQKCHdAuF7N30_Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:47:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km7NTMAWQKCHdAuF7N30_Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:47:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km7NTMAWQKCHdAuF7N30_Q/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 01:47:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km7NTMAWQKCHdAuF7N30_Q/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 01:47:42 INFO - Downloaded 11132279 bytes. 01:47:42 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 01:47:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:47:42 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 01:47:42 INFO - Return code: 0 01:47: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')]} 01:47:42 INFO - https://queue.taskcluster.net/v1/task/Km7NTMAWQKCHdAuF7N30_Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:47:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km7NTMAWQKCHdAuF7N30_Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:47:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km7NTMAWQKCHdAuF7N30_Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:47:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km7NTMAWQKCHdAuF7N30_Q/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 01:47:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km7NTMAWQKCHdAuF7N30_Q/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 01:47:45 INFO - Downloaded 55926862 bytes. 01:47:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Km7NTMAWQKCHdAuF7N30_Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:47:45 INFO - mkdir: /builds/slave/test-pgo/properties 01:47:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:47:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:47:45 INFO - Contents: 01:47:45 INFO - build_url:https://queue.taskcluster.net/v1/task/Km7NTMAWQKCHdAuF7N30_Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:47:45 INFO - Running post-action listener: _resource_record_post_action 01:47:45 INFO - Running post-action listener: set_extra_try_arguments 01:47:45 INFO - ##### 01:47:45 INFO - ##### Running populate-webroot step. 01:47:45 INFO - ##### 01:47:45 INFO - Running pre-action listener: _resource_record_pre_action 01:47:45 INFO - Running main action method: populate_webroot 01:47:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:47:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:47:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:47:45 INFO - '--tppagecycles', 01:47:45 INFO - '7'], 01:47:45 INFO - 'tests': ['tsvgm']}}, 01:47:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:47:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:47:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:47:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:47:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:47:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:47:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:47:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:45 INFO - 'talos_options': ['--e10s'], 01:47:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:47:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:45 INFO - 'tests': ['damp', 'tps']}, 01:47:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:45 INFO - 'talos_options': ['--e10s'], 01:47:45 INFO - 'tests': ['damp', 'tps']}, 01:47:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:47:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:47:45 INFO - 'other': {'tests': ['a11yr', 01:47:45 INFO - 'ts_paint', 01:47:45 INFO - 'tpaint', 01:47:45 INFO - 'sessionrestore', 01:47:45 INFO - 'sessionrestore_no_auto_restore']}, 01:47:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:47:45 INFO - 'tests': ['a11yr', 01:47:45 INFO - 'ts_paint', 01:47:45 INFO - 'tpaint', 01:47:45 INFO - 'sessionrestore', 01:47:45 INFO - 'sessionrestore_no_auto_restore']}, 01:47:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:47:45 INFO - 'tests': ['a11yr', 01:47:45 INFO - 'ts_paint', 01:47:45 INFO - 'tpaint', 01:47:45 INFO - 'sessionrestore', 01:47:45 INFO - 'sessionrestore_no_auto_restore']}, 01:47:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:47:45 INFO - 'tests': ['a11yr', 01:47:45 INFO - 'ts_paint', 01:47:45 INFO - 'tpaint', 01:47:45 INFO - 'sessionrestore', 01:47:45 INFO - 'sessionrestore_no_auto_restore']}, 01:47:45 INFO - 'other_l64': {'tests': ['a11yr', 01:47:45 INFO - 'ts_paint', 01:47:45 INFO - 'tpaint', 01:47:45 INFO - 'sessionrestore', 01:47:45 INFO - 'sessionrestore_no_auto_restore']}, 01:47:45 INFO - 'other_nol64': {'tests': ['a11yr', 01:47:45 INFO - 'ts_paint', 01:47:45 INFO - 'tpaint', 01:47:45 INFO - 'sessionrestore', 01:47:45 INFO - 'sessionrestore_no_auto_restore']}, 01:47:45 INFO - 'svgr': {'tests': ['tsvgx', 01:47:45 INFO - 'tsvgr_opacity', 01:47:45 INFO - 'tart', 01:47:45 INFO - 'tscrollx', 01:47:45 INFO - 'cart']}, 01:47:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:47:45 INFO - 'tests': ['tsvgx', 01:47:45 INFO - 'tsvgr_opacity', 01:47:45 INFO - 'tart', 01:47:45 INFO - 'tscrollx', 01:47:45 INFO - 'cart']}, 01:47:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:45 INFO - 'tests': ['tp5o']}, 01:47:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:45 INFO - 'talos_options': ['--e10s'], 01:47:45 INFO - 'tests': ['tp5o']}, 01:47:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:45 INFO - 'talos_options': ['--xperf_path', 01:47:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:47:45 INFO - 'tests': ['tp5n']}, 01:47:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:45 INFO - 'talos_options': ['--e10s', 01:47:45 INFO - '--xperf_path', 01:47:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:47:45 INFO - 'tests': ['tp5n']}}, 01:47:45 INFO - 'talos.zip': {'path': '', 01:47:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:47:45 INFO - Running post-action listener: _resource_record_post_action 01:47:45 INFO - ##### 01:47:45 INFO - ##### Running create-virtualenv step. 01:47:45 INFO - ##### 01:47:45 INFO - Running pre-action listener: _resource_record_pre_action 01:47:45 INFO - Running main action method: create_virtualenv 01:47:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:47:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 01:47:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:47:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:47:45 INFO - Using real prefix '/usr' 01:47:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:47:46 INFO - Installing distribute.............................................................................................................................................................................................done. 01:47:47 INFO - Installing pip.................done. 01:47:47 INFO - Return code: 0 01:47:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:47: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')]} 01:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47: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')]} 01:47:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47: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 0x7f945e722f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffe840>, '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 0x1f6b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6bb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525', '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 01:47: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 01:47: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 01:47:47 INFO - Using env: {'DISPLAY': ':0', 01:47:47 INFO - 'HOME': '/home/cltbld', 01:47:47 INFO - 'LANG': 'en_US.UTF-8', 01:47:47 INFO - 'LANGUAGE': 'en_US:en', 01:47:47 INFO - 'LOGNAME': 'cltbld', 01:47:47 INFO - 'MAIL': '/var/mail/cltbld', 01:47:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:47 INFO - 'MOZ_NO_REMOTE': '1', 01:47:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:47 INFO - 'NO_EM_RESTART': '1', 01:47:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:47:47 INFO - 'PWD': '/builds/slave/test-pgo', 01:47:47 INFO - 'SHELL': '/bin/bash', 01:47:47 INFO - 'SHLVL': '1', 01:47:47 INFO - 'TERM': 'linux', 01:47:47 INFO - 'TMOUT': '86400', 01:47:47 INFO - 'USER': 'cltbld', 01:47:47 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525', 01:47:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:47 INFO - '_': '/tools/buildbot/bin/python'} 01:47:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:47:48 INFO - Cleaning up... 01:47:48 INFO - Return code: 0 01:47:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f945e722f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffe840>, '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 0x1f6b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6bb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525', '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 01:47:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 01:47:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:47:48 INFO - Using env: {'DISPLAY': ':0', 01:47:48 INFO - 'HOME': '/home/cltbld', 01:47:48 INFO - 'LANG': 'en_US.UTF-8', 01:47:48 INFO - 'LANGUAGE': 'en_US:en', 01:47:48 INFO - 'LOGNAME': 'cltbld', 01:47:48 INFO - 'MAIL': '/var/mail/cltbld', 01:47:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:48 INFO - 'MOZ_NO_REMOTE': '1', 01:47:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:48 INFO - 'NO_EM_RESTART': '1', 01:47:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:47:48 INFO - 'PWD': '/builds/slave/test-pgo', 01:47:48 INFO - 'SHELL': '/bin/bash', 01:47:48 INFO - 'SHLVL': '1', 01:47:48 INFO - 'TERM': 'linux', 01:47:48 INFO - 'TMOUT': '86400', 01:47:48 INFO - 'USER': 'cltbld', 01:47:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525', 01:47:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:48 INFO - '_': '/tools/buildbot/bin/python'} 01:47:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:48 INFO - Downloading/unpacking psutil>=0.7.1 01:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:50 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 01:47:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:47:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:47:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:47:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:47:50 INFO - Installing collected packages: psutil 01:47:50 INFO - Running setup.py install for psutil 01:47:50 INFO - building 'psutil._psutil_linux' extension 01:47:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:47:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:47:50 INFO - building 'psutil._psutil_posix' extension 01:47:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:47: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 01:47:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:47:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:47:50 INFO - Successfully installed psutil 01:47:50 INFO - Cleaning up... 01:47:50 INFO - Return code: 0 01:47:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:47: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')]} 01:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47: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')]} 01:47:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47: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 0x7f945e722f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffe840>, '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 0x1f6b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6bb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525', '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 01:47: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 01:47: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 01:47:50 INFO - Using env: {'DISPLAY': ':0', 01:47:50 INFO - 'HOME': '/home/cltbld', 01:47:50 INFO - 'LANG': 'en_US.UTF-8', 01:47:50 INFO - 'LANGUAGE': 'en_US:en', 01:47:50 INFO - 'LOGNAME': 'cltbld', 01:47:50 INFO - 'MAIL': '/var/mail/cltbld', 01:47:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:50 INFO - 'MOZ_NO_REMOTE': '1', 01:47:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:50 INFO - 'NO_EM_RESTART': '1', 01:47:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:47:50 INFO - 'PWD': '/builds/slave/test-pgo', 01:47:50 INFO - 'SHELL': '/bin/bash', 01:47:50 INFO - 'SHLVL': '1', 01:47:50 INFO - 'TERM': 'linux', 01:47:50 INFO - 'TMOUT': '86400', 01:47:50 INFO - 'USER': 'cltbld', 01:47:50 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525', 01:47:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:50 INFO - '_': '/tools/buildbot/bin/python'} 01:47:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:47: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 01:47: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 01:47: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 01:47: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 01:47: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 01:47: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 01:47:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:47:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:47:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:47: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) 01:47:52 INFO - Installing collected packages: mozsystemmonitor 01:47:52 INFO - Running setup.py install for mozsystemmonitor 01:47:52 INFO - Successfully installed mozsystemmonitor 01:47:52 INFO - Cleaning up... 01:47:52 INFO - Return code: 0 01:47:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:47: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')]} 01:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47: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')]} 01:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47: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 0x7f945e722f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffe840>, '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 0x1f6b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6bb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525', '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 01:47: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 01:47: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 01:47:52 INFO - Using env: {'DISPLAY': ':0', 01:47:52 INFO - 'HOME': '/home/cltbld', 01:47:52 INFO - 'LANG': 'en_US.UTF-8', 01:47:52 INFO - 'LANGUAGE': 'en_US:en', 01:47:52 INFO - 'LOGNAME': 'cltbld', 01:47:52 INFO - 'MAIL': '/var/mail/cltbld', 01:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:52 INFO - 'MOZ_NO_REMOTE': '1', 01:47:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:52 INFO - 'NO_EM_RESTART': '1', 01:47:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:47:52 INFO - 'PWD': '/builds/slave/test-pgo', 01:47:52 INFO - 'SHELL': '/bin/bash', 01:47:52 INFO - 'SHLVL': '1', 01:47:52 INFO - 'TERM': 'linux', 01:47:52 INFO - 'TMOUT': '86400', 01:47:52 INFO - 'USER': 'cltbld', 01:47:52 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525', 01:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:52 INFO - '_': '/tools/buildbot/bin/python'} 01:47:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:53 INFO - Downloading/unpacking blobuploader==1.2.4 01:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:54 INFO - Downloading blobuploader-1.2.4.tar.gz 01:47:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:47:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:47:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:47: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 01:47: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 01:47: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 01:47: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 01:47: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 01:47: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 01:47:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:47:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:47:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:55 INFO - Downloading docopt-0.6.1.tar.gz 01:47:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:47:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:47:56 INFO - Installing collected packages: blobuploader, requests, docopt 01:47:56 INFO - Running setup.py install for blobuploader 01:47:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:47:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:47:57 INFO - Running setup.py install for requests 01:47:57 INFO - Running setup.py install for docopt 01:47:57 INFO - Successfully installed blobuploader requests docopt 01:47:57 INFO - Cleaning up... 01:47:57 INFO - Return code: 0 01:47:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:47:57 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')]} 01:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:57 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')]} 01:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:57 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 0x7f945e722f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffe840>, '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 0x1f6b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6bb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525', '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 01:47:57 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 01:47:57 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 01:47:57 INFO - Using env: {'DISPLAY': ':0', 01:47:57 INFO - 'HOME': '/home/cltbld', 01:47:57 INFO - 'LANG': 'en_US.UTF-8', 01:47:57 INFO - 'LANGUAGE': 'en_US:en', 01:47:57 INFO - 'LOGNAME': 'cltbld', 01:47:57 INFO - 'MAIL': '/var/mail/cltbld', 01:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:57 INFO - 'MOZ_NO_REMOTE': '1', 01:47:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:57 INFO - 'NO_EM_RESTART': '1', 01:47:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:47:57 INFO - 'PWD': '/builds/slave/test-pgo', 01:47:57 INFO - 'SHELL': '/bin/bash', 01:47:57 INFO - 'SHLVL': '1', 01:47:57 INFO - 'TERM': 'linux', 01:47:57 INFO - 'TMOUT': '86400', 01:47:57 INFO - 'USER': 'cltbld', 01:47:57 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525', 01:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:57 INFO - '_': '/tools/buildbot/bin/python'} 01:47:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:47:57 INFO - Running setup.py (path:/tmp/pip-tnQZYr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:47:57 INFO - Running setup.py (path:/tmp/pip-EhL7WA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:47:57 INFO - Running setup.py (path:/tmp/pip-jc5vP5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:47:58 INFO - Running setup.py (path:/tmp/pip-NAxroj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:47:58 INFO - Running setup.py (path:/tmp/pip-7fAQDK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:47:58 INFO - Running setup.py (path:/tmp/pip-5oR7DP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:47:58 INFO - Running setup.py (path:/tmp/pip-yGg_QL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:47:58 INFO - Running setup.py (path:/tmp/pip-ZQnRTl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:47:58 INFO - Running setup.py (path:/tmp/pip-Zqi2XT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:47:58 INFO - Running setup.py (path:/tmp/pip-HD2WPq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:47:58 INFO - Running setup.py (path:/tmp/pip-Hx5fyz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:47:58 INFO - Running setup.py (path:/tmp/pip-heYwFZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:47:58 INFO - Running setup.py (path:/tmp/pip-mvWAW2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:47:58 INFO - Running setup.py (path:/tmp/pip-3cE292-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:47:58 INFO - Running setup.py (path:/tmp/pip-6PmwWh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:47:58 INFO - Running setup.py (path:/tmp/pip-pgZmOb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:47:58 INFO - Running setup.py (path:/tmp/pip-YoG0cP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:47:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:47:59 INFO - Running setup.py install for manifestparser 01:47:59 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:47:59 INFO - Running setup.py install for mozcrash 01:47:59 INFO - Running setup.py install for mozdebug 01:47:59 INFO - Running setup.py install for mozdevice 01:47:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:47:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:47:59 INFO - Running setup.py install for mozfile 01:47:59 INFO - Running setup.py install for mozhttpd 01:47:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:47:59 INFO - Running setup.py install for mozinfo 01:47:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:47:59 INFO - Running setup.py install for mozInstall 01:47:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:47:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:47:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:47:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:47:59 INFO - Running setup.py install for mozleak 01:47:59 INFO - Running setup.py install for mozlog 01:48:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:48:00 INFO - Running setup.py install for moznetwork 01:48:00 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:48:00 INFO - Running setup.py install for mozprocess 01:48:00 INFO - Running setup.py install for mozprofile 01:48:00 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:48:00 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:48:00 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:48:00 INFO - Running setup.py install for mozrunner 01:48:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:48:00 INFO - Running setup.py install for mozscreenshot 01:48:00 INFO - Running setup.py install for moztest 01:48:00 INFO - Running setup.py install for mozversion 01:48:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:48:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:48:00 INFO - Cleaning up... 01:48:00 INFO - Return code: 0 01:48:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f945e722f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffe840>, '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 0x1f6b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6bb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525', '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 01:48:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 01:48:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:48:00 INFO - Using env: {'DISPLAY': ':0', 01:48:00 INFO - 'HOME': '/home/cltbld', 01:48:00 INFO - 'LANG': 'en_US.UTF-8', 01:48:00 INFO - 'LANGUAGE': 'en_US:en', 01:48:00 INFO - 'LOGNAME': 'cltbld', 01:48:00 INFO - 'MAIL': '/var/mail/cltbld', 01:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:00 INFO - 'MOZ_NO_REMOTE': '1', 01:48:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:00 INFO - 'NO_EM_RESTART': '1', 01:48:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:48:00 INFO - 'PWD': '/builds/slave/test-pgo', 01:48:00 INFO - 'SHELL': '/bin/bash', 01:48:00 INFO - 'SHLVL': '1', 01:48:00 INFO - 'TERM': 'linux', 01:48:00 INFO - 'TMOUT': '86400', 01:48:00 INFO - 'USER': 'cltbld', 01:48:00 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525', 01:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:00 INFO - '_': '/tools/buildbot/bin/python'} 01:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:48:01 INFO - Running setup.py (path:/tmp/pip-zh4T1b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:48:01 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)) 01:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:48:01 INFO - Running setup.py (path:/tmp/pip-pU2TEk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:48:01 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)) 01:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:48:01 INFO - Running setup.py (path:/tmp/pip-ajZbX_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:48:01 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)) 01:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:48:01 INFO - Running setup.py (path:/tmp/pip-QvKrHq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 01:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:48:01 INFO - Running setup.py (path:/tmp/pip-LmaTwM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:48:01 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)) 01:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:48:01 INFO - Running setup.py (path:/tmp/pip-KNEX8y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:48:01 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)) 01:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:48:01 INFO - Running setup.py (path:/tmp/pip-auNfj7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:48:01 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)) 01:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:48:01 INFO - Running setup.py (path:/tmp/pip-N1i7hg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:48:01 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)) 01:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:48:01 INFO - Running setup.py (path:/tmp/pip-IMaTKS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:48:01 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)) 01:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:48:01 INFO - Running setup.py (path:/tmp/pip-Bo73mH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:48:01 INFO - Running setup.py (path:/tmp/pip-ACmlVh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 01:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:48:01 INFO - Running setup.py (path:/tmp/pip-NSmwIm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 01:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:48:01 INFO - Running setup.py (path:/tmp/pip-Irt8i7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:48:02 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)) 01:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:48:02 INFO - Running setup.py (path:/tmp/pip-znCBM8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:48:02 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)) 01:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:48:02 INFO - Running setup.py (path:/tmp/pip-ZNlYKu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:48:02 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)) 01:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:48:02 INFO - Running setup.py (path:/tmp/pip-mpVM2z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:48:02 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)) 01:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:48:02 INFO - Running setup.py (path:/tmp/pip-OrSKVx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:48:02 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)) 01:48:02 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)) 01:48:02 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)) 01:48:02 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)) 01:48: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 mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 01:48:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 01:48:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48:04 INFO - Downloading blessings-1.5.1.tar.gz 01:48:04 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 01:48:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:48:04 INFO - Installing collected packages: blessings 01:48:04 INFO - Running setup.py install for blessings 01:48:04 INFO - Successfully installed blessings 01:48:04 INFO - Cleaning up... 01:48:04 INFO - Return code: 0 01:48:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:48:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:48:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:48:04 INFO - Reading from file tmpfile_stdout 01:48:04 INFO - Current package versions: 01:48:04 INFO - argparse == 1.2.1 01:48:04 INFO - blessings == 1.5.1 01:48:04 INFO - blobuploader == 1.2.4 01:48:04 INFO - docopt == 0.6.1 01:48:04 INFO - manifestparser == 1.1 01:48:04 INFO - mozInstall == 1.12 01:48:04 INFO - mozcrash == 0.16 01:48:04 INFO - mozdebug == 0.1 01:48:04 INFO - mozdevice == 0.48 01:48:04 INFO - mozfile == 1.2 01:48:04 INFO - mozhttpd == 0.7 01:48:04 INFO - mozinfo == 0.9 01:48:04 INFO - mozleak == 0.1 01:48:04 INFO - mozlog == 3.1 01:48:04 INFO - moznetwork == 0.27 01:48:04 INFO - mozprocess == 0.22 01:48:04 INFO - mozprofile == 0.28 01:48:04 INFO - mozrunner == 6.11 01:48:04 INFO - mozscreenshot == 0.1 01:48:04 INFO - mozsystemmonitor == 0.0 01:48:04 INFO - moztest == 0.7 01:48:04 INFO - mozversion == 1.4 01:48:04 INFO - psutil == 3.1.1 01:48:04 INFO - requests == 1.2.3 01:48:04 INFO - wsgiref == 0.1.2 01:48:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:48: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')]} 01:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48: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')]} 01:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48: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', '-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 0x7f945e722f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffe840>, '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 0x1f6b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6bb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525', '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 01:48:04 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 01:48:04 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 01:48:04 INFO - Using env: {'DISPLAY': ':0', 01:48:04 INFO - 'HOME': '/home/cltbld', 01:48:04 INFO - 'LANG': 'en_US.UTF-8', 01:48:04 INFO - 'LANGUAGE': 'en_US:en', 01:48:04 INFO - 'LOGNAME': 'cltbld', 01:48:04 INFO - 'MAIL': '/var/mail/cltbld', 01:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:04 INFO - 'MOZ_NO_REMOTE': '1', 01:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:04 INFO - 'NO_EM_RESTART': '1', 01:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:48:04 INFO - 'PWD': '/builds/slave/test-pgo', 01:48:04 INFO - 'SHELL': '/bin/bash', 01:48:04 INFO - 'SHLVL': '1', 01:48:04 INFO - 'TERM': 'linux', 01:48:04 INFO - 'TMOUT': '86400', 01:48:04 INFO - 'USER': 'cltbld', 01:48:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525', 01:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:04 INFO - '_': '/tools/buildbot/bin/python'} 01:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:04 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)) 01:48:04 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)) 01:48:04 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)) 01:48:04 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)) 01:48:04 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)) 01:48:04 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)) 01:48:04 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)) 01:48:04 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)) 01:48:04 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)) 01:48:04 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)) 01:48:04 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)) 01:48:04 INFO - Cleaning up... 01:48:04 INFO - Return code: 0 01:48:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 01:48: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')]} 01:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48: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')]} 01:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f945e722f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffe840>, '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 0x1f6b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6bb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525', '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 01:48: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', 'jsonschema'] in /builds/slave/test-pgo/build 01:48: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 jsonschema 01:48:04 INFO - Using env: {'DISPLAY': ':0', 01:48:04 INFO - 'HOME': '/home/cltbld', 01:48:04 INFO - 'LANG': 'en_US.UTF-8', 01:48:04 INFO - 'LANGUAGE': 'en_US:en', 01:48:04 INFO - 'LOGNAME': 'cltbld', 01:48:04 INFO - 'MAIL': '/var/mail/cltbld', 01:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:04 INFO - 'MOZ_NO_REMOTE': '1', 01:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:04 INFO - 'NO_EM_RESTART': '1', 01:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:48:04 INFO - 'PWD': '/builds/slave/test-pgo', 01:48:04 INFO - 'SHELL': '/bin/bash', 01:48:04 INFO - 'SHLVL': '1', 01:48:04 INFO - 'TERM': 'linux', 01:48:04 INFO - 'TMOUT': '86400', 01:48:04 INFO - 'USER': 'cltbld', 01:48:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525', 01:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:04 INFO - '_': '/tools/buildbot/bin/python'} 01:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:04 INFO - Downloading/unpacking jsonschema 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:48:06 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 01:48:06 INFO - Downloading/unpacking functools32 (from jsonschema) 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48:06 INFO - Downloading functools32-3.2.3-2.tar.gz 01:48:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 01:48:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:48:06 INFO - warning: no files found matching '*.txt' 01:48:06 INFO - no previously-included directories found matching 'build' 01:48:06 INFO - no previously-included directories found matching 'dist' 01:48:06 INFO - no previously-included directories found matching '.git*' 01:48:06 INFO - Installing collected packages: jsonschema, functools32 01:48:06 INFO - Running setup.py install for functools32 01:48:06 INFO - warning: no files found matching '*.txt' 01:48:06 INFO - no previously-included directories found matching 'build' 01:48:06 INFO - no previously-included directories found matching 'dist' 01:48:06 INFO - no previously-included directories found matching '.git*' 01:48:07 INFO - Successfully installed jsonschema functools32 01:48:07 INFO - Cleaning up... 01:48:07 INFO - Return code: 0 01:48:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 01:48:07 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')]} 01:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:07 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')]} 01:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:07 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 0x7f945e722f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffe840>, '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 0x1f6b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6bb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525', '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 01:48:07 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 01:48:07 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 01:48:07 INFO - Using env: {'DISPLAY': ':0', 01:48:07 INFO - 'HOME': '/home/cltbld', 01:48:07 INFO - 'LANG': 'en_US.UTF-8', 01:48:07 INFO - 'LANGUAGE': 'en_US:en', 01:48:07 INFO - 'LOGNAME': 'cltbld', 01:48:07 INFO - 'MAIL': '/var/mail/cltbld', 01:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:07 INFO - 'MOZ_NO_REMOTE': '1', 01:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:07 INFO - 'NO_EM_RESTART': '1', 01:48:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:48:07 INFO - 'PWD': '/builds/slave/test-pgo', 01:48:07 INFO - 'SHELL': '/bin/bash', 01:48:07 INFO - 'SHLVL': '1', 01:48:07 INFO - 'TERM': 'linux', 01:48:07 INFO - 'TMOUT': '86400', 01:48:07 INFO - 'USER': 'cltbld', 01:48:07 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525', 01:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:07 INFO - '_': '/tools/buildbot/bin/python'} 01:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:07 INFO - Downloading/unpacking flake8 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:48:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 01:48:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:48:09 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 01:48:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:48:09 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 01:48:09 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 01:48:09 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 01:48:09 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 01:48:09 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 01:48:09 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 01:48:09 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 01:48:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:48:09 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 01:48:09 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 01:48:09 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 01:48:09 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 01:48:09 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 01:48:09 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 01:48:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 01:48:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 01:48:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:48:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:48:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:48:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:48:09 INFO - no previously-included directories found matching 'docs/_build' 01:48:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:48:09 INFO - Running setup.py install for pep8 01:48:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:48:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:48:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:48:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:48:09 INFO - no previously-included directories found matching 'docs/_build' 01:48:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 01:48:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:48:09 INFO - Cleaning up... 01:48:09 INFO - Return code: 0 01:48:09 INFO - Running post-action listener: _resource_record_post_action 01:48:09 INFO - Running post-action listener: _start_resource_monitoring 01:48:09 INFO - Starting resource monitoring. 01:48:09 INFO - ##### 01:48:09 INFO - ##### Running install step. 01:48:09 INFO - ##### 01:48:09 INFO - Running pre-action listener: _resource_record_pre_action 01:48:09 INFO - Running main action method: install 01:48:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:48:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:48:10 INFO - Reading from file tmpfile_stdout 01:48:10 INFO - Detecting whether we're running mozinstall >=1.0... 01:48:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:48:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:48:10 INFO - Reading from file tmpfile_stdout 01:48:10 INFO - Output received: 01:48:10 INFO - Usage: mozinstall [options] installer 01:48:10 INFO - Options: 01:48:10 INFO - -h, --help show this help message and exit 01:48:10 INFO - -d DEST, --destination=DEST 01:48:10 INFO - Directory to install application into. [default: 01:48:10 INFO - "/builds/slave/test-pgo"] 01:48:10 INFO - --app=APP Application being installed. [default: firefox] 01:48:10 INFO - mkdir: /builds/slave/test-pgo/build/application 01:48:10 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'] 01:48:10 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 01:48:26 INFO - Reading from file tmpfile_stdout 01:48:26 INFO - Output received: 01:48:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:48:26 INFO - Running post-action listener: _resource_record_post_action 01:48:26 INFO - ##### 01:48:26 INFO - ##### Running run-tests step. 01:48:26 INFO - ##### 01:48:26 INFO - Running pre-action listener: _resource_record_pre_action 01:48:26 INFO - Running main action method: run_tests 01:48:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:48:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:48:26 INFO - Python 2.7.3 01:48:26 INFO - Return code: 0 01:48:26 INFO - grabbing minidump binary from tooltool 01:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:26 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 0x1ffe840>, '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 0x1f6b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6bb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:48:26 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 01:48:26 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 01:48:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:48:26 INFO - Return code: 0 01:48:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:48:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:48:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:48:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:48:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:48:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 01:48:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 01:48:27 INFO - Return code: 0 01:48:27 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/Km7NTMAWQKCHdAuF7N30_Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 01:48:27 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/Km7NTMAWQKCHdAuF7N30_Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 01:48:27 INFO - Using env: {'DISPLAY': ':0', 01:48:27 INFO - 'HOME': '/home/cltbld', 01:48:27 INFO - 'LANG': 'en_US.UTF-8', 01:48:27 INFO - 'LANGUAGE': 'en_US:en', 01:48:27 INFO - 'LOGNAME': 'cltbld', 01:48:27 INFO - 'MAIL': '/var/mail/cltbld', 01:48:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:48:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:27 INFO - 'MOZ_NO_REMOTE': '1', 01:48:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:27 INFO - 'NO_EM_RESTART': '1', 01:48:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:48:27 INFO - 'PWD': '/builds/slave/test-pgo', 01:48:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:48:27 INFO - 'SHELL': '/bin/bash', 01:48:27 INFO - 'SHLVL': '1', 01:48:27 INFO - 'TERM': 'linux', 01:48:27 INFO - 'TMOUT': '86400', 01:48:27 INFO - 'USER': 'cltbld', 01:48:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525', 01:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:27 INFO - '_': '/tools/buildbot/bin/python'} 01:48:27 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/Km7NTMAWQKCHdAuF7N30_Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 01:48:27 INFO - mozversion application_buildid: 20160113233019 01:48:27 INFO - mozversion application_changeset: 4ef045d1ebf84aec586c004bdd00bab4adc85710 01:48:27 INFO - mozversion application_display_name: Nightly 01:48:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:48:27 INFO - mozversion application_name: Firefox 01:48:27 INFO - mozversion application_remotingname: firefox 01:48:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 01:48:27 INFO - mozversion application_vendor: Mozilla 01:48:27 INFO - mozversion application_version: 46.0a1 01:48:27 INFO - mozversion platform_buildid: 20160113233019 01:48:27 INFO - mozversion platform_changeset: 4ef045d1ebf84aec586c004bdd00bab4adc85710 01:48:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 01:48:27 INFO - mozversion platform_version: 46.0a1 01:48:27 INFO - using testdate: 1452764907 01:48:27 INFO - actual date: 1452764907 01:48:27 INFO - starting webserver on 'localhost:40857' 01:48:27 INFO - SUITE-START | Running 3 tests 01:48:27 INFO - TEST-START | dromaeo_css 01:48:27 INFO - operating with platform_type : linux_ 01:48:27 INFO - Initialising browser for dromaeo_css test... 01:48:27 INFO - TEST-INFO | started process 8599 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2nFlC2/profile http://localhost:40857/getInfo.html) 01:48:31 INFO - PROCESS | 8599 | __metrics Screen width/height:1600/1200 01:48:31 INFO - PROCESS | 8599 | colorDepth:24 01:48:31 INFO - PROCESS | 8599 | Browser inner width/height: 1024/697 01:48:31 INFO - PROCESS | 8599 | __metrics 01:48:31 INFO - PROCESS | 8599 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:48:31 INFO - PROCESS | 8599 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:48:32 INFO - TEST-INFO | 8599: exit 0 01:48:32 INFO - Browser initialized. 01:48:32 INFO - Running cycle 1/1 for dromaeo_css test... 01:48:32 INFO - TEST-INFO | started process 8694 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2nFlC2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:48:44 INFO - PROCESS | 8694 | RSS: Main: 151085056 01:48:44 INFO - PROCESS | 8694 | 01:49:36 INFO - PROCESS | 8694 | 1452764976307 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] 01:51:44 INFO - PROCESS | 8694 | Cycle 1(1): loaded http://localhost:40857/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40857/tests/dromaeo/cssquery-ext.html) 01:51:45 INFO - PROCESS | 8694 | RSS: Main: 267612160 01:51:45 INFO - PROCESS | 8694 | 01:54:48 INFO - PROCESS | 8694 | Cycle 1(1): loaded http://localhost:40857/tests/dromaeo/cssquery-ext.html (next: http://localhost:40857/tests/dromaeo/cssquery-jquery.html) 01:54:48 INFO - PROCESS | 8694 | RSS: Main: 234438656 01:54:48 INFO - PROCESS | 8694 | 01:57:50 INFO - PROCESS | 8694 | Cycle 1(1): loaded http://localhost:40857/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40857/tests/dromaeo/cssquery-mootools.html) 01:57:51 INFO - PROCESS | 8694 | RSS: Main: 228012032 01:57:51 INFO - PROCESS | 8694 | 02:00:53 INFO - PROCESS | 8694 | Cycle 1(1): loaded http://localhost:40857/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40857/tests/dromaeo/cssquery-prototype.html) 02:00:53 INFO - PROCESS | 8694 | RSS: Main: 214630400 02:00:53 INFO - PROCESS | 8694 | 02:03:56 INFO - PROCESS | 8694 | Cycle 1(1): loaded http://localhost:40857/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40857/tests/dromaeo/cssquery-yui.html) 02:03:56 INFO - PROCESS | 8694 | RSS: Main: 217681920 02:03:56 INFO - PROCESS | 8694 | 02:06:59 INFO - PROCESS | 8694 | Cycle 1(1): loaded http://localhost:40857/tests/dromaeo/cssquery-yui.html (next: http://localhost:40857/tests/dromaeo/cssquery-dojo.html) 02:06:59 INFO - PROCESS | 8694 | RSS: Main: 270315520 02:06:59 INFO - PROCESS | 8694 | 02:06:59 INFO - PROCESS | 8694 | __start_tp_report 02:06:59 INFO - PROCESS | 8694 | _x_x_mozilla_page_load 02:06:59 INFO - PROCESS | 8694 | _x_x_mozilla_page_load_details 02:06:59 INFO - PROCESS | 8694 | |i|pagename|runs| 02:06:59 INFO - PROCESS | 8694 | |0;dojo.html;3144.5597616333703;3149.6850314968497;3194.696503832135;3212.309353489;3218.340240250749;5158.561522270612;5226.451222621627;5234.973825130874;5244.737763111843;5264.263003179548;5243.3970093439175;5247.291615631889;5255.395629502608;5295.7881684732565;5354.651947623402;4793;4810.711357318554;4815.542523460274;4822.397200349957;4881.170201065809;4511.390962220107;4916.016796640668;4930.901381972359;4941.925871111936;4992.301077849104;4764.142454358214;4795.064962332347;4856.562909338141;4878.292647566101;4879.365682461275;4866.440359358684;4869.659123861331;4875.8781030474165;4894.804207831682;4903.53416425439;4820.373351464287;4832.275158726184;4836.830710925101;4849.199882019462;4886.438059623153;5119.104156772587;5143.459936706667;5168.095583272912;5206.843794686166;5246.291750613656;5609.382967873531;5614.522765564931;5618.690971996539;5618.887622247532;5632.802851900164;5624.3250809902665;5646.774129034834;5653.067243904751;5653.0955047192665;5665.206871038058;5279.445658205871;5314.468553144655;5353.518183363438;5353.571714262888;5355.705436201008;5790.913136302959;5792.565557583198;5794.449527294901;5798.072308430631;5842.065269556851;5542.8337149885565;5543.889122217533;5545.390007099216;5547.833564993057;5576.414476479992;5576.163575463713;5637.915431268534;5687.914681279784;5690.146478028246;5722.170285308607;5629.774809007594;5641.294838145232;5642.294713160855;5644.802431914945;5645.435456454322;5626.774929002794;5668;5683.488486036276;5684.232628595087;5686.630369026;4365.585269399402;4407.294832826797;4414.713043652152;4428.446444194476;4465.821367145343;3921.176552923861;3932.842686292516;3938.448617193595;3967.4643923070016;3982.183652351261;5175.896482070413;5294;5309.946900530946;5310.309659744285;5310.389305229871;5517.586181036358;5528.778848846082;5619.550435965113;5648.4633959773755;5686.2607860977805;5230.398504172069;5235.738213089407;5238.004779091961;5241.135212689864;5241.790328386898;4788.880277993078;4794.856154315376;4797.016611594615;4827.444843842933;4852.1508735971065;5848.853778655568;5940.673262970578;5981.730822113015;5996.790112346134;6040.546958978006;5724.57065720081;5732.799352022659;5733.168690539932;5735.36910939788;5741.25363702716;5797.449242321973;5832.924344502494;5909.793157239476;5924.022536281465;5926.585139040226;5573.080441727069;5577.52591029767;5622.072358060874;5623.0721930880945;5662.377138514842;5643.040683083804;5668.971655141698;5682.829515114553;5683.914741278967;5691.23168372281;5547.5007249347755;5551.056320425457;5552.861178470571;5586.469285417878;5671.347795003628;5540.833774986757;5561.193626924154;5583.134614134816;5590.077637189818;5643.435656434323;5348.1442969124755;5439.728013599383;5442.047641662773;5442.428545002717;5443.918341224806;5399.865003374947;5460.863478413072;5504.174373843955;5539.307586551681;5586.664800112007;5402.51377376038;5424.267723857229;5442.210879422382;5445.564354851682;5485.533729632866 02:06:59 INFO - PROCESS | 8694 | |1;ext.html;529.9735013249336;534.3961323704215;537.8144540133655;555.9722013899304;557.5873853348523;27670;28329.291767705792;35524.822375888085;35805.2838943221;35894.10264743376;37496.62503374965;37927;37964;37975;38072.61927380726;8422.0735719071;8626.396152269344;8628.611712472954;8630.784230394227;8631.870521942175;8321.08468068512;8457.57712114395;8467.364947628952;8474.872876906851;8475.364347673918;8447.873281900776;8540.914590854074;8732.607032683512;8737.08260632634;8743.606537705788;8603.31173506118;8664.956675216583;8674.696385626536;8684.739457816213;8691.348148888796;8322.084570697218;8437.451565648213;8448.32413406926;8450.78873028173;8463.915360846375;37914.43128353077;38170.80914595437;38240;38346.616533834866;38369.23261534781;3104.58088158098;3156.195170231599;3177.8887738929025;3320.4023275810346;3473.7221022318154;28990.565141522893;29349.41301173986;29373.26566835825;29779.40441191186;30368.240793980105;3598.802065886375;3654;3677.0807298175455;3742.73800833939;3864.806759662006;219374;220981;221453;221716.8914155435;221758;53081.630204375724;53922;54153.729231353595;54502;54583.18125228125;63663.40841479;64114.358856411774;64127.03809442862;64173.35826641767;64250.6787466069;13684.657883552793;13970.790438143436;13985.79021314681;13985.930070349583;13997.30013499321;8813.603387847563;9114.179723824887;10104.646337378157;10125.392476451436;10445.321054131457;18831.71752423715;18858.622827543648;18864.905675471535;18908.527286817665;18956.24175032983;7295.671694773748;7597.278258565428;7640.847183056308;7651.311381975537;7725.884111738328;890.2788741119714;929.665320484625;936.0873148679982;1024.5491983527224;1033.8914413986574;26299.73700262973;28174.577381339295;29892.402151956838;30949.262684328918;33239.50140747843;1004.1815920025302;1013.1521609951262;1036.4713995862164;1101.7190616392768;1139.794836929344;14567.053141545766;14891;16038.75941860873;16501;16543.09013004272;372559;381756;382080;382096;382895;52519;53060.73469632705;53084.469155307954;53135;53194.202086968726;1303.8761317674805;1327.8605746396684;1340.9597712068457;1341.7584834729842;1344.1397505596426;28542.14373568796;29426.85286573639;29485.557716633837;29824.552631710976;30050.248743780707;43022.56977430185;43476;43520.782396087816;43591.34612980745;43619.78190109029;291758;292458;292958;293049;293792;26991.1902642921;30526.847365763027;31060.844695776377;31198.532022019233;31435;35343;35498;35961.28077438384;36574;36630.81684591666;29911.70088299176;31856.840715796272;37264.88205353844;38087.61912380841;38416;32114.839425802722;32941.34117317688;33666.663333366356;36562.63437365592;38740;32836.83581582077;33135.502967455024;33158.33683326368;37650.81174594109;38191.80904095462;29400;30607.387852243275;30925.69074309228;30928.381432371676;31030.22424439407;23504;23557.175498857458;23586.410339740956;24683.876580616983;24738.25785226446 02:06:59 INFO - PROCESS | 8694 | |2;jquery.html;363.62728203591325;363.8399104394067;364.5079143156739;366.5125383240289;370.6293706293706;13295.534656287033;13537.390817413216;15564.377424903005;15998.920005399972;16731.749023764653;13713.862861371408;14208.857911420882;14758.409663613442;14862.925685371585;14957.700845983074;5154.74226288685;5267.262583238331;5329;5332.786688532454;5340.492653197959;3964.2467931093142;4088.1823635272917;5264.578833693296;5354.437784032679;5584.581156413265;5675.631083979549;5730.4269573042775;5748.42515748426;5751.884962300752;5759.82720518383;4816.422029356482;4972.129877271499;4987.875303117415;4990.30135780991;4991.925121123186;4711.575958163782;4800.183968725325;4956.1822299320565;4965.0566392385335;4965.925511117336;10733.62432314873;10982.341059536373;11100.278481898731;11118.4996675149;11133.997940185342;2035.613233485633;2076.802703743142;2080.6566916458764;2141.304076175249;2189.824814014875;8511.82976340476;8646.697365592174;9138.862917056249;10239.590416383337;12689.16007178963;1659.427497513368;1767.3549154558623;1788.043396782728;1828.5245836082581;1837.8621603379665;53213.733931330484;53306.20040699393;55332;55542;55574.16638750422;9340.20608248293;9793.069658382443;9807;9893.258005649604;9902.65340713086;12179.634610961508;12624.24254544712;12658.556950506689;12676.556320528738;12829.807552886714;6582.605043697297;6799.864002719918;6901.75843845463;6945.40964018054;7022.4382049436945;6583.111279977237;6590.373914478117;6629;6656.8668626627195;6659.101021362151;4192.3082691355585;4243;4254;4260.126674031816;4285.100128972888;1677.7399503077042;1727.9049652269246;1737.2008875916968;1820.1536285626983;1838.0625880800887;412.24559056925756;866.6273502394031;912.9680461183959;917.417439925652;947.1428357336621;8971.37200395979;9705.757356066013;10012.599496020077;10235.590576376862;10282.177425805918;434.4807954494349;451.5777747805812;452.42090124640515;455.6783189648734;459.27434653247786;5729.88540229193;5917.615355001997;5933.792317268962;6032.849178770478;6033.5173186145885;449589;452052;493516.5324173428;497492;512405;65329.34670653327;66797;73590.63204683943;74596.62701686457;76500;494.4832649880883;511.92321151827525;512.0450360078427;512.2367672168517;512.4644746240187;9631.518424078908;10396.064354207854;14047.297635117999;15126.621834453787;15145.242737863284;33061.85999161619;33859.66140338565;34120;34492.65507344894;37508.624913750515;37746.62253377431;37911.43132853065;38027.61972380241;38077.23845523019;39099.218015640094;6870.175578930561;6897.55165914214;6932.757353492603;6996.685149168401;7074.858502830018;9764.02359764018;10969.83545246806;11055.226134170853;11123.610673626708;11234.269772464764;9428.481433521221;9673.322867399214;9760.658376956773;9838.508074596384;9966.601335946481;9670.178034867115;9741.26940479481;9832.557534910804;9973.750656233653;10084.747881303027;7941.483803552982;9634.181094607036;10114.797704046025;10246.6413675521;10407.271490995558;6962.1993470749485;7000.719971201095;7028.718851245892;7130.750423735144;7220.89168662481;8017.8396432072195;10012.69961901144;10013.499325033865;10094.343867648578;10230.335028223142 02:06:59 INFO - PROCESS | 8694 | |3;mootools.html;1272.5228039485194;1433.1186320412949;1448.9927550362247;1594.3542865139623;1751.301237799334;7104.11198600175;7754.418418618598;7896.605169741511;7928.881066783988;7934.6032698365;7663.118741344747;7857.567833769141;7919.208079192078;7926.524408535492;7934.841303173933;1968.6456437841182;2018.3541266794632;2325.3489023073566;2357.658139569766;2382.2376839411395;2370.561446132471;2374.6227188230873;2381.9166329178483;2382.5830479666074;2382.690250267463;2308.2613563659634;2389.6773935518654;2389.7849193572574;2390.0439824070336;2390.6533552634855;2328.208409140892;2334.9533009339802;2370.9051637934463;2393.3777217923293;2393.676853624756;2336.3224664847176;2341.484873327865;2362.870042147681;2387.5344307859973;2390.964135537968;8011.399145064143;8098;8105.959470202612;8107.716229931983;8111.43219974602;4715.41057367829;4797.880052998668;4815.783289751935;4843.806247750086;4845.75771211438;2956.807807492506;2983.4629766641997;2990.5514172874027;3031.8938837140595;3082.5530298106873;933.3140141995696;936.5410948635188;976.0386019770591;990.0248255468358;1006.3861044762689;11347.716307092307;11352.489137988729;11369.204155709103;11377.431128443628;11408.94295528517;4368.890777730582;4429.756363400044;4478.798454069574;4483.529229430928;4500.504944456107;9609.759756006017;9703.07820757041;9717.56270967808;9727.367721098106;9735.756606084762;4783.043391321749;4792.7124372537755;4798.04039192156;4799.944012317284;4801.7118972861745;4300.311950087971;4330.2638551446325;4342.652587792969;4360;4360.934585981213;3550.3609350317192;3608.314420260142;3625.963740362615;3778.0554861284677;3877.302085624615;1220.560598184653;1258.1067442116016;1260.3887114749339;1260.4076084240392;1265.4621785741208;1052.0426411965075;1063.6755789484127;1071.791000754861;1214.550616271985;1348.5549768576345;7622.199669034782;7695.038120234971;7696.615169241515;7712.768616941501;7716.2283771623515;1080.7892460970193;1097.160672085855;1104.100158370925;1106.4910141334915;1117.502711293483;5961.433663801932;6038.486728628116;6048.818535443944;6050.062240352752;6068.514518838482;9614.51927403627;9688.176504997155;9836.803263934682;9845.409275443497;9971.850422243671;9731.513424328756;9832.065953734384;9839;9852.359596626196;9864.852027219598;7443.139215196201;7622.123455802543;7669.501482403737;7677.923220767832;7692.923070769332;7217.927820721936;7259.709611615687;7303.598302093435;7310.890336645061;7324.08448943882;8525.658973641233;8743.081976392386;8938.061503542034;8965.193132618097;8976;8903.643854245758;8941.597628106621;9094.727158185266;9111.681091161778;9125.680601178927;7176.7846964591145;7233.710651574089;7252;7255.310745479171;7262.164851041986;6764.323567643196;6909.861802764017;7351.081114860643;7579;7591.164971853203;7039.648017598997;7255.238199988925;7299.890501642373;7314.341709246193;7322.231165727735;7004.4046256068805;7096.432285417051;7145.535540189871;7226.74706385274;7337.559746415019;7289;7330.157031941395;7395.112586489656;7416.184219735716;7416.4066874648815;6772.0857684212;6815.42068924147;6821.965890170517;6824.522283440111;6828.351306625863;6854.862902741817;6886.552374095668;6904.585724856323;6962.895556566757;6967.965160174167 02:06:59 INFO - PROCESS | 8694 | |4;prototype.html;331.51598665947716;343.07027954243995;345.87721358917594;350.8333541567757;354.32147437656874;5740.741666625001;5870.911936320953;5926.111083337496;5932.3474417814;5934.287885453751;5731.684757338345;5803.245578074855;5846.181534585162;5881.411858814116;5885.7939972100985;4514.751688657123;4518.683692141552;4529.8641040768825;4545.250033744428;4554.111948170108;4312.094460163354;4379.0366119453665;4406.184855801687;4495.9325610115875;4517.344984977176;4442.044960333527;4445.0443154721725;4448.399466072087;4466.553344665524;4471.642268618519;4465.575770301833;4471.82112715491;4483.39474170986;4490.371348011281;4496.797644106023;3937.606239376068;3944.3294639911283;3947.782871942042;3960.841566337343;3961.980190099031;5494.423085576037;5597.020521408778;5614.3543492498475;5641.097424412115;5657.519110875581;5242.161254199348;5242.737863106868;5249;5255.1329030709885;5256;5890.646561206341;6275.121482992385;6277.1525844011385;6278.748850045993;6282.403171698681;4173.165366926627;4231.42875711778;4296.613304802583;4304.074623955833;4346.348047792825;6380.872382552369;6482.351764823527;6482.6434546099945;6492.967535162341;6493.285738568754;4434.645228381722;4443.866683999485;4447.866564003085;4448.621867141329;4451.577100175478;4340;4486.394336764495;4501.099780044005;4503.2569626012;4508.346289787963;5147.3308469898675;5211.71335576547;5219.895602087937;5225;5227.660202086929;6288.308286088527;6302.873942521215;6311.431971122621;6313.747450101944;6320.494360451153;1554.5258696097574;1591.5941434934018;1591.9204039797964;1592.4665237145687;1592.4983630156696;1043.6868939318174;1046.7016900183412;1062.5218651606808;1072.7157303314627;1076.4402510694395;5921.644701317935;5930.169776231331;5933.406659334119;5937.673427961504;5945.524358051345;6440.677966101676;6450.935490645127;6451.096846441502;6458.61248325102;6462.644554549451;5917.615355001911;5923.378045305267;5937.020391635332;5943.31651860033;5944.970275148683;3376.7636265461674;3456.0668619472603;3465.913352166216;3500.4749287607065;3501.457274122515;6710.16122984627;6710.1947766267385;6718.563293385914;6719.227288861745;6743.224529179207;6626.900596491057;6627.602343859384;6629.370209830058;6632.237292711304;6633.502487313471;6523.739050437929;6705.295943925915;6713.765018224436;6714.764983225661;6718.899216511659;6223.937760622336;6283.088952102011;6408.711607977559;6500.187476565429;6508.446782023581;6251.624902505864;6327.525435592441;6374.107624932421;6431.807045788634;6440.130582371507;6705.6647167642395;6713.56361836479;6716.56342337766;6718.093057437183;6719.731210751711;4330.112326973026;4452.332150177499;4497.763115143362;4502.5141703238505;4508.368828363966;6353.872922541431;6361.522885783677;6377.93622063792;6474.2554606219;6477.838054048687;6278.4035516625845;6284.811455656338;6285.214348206474;6290.685465726604;6292.4966002720585;6132.969335153296;6267.247930248217;6271.686415679106;6278.0896769967185;6279.058141278662;6175;6188.102725104744;6197.163382943425;6200.906986395298;6207.410296021871;6338;6340.778072767615;6341.619502829661;6346;6347.714352854225;6073.726682299395;6135.877282454237;6186.443220110212;6186.876262474815;6195.690215489298 02:06:59 INFO - PROCESS | 8694 | |5;yui.html;654.5974225851102;719.4783781758226;729.8649749796288;732.813132651174;744.192551082076;10966.396848173346;11204.047655949234;11226.887731122686;11438.485268162933;12280.754384912296;12129.818052729193;12163.695907602314;12176.573819916304;12186.268823870552;12212.633620991362;653.9738410463576;660.6861740673165;771.147881590841;787.5314188058096;788.4283894176705;767.3170877918657;774.7056118674896;777.2499537945881;780.8047988003;781.601383294521;818.5988865455944;822.7696245051366;823.7611092783086;825.0223485170093;829.0176141272611;675.0953722012503;679.1103654212972;819.3608984991656;820.5076953827686;833.3000279764966;598.1565991951328;601.2694576090072;601.5217901768104;602.2231321595137;602.4367216652444;12292.815607765891;12345.197562158432;12350.938245308716;12383.504659813596;12418.441170147365;11629.883701162964;11944.433371865869;11964.461599228056;12189.085818563643;12399.318037507934;9279.953600232024;9368.11002954725;9492.857607135898;9608.327417080807;9720.75698107546;3063.5711000459955;3087.861046252924;3094.3965926644314;3139.5133754268127;3142.308692087737;46234.53765462336;47020;47088.29367559489;47120.29319560175;47381.76309118467;10025.799484010278;10146.695599132037;10232;10246.948765256126;10273.691789246335;17196.484105476855;17218.483445496655;17252;17252.482425527254;17274.04992725412;6566.5403421760975;6700.564463309869;6705.597664140168;6715.832104197337;6718.529702920749;3709.647583479565;3774.9622503774613;3803.3154032274456;3818.198178382571;3917.118648304109;2949.616549848549;2976.955345669817;2994.386150839073;2999.47509185896;3002.0243420887864;552.7291627102771;559.3651205881354;571.9942800571941;575.7696921231541;576.6107877182968;499.57286520024854;512.3211744438634;531.5349069564131;595.830188396305;608.5831205624073;7810.901323111838;7847.725329613436;7883;8063.27430531255;8227.794305142419;486.19291975321505;497.659103514094;498.30984087038985;504.95707864831166;510.9693418394908;3577.3586406434724;3673.246984368198;3807.562130354989;3914.451976723261;4029;56273.43726562682;56849;57092.429075708715;57426.425735742945;57605.711971440716;45962;46401;50183.74908125509;50946.74526627417;52771.736141319045;43070.56929430791;44426.55573444289;44534.33198502025;44589;44598;8203.42576019673;8363.749087527383;8431.494110353398;8599.183077607617;8675.869861952202;32337.67662323441;32438.675613244508;32999.835000824845;33152.336953261285;33281.83359083286;41264.58735412607;41374;43003.784981074896;43567.56432435635;43765.78117109394;11006.944965275443;11012.779744405227;11084.889151108386;11152.330860148417;11386.259893106922;12196.451159698012;12445.377731113227;12446;12491.916468516452;12617.369131543202;11010.449477525932;11256.268342557707;11330.546778128783;11497.252678575866;11679.416029198335;11075.889241107487;11449.313041217554;11462.484188211718;11486.138539609396;11622.244554104294;7592.878104155385;10529.210309226686;11403.315801051964;11545.422728863692;11704.297742135499;8802.823943520965;8934.329925255503;9018.774530636787;9077.228435583049;9102.772430689285;9768.26737994639;10010.499475026365;10034.749131271778;10035.448050357301;10133.898661013296 02:06:59 INFO - PROCESS | 8694 | __end_tp_report 02:06:59 INFO - PROCESS | 8694 | __start_cc_report 02:06:59 INFO - PROCESS | 8694 | _x_x_mozilla_cycle_collect,973 02:06:59 INFO - PROCESS | 8694 | __end_cc_report 02:06:59 INFO - PROCESS | 8694 | __startTimestamp1452766019883__endTimestamp 02:06:59 INFO - PROCESS | 8694 | 02:06:59 INFO - PROCESS | 8694 | ------- Summary: start ------- 02:06:59 INFO - PROCESS | 8694 | Number of tests: 6 02:06:59 INFO - PROCESS | 8694 | 02:06:59 INFO - PROCESS | 8694 | [#0] dojo.html Cycles:165 Average:5264.18 Median:5442.43 stddev:575.02 (10.6%) stddev-sans-first:552.21 02:06:59 INFO - PROCESS | 8694 | Values: 3144.6 3149.7 3194.7 3212.3 3218.3 5158.6 5226.5 5235.0 5244.7 5264.3 5243.4 5247.3 5255.4 5295.8 5354.7 4793.0 4810.7 4815.5 4822.4 4881.2 4511.4 4916.0 4930.9 4941.9 4992.3 4764.1 4795.1 4856.6 4878.3 4879.4 4866.4 4869.7 4875.9 4894.8 4903.5 4820.4 4832.3 4836.8 4849.2 4886.4 5119.1 5143.5 5168.1 5206.8 5246.3 5609.4 5614.5 5618.7 5618.9 5632.8 5624.3 5646.8 5653.1 5653.1 5665.2 5279.4 5314.5 5353.5 5353.6 5355.7 5790.9 5792.6 5794.4 5798.1 5842.1 5542.8 5543.9 5545.4 5547.8 5576.4 5576.2 5637.9 5687.9 5690.1 5722.2 5629.8 5641.3 5642.3 5644.8 5645.4 5626.8 5668.0 5683.5 5684.2 5686.6 4365.6 4407.3 4414.7 4428.4 4465.8 3921.2 3932.8 3938.4 3967.5 3982.2 5175.9 5294.0 5309.9 5310.3 5310.4 5517.6 5528.8 5619.6 5648.5 5686.3 5230.4 5235.7 5238.0 5241.1 5241.8 4788.9 4794.9 4797.0 4827.4 4852.2 5848.9 5940.7 5981.7 5996.8 6040.5 5724.6 5732.8 5733.2 5735.4 5741.3 5797.4 5832.9 5909.8 5924.0 5926.6 5573.1 5577.5 5622.1 5623.1 5662.4 5643.0 5669.0 5682.8 5683.9 5691.2 5547.5 5551.1 5552.9 5586.5 5671.3 5540.8 5561.2 5583.1 5590.1 5643.4 5348.1 5439.7 5442.0 5442.4 5443.9 5399.9 5460.9 5504.2 5539.3 5586.7 5402.5 5424.3 5442.2 5445.6 5485.5 02:06:59 INFO - PROCESS | 8694 | 02:06:59 INFO - PROCESS | 8694 | [#1] ext.html Cycles:180 Average:45870.97 Median:19780.04 stddev:80252.81 (405.7%) stddev-sans-first:80405.74 02:06:59 INFO - PROCESS | 8694 | Values: 530.0 534.4 537.8 556.0 557.6 27670.0 28329.3 35524.8 35805.3 35894.1 37496.6 37927.0 37964.0 37975.0 38072.6 8422.1 8626.4 8628.6 8630.8 8631.9 8321.1 8457.6 8467.4 8474.9 8475.4 8447.9 8540.9 8732.6 8737.1 8743.6 8603.3 8665.0 8674.7 8684.7 8691.3 8322.1 8437.5 8448.3 8450.8 8463.9 37914.4 38170.8 38240.0 38346.6 38369.2 3104.6 3156.2 3177.9 3320.4 3473.7 28990.6 29349.4 29373.3 29779.4 30368.2 3598.8 3654.0 3677.1 3742.7 3864.8 219374.0 220981.0 221453.0 221716.9 221758.0 53081.6 53922.0 54153.7 54502.0 54583.2 63663.4 64114.4 64127.0 64173.4 64250.7 13684.7 13970.8 13985.8 13985.9 13997.3 8813.6 9114.2 10104.6 10125.4 10445.3 18831.7 18858.6 18864.9 18908.5 18956.2 7295.7 7597.3 7640.8 7651.3 7725.9 890.3 929.7 936.1 1024.5 1033.9 26299.7 28174.6 29892.4 30949.3 33239.5 1004.2 1013.2 1036.5 1101.7 1139.8 14567.1 14891.0 16038.8 16501.0 16543.1 372559.0 381756.0 382080.0 382096.0 382895.0 52519.0 53060.7 53084.5 53135.0 53194.2 1303.9 1327.9 1341.0 1341.8 1344.1 28542.1 29426.9 29485.6 29824.6 30050.2 43022.6 43476.0 43520.8 43591.3 43619.8 291758.0 292458.0 292958.0 293049.0 293792.0 26991.2 30526.8 31060.8 31198.5 31435.0 35343.0 35498.0 35961.3 36574.0 36630.8 29911.7 31856.8 37264.9 38087.6 38416.0 32114.8 32941.3 33666.7 36562.6 38740.0 32836.8 33135.5 33158.3 37650.8 38191.8 29400.0 30607.4 30925.7 30928.4 31030.2 23504.0 23557.2 23586.4 24683.9 24738.3 02:06:59 INFO - PROCESS | 8694 | 02:06:59 INFO - PROCESS | 8694 | [#2] jquery.html Cycles:180 Average:24891.75 Median:2725.33 stddev:78841.45 (2892.9%) stddev-sans-first:79041.11 02:06:59 INFO - PROCESS | 8694 | Values: 363.6 363.8 364.5 366.5 370.6 13295.5 13537.4 15564.4 15998.9 16731.7 13713.9 14208.9 14758.4 14862.9 14957.7 5154.7 5267.3 5329.0 5332.8 5340.5 3964.2 4088.2 5264.6 5354.4 5584.6 5675.6 5730.4 5748.4 5751.9 5759.8 4816.4 4972.1 4987.9 4990.3 4991.9 4711.6 4800.2 4956.2 4965.1 4965.9 10733.6 10982.3 11100.3 11118.5 11134.0 2035.6 2076.8 2080.7 2141.3 2189.8 8511.8 8646.7 9138.9 10239.6 12689.2 1659.4 1767.4 1788.0 1828.5 1837.9 53213.7 53306.2 55332.0 55542.0 55574.2 9340.2 9793.1 9807.0 9893.3 9902.7 12179.6 12624.2 12658.6 12676.6 12829.8 6582.6 6799.9 6901.8 6945.4 7022.4 6583.1 6590.4 6629.0 6656.9 6659.1 4192.3 4243.0 4254.0 4260.1 4285.1 1677.7 1727.9 1737.2 1820.2 1838.1 412.2 866.6 913.0 917.4 947.1 8971.4 9705.8 10012.6 10235.6 10282.2 434.5 451.6 452.4 455.7 459.3 5729.9 5917.6 5933.8 6032.8 6033.5 449589.0 452052.0 493516.5 497492.0 512405.0 65329.3 66797.0 73590.6 74596.6 76500.0 494.5 511.9 512.0 512.2 512.5 9631.5 10396.1 14047.3 15126.6 15145.2 33061.9 33859.7 34120.0 34492.7 37508.6 37746.6 37911.4 38027.6 38077.2 39099.2 6870.2 6897.6 6932.8 6996.7 7074.9 9764.0 10969.8 11055.2 11123.6 11234.3 9428.5 9673.3 9760.7 9838.5 9966.6 9670.2 9741.3 9832.6 9973.8 10084.7 7941.5 9634.2 10114.8 10246.6 10407.3 6962.2 7000.7 7028.7 7130.8 7220.9 8017.8 10012.7 10013.5 10094.3 10230.3 02:06:59 INFO - PROCESS | 8694 | 02:06:59 INFO - PROCESS | 8694 | [#3] mootools.html Cycles:180 Average:5654.96 Median:6826.44 stddev:2976.44 (43.6%) stddev-sans-first:2966.56 02:06:59 INFO - PROCESS | 8694 | Values: 1272.5 1433.1 1449.0 1594.4 1751.3 7104.1 7754.4 7896.6 7928.9 7934.6 7663.1 7857.6 7919.2 7926.5 7934.8 1968.6 2018.4 2325.3 2357.7 2382.2 2370.6 2374.6 2381.9 2382.6 2382.7 2308.3 2389.7 2389.8 2390.0 2390.7 2328.2 2335.0 2370.9 2393.4 2393.7 2336.3 2341.5 2362.9 2387.5 2391.0 8011.4 8098.0 8106.0 8107.7 8111.4 4715.4 4797.9 4815.8 4843.8 4845.8 2956.8 2983.5 2990.6 3031.9 3082.6 933.3 936.5 976.0 990.0 1006.4 11347.7 11352.5 11369.2 11377.4 11408.9 4368.9 4429.8 4478.8 4483.5 4500.5 9609.8 9703.1 9717.6 9727.4 9735.8 4783.0 4792.7 4798.0 4799.9 4801.7 4300.3 4330.3 4342.7 4360.0 4360.9 3550.4 3608.3 3626.0 3778.1 3877.3 1220.6 1258.1 1260.4 1260.4 1265.5 1052.0 1063.7 1071.8 1214.6 1348.6 7622.2 7695.0 7696.6 7712.8 7716.2 1080.8 1097.2 1104.1 1106.5 1117.5 5961.4 6038.5 6048.8 6050.1 6068.5 9614.5 9688.2 9836.8 9845.4 9971.9 9731.5 9832.1 9839.0 9852.4 9864.9 7443.1 7622.1 7669.5 7677.9 7692.9 7217.9 7259.7 7303.6 7310.9 7324.1 8525.7 8743.1 8938.1 8965.2 8976.0 8903.6 8941.6 9094.7 9111.7 9125.7 7176.8 7233.7 7252.0 7255.3 7262.2 6764.3 6909.9 7351.1 7579.0 7591.2 7039.6 7255.2 7299.9 7314.3 7322.2 7004.4 7096.4 7145.5 7226.7 7337.6 7289.0 7330.2 7395.1 7416.2 7416.4 6772.1 6815.4 6822.0 6824.5 6828.4 6854.9 6886.6 6904.6 6962.9 6968.0 02:06:59 INFO - PROCESS | 8694 | 02:06:59 INFO - PROCESS | 8694 | [#4] prototype.html Cycles:180 Average:5225.50 Median:5924.74 stddev:1577.68 (26.6%) stddev-sans-first:1538.74 02:06:59 INFO - PROCESS | 8694 | Values: 331.5 343.1 345.9 350.8 354.3 5740.7 5870.9 5926.1 5932.3 5934.3 5731.7 5803.2 5846.2 5881.4 5885.8 4514.8 4518.7 4529.9 4545.3 4554.1 4312.1 4379.0 4406.2 4495.9 4517.3 4442.0 4445.0 4448.4 4466.6 4471.6 4465.6 4471.8 4483.4 4490.4 4496.8 3937.6 3944.3 3947.8 3960.8 3962.0 5494.4 5597.0 5614.4 5641.1 5657.5 5242.2 5242.7 5249.0 5255.1 5256.0 5890.6 6275.1 6277.2 6278.7 6282.4 4173.2 4231.4 4296.6 4304.1 4346.3 6380.9 6482.4 6482.6 6493.0 6493.3 4434.6 4443.9 4447.9 4448.6 4451.6 4340.0 4486.4 4501.1 4503.3 4508.3 5147.3 5211.7 5219.9 5225.0 5227.7 6288.3 6302.9 6311.4 6313.7 6320.5 1554.5 1591.6 1591.9 1592.5 1592.5 1043.7 1046.7 1062.5 1072.7 1076.4 5921.6 5930.2 5933.4 5937.7 5945.5 6440.7 6450.9 6451.1 6458.6 6462.6 5917.6 5923.4 5937.0 5943.3 5945.0 3376.8 3456.1 3465.9 3500.5 3501.5 6710.2 6710.2 6718.6 6719.2 6743.2 6626.9 6627.6 6629.4 6632.2 6633.5 6523.7 6705.3 6713.8 6714.8 6718.9 6223.9 6283.1 6408.7 6500.2 6508.4 6251.6 6327.5 6374.1 6431.8 6440.1 6705.7 6713.6 6716.6 6718.1 6719.7 4330.1 4452.3 4497.8 4502.5 4508.4 6353.9 6361.5 6377.9 6474.3 6477.8 6278.4 6284.8 6285.2 6290.7 6292.5 6133.0 6267.2 6271.7 6278.1 6279.1 6175.0 6188.1 6197.2 6200.9 6207.4 6338.0 6340.8 6341.6 6346.0 6347.7 6073.7 6135.9 6186.4 6186.9 6195.7 02:06:59 INFO - PROCESS | 8694 | 02:06:59 INFO - PROCESS | 8694 | [#5] yui.html Cycles:180 Average:13237.81 Median:44561.67 stddev:15470.88 (34.7%) stddev-sans-first:15485.42 02:06:59 INFO - PROCESS | 8694 | Values: 654.6 719.5 729.9 732.8 744.2 10966.4 11204.0 11226.9 11438.5 12280.8 12129.8 12163.7 12176.6 12186.3 12212.6 654.0 660.7 771.1 787.5 788.4 767.3 774.7 777.2 780.8 781.6 818.6 822.8 823.8 825.0 829.0 675.1 679.1 819.4 820.5 833.3 598.2 601.3 601.5 602.2 602.4 12292.8 12345.2 12350.9 12383.5 12418.4 11629.9 11944.4 11964.5 12189.1 12399.3 9280.0 9368.1 9492.9 9608.3 9720.8 3063.6 3087.9 3094.4 3139.5 3142.3 46234.5 47020.0 47088.3 47120.3 47381.8 10025.8 10146.7 10232.0 10246.9 10273.7 17196.5 17218.5 17252.0 17252.5 17274.0 6566.5 6700.6 6705.6 6715.8 6718.5 3709.6 3775.0 3803.3 3818.2 3917.1 2949.6 2977.0 2994.4 2999.5 3002.0 552.7 559.4 572.0 575.8 576.6 499.6 512.3 531.5 595.8 608.6 7810.9 7847.7 7883.0 8063.3 8227.8 486.2 497.7 498.3 505.0 511.0 3577.4 3673.2 3807.6 3914.5 4029.0 56273.4 56849.0 57092.4 57426.4 57605.7 45962.0 46401.0 50183.7 50946.7 52771.7 43070.6 44426.6 44534.3 44589.0 44598.0 8203.4 8363.7 8431.5 8599.2 8675.9 32337.7 32438.7 32999.8 33152.3 33281.8 41264.6 41374.0 43003.8 43567.6 43765.8 11006.9 11012.8 11084.9 11152.3 11386.3 12196.5 12445.4 12446.0 12491.9 12617.4 11010.4 11256.3 11330.5 11497.3 11679.4 11075.9 11449.3 11462.5 11486.1 11622.2 7592.9 10529.2 11403.3 11545.4 11704.3 8802.8 8934.3 9018.8 9077.2 9102.8 9768.3 10010.5 10034.7 10035.4 10133.9 02:06:59 INFO - PROCESS | 8694 | -------- Summary: end -------- 02:06:59 INFO - PROCESS | 8694 | 02:07:00 INFO - TEST-INFO | 8694: exit 0 02:07:00 INFO - TEST-OK | dromaeo_css | took 1113170ms 02:07:00 INFO - TEST-START | kraken 02:07:00 INFO - operating with platform_type : linux_ 02:07:00 INFO - Initialising browser for kraken test... 02:07:00 INFO - TEST-INFO | started process 8881 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpctNLgw/profile http://localhost:40857/getInfo.html) 02:07:04 INFO - PROCESS | 8881 | __metrics Screen width/height:1600/1200 02:07:04 INFO - PROCESS | 8881 | colorDepth:24 02:07:04 INFO - PROCESS | 8881 | Browser inner width/height: 1024/697 02:07:04 INFO - PROCESS | 8881 | __metrics 02:07:04 INFO - PROCESS | 8881 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:07:04 INFO - PROCESS | 8881 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:07:05 INFO - TEST-INFO | 8881: exit 0 02:07:05 INFO - Browser initialized. 02:07:05 INFO - Running cycle 1/1 for kraken test... 02:07:05 INFO - TEST-INFO | started process 8964 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpctNLgw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:07:17 INFO - PROCESS | 8964 | RSS: Main: 149819392 02:07:17 INFO - PROCESS | 8964 | 02:07:19 INFO - PROCESS | 8964 | Cycle 1(1): loaded http://localhost:40857/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40857/tests/kraken/driver.html?testName=audio-beat-detection) 02:07:20 INFO - PROCESS | 8964 | RSS: Main: 190021632 02:07:20 INFO - PROCESS | 8964 | 02:07:23 INFO - PROCESS | 8964 | Cycle 1(1): loaded http://localhost:40857/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40857/tests/kraken/driver.html?testName=audio-dft) 02:07:23 INFO - PROCESS | 8964 | RSS: Main: 178499584 02:07:23 INFO - PROCESS | 8964 | 02:07:26 INFO - PROCESS | 8964 | Cycle 1(1): loaded http://localhost:40857/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40857/tests/kraken/driver.html?testName=audio-fft) 02:07:27 INFO - PROCESS | 8964 | RSS: Main: 161771520 02:07:27 INFO - PROCESS | 8964 | 02:07:29 INFO - PROCESS | 8964 | Cycle 1(1): loaded http://localhost:40857/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40857/tests/kraken/driver.html?testName=audio-oscillator) 02:07:29 INFO - PROCESS | 8964 | RSS: Main: 162721792 02:07:29 INFO - PROCESS | 8964 | 02:07:31 INFO - PROCESS | 8964 | Cycle 1(1): loaded http://localhost:40857/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40857/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:07:32 INFO - PROCESS | 8964 | RSS: Main: 164904960 02:07:32 INFO - PROCESS | 8964 | 02:07:35 INFO - PROCESS | 8964 | Cycle 1(1): loaded http://localhost:40857/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40857/tests/kraken/driver.html?testName=imaging-darkroom) 02:07:35 INFO - PROCESS | 8964 | RSS: Main: 165031936 02:07:35 INFO - PROCESS | 8964 | 02:07:39 INFO - PROCESS | 8964 | Cycle 1(1): loaded http://localhost:40857/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40857/tests/kraken/driver.html?testName=imaging-desaturate) 02:07:39 INFO - PROCESS | 8964 | RSS: Main: 166043648 02:07:39 INFO - PROCESS | 8964 | 02:07:42 INFO - PROCESS | 8964 | Cycle 1(1): loaded http://localhost:40857/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40857/tests/kraken/driver.html?testName=json-parse-financial) 02:07:43 INFO - PROCESS | 8964 | RSS: Main: 165617664 02:07:43 INFO - PROCESS | 8964 | 02:07:44 INFO - PROCESS | 8964 | Cycle 1(1): loaded http://localhost:40857/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40857/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:07:45 INFO - PROCESS | 8964 | RSS: Main: 177242112 02:07:45 INFO - PROCESS | 8964 | 02:07:47 INFO - PROCESS | 8964 | Cycle 1(1): loaded http://localhost:40857/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40857/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:07:47 INFO - PROCESS | 8964 | RSS: Main: 175439872 02:07:47 INFO - PROCESS | 8964 | 02:07:49 INFO - PROCESS | 8964 | Cycle 1(1): loaded http://localhost:40857/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40857/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:07:50 INFO - PROCESS | 8964 | RSS: Main: 181747712 02:07:50 INFO - PROCESS | 8964 | 02:07:52 INFO - PROCESS | 8964 | Cycle 1(1): loaded http://localhost:40857/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40857/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:07:53 INFO - PROCESS | 8964 | RSS: Main: 190795776 02:07:53 INFO - PROCESS | 8964 | 02:07:55 INFO - PROCESS | 8964 | Cycle 1(1): loaded http://localhost:40857/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40857/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:07:56 INFO - PROCESS | 8964 | RSS: Main: 190550016 02:07:56 INFO - PROCESS | 8964 | 02:07:58 INFO - PROCESS | 8964 | Cycle 1(1): loaded http://localhost:40857/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40857/tests/kraken/driver.html?testName=ai-astar) 02:07:58 INFO - PROCESS | 8964 | RSS: Main: 247750656 02:07:58 INFO - PROCESS | 8964 | 02:07:58 INFO - PROCESS | 8964 | __start_tp_report 02:07:58 INFO - PROCESS | 8964 | _x_x_mozilla_page_load 02:07:58 INFO - PROCESS | 8964 | _x_x_mozilla_page_load_details 02:07:58 INFO - PROCESS | 8964 | |i|pagename|runs| 02:07:58 INFO - PROCESS | 8964 | |0;ai-astar;110;110;105;109;110;110;101;112;111;110 02:07:58 INFO - PROCESS | 8964 | |1;audio-beat-detection;167;125;149;164;125;152;151;127;165;125 02:07:58 INFO - PROCESS | 8964 | |2;audio-dft;160;160;160;160;161;159;159;161;161;161 02:07:58 INFO - PROCESS | 8964 | |3;audio-fft;72;73;97;96;72;72;73;103;91;71 02:07:58 INFO - PROCESS | 8964 | |4;audio-oscillator;95;96;136;95;97;97;137;95;97;148 02:07:58 INFO - PROCESS | 8964 | |5;imaging-gaussian-blur;108;109;109;110;109;109;110;109;109;109 02:07:58 INFO - PROCESS | 8964 | |6;imaging-darkroom;146;146;145;146;145;145;145;145;145;144 02:07:58 INFO - PROCESS | 8964 | |7;imaging-desaturate;96;96;96;95;95;96;95;96;96;95 02:07:58 INFO - PROCESS | 8964 | |8;json-parse-financial;58;59;56;55;59;56;56;66;55;55 02:07:58 INFO - PROCESS | 8964 | |9;json-stringify-tinderbox;67;68;67;69;67;67;69;68;68;69 02:07:58 INFO - PROCESS | 8964 | |10;stanford-crypto-aes;81;90;90;83;82;88;82;83;82;83 02:07:58 INFO - PROCESS | 8964 | |11;stanford-crypto-ccm;116;115;122;124;123;133;124;122;120;118 02:07:58 INFO - PROCESS | 8964 | |12;stanford-crypto-pbkdf2;151;148;150;149;149;138;159;147;149;152 02:07:58 INFO - PROCESS | 8964 | |13;stanford-crypto-sha256-iterative;67;69;67;67;70;68;66;68;71;67 02:07:58 INFO - PROCESS | 8964 | __end_tp_report 02:07:58 INFO - PROCESS | 8964 | __start_cc_report 02:07:58 INFO - PROCESS | 8964 | _x_x_mozilla_cycle_collect,953 02:07:58 INFO - PROCESS | 8964 | __end_cc_report 02:07:58 INFO - PROCESS | 8964 | __startTimestamp1452766078437__endTimestamp 02:07:58 INFO - PROCESS | 8964 | 02:07:58 INFO - PROCESS | 8964 | ------- Summary: start ------- 02:07:58 INFO - PROCESS | 8964 | Number of tests: 14 02:07:58 INFO - PROCESS | 8964 | 02:07:58 INFO - PROCESS | 8964 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:3.29 (3.0%) stddev-sans-first:3.46 02:07:58 INFO - PROCESS | 8964 | Values: 110.0 110.0 105.0 109.0 110.0 110.0 101.0 112.0 111.0 110.0 02:07:58 INFO - PROCESS | 8964 | 02:07:58 INFO - PROCESS | 8964 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:151.50 stddev:17.86 (11.8%) stddev-sans-first:17.07 02:07:58 INFO - PROCESS | 8964 | Values: 167.0 125.0 149.0 164.0 125.0 152.0 151.0 127.0 165.0 125.0 02:07:58 INFO - PROCESS | 8964 | 02:07:58 INFO - PROCESS | 8964 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 02:07:58 INFO - PROCESS | 8964 | Values: 160.0 160.0 160.0 160.0 161.0 159.0 159.0 161.0 161.0 161.0 02:07:58 INFO - PROCESS | 8964 | 02:07:58 INFO - PROCESS | 8964 | [#3] audio-fft Cycles:10 Average:82.00 Median:73.00 stddev:13.02 (17.8%) stddev-sans-first:13.30 02:07:58 INFO - PROCESS | 8964 | Values: 72.0 73.0 97.0 96.0 72.0 72.0 73.0 103.0 91.0 71.0 02:07:58 INFO - PROCESS | 8964 | 02:07:58 INFO - PROCESS | 8964 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:95.50 stddev:21.66 (22.7%) stddev-sans-first:22.35 02:07:58 INFO - PROCESS | 8964 | Values: 95.0 96.0 136.0 95.0 97.0 97.0 137.0 95.0 97.0 148.0 02:07:58 INFO - PROCESS | 8964 | 02:07:58 INFO - PROCESS | 8964 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 02:07:58 INFO - PROCESS | 8964 | Values: 108.0 109.0 109.0 110.0 109.0 109.0 110.0 109.0 109.0 109.0 02:07:58 INFO - PROCESS | 8964 | 02:07:58 INFO - PROCESS | 8964 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 02:07:58 INFO - PROCESS | 8964 | Values: 146.0 146.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 144.0 02:07:58 INFO - PROCESS | 8964 | 02:07:58 INFO - PROCESS | 8964 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:07:58 INFO - PROCESS | 8964 | Values: 96.0 96.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 02:07:58 INFO - PROCESS | 8964 | 02:07:58 INFO - PROCESS | 8964 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.00 stddev:3.37 (5.9%) stddev-sans-first:3.57 02:07:58 INFO - PROCESS | 8964 | Values: 58.0 59.0 56.0 55.0 59.0 56.0 56.0 66.0 55.0 55.0 02:07:58 INFO - PROCESS | 8964 | 02:07:58 INFO - PROCESS | 8964 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 02:07:58 INFO - PROCESS | 8964 | Values: 67.0 68.0 67.0 69.0 67.0 67.0 69.0 68.0 68.0 69.0 02:07:58 INFO - PROCESS | 8964 | 02:07:58 INFO - PROCESS | 8964 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:83.00 stddev:3.50 (4.2%) stddev-sans-first:3.49 02:07:58 INFO - PROCESS | 8964 | Values: 81.0 90.0 90.0 83.0 82.0 88.0 82.0 83.0 82.0 83.0 02:07:58 INFO - PROCESS | 8964 | 02:07:58 INFO - PROCESS | 8964 | [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:122.50 stddev:5.10 (4.2%) stddev-sans-first:4.97 02:07:58 INFO - PROCESS | 8964 | Values: 116.0 115.0 122.0 124.0 123.0 133.0 124.0 122.0 120.0 118.0 02:07:58 INFO - PROCESS | 8964 | 02:07:58 INFO - PROCESS | 8964 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.20 Median:149.50 stddev:5.16 (3.5%) stddev-sans-first:5.43 02:07:58 INFO - PROCESS | 8964 | Values: 151.0 148.0 150.0 149.0 149.0 138.0 159.0 147.0 149.0 152.0 02:07:58 INFO - PROCESS | 8964 | 02:07:58 INFO - PROCESS | 8964 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.56 (2.3%) stddev-sans-first:1.62 02:07:58 INFO - PROCESS | 8964 | Values: 67.0 69.0 67.0 67.0 70.0 68.0 66.0 68.0 71.0 67.0 02:07:58 INFO - PROCESS | 8964 | -------- Summary: end -------- 02:07:58 INFO - PROCESS | 8964 | 02:07:59 INFO - TEST-INFO | 8964: exit 0 02:07:59 INFO - TEST-OK | kraken | took 58714ms 02:07:59 INFO - TEST-START | v8_7 02:07:59 INFO - operating with platform_type : linux_ 02:07:59 INFO - Initialising browser for v8_7 test... 02:07:59 INFO - TEST-INFO | started process 9210 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsi3EI5/profile http://localhost:40857/getInfo.html) 02:08:03 INFO - PROCESS | 9210 | __metrics Screen width/height:1600/1200 02:08:03 INFO - PROCESS | 9210 | colorDepth:24 02:08:03 INFO - PROCESS | 9210 | Browser inner width/height: 1024/697 02:08:03 INFO - PROCESS | 9210 | __metrics 02:08:03 INFO - PROCESS | 9210 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:08:03 INFO - PROCESS | 9210 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:08:04 INFO - TEST-INFO | 9210: exit 0 02:08:04 INFO - Browser initialized. 02:08:04 INFO - Running cycle 1/1 for v8_7 test... 02:08:04 INFO - TEST-INFO | started process 9292 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsi3EI5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:08:16 INFO - PROCESS | 9292 | RSS: Main: 150384640 02:08:16 INFO - PROCESS | 9292 | 02:08:38 INFO - PROCESS | 9292 | Cycle 1(1): loaded http://localhost:40857/tests/v8_7/run.html (next: http://localhost:40857/tests/v8_7/run.html) 02:08:38 INFO - PROCESS | 9292 | RSS: Main: 565567488 02:08:38 INFO - PROCESS | 9292 | 02:08:38 INFO - PROCESS | 9292 | __start_tp_report 02:08:38 INFO - PROCESS | 9292 | _x_x_mozilla_page_load 02:08:38 INFO - PROCESS | 9292 | _x_x_mozilla_page_load_details 02:08:38 INFO - PROCESS | 9292 | |i|pagename|runs| 02:08:38 INFO - PROCESS | 9292 | |0;Richards;167.22408026755852 02:08:38 INFO - PROCESS | 9292 | |1;DeltaBlue;190.22256039566292 02:08:38 INFO - PROCESS | 9292 | |2;Encrypt;285.8776443682104 02:08:38 INFO - PROCESS | 9292 | |3;Decrypt;5175.257731958763 02:08:38 INFO - PROCESS | 9292 | |4;RayTrace;2018.1451612903227 02:08:38 INFO - PROCESS | 9292 | |5;Earley;770.4160246533128 02:08:38 INFO - PROCESS | 9292 | |6;Boyer;12207.317073170732 02:08:38 INFO - PROCESS | 9292 | |7;RegExp;42000 02:08:38 INFO - PROCESS | 9292 | |8;Splay;555.5555555555555 02:08:38 INFO - PROCESS | 9292 | |9;NavierStokes;4854.368932038835 02:08:38 INFO - PROCESS | 9292 | __end_tp_report 02:08:38 INFO - PROCESS | 9292 | __startTimestamp1452766118795__endTimestamp 02:08:38 INFO - PROCESS | 9292 | 02:08:38 INFO - PROCESS | 9292 | ------- Summary: start ------- 02:08:38 INFO - PROCESS | 9292 | Number of tests: 10 02:08:38 INFO - PROCESS | 9292 | 02:08:38 INFO - PROCESS | 9292 | [#0] Richards Cycles:1 Average:167.22 Median:167.22 stddev:0.00 (0.0%) 02:08:38 INFO - PROCESS | 9292 | Values: 167.2 02:08:38 INFO - PROCESS | 9292 | 02:08:38 INFO - PROCESS | 9292 | [#1] DeltaBlue Cycles:1 Average:190.22 Median:190.22 stddev:0.00 (0.0%) 02:08:38 INFO - PROCESS | 9292 | Values: 190.2 02:08:38 INFO - PROCESS | 9292 | 02:08:38 INFO - PROCESS | 9292 | [#2] Encrypt Cycles:1 Average:285.88 Median:285.88 stddev:0.00 (0.0%) 02:08:38 INFO - PROCESS | 9292 | Values: 285.9 02:08:38 INFO - PROCESS | 9292 | 02:08:38 INFO - PROCESS | 9292 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 02:08:38 INFO - PROCESS | 9292 | Values: 5175.3 02:08:38 INFO - PROCESS | 9292 | 02:08:38 INFO - PROCESS | 9292 | [#4] RayTrace Cycles:1 Average:2018.15 Median:2018.15 stddev:0.00 (0.0%) 02:08:38 INFO - PROCESS | 9292 | Values: 2018.1 02:08:38 INFO - PROCESS | 9292 | 02:08:38 INFO - PROCESS | 9292 | [#5] Earley Cycles:1 Average:770.42 Median:770.42 stddev:0.00 (0.0%) 02:08:38 INFO - PROCESS | 9292 | Values: 770.4 02:08:38 INFO - PROCESS | 9292 | 02:08:38 INFO - PROCESS | 9292 | [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 02:08:38 INFO - PROCESS | 9292 | Values: 12207.3 02:08:38 INFO - PROCESS | 9292 | 02:08:38 INFO - PROCESS | 9292 | [#7] RegExp Cycles:1 Average:42000.00 Median:42000.00 stddev:0.00 (0.0%) 02:08:38 INFO - PROCESS | 9292 | Values: 42000.0 02:08:38 INFO - PROCESS | 9292 | 02:08:38 INFO - PROCESS | 9292 | [#8] Splay Cycles:1 Average:555.56 Median:555.56 stddev:0.00 (0.0%) 02:08:38 INFO - PROCESS | 9292 | Values: 555.6 02:08:38 INFO - PROCESS | 9292 | 02:08:38 INFO - PROCESS | 9292 | [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 02:08:38 INFO - PROCESS | 9292 | Values: 4854.4 02:08:38 INFO - PROCESS | 9292 | -------- Summary: end -------- 02:08:38 INFO - PROCESS | 9292 | 02:08:39 INFO - TEST-INFO | 9292: exit 0 02:08:39 INFO - TEST-OK | v8_7 | took 40329ms 02:08:39 INFO - SUITE-END | took 1212s 02:08:39 INFO - Completed test suite (00:20:12) 02:08:39 INFO - Working with test: dromaeo_css 02:08:39 INFO - Generating results file: dromaeo_css 02:08:39 INFO - Working with test: kraken 02:08:39 INFO - Generating results file: kraken 02:08:39 INFO - javascript benchmark 02:08:39 INFO - Working with test: v8_7 02:08:39 INFO - Generating results file: v8_7 02:08:39 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:08:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 02:08:39 INFO - process_Request line: dromaeo_css 6653.14 graph.html#tests=[[72,201,35]] 02:08:39 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:08:39 INFO - process_Request line: kraken 1503.90 graph.html#tests=[[232,201,35]] 02:08:39 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:08:39 INFO - process_Request line: v8_7 19033.15 graph.html#tests=[[230,201,35]] 02:08:39 INFO - RETURN: dromaeo_css: 6653.14 02:08:39 INFO - RETURN: kraken: 1503.90 02:08:39 INFO - RETURN: v8_7: 19033.15 02:08:39 INFO - javascript benchmark 02:08:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3144.5597616333703, 3149.6850314968497, 3194.696503832135, 3212.309353489, 3218.340240250749, 5158.561522270612, 5226.451222621627, 5234.973825130874, 5244.737763111843, 5264.263003179548, 5243.3970093439175, 5247.291615631889, 5255.395629502608, 5295.7881684732565, 5354.651947623402, 4793.0, 4810.711357318554, 4815.542523460274, 4822.397200349957, 4881.170201065809, 4511.390962220107, 4916.016796640668, 4930.901381972359, 4941.925871111936, 4992.301077849104, 4764.142454358214, 4795.064962332347, 4856.562909338141, 4878.292647566101, 4879.365682461275, 4866.440359358684, 4869.659123861331, 4875.8781030474165, 4894.804207831682, 4903.53416425439, 4820.373351464287, 4832.275158726184, 4836.830710925101, 4849.199882019462, 4886.438059623153, 5119.104156772587, 5143.459936706667, 5168.095583272912, 5206.843794686166, 5246.291750613656, 5609.382967873531, 5614.522765564931, 5618.690971996539, 5618.887622247532, 5632.802851900164, 5624.3250809902665, 5646.774129034834, 5653.067243904751, 5653.0955047192665, 5665.206871038058, 5279.445658205871, 5314.468553144655, 5353.518183363438, 5353.571714262888, 5355.705436201008, 5790.913136302959, 5792.565557583198, 5794.449527294901, 5798.072308430631, 5842.065269556851, 5542.8337149885565, 5543.889122217533, 5545.390007099216, 5547.833564993057, 5576.414476479992, 5576.163575463713, 5637.915431268534, 5687.914681279784, 5690.146478028246, 5722.170285308607, 5629.774809007594, 5641.294838145232, 5642.294713160855, 5644.802431914945, 5645.435456454322, 5626.774929002794, 5668.0, 5683.488486036276, 5684.232628595087, 5686.630369026, 4365.585269399402, 4407.294832826797, 4414.713043652152, 4428.446444194476, 4465.821367145343, 3921.176552923861, 3932.842686292516, 3938.448617193595, 3967.4643923070016, 3982.183652351261, 5175.896482070413, 5294.0, 5309.946900530946, 5310.309659744285, 5310.389305229871, 5517.586181036358, 5528.778848846082, 5619.550435965113, 5648.4633959773755, 5686.2607860977805, 5230.398504172069, 5235.738213089407, 5238.004779091961, 5241.135212689864, 5241.790328386898, 4788.880277993078, 4794.856154315376, 4797.016611594615, 4827.444843842933, 4852.1508735971065, 5848.853778655568, 5940.673262970578, 5981.730822113015, 5996.790112346134, 6040.546958978006, 5724.57065720081, 5732.799352022659, 5733.168690539932, 5735.36910939788, 5741.25363702716, 5797.449242321973, 5832.924344502494, 5909.793157239476, 5924.022536281465, 5926.585139040226, 5573.080441727069, 5577.52591029767, 5622.072358060874, 5623.0721930880945, 5662.377138514842, 5643.040683083804, 5668.971655141698, 5682.829515114553, 5683.914741278967, 5691.23168372281, 5547.5007249347755, 5551.056320425457, 5552.861178470571, 5586.469285417878, 5671.347795003628, 5540.833774986757, 5561.193626924154, 5583.134614134816, 5590.077637189818, 5643.435656434323, 5348.1442969124755, 5439.728013599383, 5442.047641662773, 5442.428545002717, 5443.918341224806, 5399.865003374947, 5460.863478413072, 5504.174373843955, 5539.307586551681, 5586.664800112007, 5402.51377376038, 5424.267723857229, 5442.210879422382, 5445.564354851682, 5485.533729632866], "unit": "score", "name": "dojo.html", "value": 5227.613560520624}, {"lowerIsBetter": false, "replicates": [529.9735013249336, 534.3961323704215, 537.8144540133655, 555.9722013899304, 557.5873853348523, 27670.0, 28329.291767705792, 35524.822375888085, 35805.2838943221, 35894.10264743376, 37496.62503374965, 37927.0, 37964.0, 37975.0, 38072.61927380726, 8422.0735719071, 8626.396152269344, 8628.611712472954, 8630.784230394227, 8631.870521942175, 8321.08468068512, 8457.57712114395, 8467.364947628952, 8474.872876906851, 8475.364347673918, 8447.873281900776, 8540.914590854074, 8732.607032683512, 8737.08260632634, 8743.606537705788, 8603.31173506118, 8664.956675216583, 8674.696385626536, 8684.739457816213, 8691.348148888796, 8322.084570697218, 8437.451565648213, 8448.32413406926, 8450.78873028173, 8463.915360846375, 37914.43128353077, 38170.80914595437, 38240.0, 38346.616533834866, 38369.23261534781, 3104.58088158098, 3156.195170231599, 3177.8887738929025, 3320.4023275810346, 3473.7221022318154, 28990.565141522893, 29349.41301173986, 29373.26566835825, 29779.40441191186, 30368.240793980105, 3598.802065886375, 3654.0, 3677.0807298175455, 3742.73800833939, 3864.806759662006, 219374.0, 220981.0, 221453.0, 221716.8914155435, 221758.0, 53081.630204375724, 53922.0, 54153.729231353595, 54502.0, 54583.18125228125, 63663.40841479, 64114.358856411774, 64127.03809442862, 64173.35826641767, 64250.6787466069, 13684.657883552793, 13970.790438143436, 13985.79021314681, 13985.930070349583, 13997.30013499321, 8813.603387847563, 9114.179723824887, 10104.646337378157, 10125.392476451436, 10445.321054131457, 18831.71752423715, 18858.622827543648, 18864.905675471535, 18908.527286817665, 18956.24175032983, 7295.671694773748, 7597.278258565428, 7640.847183056308, 7651.311381975537, 7725.884111738328, 890.2788741119714, 929.665320484625, 936.0873148679982, 1024.5491983527224, 1033.8914413986574, 26299.73700262973, 28174.577381339295, 29892.402151956838, 30949.262684328918, 33239.50140747843, 1004.1815920025302, 1013.1521609951262, 1036.4713995862164, 1101.7190616392768, 1139.794836929344, 14567.053141545766, 14891.0, 16038.75941860873, 16501.0, 16543.09013004272, 372559.0, 381756.0, 382080.0, 382096.0, 382895.0, 52519.0, 53060.73469632705, 53084.469155307954, 53135.0, 53194.202086968726, 1303.8761317674805, 1327.8605746396684, 1340.9597712068457, 1341.7584834729842, 1344.1397505596426, 28542.14373568796, 29426.85286573639, 29485.557716633837, 29824.552631710976, 30050.248743780707, 43022.56977430185, 43476.0, 43520.782396087816, 43591.34612980745, 43619.78190109029, 291758.0, 292458.0, 292958.0, 293049.0, 293792.0, 26991.1902642921, 30526.847365763027, 31060.844695776377, 31198.532022019233, 31435.0, 35343.0, 35498.0, 35961.28077438384, 36574.0, 36630.81684591666, 29911.70088299176, 31856.840715796272, 37264.88205353844, 38087.61912380841, 38416.0, 32114.839425802722, 32941.34117317688, 33666.663333366356, 36562.63437365592, 38740.0, 32836.83581582077, 33135.502967455024, 33158.33683326368, 37650.81174594109, 38191.80904095462, 29400.0, 30607.387852243275, 30925.69074309228, 30928.381432371676, 31030.22424439407, 23504.0, 23557.175498857458, 23586.410339740956, 24683.876580616983, 24738.25785226446], "unit": "score", "name": "ext.html", "value": 17791.976633187016}, {"lowerIsBetter": false, "replicates": [363.62728203591325, 363.8399104394067, 364.5079143156739, 366.5125383240289, 370.6293706293706, 13295.534656287033, 13537.390817413216, 15564.377424903005, 15998.920005399972, 16731.749023764653, 13713.862861371408, 14208.857911420882, 14758.409663613442, 14862.925685371585, 14957.700845983074, 5154.74226288685, 5267.262583238331, 5329.0, 5332.786688532454, 5340.492653197959, 3964.2467931093142, 4088.1823635272917, 5264.578833693296, 5354.437784032679, 5584.581156413265, 5675.631083979549, 5730.4269573042775, 5748.42515748426, 5751.884962300752, 5759.82720518383, 4816.422029356482, 4972.129877271499, 4987.875303117415, 4990.30135780991, 4991.925121123186, 4711.575958163782, 4800.183968725325, 4956.1822299320565, 4965.0566392385335, 4965.925511117336, 10733.62432314873, 10982.341059536373, 11100.278481898731, 11118.4996675149, 11133.997940185342, 2035.613233485633, 2076.802703743142, 2080.6566916458764, 2141.304076175249, 2189.824814014875, 8511.82976340476, 8646.697365592174, 9138.862917056249, 10239.590416383337, 12689.16007178963, 1659.427497513368, 1767.3549154558623, 1788.043396782728, 1828.5245836082581, 1837.8621603379665, 53213.733931330484, 53306.20040699393, 55332.0, 55542.0, 55574.16638750422, 9340.20608248293, 9793.069658382443, 9807.0, 9893.258005649604, 9902.65340713086, 12179.634610961508, 12624.24254544712, 12658.556950506689, 12676.556320528738, 12829.807552886714, 6582.605043697297, 6799.864002719918, 6901.75843845463, 6945.40964018054, 7022.4382049436945, 6583.111279977237, 6590.373914478117, 6629.0, 6656.8668626627195, 6659.101021362151, 4192.3082691355585, 4243.0, 4254.0, 4260.126674031816, 4285.100128972888, 1677.7399503077042, 1727.9049652269246, 1737.2008875916968, 1820.1536285626983, 1838.0625880800887, 412.24559056925756, 866.6273502394031, 912.9680461183959, 917.417439925652, 947.1428357336621, 8971.37200395979, 9705.757356066013, 10012.599496020077, 10235.590576376862, 10282.177425805918, 434.4807954494349, 451.5777747805812, 452.42090124640515, 455.6783189648734, 459.27434653247786, 5729.88540229193, 5917.615355001997, 5933.792317268962, 6032.849178770478, 6033.5173186145885, 449589.0, 452052.0, 493516.5324173428, 497492.0, 512405.0, 65329.34670653327, 66797.0, 73590.63204683943, 74596.62701686457, 76500.0, 494.4832649880883, 511.92321151827525, 512.0450360078427, 512.2367672168517, 512.4644746240187, 9631.518424078908, 10396.064354207854, 14047.297635117999, 15126.621834453787, 15145.242737863284, 33061.85999161619, 33859.66140338565, 34120.0, 34492.65507344894, 37508.624913750515, 37746.62253377431, 37911.43132853065, 38027.61972380241, 38077.23845523019, 39099.218015640094, 6870.175578930561, 6897.55165914214, 6932.757353492603, 6996.685149168401, 7074.858502830018, 9764.02359764018, 10969.83545246806, 11055.226134170853, 11123.610673626708, 11234.269772464764, 9428.481433521221, 9673.322867399214, 9760.658376956773, 9838.508074596384, 9966.601335946481, 9670.178034867115, 9741.26940479481, 9832.557534910804, 9973.750656233653, 10084.747881303027, 7941.483803552982, 9634.181094607036, 10114.797704046025, 10246.6413675521, 10407.271490995558, 6962.1993470749485, 7000.719971201095, 7028.718851245892, 7130.750423735144, 7220.89168662481, 8017.8396432072195, 10012.69961901144, 10013.499325033865, 10094.343867648578, 10230.335028223142], "unit": "score", "name": "jquery.html", "value": 7217.027311714176}, {"lowerIsBetter": false, "replicates": [1272.5228039485194, 1433.1186320412949, 1448.9927550362247, 1594.3542865139623, 1751.301237799334, 7104.11198600175, 7754.418418618598, 7896.605169741511, 7928.881066783988, 7934.6032698365, 7663.118741344747, 7857.567833769141, 7919.208079192078, 7926.524408535492, 7934.841303173933, 1968.6456437841182, 2018.3541266794632, 2325.3489023073566, 2357.658139569766, 2382.2376839411395, 2370.561446132471, 2374.6227188230873, 2381.9166329178483, 2382.5830479666074, 2382.690250267463, 2308.2613563659634, 2389.6773935518654, 2389.7849193572574, 2390.0439824070336, 2390.6533552634855, 2328.208409140892, 2334.9533009339802, 2370.9051637934463, 2393.3777217923293, 2393.676853624756, 2336.3224664847176, 2341.484873327865, 2362.870042147681, 2387.5344307859973, 2390.964135537968, 8011.399145064143, 8098.0, 8105.959470202612, 8107.716229931983, 8111.43219974602, 4715.41057367829, 4797.880052998668, 4815.783289751935, 4843.806247750086, 4845.75771211438, 2956.807807492506, 2983.4629766641997, 2990.5514172874027, 3031.8938837140595, 3082.5530298106873, 933.3140141995696, 936.5410948635188, 976.0386019770591, 990.0248255468358, 1006.3861044762689, 11347.716307092307, 11352.489137988729, 11369.204155709103, 11377.431128443628, 11408.94295528517, 4368.890777730582, 4429.756363400044, 4478.798454069574, 4483.529229430928, 4500.504944456107, 9609.759756006017, 9703.07820757041, 9717.56270967808, 9727.367721098106, 9735.756606084762, 4783.043391321749, 4792.7124372537755, 4798.04039192156, 4799.944012317284, 4801.7118972861745, 4300.311950087971, 4330.2638551446325, 4342.652587792969, 4360.0, 4360.934585981213, 3550.3609350317192, 3608.314420260142, 3625.963740362615, 3778.0554861284677, 3877.302085624615, 1220.560598184653, 1258.1067442116016, 1260.3887114749339, 1260.4076084240392, 1265.4621785741208, 1052.0426411965075, 1063.6755789484127, 1071.791000754861, 1214.550616271985, 1348.5549768576345, 7622.199669034782, 7695.038120234971, 7696.615169241515, 7712.768616941501, 7716.2283771623515, 1080.7892460970193, 1097.160672085855, 1104.100158370925, 1106.4910141334915, 1117.502711293483, 5961.433663801932, 6038.486728628116, 6048.818535443944, 6050.062240352752, 6068.514518838482, 9614.51927403627, 9688.176504997155, 9836.803263934682, 9845.409275443497, 9971.850422243671, 9731.513424328756, 9832.065953734384, 9839.0, 9852.359596626196, 9864.852027219598, 7443.139215196201, 7622.123455802543, 7669.501482403737, 7677.923220767832, 7692.923070769332, 7217.927820721936, 7259.709611615687, 7303.598302093435, 7310.890336645061, 7324.08448943882, 8525.658973641233, 8743.081976392386, 8938.061503542034, 8965.193132618097, 8976.0, 8903.643854245758, 8941.597628106621, 9094.727158185266, 9111.681091161778, 9125.680601178927, 7176.7846964591145, 7233.710651574089, 7252.0, 7255.310745479171, 7262.164851041986, 6764.323567643196, 6909.861802764017, 7351.081114860643, 7579.0, 7591.164971853203, 7039.648017598997, 7255.238199988925, 7299.890501642373, 7314.341709246193, 7322.231165727735, 7004.4046256068805, 7096.432285417051, 7145.535540189871, 7226.74706385274, 7337.559746415019, 7289.0, 7330.157031941395, 7395.112586489656, 7416.184219735716, 7416.4066874648815, 6772.0857684212, 6815.42068924147, 6821.965890170517, 6824.522283440111, 6828.351306625863, 6854.862902741817, 6886.552374095668, 6904.585724856323, 6962.895556566757, 6967.965160174167], "unit": "score", "name": "mootools.html", "value": 4613.524785305314}, {"lowerIsBetter": false, "replicates": [331.51598665947716, 343.07027954243995, 345.87721358917594, 350.8333541567757, 354.32147437656874, 5740.741666625001, 5870.911936320953, 5926.111083337496, 5932.3474417814, 5934.287885453751, 5731.684757338345, 5803.245578074855, 5846.181534585162, 5881.411858814116, 5885.7939972100985, 4514.751688657123, 4518.683692141552, 4529.8641040768825, 4545.250033744428, 4554.111948170108, 4312.094460163354, 4379.0366119453665, 4406.184855801687, 4495.9325610115875, 4517.344984977176, 4442.044960333527, 4445.0443154721725, 4448.399466072087, 4466.553344665524, 4471.642268618519, 4465.575770301833, 4471.82112715491, 4483.39474170986, 4490.371348011281, 4496.797644106023, 3937.606239376068, 3944.3294639911283, 3947.782871942042, 3960.841566337343, 3961.980190099031, 5494.423085576037, 5597.020521408778, 5614.3543492498475, 5641.097424412115, 5657.519110875581, 5242.161254199348, 5242.737863106868, 5249.0, 5255.1329030709885, 5256.0, 5890.646561206341, 6275.121482992385, 6277.1525844011385, 6278.748850045993, 6282.403171698681, 4173.165366926627, 4231.42875711778, 4296.613304802583, 4304.074623955833, 4346.348047792825, 6380.872382552369, 6482.351764823527, 6482.6434546099945, 6492.967535162341, 6493.285738568754, 4434.645228381722, 4443.866683999485, 4447.866564003085, 4448.621867141329, 4451.577100175478, 4340.0, 4486.394336764495, 4501.099780044005, 4503.2569626012, 4508.346289787963, 5147.3308469898675, 5211.71335576547, 5219.895602087937, 5225.0, 5227.660202086929, 6288.308286088527, 6302.873942521215, 6311.431971122621, 6313.747450101944, 6320.494360451153, 1554.5258696097574, 1591.5941434934018, 1591.9204039797964, 1592.4665237145687, 1592.4983630156696, 1043.6868939318174, 1046.7016900183412, 1062.5218651606808, 1072.7157303314627, 1076.4402510694395, 5921.644701317935, 5930.169776231331, 5933.406659334119, 5937.673427961504, 5945.524358051345, 6440.677966101676, 6450.935490645127, 6451.096846441502, 6458.61248325102, 6462.644554549451, 5917.615355001911, 5923.378045305267, 5937.020391635332, 5943.31651860033, 5944.970275148683, 3376.7636265461674, 3456.0668619472603, 3465.913352166216, 3500.4749287607065, 3501.457274122515, 6710.16122984627, 6710.1947766267385, 6718.563293385914, 6719.227288861745, 6743.224529179207, 6626.900596491057, 6627.602343859384, 6629.370209830058, 6632.237292711304, 6633.502487313471, 6523.739050437929, 6705.295943925915, 6713.765018224436, 6714.764983225661, 6718.899216511659, 6223.937760622336, 6283.088952102011, 6408.711607977559, 6500.187476565429, 6508.446782023581, 6251.624902505864, 6327.525435592441, 6374.107624932421, 6431.807045788634, 6440.130582371507, 6705.6647167642395, 6713.56361836479, 6716.56342337766, 6718.093057437183, 6719.731210751711, 4330.112326973026, 4452.332150177499, 4497.763115143362, 4502.5141703238505, 4508.368828363966, 6353.872922541431, 6361.522885783677, 6377.93622063792, 6474.2554606219, 6477.838054048687, 6278.4035516625845, 6284.811455656338, 6285.214348206474, 6290.685465726604, 6292.4966002720585, 6132.969335153296, 6267.247930248217, 6271.686415679106, 6278.0896769967185, 6279.058141278662, 6175.0, 6188.102725104744, 6197.163382943425, 6200.906986395298, 6207.410296021871, 6338.0, 6340.778072767615, 6341.619502829661, 6346.0, 6347.714352854225, 6073.726682299395, 6135.877282454237, 6186.443220110212, 6186.876262474815, 6195.690215489298], "unit": "score", "name": "prototype.html", "value": 4717.354957219261}, {"lowerIsBetter": false, "replicates": [654.5974225851102, 719.4783781758226, 729.8649749796288, 732.813132651174, 744.192551082076, 10966.396848173346, 11204.047655949234, 11226.887731122686, 11438.485268162933, 12280.754384912296, 12129.818052729193, 12163.695907602314, 12176.573819916304, 12186.268823870552, 12212.633620991362, 653.9738410463576, 660.6861740673165, 771.147881590841, 787.5314188058096, 788.4283894176705, 767.3170877918657, 774.7056118674896, 777.2499537945881, 780.8047988003, 781.601383294521, 818.5988865455944, 822.7696245051366, 823.7611092783086, 825.0223485170093, 829.0176141272611, 675.0953722012503, 679.1103654212972, 819.3608984991656, 820.5076953827686, 833.3000279764966, 598.1565991951328, 601.2694576090072, 601.5217901768104, 602.2231321595137, 602.4367216652444, 12292.815607765891, 12345.197562158432, 12350.938245308716, 12383.504659813596, 12418.441170147365, 11629.883701162964, 11944.433371865869, 11964.461599228056, 12189.085818563643, 12399.318037507934, 9279.953600232024, 9368.11002954725, 9492.857607135898, 9608.327417080807, 9720.75698107546, 3063.5711000459955, 3087.861046252924, 3094.3965926644314, 3139.5133754268127, 3142.308692087737, 46234.53765462336, 47020.0, 47088.29367559489, 47120.29319560175, 47381.76309118467, 10025.799484010278, 10146.695599132037, 10232.0, 10246.948765256126, 10273.691789246335, 17196.484105476855, 17218.483445496655, 17252.0, 17252.482425527254, 17274.04992725412, 6566.5403421760975, 6700.564463309869, 6705.597664140168, 6715.832104197337, 6718.529702920749, 3709.647583479565, 3774.9622503774613, 3803.3154032274456, 3818.198178382571, 3917.118648304109, 2949.616549848549, 2976.955345669817, 2994.386150839073, 2999.47509185896, 3002.0243420887864, 552.7291627102771, 559.3651205881354, 571.9942800571941, 575.7696921231541, 576.6107877182968, 499.57286520024854, 512.3211744438634, 531.5349069564131, 595.830188396305, 608.5831205624073, 7810.901323111838, 7847.725329613436, 7883.0, 8063.27430531255, 8227.794305142419, 486.19291975321505, 497.659103514094, 498.30984087038985, 504.95707864831166, 510.9693418394908, 3577.3586406434724, 3673.246984368198, 3807.562130354989, 3914.451976723261, 4029.0, 56273.43726562682, 56849.0, 57092.429075708715, 57426.425735742945, 57605.711971440716, 45962.0, 46401.0, 50183.74908125509, 50946.74526627417, 52771.736141319045, 43070.56929430791, 44426.55573444289, 44534.33198502025, 44589.0, 44598.0, 8203.42576019673, 8363.749087527383, 8431.494110353398, 8599.183077607617, 8675.869861952202, 32337.67662323441, 32438.675613244508, 32999.835000824845, 33152.336953261285, 33281.83359083286, 41264.58735412607, 41374.0, 43003.784981074896, 43567.56432435635, 43765.78117109394, 11006.944965275443, 11012.779744405227, 11084.889151108386, 11152.330860148417, 11386.259893106922, 12196.451159698012, 12445.377731113227, 12446.0, 12491.916468516452, 12617.369131543202, 11010.449477525932, 11256.268342557707, 11330.546778128783, 11497.252678575866, 11679.416029198335, 11075.889241107487, 11449.313041217554, 11462.484188211718, 11486.138539609396, 11622.244554104294, 7592.878104155385, 10529.210309226686, 11403.315801051964, 11545.422728863692, 11704.297742135499, 8802.823943520965, 8934.329925255503, 9018.774530636787, 9077.228435583049, 9102.772430689285, 9768.26737994639, 10010.499475026365, 10034.749131271778, 10035.448050357301, 10133.898661013296], "unit": "score", "name": "yui.html", "value": 5936.214332860371}], "name": "dromaeo_css", "value": 6653.146103086905}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 105.0, 109.0, 110.0, 110.0, 101.0, 112.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [167.0, 125.0, 149.0, 164.0, 125.0, 152.0, 151.0, 127.0, 165.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 145.0}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 160.0, 160.0, 161.0, 159.0, 159.0, 161.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.2}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 97.0, 96.0, 72.0, 72.0, 73.0, 103.0, 91.0, 71.0], "unit": "score", "name": "audio-fft", "value": 82.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 136.0, 95.0, 97.0, 97.0, 137.0, 95.0, 97.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 109.3}, {"lowerIsBetter": true, "replicates": [108.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 144.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 56.0, 55.0, 59.0, 56.0, 56.0, 66.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 69.0, 67.0, 67.0, 69.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [81.0, 90.0, 90.0, 83.0, 82.0, 88.0, 82.0, 83.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [116.0, 115.0, 122.0, 124.0, 123.0, 133.0, 124.0, 122.0, 120.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.7}, {"lowerIsBetter": true, "replicates": [151.0, 148.0, 150.0, 149.0, 149.0, 138.0, 159.0, 147.0, 149.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.2}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 67.0, 67.0, 70.0, 68.0, 66.0, 68.0, 71.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1503.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.22408026755852], "unit": "score", "name": "Richards", "value": 211.10596}, {"lowerIsBetter": false, "replicates": [190.22256039566292], "unit": "score", "name": "DeltaBlue", "value": 347.58232600000014}, {"lowerIsBetter": false, "replicates": [285.8776443682104], "unit": "score", "name": "Encrypt", "value": 931.1011380000001}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [2018.1451612903227], "unit": "score", "name": "RayTrace", "value": 366.667876123876}, {"lowerIsBetter": false, "replicates": [770.4160246533128], "unit": "score", "name": "Earley", "value": 865.0689739999998}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [42000.0], "unit": "score", "name": "RegExp", "value": 21.690119047619053}, {"lowerIsBetter": false, "replicates": [555.5555555555555], "unit": "score", "name": "Splay", "value": 146.68380000000002}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 19033.151053186943}]} 02:08:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19033.15"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1503.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6653.14"}}} 02:08:39 INFO - Return code: 0 02:08:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:08:40 INFO - # TBPL SUCCESS # 02:08:40 INFO - Running post-action listener: _resource_record_post_action 02:08:40 INFO - Running post-run listener: _resource_record_post_run 02:08:41 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 585728; Write bytes: 299094016; Read time: 324; Write time: 280176 02:08:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1499136; Read time: 0; Write time: 88 02:08:41 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 585728; Write bytes: 297594880; Read time: 324; Write time: 280088 02:08:41 INFO - Running post-run listener: _upload_blobber_files 02:08:41 INFO - Blob upload gear active. 02:08:41 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:08:41 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 02:08:41 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'] 02:08:41 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 02:08:41 INFO - (blobuploader) - INFO - Open directory for files ... 02:08:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 02:08:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:08:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:08:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:08:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:08:42 INFO - (blobuploader) - INFO - Done attempting. 02:08:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:08:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:08:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:08:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:08:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:08:43 INFO - (blobuploader) - INFO - Done attempting. 02:08:43 INFO - (blobuploader) - INFO - Iteration through files over. 02:08:43 INFO - Return code: 0 02:08:43 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:08:43 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:08:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/0feeaedb34b4c315b2876b9ddcd4f680e1234d64c0fd59d998add36a4503da757bdea0b6d05afaa5e6d53619080cd002699df5848d29e3d48ec0fd190ed683ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/2e9445b41dff12f4090dd3c4c875771d34a13ad583f7e129dcd5487ba520473c8c25b1a9dcc0e026790150bed73bd422d873bb2c2a0c5a3a2e61f6a6d5424418"} 02:08:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:08:43 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:08:43 INFO - Contents: 02:08:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/0feeaedb34b4c315b2876b9ddcd4f680e1234d64c0fd59d998add36a4503da757bdea0b6d05afaa5e6d53619080cd002699df5848d29e3d48ec0fd190ed683ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/2e9445b41dff12f4090dd3c4c875771d34a13ad583f7e129dcd5487ba520473c8c25b1a9dcc0e026790150bed73bd422d873bb2c2a0c5a3a2e61f6a6d5424418"} 02:08:43 INFO - Copying logs to upload dir... 02:08:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1277.050361 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-14 02:08:43.201158) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 02:08:43.204559) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525 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/0feeaedb34b4c315b2876b9ddcd4f680e1234d64c0fd59d998add36a4503da757bdea0b6d05afaa5e6d53619080cd002699df5848d29e3d48ec0fd190ed683ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/2e9445b41dff12f4090dd3c4c875771d34a13ad583f7e129dcd5487ba520473c8c25b1a9dcc0e026790150bed73bd422d873bb2c2a0c5a3a2e61f6a6d5424418"} build_url:https://queue.taskcluster.net/v1/task/Km7NTMAWQKCHdAuF7N30_Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011326 build_url: 'https://queue.taskcluster.net/v1/task/Km7NTMAWQKCHdAuF7N30_Q/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/0feeaedb34b4c315b2876b9ddcd4f680e1234d64c0fd59d998add36a4503da757bdea0b6d05afaa5e6d53619080cd002699df5848d29e3d48ec0fd190ed683ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/2e9445b41dff12f4090dd3c4c875771d34a13ad583f7e129dcd5487ba520473c8c25b1a9dcc0e026790150bed73bd422d873bb2c2a0c5a3a2e61f6a6d5424418"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 02:08:43.229662) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 02:08:43.229994) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452764277.838312-1845625525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004599 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 02:08:43.312113) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 02:08:43.312421) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 02:08:43.312743) ========= ========= Total master_lag: 0.23 =========