builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1453219290.38 results: success (0) buildid: 20160119053002 builduid: 1a3347ab83704db9a9d0de5e830a9e64 revision: 92bc05890a25148533254d733c40fd7115008c40 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 08:01:30.377729) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 08:01:30.378163) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 08:01:30.378458) ========= 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=745a4373a2a16df560f216e000000264-1453218942.685824-467089513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006338 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 08:01:30.466293) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 08:01:30.466613) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 08:01:30.490119) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 08:01:30.490581) ========= 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=745a4373a2a16df560f216e000000264-1453218942.685824-467089513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004668 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 08:01:30.539922) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 08:01:30.540214) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 08:01:30.540582) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 08:01:30.540848) ========= 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=745a4373a2a16df560f216e000000264-1453218942.685824-467089513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-19 08:01:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-01-19 08:01:30 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172560 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 08:01:30.726046) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 08:01:30.726405) ========= 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=745a4373a2a16df560f216e000000264-1453218942.685824-467089513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015732 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 08:01:30.776673) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-19 08:01:30.777055) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 92bc05890a25148533254d733c40fd7115008c40 --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 92bc05890a25148533254d733c40fd7115008c40 --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=745a4373a2a16df560f216e000000264-1453218942.685824-467089513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-19 08:01:31,031 truncating revision to first 12 chars 2016-01-19 08:01:31,031 Setting DEBUG logging. 2016-01-19 08:01:31,031 attempt 1/10 2016-01-19 08:01:31,031 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/92bc05890a25?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-19 08:01:32,066 unpacking tar archive at: b2g-inbound-92bc05890a25/testing/mozharness/ program finished with exit code 0 elapsedTime=1.331113 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-19 08:01:32.125737) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 08:01:32.126052) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1453218942.685824-467089513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004804 script_repo_revision: '%(revision)s' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 08:01:32.175512) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 08:01:32.175810) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 08:01:32.189630) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 08:01:32.189901) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 08:01:32.190244) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-19 08:01:32.190532) ========= /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=745a4373a2a16df560f216e000000264-1453218942.685824-467089513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:01:32 INFO - MultiFileLogger online at 20160119 08:01:32 in /builds/slave/test-pgo 08:01:32 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 08:01:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:01:32 INFO - {'append_to_log': False, 08:01:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:01:32 INFO - 'blob_upload_branch': 'B2G-Inbound', 08:01:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:01:32 INFO - 'branch': 'B2G-Inbound', 08:01:32 INFO - 'buildbot_json_path': 'buildprops.json', 08:01:32 INFO - 'config_files': ('talos/linux_config.py',), 08:01:32 INFO - 'default_actions': ('clobber', 08:01:32 INFO - 'read-buildbot-config', 08:01:32 INFO - 'download-and-extract', 08:01:32 INFO - 'populate-webroot', 08:01:32 INFO - 'create-virtualenv', 08:01:32 INFO - 'install', 08:01:32 INFO - 'run-tests'), 08:01:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:01:32 INFO - 'download_minidump_stackwalk': True, 08:01:32 INFO - 'download_symbols': 'ondemand', 08:01:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:01:32 INFO - 'tooltool.py': '/tools/tooltool.py', 08:01:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:01:32 INFO - '/tools/misc-python/virtualenv.py')}, 08:01:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:01:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:01:32 INFO - 'installer_path': 'installer.exe', 08:01:32 INFO - 'log_level': 'info', 08:01:32 INFO - 'log_name': 'talos', 08:01:32 INFO - 'log_to_console': True, 08:01:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:01:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:01:32 INFO - 'opt_config_files': (), 08:01:32 INFO - 'pip_index': False, 08:01:32 INFO - 'sps_profile': False, 08:01:32 INFO - 'sps_profile_interval': 0, 08:01:32 INFO - 'suite': 'dromaeojs', 08:01:32 INFO - 'system_bits': '32', 08:01:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:01:32 INFO - 'title': 'talos-linux64-ix-032', 08:01:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:01:32 INFO - 'use_talos_json': True, 08:01:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:01:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:01:32 INFO - 'work_dir': 'build'} 08:01:32 INFO - ##### 08:01:32 INFO - ##### Running clobber step. 08:01:32 INFO - ##### 08:01:32 INFO - Running pre-action listener: _resource_record_pre_action 08:01:32 INFO - Running main action method: clobber 08:01:32 INFO - rmtree: /builds/slave/test-pgo/build 08:01:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:01:33 INFO - Running post-action listener: _resource_record_post_action 08:01:33 INFO - ##### 08:01:33 INFO - ##### Running read-buildbot-config step. 08:01:33 INFO - ##### 08:01:33 INFO - Running pre-action listener: _resource_record_pre_action 08:01:33 INFO - Running main action method: read_buildbot_config 08:01:33 INFO - Using buildbot properties: 08:01:33 INFO - { 08:01:33 INFO - "project": "", 08:01:33 INFO - "product": "firefox", 08:01:33 INFO - "script_repo_revision": "production", 08:01:33 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 08:01:33 INFO - "repository": "", 08:01:33 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 08:01:33 INFO - "buildid": "20160119053002", 08:01:33 INFO - "pgo_build": "True", 08:01:33 INFO - "basedir": "/builds/slave/test-pgo", 08:01:33 INFO - "buildnumber": 1118, 08:01:33 INFO - "slavename": "talos-linux64-ix-032", 08:01:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:01:33 INFO - "platform": "ubuntu64_hw", 08:01:33 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 08:01:33 INFO - "branch": "b2g-inbound", 08:01:33 INFO - "repo_path": "integration/b2g-inbound", 08:01:33 INFO - "revision": "92bc05890a25148533254d733c40fd7115008c40", 08:01:33 INFO - "stage_platform": "linux64-pgo", 08:01:33 INFO - "builduid": "1a3347ab83704db9a9d0de5e830a9e64", 08:01:33 INFO - "slavebuilddir": "test" 08:01:33 INFO - } 08:01:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/JCag0h65Tn6u3LzkARxNUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:01:33 INFO - Running post-action listener: _resource_record_post_action 08:01:33 INFO - ##### 08:01:33 INFO - ##### Running download-and-extract step. 08:01:33 INFO - ##### 08:01:33 INFO - Running pre-action listener: _resource_record_pre_action 08:01:33 INFO - Running main action method: download_and_extract 08:01:33 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:01:33 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')]} 08:01:33 INFO - https://queue.taskcluster.net/v1/task/JCag0h65Tn6u3LzkARxNUQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:01:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCag0h65Tn6u3LzkARxNUQ/artifacts/public/build/test_packages.json 08:01:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCag0h65Tn6u3LzkARxNUQ/artifacts/public/build/test_packages.json 08:01:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCag0h65Tn6u3LzkARxNUQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:01:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCag0h65Tn6u3LzkARxNUQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:01:36 INFO - Downloaded 1448 bytes. 08:01:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:01:36 INFO - Using the following test package requirements: 08:01:36 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:01:36 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:01:36 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:01:36 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:36 INFO - u'jsshell-linux-x86_64.zip'], 08:01:36 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:01:36 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:01:36 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:01:36 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:01:36 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:01:36 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:01:36 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:01:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:01: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')]} 08:01:36 INFO - https://queue.taskcluster.net/v1/task/JCag0h65Tn6u3LzkARxNUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:01:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCag0h65Tn6u3LzkARxNUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:01:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCag0h65Tn6u3LzkARxNUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:01:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCag0h65Tn6u3LzkARxNUQ/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 08:01:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCag0h65Tn6u3LzkARxNUQ/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 08:01:39 INFO - Downloaded 22483951 bytes. 08:01:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:01:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:01:40 INFO - Return code: 0 08:01:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:01: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')]} 08:01:40 INFO - https://queue.taskcluster.net/v1/task/JCag0h65Tn6u3LzkARxNUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:01:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCag0h65Tn6u3LzkARxNUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:01:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCag0h65Tn6u3LzkARxNUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:01:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCag0h65Tn6u3LzkARxNUQ/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 08:01:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCag0h65Tn6u3LzkARxNUQ/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 08:01:42 INFO - Downloaded 22483951 bytes. 08:01:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:01:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:01:43 INFO - Return code: 0 08:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:43 INFO - https://queue.taskcluster.net/v1/task/JCag0h65Tn6u3LzkARxNUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:01:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCag0h65Tn6u3LzkARxNUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:01:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCag0h65Tn6u3LzkARxNUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:01:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCag0h65Tn6u3LzkARxNUQ/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 08:01:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCag0h65Tn6u3LzkARxNUQ/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 08:01:44 INFO - Downloaded 11132144 bytes. 08:01:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:01:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 08:01:44 INFO - Return code: 0 08:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:44 INFO - https://queue.taskcluster.net/v1/task/JCag0h65Tn6u3LzkARxNUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:01:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCag0h65Tn6u3LzkARxNUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:01:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCag0h65Tn6u3LzkARxNUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:01:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCag0h65Tn6u3LzkARxNUQ/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 08:01:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCag0h65Tn6u3LzkARxNUQ/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 08:01:46 INFO - Downloaded 55941429 bytes. 08:01:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JCag0h65Tn6u3LzkARxNUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:01:46 INFO - mkdir: /builds/slave/test-pgo/properties 08:01:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:01:46 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:01:46 INFO - Contents: 08:01:46 INFO - build_url:https://queue.taskcluster.net/v1/task/JCag0h65Tn6u3LzkARxNUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:01:46 INFO - Running post-action listener: _resource_record_post_action 08:01:46 INFO - Running post-action listener: set_extra_try_arguments 08:01:46 INFO - ##### 08:01:46 INFO - ##### Running populate-webroot step. 08:01:46 INFO - ##### 08:01:46 INFO - Running pre-action listener: _resource_record_pre_action 08:01:46 INFO - Running main action method: populate_webroot 08:01:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:01:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:01:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:01:46 INFO - '--tppagecycles', 08:01:46 INFO - '7'], 08:01:46 INFO - 'tests': ['tsvgm']}}, 08:01:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:01:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:01:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:01:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:01:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:01:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:01:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:01:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:46 INFO - 'talos_options': ['--e10s'], 08:01:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:01:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:46 INFO - 'tests': ['damp', 'tps']}, 08:01:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:46 INFO - 'talos_options': ['--e10s'], 08:01:46 INFO - 'tests': ['damp', 'tps']}, 08:01:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:01:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:01:46 INFO - 'other': {'tests': ['a11yr', 08:01:46 INFO - 'ts_paint', 08:01:46 INFO - 'tpaint', 08:01:46 INFO - 'sessionrestore', 08:01:46 INFO - 'sessionrestore_no_auto_restore']}, 08:01:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:01:46 INFO - 'tests': ['a11yr', 08:01:46 INFO - 'ts_paint', 08:01:46 INFO - 'tpaint', 08:01:46 INFO - 'sessionrestore', 08:01:46 INFO - 'sessionrestore_no_auto_restore']}, 08:01:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:01:46 INFO - 'tests': ['a11yr', 08:01:46 INFO - 'ts_paint', 08:01:46 INFO - 'tpaint', 08:01:46 INFO - 'sessionrestore', 08:01:46 INFO - 'sessionrestore_no_auto_restore']}, 08:01:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:01:46 INFO - 'tests': ['a11yr', 08:01:46 INFO - 'ts_paint', 08:01:46 INFO - 'tpaint', 08:01:46 INFO - 'sessionrestore', 08:01:46 INFO - 'sessionrestore_no_auto_restore']}, 08:01:46 INFO - 'other_l64': {'tests': ['a11yr', 08:01:46 INFO - 'ts_paint', 08:01:46 INFO - 'tpaint', 08:01:46 INFO - 'sessionrestore', 08:01:46 INFO - 'sessionrestore_no_auto_restore']}, 08:01:46 INFO - 'other_nol64': {'tests': ['a11yr', 08:01:46 INFO - 'ts_paint', 08:01:46 INFO - 'tpaint', 08:01:46 INFO - 'sessionrestore', 08:01:46 INFO - 'sessionrestore_no_auto_restore']}, 08:01:46 INFO - 'svgr': {'tests': ['tsvgx', 08:01:46 INFO - 'tsvgr_opacity', 08:01:46 INFO - 'tart', 08:01:46 INFO - 'tscrollx', 08:01:46 INFO - 'cart']}, 08:01:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:01:46 INFO - 'tests': ['tsvgx', 08:01:46 INFO - 'tsvgr_opacity', 08:01:46 INFO - 'tart', 08:01:46 INFO - 'tscrollx', 08:01:46 INFO - 'cart']}, 08:01:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:46 INFO - 'tests': ['tp5o']}, 08:01:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:46 INFO - 'talos_options': ['--e10s'], 08:01:46 INFO - 'tests': ['tp5o']}, 08:01:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:46 INFO - 'talos_options': ['--xperf_path', 08:01:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:01:46 INFO - 'tests': ['tp5n']}, 08:01:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:46 INFO - 'talos_options': ['--e10s', 08:01:46 INFO - '--xperf_path', 08:01:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:01:46 INFO - 'tests': ['tp5n']}}, 08:01:46 INFO - 'talos.zip': {'path': '', 08:01:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:01:46 INFO - Running post-action listener: _resource_record_post_action 08:01:46 INFO - ##### 08:01:46 INFO - ##### Running create-virtualenv step. 08:01:46 INFO - ##### 08:01:46 INFO - Running pre-action listener: _resource_record_pre_action 08:01:46 INFO - Running main action method: create_virtualenv 08:01:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:01:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 08:01:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:01:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:01:46 INFO - Using real prefix '/usr' 08:01:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:01:46 INFO - Installing distribute.............................................................................................................................................................................................done. 08:01:48 INFO - Installing pip.................done. 08:01:48 INFO - Return code: 0 08:01:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7cff950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e9840>, '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 0x25566b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556b60>, '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': '745a4373a2a16df560f216e000000264-1453218942.685824-467089513', '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 08:01:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 08:01:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:01:48 INFO - Using env: {'DISPLAY': ':0', 08:01:48 INFO - 'HOME': '/home/cltbld', 08:01:48 INFO - 'LANG': 'en_US.UTF-8', 08:01:48 INFO - 'LANGUAGE': 'en_US:en', 08:01:48 INFO - 'LOGNAME': 'cltbld', 08:01:48 INFO - 'MAIL': '/var/mail/cltbld', 08:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:48 INFO - 'MOZ_NO_REMOTE': '1', 08:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:48 INFO - 'NO_EM_RESTART': '1', 08:01:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:01:48 INFO - 'PWD': '/builds/slave/test-pgo', 08:01:48 INFO - 'SHELL': '/bin/bash', 08:01:48 INFO - 'SHLVL': '1', 08:01:48 INFO - 'TERM': 'linux', 08:01:48 INFO - 'TMOUT': '86400', 08:01:48 INFO - 'USER': 'cltbld', 08:01:48 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453218942.685824-467089513', 08:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:48 INFO - '_': '/tools/buildbot/bin/python'} 08:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01: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 08:01:48 INFO - Cleaning up... 08:01:48 INFO - Return code: 0 08:01:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7cff950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e9840>, '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 0x25566b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556b60>, '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': '745a4373a2a16df560f216e000000264-1453218942.685824-467089513', '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 08:01:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 08:01:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:01:48 INFO - Using env: {'DISPLAY': ':0', 08:01:48 INFO - 'HOME': '/home/cltbld', 08:01:48 INFO - 'LANG': 'en_US.UTF-8', 08:01:48 INFO - 'LANGUAGE': 'en_US:en', 08:01:48 INFO - 'LOGNAME': 'cltbld', 08:01:48 INFO - 'MAIL': '/var/mail/cltbld', 08:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:48 INFO - 'MOZ_NO_REMOTE': '1', 08:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:48 INFO - 'NO_EM_RESTART': '1', 08:01:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:01:48 INFO - 'PWD': '/builds/slave/test-pgo', 08:01:48 INFO - 'SHELL': '/bin/bash', 08:01:48 INFO - 'SHLVL': '1', 08:01:49 INFO - 'TERM': 'linux', 08:01:49 INFO - 'TMOUT': '86400', 08:01:49 INFO - 'USER': 'cltbld', 08:01:49 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453218942.685824-467089513', 08:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:49 INFO - '_': '/tools/buildbot/bin/python'} 08:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:49 INFO - Downloading/unpacking psutil>=0.7.1 08:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:50 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 08:01:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:01:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:01:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:01:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:01:51 INFO - Installing collected packages: psutil 08:01:51 INFO - Running setup.py install for psutil 08:01:51 INFO - building 'psutil._psutil_linux' extension 08:01:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:01:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:01:51 INFO - building 'psutil._psutil_posix' extension 08:01:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:01:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:01:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:01:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:01:51 INFO - Successfully installed psutil 08:01:51 INFO - Cleaning up... 08:01:51 INFO - Return code: 0 08:01:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7cff950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e9840>, '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 0x25566b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556b60>, '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': '745a4373a2a16df560f216e000000264-1453218942.685824-467089513', '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 08:01:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 08:01:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:01:51 INFO - Using env: {'DISPLAY': ':0', 08:01:51 INFO - 'HOME': '/home/cltbld', 08:01:51 INFO - 'LANG': 'en_US.UTF-8', 08:01:51 INFO - 'LANGUAGE': 'en_US:en', 08:01:51 INFO - 'LOGNAME': 'cltbld', 08:01:51 INFO - 'MAIL': '/var/mail/cltbld', 08:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:51 INFO - 'MOZ_NO_REMOTE': '1', 08:01:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:51 INFO - 'NO_EM_RESTART': '1', 08:01:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:01:51 INFO - 'PWD': '/builds/slave/test-pgo', 08:01:51 INFO - 'SHELL': '/bin/bash', 08:01:51 INFO - 'SHLVL': '1', 08:01:51 INFO - 'TERM': 'linux', 08:01:51 INFO - 'TMOUT': '86400', 08:01:51 INFO - 'USER': 'cltbld', 08:01:51 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453218942.685824-467089513', 08:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:51 INFO - '_': '/tools/buildbot/bin/python'} 08:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:01:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:01:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:01:53 INFO - Installing collected packages: mozsystemmonitor 08:01:53 INFO - Running setup.py install for mozsystemmonitor 08:01:53 INFO - Successfully installed mozsystemmonitor 08:01:53 INFO - Cleaning up... 08:01:53 INFO - Return code: 0 08:01:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7cff950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e9840>, '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 0x25566b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556b60>, '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': '745a4373a2a16df560f216e000000264-1453218942.685824-467089513', '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 08:01:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 08:01:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:01:53 INFO - Using env: {'DISPLAY': ':0', 08:01:53 INFO - 'HOME': '/home/cltbld', 08:01:53 INFO - 'LANG': 'en_US.UTF-8', 08:01:53 INFO - 'LANGUAGE': 'en_US:en', 08:01:53 INFO - 'LOGNAME': 'cltbld', 08:01:53 INFO - 'MAIL': '/var/mail/cltbld', 08:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:53 INFO - 'MOZ_NO_REMOTE': '1', 08:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:53 INFO - 'NO_EM_RESTART': '1', 08:01:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:01:53 INFO - 'PWD': '/builds/slave/test-pgo', 08:01:53 INFO - 'SHELL': '/bin/bash', 08:01:53 INFO - 'SHLVL': '1', 08:01:53 INFO - 'TERM': 'linux', 08:01:53 INFO - 'TMOUT': '86400', 08:01:53 INFO - 'USER': 'cltbld', 08:01:53 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453218942.685824-467089513', 08:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:53 INFO - '_': '/tools/buildbot/bin/python'} 08:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:53 INFO - Downloading/unpacking blobuploader==1.2.4 08:01: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 08:01: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 08:01: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 08:01: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 08:01: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 08:01: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 08:01:55 INFO - Downloading blobuploader-1.2.4.tar.gz 08:01:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:01:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:01:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:01: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 08:01: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 08:01: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 08:01: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 08:01: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 08:01: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 08:01:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:01:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:01:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:56 INFO - Downloading docopt-0.6.1.tar.gz 08:01:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:01:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:01:56 INFO - Installing collected packages: blobuploader, requests, docopt 08:01:56 INFO - Running setup.py install for blobuploader 08:01:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:01:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:01:56 INFO - Running setup.py install for requests 08:01:56 INFO - Running setup.py install for docopt 08:01:56 INFO - Successfully installed blobuploader requests docopt 08:01:56 INFO - Cleaning up... 08:01:56 INFO - Return code: 0 08:01:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7cff950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e9840>, '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 0x25566b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556b60>, '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': '745a4373a2a16df560f216e000000264-1453218942.685824-467089513', '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 08:01:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 08:01:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:01:56 INFO - Using env: {'DISPLAY': ':0', 08:01:56 INFO - 'HOME': '/home/cltbld', 08:01:56 INFO - 'LANG': 'en_US.UTF-8', 08:01:56 INFO - 'LANGUAGE': 'en_US:en', 08:01:56 INFO - 'LOGNAME': 'cltbld', 08:01:56 INFO - 'MAIL': '/var/mail/cltbld', 08:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:56 INFO - 'MOZ_NO_REMOTE': '1', 08:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:56 INFO - 'NO_EM_RESTART': '1', 08:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:01:56 INFO - 'PWD': '/builds/slave/test-pgo', 08:01:56 INFO - 'SHELL': '/bin/bash', 08:01:56 INFO - 'SHLVL': '1', 08:01:56 INFO - 'TERM': 'linux', 08:01:56 INFO - 'TMOUT': '86400', 08:01:56 INFO - 'USER': 'cltbld', 08:01:56 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453218942.685824-467089513', 08:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:56 INFO - '_': '/tools/buildbot/bin/python'} 08:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:01:57 INFO - Running setup.py (path:/tmp/pip-Oz9aa2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:01:57 INFO - Running setup.py (path:/tmp/pip-o0afvt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:01:57 INFO - Running setup.py (path:/tmp/pip-vTX7Z2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:01:57 INFO - Running setup.py (path:/tmp/pip-rme2UP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:01:57 INFO - Running setup.py (path:/tmp/pip-2IDQL5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:01:57 INFO - Running setup.py (path:/tmp/pip-uHeXoX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:01:57 INFO - Running setup.py (path:/tmp/pip-G61Xeu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:01:57 INFO - Running setup.py (path:/tmp/pip-dEFa6S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:01:57 INFO - Running setup.py (path:/tmp/pip-zoWbmZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:01:57 INFO - Running setup.py (path:/tmp/pip-YPrXlG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:01:57 INFO - Running setup.py (path:/tmp/pip-oghkCs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:01:57 INFO - Running setup.py (path:/tmp/pip-jMG2Rt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:01:58 INFO - Running setup.py (path:/tmp/pip-uICok3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:01:58 INFO - Running setup.py (path:/tmp/pip-_MYylM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:01:58 INFO - Running setup.py (path:/tmp/pip-MWFcjm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:01:58 INFO - Running setup.py (path:/tmp/pip-Nx3INR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:01:58 INFO - Running setup.py (path:/tmp/pip-YEGaCY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:01:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:01:58 INFO - Running setup.py install for manifestparser 08:01:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:01:58 INFO - Running setup.py install for mozcrash 08:01:58 INFO - Running setup.py install for mozdebug 08:01:58 INFO - Running setup.py install for mozdevice 08:01:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:01:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:01:58 INFO - Running setup.py install for mozfile 08:01:58 INFO - Running setup.py install for mozhttpd 08:01:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:01:58 INFO - Running setup.py install for mozinfo 08:01:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:01:59 INFO - Running setup.py install for mozInstall 08:01:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:01:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:01:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:01:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:01:59 INFO - Running setup.py install for mozleak 08:01:59 INFO - Running setup.py install for mozlog 08:01:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:01:59 INFO - Running setup.py install for moznetwork 08:01:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:01:59 INFO - Running setup.py install for mozprocess 08:01:59 INFO - Running setup.py install for mozprofile 08:01:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:01:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:01:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:01:59 INFO - Running setup.py install for mozrunner 08:01:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:01:59 INFO - Running setup.py install for mozscreenshot 08:01:59 INFO - Running setup.py install for moztest 08:02:00 INFO - Running setup.py install for mozversion 08:02:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:02:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:02:00 INFO - Cleaning up... 08:02:00 INFO - Return code: 0 08:02:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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 0x7f7cff950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e9840>, '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 0x25566b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556b60>, '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': '745a4373a2a16df560f216e000000264-1453218942.685824-467089513', '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 08:02: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 08:02: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 08:02:00 INFO - Using env: {'DISPLAY': ':0', 08:02:00 INFO - 'HOME': '/home/cltbld', 08:02:00 INFO - 'LANG': 'en_US.UTF-8', 08:02:00 INFO - 'LANGUAGE': 'en_US:en', 08:02:00 INFO - 'LOGNAME': 'cltbld', 08:02:00 INFO - 'MAIL': '/var/mail/cltbld', 08:02:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:00 INFO - 'MOZ_NO_REMOTE': '1', 08:02:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:00 INFO - 'NO_EM_RESTART': '1', 08:02:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:02:00 INFO - 'PWD': '/builds/slave/test-pgo', 08:02:00 INFO - 'SHELL': '/bin/bash', 08:02:00 INFO - 'SHLVL': '1', 08:02:00 INFO - 'TERM': 'linux', 08:02:00 INFO - 'TMOUT': '86400', 08:02:00 INFO - 'USER': 'cltbld', 08:02:00 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453218942.685824-467089513', 08:02:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:00 INFO - '_': '/tools/buildbot/bin/python'} 08:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:02:00 INFO - Running setup.py (path:/tmp/pip-f09q6k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 08:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:02:00 INFO - Running setup.py (path:/tmp/pip-LWAaae-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 08:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:02:00 INFO - Running setup.py (path:/tmp/pip-C70LIK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 08:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:02:00 INFO - Running setup.py (path:/tmp/pip-h7ZKKt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:02:00 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)) 08:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:02:00 INFO - Running setup.py (path:/tmp/pip-E6yKHT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 08:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:02:00 INFO - Running setup.py (path:/tmp/pip-y28mLp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 08:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:02:00 INFO - Running setup.py (path:/tmp/pip-wHf7qH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 08:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:02:00 INFO - Running setup.py (path:/tmp/pip-dG2VaF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 08:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:02:00 INFO - Running setup.py (path:/tmp/pip-ixvuBX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:02: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)) 08:02:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:02:01 INFO - Running setup.py (path:/tmp/pip-ajXZ7j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:02: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)) 08:02:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:02:01 INFO - Running setup.py (path:/tmp/pip-F0m1Pq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:02: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)) 08:02:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:02:01 INFO - Running setup.py (path:/tmp/pip-l1Y13v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:02: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)) 08:02:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:02:01 INFO - Running setup.py (path:/tmp/pip-sdGv3Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 08:02:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:02:01 INFO - Running setup.py (path:/tmp/pip-bgMoqd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 08:02:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:02:01 INFO - Running setup.py (path:/tmp/pip-9Dbuks-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 08:02:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:02:01 INFO - Running setup.py (path:/tmp/pip-rbIjVZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 08:02:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:02:01 INFO - Running setup.py (path:/tmp/pip-HjRhcn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 08:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 08:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 08:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 08:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:02:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:03 INFO - Downloading blessings-1.5.1.tar.gz 08:02:03 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 08:02:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:02:03 INFO - Installing collected packages: blessings 08:02:03 INFO - Running setup.py install for blessings 08:02:03 INFO - Successfully installed blessings 08:02:03 INFO - Cleaning up... 08:02:03 INFO - Return code: 0 08:02:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:02:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:02:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:02:03 INFO - Reading from file tmpfile_stdout 08:02:03 INFO - Current package versions: 08:02:03 INFO - argparse == 1.2.1 08:02:03 INFO - blessings == 1.5.1 08:02:03 INFO - blobuploader == 1.2.4 08:02:03 INFO - docopt == 0.6.1 08:02:03 INFO - manifestparser == 1.1 08:02:03 INFO - mozInstall == 1.12 08:02:03 INFO - mozcrash == 0.16 08:02:03 INFO - mozdebug == 0.1 08:02:03 INFO - mozdevice == 0.48 08:02:03 INFO - mozfile == 1.2 08:02:03 INFO - mozhttpd == 0.7 08:02:03 INFO - mozinfo == 0.9 08:02:03 INFO - mozleak == 0.1 08:02:03 INFO - mozlog == 3.1 08:02:03 INFO - moznetwork == 0.27 08:02:03 INFO - mozprocess == 0.22 08:02:03 INFO - mozprofile == 0.28 08:02:03 INFO - mozrunner == 6.11 08:02:03 INFO - mozscreenshot == 0.1 08:02:03 INFO - mozsystemmonitor == 0.0 08:02:03 INFO - moztest == 0.7 08:02:03 INFO - mozversion == 1.4 08:02:03 INFO - psutil == 3.1.1 08:02:03 INFO - requests == 1.2.3 08:02:03 INFO - wsgiref == 0.1.2 08:02:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7cff950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e9840>, '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 0x25566b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556b60>, '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': '745a4373a2a16df560f216e000000264-1453218942.685824-467089513', '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 08:02:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 08:02:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:02:03 INFO - Using env: {'DISPLAY': ':0', 08:02:03 INFO - 'HOME': '/home/cltbld', 08:02:03 INFO - 'LANG': 'en_US.UTF-8', 08:02:03 INFO - 'LANGUAGE': 'en_US:en', 08:02:03 INFO - 'LOGNAME': 'cltbld', 08:02:03 INFO - 'MAIL': '/var/mail/cltbld', 08:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:03 INFO - 'MOZ_NO_REMOTE': '1', 08:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:03 INFO - 'NO_EM_RESTART': '1', 08:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:02:03 INFO - 'PWD': '/builds/slave/test-pgo', 08:02:03 INFO - 'SHELL': '/bin/bash', 08:02:03 INFO - 'SHLVL': '1', 08:02:03 INFO - 'TERM': 'linux', 08:02:03 INFO - 'TMOUT': '86400', 08:02:03 INFO - 'USER': 'cltbld', 08:02:03 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453218942.685824-467089513', 08:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:03 INFO - '_': '/tools/buildbot/bin/python'} 08:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 08:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 08:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 08:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 08:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 08:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 08:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 08:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 08:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 08:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 08:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 08:02:03 INFO - Cleaning up... 08:02:04 INFO - Return code: 0 08:02:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:02: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')]} 08:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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')]} 08:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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 0x7f7cff950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e9840>, '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 0x25566b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556b60>, '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': '745a4373a2a16df560f216e000000264-1453218942.685824-467089513', '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 08:02: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 08:02: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 08:02:04 INFO - Using env: {'DISPLAY': ':0', 08:02:04 INFO - 'HOME': '/home/cltbld', 08:02:04 INFO - 'LANG': 'en_US.UTF-8', 08:02:04 INFO - 'LANGUAGE': 'en_US:en', 08:02:04 INFO - 'LOGNAME': 'cltbld', 08:02:04 INFO - 'MAIL': '/var/mail/cltbld', 08:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:04 INFO - 'MOZ_NO_REMOTE': '1', 08:02:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:04 INFO - 'NO_EM_RESTART': '1', 08:02:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:02:04 INFO - 'PWD': '/builds/slave/test-pgo', 08:02:04 INFO - 'SHELL': '/bin/bash', 08:02:04 INFO - 'SHLVL': '1', 08:02:04 INFO - 'TERM': 'linux', 08:02:04 INFO - 'TMOUT': '86400', 08:02:04 INFO - 'USER': 'cltbld', 08:02:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453218942.685824-467089513', 08:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:04 INFO - '_': '/tools/buildbot/bin/python'} 08:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:04 INFO - Downloading/unpacking jsonschema 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:02:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 08:02:05 INFO - Downloading/unpacking functools32 (from jsonschema) 08:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:06 INFO - Downloading functools32-3.2.3-2.tar.gz 08:02: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 08:02:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:02:06 INFO - warning: no files found matching '*.txt' 08:02:06 INFO - no previously-included directories found matching 'build' 08:02:06 INFO - no previously-included directories found matching 'dist' 08:02:06 INFO - no previously-included directories found matching '.git*' 08:02:06 INFO - Installing collected packages: jsonschema, functools32 08:02:06 INFO - Running setup.py install for functools32 08:02:06 INFO - warning: no files found matching '*.txt' 08:02:06 INFO - no previously-included directories found matching 'build' 08:02:06 INFO - no previously-included directories found matching 'dist' 08:02:06 INFO - no previously-included directories found matching '.git*' 08:02:06 INFO - Successfully installed jsonschema functools32 08:02:06 INFO - Cleaning up... 08:02:06 INFO - Return code: 0 08:02:06 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7cff950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e9840>, '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 0x25566b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556b60>, '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': '745a4373a2a16df560f216e000000264-1453218942.685824-467089513', '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 08:02:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 08:02:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:02:06 INFO - Using env: {'DISPLAY': ':0', 08:02:06 INFO - 'HOME': '/home/cltbld', 08:02:06 INFO - 'LANG': 'en_US.UTF-8', 08:02:06 INFO - 'LANGUAGE': 'en_US:en', 08:02:06 INFO - 'LOGNAME': 'cltbld', 08:02:06 INFO - 'MAIL': '/var/mail/cltbld', 08:02:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:06 INFO - 'MOZ_NO_REMOTE': '1', 08:02:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:06 INFO - 'NO_EM_RESTART': '1', 08:02:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:02:06 INFO - 'PWD': '/builds/slave/test-pgo', 08:02:06 INFO - 'SHELL': '/bin/bash', 08:02:06 INFO - 'SHLVL': '1', 08:02:06 INFO - 'TERM': 'linux', 08:02:06 INFO - 'TMOUT': '86400', 08:02:06 INFO - 'USER': 'cltbld', 08:02:06 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453218942.685824-467089513', 08:02:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:06 INFO - '_': '/tools/buildbot/bin/python'} 08:02:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:06 INFO - Downloading/unpacking flake8 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:02: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 08:02:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:02:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 08:02:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 08:02:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:02:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:02:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:02:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:02:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:02:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:02:08 INFO - no previously-included directories found matching 'docs/_build' 08:02:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:02:09 INFO - Running setup.py install for pep8 08:02:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:02:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:02:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:02:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:02:09 INFO - no previously-included directories found matching 'docs/_build' 08:02:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:02:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:02:09 INFO - Cleaning up... 08:02:09 INFO - Return code: 0 08:02:09 INFO - Running post-action listener: _resource_record_post_action 08:02:09 INFO - Running post-action listener: _start_resource_monitoring 08:02:09 INFO - Starting resource monitoring. 08:02:09 INFO - ##### 08:02:09 INFO - ##### Running install step. 08:02:09 INFO - ##### 08:02:09 INFO - Running pre-action listener: _resource_record_pre_action 08:02:09 INFO - Running main action method: install 08:02:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:02:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:02:09 INFO - Reading from file tmpfile_stdout 08:02:09 INFO - Detecting whether we're running mozinstall >=1.0... 08:02:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:02:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:02:09 INFO - Reading from file tmpfile_stdout 08:02:09 INFO - Output received: 08:02:09 INFO - Usage: mozinstall [options] installer 08:02:09 INFO - Options: 08:02:09 INFO - -h, --help show this help message and exit 08:02:09 INFO - -d DEST, --destination=DEST 08:02:09 INFO - Directory to install application into. [default: 08:02:09 INFO - "/builds/slave/test-pgo"] 08:02:09 INFO - --app=APP Application being installed. [default: firefox] 08:02:09 INFO - mkdir: /builds/slave/test-pgo/build/application 08:02:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 08:02:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 08:02:25 INFO - Reading from file tmpfile_stdout 08:02:25 INFO - Output received: 08:02:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:02:25 INFO - Running post-action listener: _resource_record_post_action 08:02:25 INFO - ##### 08:02:25 INFO - ##### Running run-tests step. 08:02:25 INFO - ##### 08:02:25 INFO - Running pre-action listener: _resource_record_pre_action 08:02:25 INFO - Running main action method: run_tests 08:02:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:02:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:02:25 INFO - Python 2.7.3 08:02:25 INFO - Return code: 0 08:02:25 INFO - grabbing minidump binary from tooltool 08:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e9840>, '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 0x25566b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:02:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 08:02:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:02:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:02:25 INFO - Return code: 0 08:02:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:02:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:02:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:02:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:02:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:02:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:02:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:02:26 INFO - Return code: 0 08:02:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JCag0h65Tn6u3LzkARxNUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 08:02:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JCag0h65Tn6u3LzkARxNUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 08:02:26 INFO - Using env: {'DISPLAY': ':0', 08:02:26 INFO - 'HOME': '/home/cltbld', 08:02:26 INFO - 'LANG': 'en_US.UTF-8', 08:02:26 INFO - 'LANGUAGE': 'en_US:en', 08:02:26 INFO - 'LOGNAME': 'cltbld', 08:02:26 INFO - 'MAIL': '/var/mail/cltbld', 08:02:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:02:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:02:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:26 INFO - 'MOZ_NO_REMOTE': '1', 08:02:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:02:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:26 INFO - 'NO_EM_RESTART': '1', 08:02:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:02:26 INFO - 'PWD': '/builds/slave/test-pgo', 08:02:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:02:26 INFO - 'SHELL': '/bin/bash', 08:02:26 INFO - 'SHLVL': '1', 08:02:26 INFO - 'TERM': 'linux', 08:02:26 INFO - 'TMOUT': '86400', 08:02:26 INFO - 'USER': 'cltbld', 08:02:26 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453218942.685824-467089513', 08:02:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:26 INFO - '_': '/tools/buildbot/bin/python'} 08:02:26 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JCag0h65Tn6u3LzkARxNUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 08:02:27 INFO - mozversion application_buildid: 20160119053002 08:02:27 INFO - mozversion application_changeset: 92bc05890a25148533254d733c40fd7115008c40 08:02:27 INFO - mozversion application_display_name: Nightly 08:02:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:02:27 INFO - mozversion application_name: Firefox 08:02:27 INFO - mozversion application_remotingname: firefox 08:02:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 08:02:27 INFO - mozversion application_vendor: Mozilla 08:02:27 INFO - mozversion application_version: 46.0a1 08:02:27 INFO - mozversion platform_buildid: 20160119053002 08:02:27 INFO - mozversion platform_changeset: 92bc05890a25148533254d733c40fd7115008c40 08:02:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 08:02:27 INFO - mozversion platform_version: 46.0a1 08:02:27 INFO - using testdate: 1453219347 08:02:27 INFO - actual date: 1453219347 08:02:27 INFO - starting webserver on 'localhost:34962' 08:02:27 INFO - SUITE-START | Running 3 tests 08:02:27 INFO - TEST-START | dromaeo_css 08:02:27 INFO - operating with platform_type : linux_ 08:02:27 INFO - Initialising browser for dromaeo_css test... 08:02:27 INFO - TEST-INFO | started process 25034 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaGe1zO/profile http://localhost:34962/getInfo.html) 08:02:32 INFO - PROCESS | 25034 | __metrics Screen width/height:1600/1200 08:02:32 INFO - PROCESS | 25034 | colorDepth:24 08:02:32 INFO - PROCESS | 25034 | Browser inner width/height: 1024/697 08:02:32 INFO - PROCESS | 25034 | __metrics 08:02:32 INFO - PROCESS | 25034 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:02:32 INFO - PROCESS | 25034 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:02:33 INFO - TEST-INFO | 25034: exit 0 08:02:33 INFO - Browser initialized. 08:02:33 INFO - Running cycle 1/1 for dromaeo_css test... 08:02:33 INFO - TEST-INFO | started process 25125 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaGe1zO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:02:45 INFO - PROCESS | 25125 | RSS: Main: 149073920 08:02:45 INFO - PROCESS | 25125 | 08:03:35 INFO - PROCESS | 25125 | 1453219415986 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] 08:05:44 INFO - PROCESS | 25125 | Cycle 1(1): loaded http://localhost:34962/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34962/tests/dromaeo/cssquery-ext.html) 08:05:45 INFO - PROCESS | 25125 | RSS: Main: 275566592 08:05:45 INFO - PROCESS | 25125 | 08:08:47 INFO - PROCESS | 25125 | Cycle 1(1): loaded http://localhost:34962/tests/dromaeo/cssquery-ext.html (next: http://localhost:34962/tests/dromaeo/cssquery-jquery.html) 08:08:48 INFO - PROCESS | 25125 | RSS: Main: 238002176 08:08:48 INFO - PROCESS | 25125 | 08:11:50 INFO - PROCESS | 25125 | Cycle 1(1): loaded http://localhost:34962/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34962/tests/dromaeo/cssquery-mootools.html) 08:11:51 INFO - PROCESS | 25125 | RSS: Main: 241750016 08:11:51 INFO - PROCESS | 25125 | 08:14:53 INFO - PROCESS | 25125 | Cycle 1(1): loaded http://localhost:34962/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34962/tests/dromaeo/cssquery-prototype.html) 08:14:53 INFO - PROCESS | 25125 | RSS: Main: 214568960 08:14:53 INFO - PROCESS | 25125 | 08:17:56 INFO - PROCESS | 25125 | Cycle 1(1): loaded http://localhost:34962/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34962/tests/dromaeo/cssquery-yui.html) 08:17:56 INFO - PROCESS | 25125 | RSS: Main: 214966272 08:17:56 INFO - PROCESS | 25125 | 08:20:59 INFO - PROCESS | 25125 | Cycle 1(1): loaded http://localhost:34962/tests/dromaeo/cssquery-yui.html (next: http://localhost:34962/tests/dromaeo/cssquery-dojo.html) 08:20:59 INFO - PROCESS | 25125 | RSS: Main: 303796224 08:20:59 INFO - PROCESS | 25125 | 08:20:59 INFO - PROCESS | 25125 | __start_tp_report 08:20:59 INFO - PROCESS | 25125 | _x_x_mozilla_page_load 08:20:59 INFO - PROCESS | 25125 | _x_x_mozilla_page_load_details 08:20:59 INFO - PROCESS | 25125 | |i|pagename|runs| 08:20:59 INFO - PROCESS | 25125 | |0;dojo.html;3111.377724455109;3165.4460469417877;3185.697358750918;3187.5856138701965;3215.4533729266013;5163.044836705203;5269.81555645552;5270;5282.313299271094;5285.841424757254;5179.896402071966;5205.16717325228;5229.764660590273;5230.7123108229125;5236.2931004314405;4787.61699064074;4843.515648435164;4857.489963553829;4876.756162191894;4900.607951363901;339.9511091818782;4853.199222128363;4883.926741098869;4886.926696099544;4886.926696099561;4798.808047678106;4816.903661926759;4818.277258411266;4820.927686084711;4829.7343646099625;4823.445303790038;4824.710517368934;4826.131296366652;4833.057553777015;4864.708117512925;4699.154152252593;4856.562909338141;4896.534829191221;4897;4902.975485122552;5047.041062198171;5091.66904151229;5104.64267501275;5138.409082955471;5154.561862241714;5555.138953462219;5564.693941833198;5576.776928922838;5577.191307260425;5581.776728930838;5600.411956744565;5609.242752228438;5610.074337734269;5615;5683.886322273573;5243.344581927259;5277.47225277473;5298.417174110845;5299.2845965794895;5303.814366497154;5781.5952883298605;5805.158252053428;5822.33043200029;5826.737796799154;5838.095095260242;5423.05096608092;5580.246666700024;5583.134614134816;5584.050711379075;5588.133839254922;5558.44415558441;5598.412166722517;5642.238297829823;5651.350094739158;5685.658860468385;5600.52395546375;5602.831915042555;5610.410906854803;5615;5619.466150715675;5512;5593.720313984366;5597.776088956396;5603.915941260884;5612.382637909908;4310.698251122454;4326.372675961968;4377.9124417511475;4413.073254616503;4424.955750442518;3920.549136849299;3931;3938.3107956107565;3950.9802450987563;3968.940465893014;5141.434442211354;5200.193969934666;5208.114620514521;5212.166053431432;5213.765380557884;5531.557475401958;5542.39033706292;5582.413846546136;5611.7474713637985;5642.04085305499;5214.217867319932;5242.633015688942;5255.605829562722;5259.579233661298;5265.157574788015;4727.078219747116;4842.491538388489;4845.491223421561;4845.6123510119105;4873.561379475864;5788.18965344852;5875.177475153482;5902.173695682608;5903.616264942765;5918.970405147947;5576.693281869536;5592.552595792408;5636.239107720406;5647.7176141193595;5654.943450565442;5713.285839270091;5827.562932779973;5857.47282744555;5872.588918775816;5884.411558844081;5504.504594586507;5551.195076713934;5604.271444712162;5609.326880774333;5619.297587801525;5602.467765562265;5603.1875378069135;5607.5513958884;5613.298337707786;5618.101103823368;5412.891742165056;5484.396716361117;5494.862628434321;5503.587230957774;5552.7223638818705;5394.622376433769;5481.67109973387;5506.669599824023;5552.944470555242;5588.944110559005;5343.519083282523;5344.251804747416;5345.438728933562;5348.144296912631;5369.704666243394;5431.83704488866;5432.239486471818;5459.863503412446;5497;5525.723713814213;5300.3904550975585;5318.441563635917;5368;5394.244805727123;5396.325459317585 08:20:59 INFO - PROCESS | 25125 | |1;ext.html;527.0565687419519;542.8073034072904;553.2724467325469;556.6326224691703;600.9519238460921;27776.305592360175;28140;34995.82502087492;35671.4649280261;35692.643073569256;38028;38520.22959540808;38523.22953540928;38527.229455410874;38569.421458678145;8468.534230617313;8590.226879580836;8613.827723445527;8662.13378662135;8676.045634980148;8367.748967530984;8434.325253979698;8475.660973561051;8495.065542790288;8496.702615408461;8671.69649062283;8697.826043479126;8726.650933962666;8746.344024198179;8752.387332886701;8658.61036253367;8661.956690216572;8703.042665306875;8730.079382535832;8737.257333126692;8553;8698.652053917836;8704.651813927436;8711.259542938858;8716.302695784321;39224.80387598044;39649.40525892114;39662.20675586501;39703.205935881124;39770;3245.789023713451;3262.902112936592;3305.9504107438406;3342.799432034086;3359.7648164628486;28901.421971560452;29169.41661166786;29174.708252917622;29424.264393390124;29483.70516294831;3845.7500262483127;3932.4494570760116;4002.939955900664;4031.7984100794843;4058.715889887709;254071;254346;254710;254923;255440;51626.22560661593;52337;55586.72206638941;55890.720546397824;55949;62087.068693969624;62115.689421552604;62192.37807621866;63055;63167.68416157982;12919.677008074685;13136.27750473733;13159.802602960963;13166.078374513692;13175.538856139989;9254.722358329262;9413.717588472357;9560.90439095614;9638.614455421844;9827.47674110514;18619.39328494012;19260.229590816492;19321.51696207606;19371.709424358647;19375.90312048431;7555.886661700079;7752.7674169775;7767.805804854924;7801.531908085533;7893.894854720344;922.9077092290718;932.6083045121065;989.4113002763344;991.1872264742842;1112.5160555158532;27881.30296742557;27915.16254512368;28847;29058.564121538195;29090.563641545396;989.3668052446296;1078.2613909472036;1095.27164435651;1103.812351900179;1121.5681962444355;13474.797878031837;13679.726405471834;13770.242636654879;13908.443662253396;13909.721805564035;257406;259479;259545;260154;261028;45045.32432013522;48515.51484485181;48673.51326486761;48735.75632121817;48801.51198488041;1302.9348532573333;1303.3939218263363;1323.2854258700386;1324.4702119152223;1327.230206480239;26627.733722662524;27267;27888.16335509938;27900.58149127805;27915.860420697765;44031.33952990772;44320.77839610782;44425.55574444344;44470.332945005204;44529.55470445254;294005;295442;295569;297494;297772;27395.86302068477;30652.555379469406;30943.535846962764;31350;31450;35897.28205435929;37198.814005929795;37280.62719372771;37318.62681373151;37680.623193767715;32238.35523289568;33786.32427351488;33885.32229355448;34053.148671283416;34190;27863.44273114486;32383.190420239684;32747.83626081854;34550.48174277337;34835;30997.225069373446;34451.655483445844;35506.644933550335;35529.28941421105;35555.288894221456;27923.860380698778;31178.37643247077;32518.34963300768;33381.83309083439;34315.14212144716;24019.159329423386;24087.397815054763;24159.03363865426;24378.390540236636;24471.75528244695 08:20:59 INFO - PROCESS | 25125 | |2;jquery.html;368.04675889446327;369.89273110797865;371.5782586764022;372.5678213272603;379.83287353564447;13817.51638692646;14666.486672966448;15734.921325393372;16834.326626934922;17522.299108035695;16061.277242524086;16487.17564121795;16529.25618347174;16765.91617041916;17497.73753393697;4401.471823381199;5859.912101318484;6048.183495228154;6050.092486127072;6052.394760523935;4531.456225252974;6400.327965563619;6660.034295027218;6667.533272670915;6678.833029174285;6390.904136437957;6669.633170175638;6674.466042716595;6677.4991875609285;6701.396874281314;6485.383888530582;6667.566608170453;6694.531382803206;6725.09211256479;6740.662966851638;6209.037599172136;6458.870822583522;6459.418652321267;6460.3862633049785;6511.218653761532;19817.405477835688;20183.495412614655;20536.79463205379;22094;22142;2240.2719116287108;2320.8955596998176;2337.31049340445;2387.248016874679;2415.7946574541184;12617.242965422103;12899.161554498927;13381.732365352736;13575.52485662997;13731.794023089662;1835.9816401835944;1878.445858471754;1925.3935010471657;1931.420573827846;1980.99009504953;58026.7098664504;60234.09648855271;60406.39593604096;61166.38833611696;62879;14933;15109.47116850905;15150.500167472464;15193.468228611946;15198.924005379902;23266.53466930652;23301.7669823303;23464.06143754265;23611.409714756926;23620.40948976255;6578;6817.420519255819;6904.689288982008;6920.9653951730925;6955.478339124586;6379.3301703320485;6387.297397286295;6392.169018027626;6488.124103246001;6499.317571655003;4175.060611362419;4308.482982042175;4315.892102697395;4447.533009034069;4507;1731.2036463227057;1742.7908650961965;1764.8676349273856;1768.2043080613776;1780.9554761131076;780.2587541835279;823.1768231768232;881.2421317666801;905.2395987370641;1019.1999280564869;13320.33398330099;14095.71808563823;15228.619284517754;15339.923300383427;15456.381744730084;876.0363600039905;894.2532984957503;916.2212119698203;953.3040880157524;954.737447202025;7723.845523089507;8728.825423491495;8865.64537418509;9133.132352426508;10048.944860789657;502783;510282;511962;526418;529072;70148;71671.64164179146;71873;72441;73298.63350683212;1053.794510070529;1058.444316733721;1080.6866008857344;1081.864766904137;1094.5348227003492;14899;14983.175925324213;15085.24315259927;15170.544883653509;15448.536543903701;29991.85004075053;30865.537016944316;32950.83524582362;33842.3231535363;35762.960148387676;43223.60068378813;44714.10571788611;46583.76708116573;46666.300005499266;46766.76616616895;10094.54574544162;10160.745981350525;10319.071283584213;10332.535035923553;10377.976294622476;11448.3703396314;11837.289762614271;12127.00898498869;12213.084018698812;12563.93718031404;10293.794124117327;10324.845127322946;10566.947165264432;10722.303050301705;10905.34567925927;7620.771376858703;7677.500962437423;7991.600419979094;10317.226208034277;10745.570177192825;3100.3334283128333;3942.014496375906;5203.869903252449;7614.238576142341;7829.530228186327;8303.626336814737;10567.260291779809;10614.628488002883;10786.460676965964;10841.728956776144;10445.164386848883;10706.197035222234;10713.785724285315;10787.298825576312;10928.672139835817 08:20:59 INFO - PROCESS | 25125 | |3;mootools.html;1269.1433282534288;1440.6038339456652;1450.9709805803884;1599.7440409534477;1757.507897788619;6854.485913556485;7240.601766902825;7301.817454563638;7378.262173782619;7400.851982960337;7452.366548843342;7613.581253031081;7639.00692909921;7667.654955527;7679;2057.660486019812;2108.5150415404464;2308.976910230893;2322.291701031189;2345.6481527770884;2334.6964894563685;2335.684682567857;2339.3099035784485;2341.3327201747506;2341.7658234176615;2256.4810093678466;2323.465602911331;2325.732540757818;2329.04509151248;2329.452578644017;2291.713535808024;2330.475642980333;2336.439254578906;2339.649052642109;2341.1454818991115;2316.501952080294;2321.2339927823778;2323.907043718249;2340.871252081135;2345.519168570439;7740.574268415235;7747.225277472207;7752.7674169775;7765.72819951299;7770.57261850598;4761.166795810719;4856.708597484162;4891;4892.755362231874;4892.996935628188;3216.4210442120407;3265.6244531878665;3275.7543184261276;3307.0244277937827;3322.750793690483;1078.3152698036724;1085.1915323084352;1090.1278976818514;1102.1238115698038;1119.8432219489196;10630.25588208818;10647.787044259148;10663.946680266548;10676;10696.946515267451;4354.521002689701;4367.235733746582;4430.313301438282;4433.645308375322;4448.644108471314;9181.311401644904;9187.26501879848;9190.218831399272;9193.448393096436;9220.170184683411;4923.556879880828;4926.8768280793265;4955.157623204064;4964.131277026506;4964.354633897642;4443.711158774734;4487.461504619467;4522.29904364824;4523.570260825217;4526.909461810811;3461.688448039638;3528.929421411609;3532.876349327761;3649.39784935488;3765.642263984917;1191.0531127753457;1213.5691829400437;1234.2656119608819;1234.2964510229083;1236.7650146472142;1315.0728736240926;1323.1862404621088;1330.9267990260435;1349.2174538767492;1353.1204716933876;7170.856582868418;7311.122665280094;7331.083614548182;7336.193018767931;7355.77932662021;1078.7896360209684;1084.0893649334596;1123.2193625430411;1138.2544433396138;1150.6333464502234;5697.259356283656;5707.543396528268;5728.656280623092;5768.394318596487;5827.912581311284;8939.150780675825;9024.684136055337;9219.17027467531;9370.90629093714;9388.906110938804;9239.815203696024;9241.861372079424;9249.583768730423;9250.259979201648;9269.258459323239;7203.89194162088;7274.054372931485;7325.560466372035;7333.779986600411;7390.150132734804;7090.255523170199;7101.254368291255;7102.18324892644;7148.678309475982;7188.209296977433;8082.474639148437;8191.385646076687;8375.371847111614;8524.232819046316;8529.616167272363;8425.578721064045;8556.914430855611;8576.099509551657;8675.739727808175;8691.565421729014;6600.867982640416;6758.966205169139;6765.9661701691175;6766.729330826909;6771.45828333742;6515.934840651723;6632.038354438483;7086.787396378117;7301.379382752313;7309.926900731138;6929.618870961944;6932.133483314586;7066.752663656747;7123.25205853378;7162.820929476597;6764.458843292623;6786.151731033621;6883.105196324445;6988.301169883174;7018.157821061301;6967.581945083311;6980.6509674515055;7017.964910175417;7019.3682568569075;7037.437005039482;6500.479961602966;6525.314841941527;6563.146790917151;6577.177852768404;6585.769498067544;6590.868182636416;6657.700403481952;6662.100616416916;6668.366505182;6673.065770791996 08:20:59 INFO - PROCESS | 25125 | |4;prototype.html;342.0815111425822;345.85819813876316;348.02379325990586;348.9127718070484;350.5617977528089;5660.915086273709;5751.942480575193;5783.38065341704;5785.913211301834;5837.737301821423;5620.91568626471;5762.56780741445;5792;5795.681237531934;5803.506701930341;4523.5024147343765;4525.298578720303;4545.818167273322;4552.772361381934;4558.27067669173;4351.564843515639;4427.977860110695;4479.507254202035;4534.9546504534865;4548.590626843584;4498.50516443191;4499.617532509724;4501.347304640825;4505.053938672882;4528.320751887227;4485.753283569403;4512.1426928883575;4519.299508576176;4519.457665080178;4528.796204170821;3994.1811928554575;4000.3599424092295;4001.099752555681;4001.459802926626;4002.7598344099447;5394.32570928634;5552.222688823568;5553.750081246354;5575.107982722745;5577.52591029763;5156.535911767922;5163.406208286057;5167.534921857014;5170.948290517084;5172.767225474862;5876.853078673024;6093.390660933871;6101.969490152565;6104.847378815521;6203.2245969253845;4225.176090662322;4239.533651298355;4345.41336919515;4389.648828093745;4394.670399720034;6304.873902521924;6424.00427933671;6424.100625912376;6425.1326070980285;6425.357464253537;4434.224010798098;4435.778211089432;4437.711548749321;4438.977805110953;4441.578050085237;4372.628326592276;4483.574060464251;4485.977570112129;4496.977515112403;4520.9827788747925;5190.169572868398;5197.688138711689;5206;5209.374875014947;5221.034108689904;6174.228221472316;6210.31686514483;6223.222097237845;6227.595206311576;6228.4705800007505;1565.2799712132546;1589.61849156204;1590.3956496531243;1591.9204039797964;1592.936282548685;1057.9153667706564;1059.7615536504225;1064.206811522587;1068.5084860963889;1091.579741799397;5843.29880414353;5852.4147585241135;5853.2976042875125;5853.853653658607;5855.912161317584;6329.525285603599;6333.651649159248;6337.302896681362;6343.619382837044;6349.650769207646;5834.766609335664;5843.970780146072;5844.620099693591;5848.707564621837;5849.151872978395;3309.4539400998565;3419.65803419661;3419.777714448553;3421.3157368526395;3422.880199193066;6577.901331480031;6615.801525954229;6618.933810661832;6620.337966203341;6623.4038936495945;6491.480681545465;6498.057781621733;6501.99219121037;6508.934910650928;6511;6477.514186436036;6572.244191917895;6599.1091202687985;6670.699818508082;6676.26561078281;6121.755129794758;6226.346233645402;6409.4231519163495;6411.134496842867;6421.775237866652;6210.7515699371515;6328.620282782864;6334.049892516159;6348.714307856065;6348.71430785625;6647.202335719745;6655.534112612071;6656.334366563498;6658.766943156967;6658.866822663616;4332.4367832181615;4432.800523976364;4461.776911154364;4469.575390337913;4472.731636101845;6322.146510221061;6362.491000720024;6374.617522948638;6377.362263773771;6381.074744162163;6160.476359509313;6190.164327815687;6209.565330426827;6214.5028397728975;6219.595726277777;6096.390360964046;6188.876222475616;6198.318184999556;6201.596896201732;6203.06953956892;6059.363766804422;6067.453929146398;6071.635701857903;6074.574779765374;6077.544184186292;6206.348333424925;6268.341824108586;6277.937220627735;6289.7169627365965;6296.653684047238;5961.761529538943;6150.969245153925;6158;6159.507239420746;6164.630122192682 08:20:59 INFO - PROCESS | 25125 | |5;yui.html;717.3364637710118;778.8870613761003;826.4091174810013;827.770760420775;859.2567429173766;12904.290264035475;13119.672008199788;13184.34078296085;13300.068995170343;13301.866981330184;11822.822657660121;12226.877731222685;12521.248725076479;12546;12724.809127863089;799.7800604833674;807.0235015631093;814.5764202614637;814.775936617432;816.1512027491402;803.2088392932985;804.2480280937342;804.2841870735022;804.3685706720197;804.8350088231928;843.3084870406269;843.6077224090797;845.7082306604211;846.3736834742308;847.3348421489133;834.5576844272546;837.8701301298308;839.6515446089866;840.9873851892196;843.4517563583659;618.8855061813579;622.8474023864137;623.1151764494383;625.0998562070649;627.7143899525751;11793.823092653616;11832.112591555668;11848.822267665906;11856.822147667706;11876.406179691066;11055.115590752801;11277.266977646426;11433;11772.941135294355;11896.869797369236;9765.121139097444;9916;9929.404235745806;10050.497475126214;10118.494075296207;3529.294141171776;3593.586737525166;3633.94549081764;3672.210474747942;3713.702903767692;47658.5234147661;48181;49477.50522494801;49939.75030124826;51137.23294150591;10157.187425005981;10219.182465402899;10240.846387304196;10280.280380373451;10310.123639490577;17935.551611209823;17944.282228710967;17957.461276161735;18144.546386340447;18359.63280734378;7567.3189412952;7703.229677032252;7724.111727151337;7806.57063861493;7999.920000800034;4230.576942305806;4279.764612946318;4332.696711230246;4400.15568706895;4436.179306828247;3142.4343618148496;3145.7011583899493;3152.4798408262836;3154.085315258595;3156.873725051018;597.7818096394872;617.8177437655902;619.1517620859362;627.8179327994922;636.662568838507;523.2439125463668;620.602814198913;628.4155735166339;630.4200135875006;643.3727116061802;8443.873341899876;9182.989871114172;9639.662611808693;9706.70879873605;9744.220462362993;580.6458060583041;615.2463232540192;694.5763084518439;698.1064237775655;719.7588807749357;3850.8442311696826;4044.272031034442;4093.570175131628;4133.256013917524;4151.56408577095;57995;59285.70357148186;59598;59661;59712.2374091374;48010.75994620074;49960.75019624879;52727.73636131795;52929.47070529322;53734.462655373725;44836.775816121364;47376.157430554274;47830.04339913182;48460.515394846305;48948.75525622349;7804.2585954334245;8114.472559283628;8232.794180145544;8340.249377555807;8986.820263594822;33936.66063339335;35770.28459430745;36042.4593631101;36794.816025919696;36966.26067478689;46528.767356163;47180;47369;47399.28901066418;47424.28863567118;10920.235583509078;10924.289921155418;10933.726656833644;10943.28868623537;11034.503447345049;12348.567800127312;12355.505779769068;12947.611571652866;12961.22232666043;13375.514643436962;11837.644870653894;11878.346690932081;11981;12000.939995300318;12396.504139834306;11656.708582285171;12132.393380331125;12142.939285303517;12481.251124932533;12535.310557919402;12136.514539418678;12270.263784172977;12519.56181533642;12535.686607834512;12562.371881406076;9408;9720.562574684298;9762.46306453152;9991.900080999098;10051.346662466916;8784.077671844365;9054.864177037482;9612.1829644481;9688.612455501983;9718.465484398143 08:20:59 INFO - PROCESS | 25125 | __end_tp_report 08:20:59 INFO - PROCESS | 25125 | __start_cc_report 08:20:59 INFO - PROCESS | 25125 | _x_x_mozilla_cycle_collect,961 08:20:59 INFO - PROCESS | 25125 | __end_cc_report 08:20:59 INFO - PROCESS | 25125 | __startTimestamp1453220459720__endTimestamp 08:20:59 INFO - PROCESS | 25125 | 08:20:59 INFO - PROCESS | 25125 | ------- Summary: start ------- 08:20:59 INFO - PROCESS | 25125 | Number of tests: 6 08:20:59 INFO - PROCESS | 25125 | 08:20:59 INFO - PROCESS | 25125 | [#0] dojo.html Cycles:165 Average:5199.80 Median:5369.70 stddev:676.74 (12.6%) stddev-sans-first:658.69 08:20:59 INFO - PROCESS | 25125 | Values: 3111.4 3165.4 3185.7 3187.6 3215.5 5163.0 5269.8 5270.0 5282.3 5285.8 5179.9 5205.2 5229.8 5230.7 5236.3 4787.6 4843.5 4857.5 4876.8 4900.6 340.0 4853.2 4883.9 4886.9 4886.9 4798.8 4816.9 4818.3 4820.9 4829.7 4823.4 4824.7 4826.1 4833.1 4864.7 4699.2 4856.6 4896.5 4897.0 4903.0 5047.0 5091.7 5104.6 5138.4 5154.6 5555.1 5564.7 5576.8 5577.2 5581.8 5600.4 5609.2 5610.1 5615.0 5683.9 5243.3 5277.5 5298.4 5299.3 5303.8 5781.6 5805.2 5822.3 5826.7 5838.1 5423.1 5580.2 5583.1 5584.1 5588.1 5558.4 5598.4 5642.2 5651.4 5685.7 5600.5 5602.8 5610.4 5615.0 5619.5 5512.0 5593.7 5597.8 5603.9 5612.4 4310.7 4326.4 4377.9 4413.1 4425.0 3920.5 3931.0 3938.3 3951.0 3968.9 5141.4 5200.2 5208.1 5212.2 5213.8 5531.6 5542.4 5582.4 5611.7 5642.0 5214.2 5242.6 5255.6 5259.6 5265.2 4727.1 4842.5 4845.5 4845.6 4873.6 5788.2 5875.2 5902.2 5903.6 5919.0 5576.7 5592.6 5636.2 5647.7 5654.9 5713.3 5827.6 5857.5 5872.6 5884.4 5504.5 5551.2 5604.3 5609.3 5619.3 5602.5 5603.2 5607.6 5613.3 5618.1 5412.9 5484.4 5494.9 5503.6 5552.7 5394.6 5481.7 5506.7 5552.9 5588.9 5343.5 5344.3 5345.4 5348.1 5369.7 5431.8 5432.2 5459.9 5497.0 5525.7 5300.4 5318.4 5368.0 5394.2 5396.3 08:20:59 INFO - PROCESS | 25125 | 08:20:59 INFO - PROCESS | 25125 | [#1] ext.html Cycles:180 Average:43248.16 Median:35517.97 stddev:70667.07 (199.0%) stddev-sans-first:70792.51 08:20:59 INFO - PROCESS | 25125 | Values: 527.1 542.8 553.3 556.6 601.0 27776.3 28140.0 34995.8 35671.5 35692.6 38028.0 38520.2 38523.2 38527.2 38569.4 8468.5 8590.2 8613.8 8662.1 8676.0 8367.7 8434.3 8475.7 8495.1 8496.7 8671.7 8697.8 8726.7 8746.3 8752.4 8658.6 8662.0 8703.0 8730.1 8737.3 8553.0 8698.7 8704.7 8711.3 8716.3 39224.8 39649.4 39662.2 39703.2 39770.0 3245.8 3262.9 3306.0 3342.8 3359.8 28901.4 29169.4 29174.7 29424.3 29483.7 3845.8 3932.4 4002.9 4031.8 4058.7 254071.0 254346.0 254710.0 254923.0 255440.0 51626.2 52337.0 55586.7 55890.7 55949.0 62087.1 62115.7 62192.4 63055.0 63167.7 12919.7 13136.3 13159.8 13166.1 13175.5 9254.7 9413.7 9560.9 9638.6 9827.5 18619.4 19260.2 19321.5 19371.7 19375.9 7555.9 7752.8 7767.8 7801.5 7893.9 922.9 932.6 989.4 991.2 1112.5 27881.3 27915.2 28847.0 29058.6 29090.6 989.4 1078.3 1095.3 1103.8 1121.6 13474.8 13679.7 13770.2 13908.4 13909.7 257406.0 259479.0 259545.0 260154.0 261028.0 45045.3 48515.5 48673.5 48735.8 48801.5 1302.9 1303.4 1323.3 1324.5 1327.2 26627.7 27267.0 27888.2 27900.6 27915.9 44031.3 44320.8 44425.6 44470.3 44529.6 294005.0 295442.0 295569.0 297494.0 297772.0 27395.9 30652.6 30943.5 31350.0 31450.0 35897.3 37198.8 37280.6 37318.6 37680.6 32238.4 33786.3 33885.3 34053.1 34190.0 27863.4 32383.2 32747.8 34550.5 34835.0 30997.2 34451.7 35506.6 35529.3 35555.3 27923.9 31178.4 32518.3 33381.8 34315.1 24019.2 24087.4 24159.0 24378.4 24471.8 08:20:59 INFO - PROCESS | 25125 | 08:20:59 INFO - PROCESS | 25125 | [#2] jquery.html Cycles:180 Average:27703.10 Median:18025.58 stddev:84279.80 (467.6%) stddev-sans-first:84491.24 08:20:59 INFO - PROCESS | 25125 | Values: 368.0 369.9 371.6 372.6 379.8 13817.5 14666.5 15734.9 16834.3 17522.3 16061.3 16487.2 16529.3 16765.9 17497.7 4401.5 5859.9 6048.2 6050.1 6052.4 4531.5 6400.3 6660.0 6667.5 6678.8 6390.9 6669.6 6674.5 6677.5 6701.4 6485.4 6667.6 6694.5 6725.1 6740.7 6209.0 6458.9 6459.4 6460.4 6511.2 19817.4 20183.5 20536.8 22094.0 22142.0 2240.3 2320.9 2337.3 2387.2 2415.8 12617.2 12899.2 13381.7 13575.5 13731.8 1836.0 1878.4 1925.4 1931.4 1981.0 58026.7 60234.1 60406.4 61166.4 62879.0 14933.0 15109.5 15150.5 15193.5 15198.9 23266.5 23301.8 23464.1 23611.4 23620.4 6578.0 6817.4 6904.7 6921.0 6955.5 6379.3 6387.3 6392.2 6488.1 6499.3 4175.1 4308.5 4315.9 4447.5 4507.0 1731.2 1742.8 1764.9 1768.2 1781.0 780.3 823.2 881.2 905.2 1019.2 13320.3 14095.7 15228.6 15339.9 15456.4 876.0 894.3 916.2 953.3 954.7 7723.8 8728.8 8865.6 9133.1 10048.9 502783.0 510282.0 511962.0 526418.0 529072.0 70148.0 71671.6 71873.0 72441.0 73298.6 1053.8 1058.4 1080.7 1081.9 1094.5 14899.0 14983.2 15085.2 15170.5 15448.5 29991.9 30865.5 32950.8 33842.3 35763.0 43223.6 44714.1 46583.8 46666.3 46766.8 10094.5 10160.7 10319.1 10332.5 10378.0 11448.4 11837.3 12127.0 12213.1 12563.9 10293.8 10324.8 10566.9 10722.3 10905.3 7620.8 7677.5 7991.6 10317.2 10745.6 3100.3 3942.0 5203.9 7614.2 7829.5 8303.6 10567.3 10614.6 10786.5 10841.7 10445.2 10706.2 10713.8 10787.3 10928.7 08:20:59 INFO - PROCESS | 25125 | 08:20:59 INFO - PROCESS | 25125 | [#3] mootools.html Cycles:180 Average:5459.05 Median:6508.21 stddev:2761.49 (42.4%) stddev-sans-first:2751.27 08:20:59 INFO - PROCESS | 25125 | Values: 1269.1 1440.6 1451.0 1599.7 1757.5 6854.5 7240.6 7301.8 7378.3 7400.9 7452.4 7613.6 7639.0 7667.7 7679.0 2057.7 2108.5 2309.0 2322.3 2345.6 2334.7 2335.7 2339.3 2341.3 2341.8 2256.5 2323.5 2325.7 2329.0 2329.5 2291.7 2330.5 2336.4 2339.6 2341.1 2316.5 2321.2 2323.9 2340.9 2345.5 7740.6 7747.2 7752.8 7765.7 7770.6 4761.2 4856.7 4891.0 4892.8 4893.0 3216.4 3265.6 3275.8 3307.0 3322.8 1078.3 1085.2 1090.1 1102.1 1119.8 10630.3 10647.8 10663.9 10676.0 10696.9 4354.5 4367.2 4430.3 4433.6 4448.6 9181.3 9187.3 9190.2 9193.4 9220.2 4923.6 4926.9 4955.2 4964.1 4964.4 4443.7 4487.5 4522.3 4523.6 4526.9 3461.7 3528.9 3532.9 3649.4 3765.6 1191.1 1213.6 1234.3 1234.3 1236.8 1315.1 1323.2 1330.9 1349.2 1353.1 7170.9 7311.1 7331.1 7336.2 7355.8 1078.8 1084.1 1123.2 1138.3 1150.6 5697.3 5707.5 5728.7 5768.4 5827.9 8939.2 9024.7 9219.2 9370.9 9388.9 9239.8 9241.9 9249.6 9250.3 9269.3 7203.9 7274.1 7325.6 7333.8 7390.2 7090.3 7101.3 7102.2 7148.7 7188.2 8082.5 8191.4 8375.4 8524.2 8529.6 8425.6 8556.9 8576.1 8675.7 8691.6 6600.9 6759.0 6766.0 6766.7 6771.5 6515.9 6632.0 7086.8 7301.4 7309.9 6929.6 6932.1 7066.8 7123.3 7162.8 6764.5 6786.2 6883.1 6988.3 7018.2 6967.6 6980.7 7018.0 7019.4 7037.4 6500.5 6525.3 6563.1 6577.2 6585.8 6590.9 6657.7 6662.1 6668.4 6673.1 08:20:59 INFO - PROCESS | 25125 | 08:20:59 INFO - PROCESS | 25125 | [#4] prototype.html Cycles:180 Average:5178.72 Median:5840.52 stddev:1543.03 (26.4%) stddev-sans-first:1504.05 08:20:59 INFO - PROCESS | 25125 | Values: 342.1 345.9 348.0 348.9 350.6 5660.9 5751.9 5783.4 5785.9 5837.7 5620.9 5762.6 5792.0 5795.7 5803.5 4523.5 4525.3 4545.8 4552.8 4558.3 4351.6 4428.0 4479.5 4535.0 4548.6 4498.5 4499.6 4501.3 4505.1 4528.3 4485.8 4512.1 4519.3 4519.5 4528.8 3994.2 4000.4 4001.1 4001.5 4002.8 5394.3 5552.2 5553.8 5575.1 5577.5 5156.5 5163.4 5167.5 5170.9 5172.8 5876.9 6093.4 6102.0 6104.8 6203.2 4225.2 4239.5 4345.4 4389.6 4394.7 6304.9 6424.0 6424.1 6425.1 6425.4 4434.2 4435.8 4437.7 4439.0 4441.6 4372.6 4483.6 4486.0 4497.0 4521.0 5190.2 5197.7 5206.0 5209.4 5221.0 6174.2 6210.3 6223.2 6227.6 6228.5 1565.3 1589.6 1590.4 1591.9 1592.9 1057.9 1059.8 1064.2 1068.5 1091.6 5843.3 5852.4 5853.3 5853.9 5855.9 6329.5 6333.7 6337.3 6343.6 6349.7 5834.8 5844.0 5844.6 5848.7 5849.2 3309.5 3419.7 3419.8 3421.3 3422.9 6577.9 6615.8 6618.9 6620.3 6623.4 6491.5 6498.1 6502.0 6508.9 6511.0 6477.5 6572.2 6599.1 6670.7 6676.3 6121.8 6226.3 6409.4 6411.1 6421.8 6210.8 6328.6 6334.0 6348.7 6348.7 6647.2 6655.5 6656.3 6658.8 6658.9 4332.4 4432.8 4461.8 4469.6 4472.7 6322.1 6362.5 6374.6 6377.4 6381.1 6160.5 6190.2 6209.6 6214.5 6219.6 6096.4 6188.9 6198.3 6201.6 6203.1 6059.4 6067.5 6071.6 6074.6 6077.5 6206.3 6268.3 6277.9 6289.7 6296.7 5961.8 6151.0 6158.0 6159.5 6164.6 08:20:59 INFO - PROCESS | 25125 | 08:20:59 INFO - PROCESS | 25125 | [#5] yui.html Cycles:180 Average:14011.24 Median:47744.28 stddev:16397.01 (34.3%) stddev-sans-first:16412.62 08:20:59 INFO - PROCESS | 25125 | Values: 717.3 778.9 826.4 827.8 859.3 12904.3 13119.7 13184.3 13300.1 13301.9 11822.8 12226.9 12521.2 12546.0 12724.8 799.8 807.0 814.6 814.8 816.2 803.2 804.2 804.3 804.4 804.8 843.3 843.6 845.7 846.4 847.3 834.6 837.9 839.7 841.0 843.5 618.9 622.8 623.1 625.1 627.7 11793.8 11832.1 11848.8 11856.8 11876.4 11055.1 11277.3 11433.0 11772.9 11896.9 9765.1 9916.0 9929.4 10050.5 10118.5 3529.3 3593.6 3633.9 3672.2 3713.7 47658.5 48181.0 49477.5 49939.8 51137.2 10157.2 10219.2 10240.8 10280.3 10310.1 17935.6 17944.3 17957.5 18144.5 18359.6 7567.3 7703.2 7724.1 7806.6 7999.9 4230.6 4279.8 4332.7 4400.2 4436.2 3142.4 3145.7 3152.5 3154.1 3156.9 597.8 617.8 619.2 627.8 636.7 523.2 620.6 628.4 630.4 643.4 8443.9 9183.0 9639.7 9706.7 9744.2 580.6 615.2 694.6 698.1 719.8 3850.8 4044.3 4093.6 4133.3 4151.6 57995.0 59285.7 59598.0 59661.0 59712.2 48010.8 49960.8 52727.7 52929.5 53734.5 44836.8 47376.2 47830.0 48460.5 48948.8 7804.3 8114.5 8232.8 8340.2 8986.8 33936.7 35770.3 36042.5 36794.8 36966.3 46528.8 47180.0 47369.0 47399.3 47424.3 10920.2 10924.3 10933.7 10943.3 11034.5 12348.6 12355.5 12947.6 12961.2 13375.5 11837.6 11878.3 11981.0 12000.9 12396.5 11656.7 12132.4 12142.9 12481.3 12535.3 12136.5 12270.3 12519.6 12535.7 12562.4 9408.0 9720.6 9762.5 9991.9 10051.3 8784.1 9054.9 9612.2 9688.6 9718.5 08:20:59 INFO - PROCESS | 25125 | -------- Summary: end -------- 08:20:59 INFO - PROCESS | 25125 | 08:21:00 INFO - TEST-INFO | 25125: exit 0 08:21:00 INFO - TEST-OK | dromaeo_css | took 1113264ms 08:21:00 INFO - TEST-START | kraken 08:21:00 INFO - operating with platform_type : linux_ 08:21:00 INFO - Initialising browser for kraken test... 08:21:00 INFO - TEST-INFO | started process 25329 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAxz7L6/profile http://localhost:34962/getInfo.html) 08:21:05 INFO - PROCESS | 25329 | __metrics Screen width/height:1600/1200 08:21:05 INFO - PROCESS | 25329 | colorDepth:24 08:21:05 INFO - PROCESS | 25329 | Browser inner width/height: 1024/697 08:21:05 INFO - PROCESS | 25329 | __metrics 08:21:05 INFO - PROCESS | 25329 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:21:05 INFO - PROCESS | 25329 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:21:06 INFO - TEST-INFO | 25329: exit 0 08:21:06 INFO - Browser initialized. 08:21:06 INFO - Running cycle 1/1 for kraken test... 08:21:06 INFO - TEST-INFO | started process 25411 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAxz7L6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:21:18 INFO - PROCESS | 25411 | RSS: Main: 149385216 08:21:18 INFO - PROCESS | 25411 | 08:21:20 INFO - PROCESS | 25411 | Cycle 1(1): loaded http://localhost:34962/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34962/tests/kraken/driver.html?testName=audio-beat-detection) 08:21:21 INFO - PROCESS | 25411 | RSS: Main: 186454016 08:21:21 INFO - PROCESS | 25411 | 08:21:23 INFO - PROCESS | 25411 | Cycle 1(1): loaded http://localhost:34962/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34962/tests/kraken/driver.html?testName=audio-dft) 08:21:24 INFO - PROCESS | 25411 | RSS: Main: 176017408 08:21:24 INFO - PROCESS | 25411 | 08:21:27 INFO - PROCESS | 25411 | Cycle 1(1): loaded http://localhost:34962/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34962/tests/kraken/driver.html?testName=audio-fft) 08:21:28 INFO - PROCESS | 25411 | RSS: Main: 161980416 08:21:28 INFO - PROCESS | 25411 | 08:21:30 INFO - PROCESS | 25411 | Cycle 1(1): loaded http://localhost:34962/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34962/tests/kraken/driver.html?testName=audio-oscillator) 08:21:30 INFO - PROCESS | 25411 | RSS: Main: 164302848 08:21:30 INFO - PROCESS | 25411 | 08:21:32 INFO - PROCESS | 25411 | Cycle 1(1): loaded http://localhost:34962/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34962/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:21:33 INFO - PROCESS | 25411 | RSS: Main: 164024320 08:21:33 INFO - PROCESS | 25411 | 08:21:36 INFO - PROCESS | 25411 | Cycle 1(1): loaded http://localhost:34962/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34962/tests/kraken/driver.html?testName=imaging-darkroom) 08:21:36 INFO - PROCESS | 25411 | RSS: Main: 164986880 08:21:36 INFO - PROCESS | 25411 | 08:21:40 INFO - PROCESS | 25411 | Cycle 1(1): loaded http://localhost:34962/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34962/tests/kraken/driver.html?testName=imaging-desaturate) 08:21:40 INFO - PROCESS | 25411 | RSS: Main: 165261312 08:21:40 INFO - PROCESS | 25411 | 08:21:43 INFO - PROCESS | 25411 | Cycle 1(1): loaded http://localhost:34962/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34962/tests/kraken/driver.html?testName=json-parse-financial) 08:21:44 INFO - PROCESS | 25411 | RSS: Main: 165060608 08:21:44 INFO - PROCESS | 25411 | 08:21:45 INFO - PROCESS | 25411 | Cycle 1(1): loaded http://localhost:34962/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34962/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:21:46 INFO - PROCESS | 25411 | RSS: Main: 180125696 08:21:46 INFO - PROCESS | 25411 | 08:21:47 INFO - PROCESS | 25411 | Cycle 1(1): loaded http://localhost:34962/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34962/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:21:48 INFO - PROCESS | 25411 | RSS: Main: 176812032 08:21:48 INFO - PROCESS | 25411 | 08:21:50 INFO - PROCESS | 25411 | Cycle 1(1): loaded http://localhost:34962/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34962/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:21:51 INFO - PROCESS | 25411 | RSS: Main: 188727296 08:21:51 INFO - PROCESS | 25411 | 08:21:53 INFO - PROCESS | 25411 | Cycle 1(1): loaded http://localhost:34962/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34962/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:21:54 INFO - PROCESS | 25411 | RSS: Main: 194265088 08:21:54 INFO - PROCESS | 25411 | 08:21:56 INFO - PROCESS | 25411 | Cycle 1(1): loaded http://localhost:34962/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34962/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:21:57 INFO - PROCESS | 25411 | RSS: Main: 192409600 08:21:57 INFO - PROCESS | 25411 | 08:21:58 INFO - PROCESS | 25411 | Cycle 1(1): loaded http://localhost:34962/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34962/tests/kraken/driver.html?testName=ai-astar) 08:21:59 INFO - PROCESS | 25411 | RSS: Main: 250589184 08:21:59 INFO - PROCESS | 25411 | 08:21:59 INFO - PROCESS | 25411 | __start_tp_report 08:21:59 INFO - PROCESS | 25411 | _x_x_mozilla_page_load 08:21:59 INFO - PROCESS | 25411 | _x_x_mozilla_page_load_details 08:21:59 INFO - PROCESS | 25411 | |i|pagename|runs| 08:21:59 INFO - PROCESS | 25411 | |0;ai-astar;113;110;107;108;109;110;110;110;103;111 08:21:59 INFO - PROCESS | 25411 | |1;audio-beat-detection;157;126;157;176;126;148;148;127;169;129 08:21:59 INFO - PROCESS | 25411 | |2;audio-dft;161;159;161;159;161;158;159;159;163;161 08:21:59 INFO - PROCESS | 25411 | |3;audio-fft;71;73;105;94;71;72;72;123;93;72 08:21:59 INFO - PROCESS | 25411 | |4;audio-oscillator;96;96;139;94;96;96;138;96;95;139 08:21:59 INFO - PROCESS | 25411 | |5;imaging-gaussian-blur;110;109;109;109;109;108;109;109;109;109 08:21:59 INFO - PROCESS | 25411 | |6;imaging-darkroom;147;145;145;146;146;146;146;145;145;145 08:21:59 INFO - PROCESS | 25411 | |7;imaging-desaturate;95;96;95;96;95;96;95;96;96;95 08:21:59 INFO - PROCESS | 25411 | |8;json-parse-financial;56;55;54;62;56;56;55;55;55;53 08:21:59 INFO - PROCESS | 25411 | |9;json-stringify-tinderbox;68;68;68;69;69;69;68;68;69;68 08:21:59 INFO - PROCESS | 25411 | |10;stanford-crypto-aes;80;80;81;81;85;82;83;91;91;81 08:21:59 INFO - PROCESS | 25411 | |11;stanford-crypto-ccm;118;119;112;117;112;114;116;118;119;118 08:21:59 INFO - PROCESS | 25411 | |12;stanford-crypto-pbkdf2;145;136;143;142;141;131;143;143;156;142 08:21:59 INFO - PROCESS | 25411 | |13;stanford-crypto-sha256-iterative;65;67;66;65;65;66;66;67;65;65 08:21:59 INFO - PROCESS | 25411 | __end_tp_report 08:21:59 INFO - PROCESS | 25411 | __start_cc_report 08:21:59 INFO - PROCESS | 25411 | _x_x_mozilla_cycle_collect,977 08:21:59 INFO - PROCESS | 25411 | __end_cc_report 08:21:59 INFO - PROCESS | 25411 | __startTimestamp1453220519151__endTimestamp 08:21:59 INFO - PROCESS | 25411 | 08:21:59 INFO - PROCESS | 25411 | ------- Summary: start ------- 08:21:59 INFO - PROCESS | 25411 | Number of tests: 14 08:21:59 INFO - PROCESS | 25411 | 08:21:59 INFO - PROCESS | 25411 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:2.69 (2.4%) stddev-sans-first:2.45 08:21:59 INFO - PROCESS | 25411 | Values: 113.0 110.0 107.0 108.0 109.0 110.0 110.0 110.0 103.0 111.0 08:21:59 INFO - PROCESS | 25411 | 08:21:59 INFO - PROCESS | 25411 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:152.50 stddev:18.64 (12.2%) stddev-sans-first:19.37 08:21:59 INFO - PROCESS | 25411 | Values: 157.0 126.0 157.0 176.0 126.0 148.0 148.0 127.0 169.0 129.0 08:21:59 INFO - PROCESS | 25411 | 08:21:59 INFO - PROCESS | 25411 | [#2] audio-dft Cycles:10 Average:160.10 Median:161.00 stddev:1.52 (0.9%) stddev-sans-first:1.58 08:21:59 INFO - PROCESS | 25411 | Values: 161.0 159.0 161.0 159.0 161.0 158.0 159.0 159.0 163.0 161.0 08:21:59 INFO - PROCESS | 25411 | 08:21:59 INFO - PROCESS | 25411 | [#3] audio-fft Cycles:10 Average:84.60 Median:72.00 stddev:18.35 (25.5%) stddev-sans-first:18.79 08:21:59 INFO - PROCESS | 25411 | Values: 71.0 73.0 105.0 94.0 71.0 72.0 72.0 123.0 93.0 72.0 08:21:59 INFO - PROCESS | 25411 | 08:21:59 INFO - PROCESS | 25411 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:96.00 stddev:20.83 (21.7%) stddev-sans-first:21.60 08:21:59 INFO - PROCESS | 25411 | Values: 96.0 96.0 139.0 94.0 96.0 96.0 138.0 96.0 95.0 139.0 08:21:59 INFO - PROCESS | 25411 | 08:21:59 INFO - PROCESS | 25411 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 08:21:59 INFO - PROCESS | 25411 | Values: 110.0 109.0 109.0 109.0 109.0 108.0 109.0 109.0 109.0 109.0 08:21:59 INFO - PROCESS | 25411 | 08:21:59 INFO - PROCESS | 25411 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 08:21:59 INFO - PROCESS | 25411 | Values: 147.0 145.0 145.0 146.0 146.0 146.0 146.0 145.0 145.0 145.0 08:21:59 INFO - PROCESS | 25411 | 08:21:59 INFO - PROCESS | 25411 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:21:59 INFO - PROCESS | 25411 | Values: 95.0 96.0 95.0 96.0 95.0 96.0 95.0 96.0 96.0 95.0 08:21:59 INFO - PROCESS | 25411 | 08:21:59 INFO - PROCESS | 25411 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.50 stddev:2.41 (4.3%) stddev-sans-first:2.55 08:21:59 INFO - PROCESS | 25411 | Values: 56.0 55.0 54.0 62.0 56.0 56.0 55.0 55.0 55.0 53.0 08:21:59 INFO - PROCESS | 25411 | 08:21:59 INFO - PROCESS | 25411 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 08:21:59 INFO - PROCESS | 25411 | Values: 68.0 68.0 68.0 69.0 69.0 69.0 68.0 68.0 69.0 68.0 08:21:59 INFO - PROCESS | 25411 | 08:21:59 INFO - PROCESS | 25411 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:82.50 stddev:4.22 (5.1%) stddev-sans-first:4.28 08:21:59 INFO - PROCESS | 25411 | Values: 80.0 80.0 81.0 81.0 85.0 82.0 83.0 91.0 91.0 81.0 08:21:59 INFO - PROCESS | 25411 | 08:21:59 INFO - PROCESS | 25411 | [#11] stanford-crypto-ccm Cycles:10 Average:116.30 Median:118.00 stddev:2.71 (2.3%) stddev-sans-first:2.80 08:21:59 INFO - PROCESS | 25411 | Values: 118.0 119.0 112.0 117.0 112.0 114.0 116.0 118.0 119.0 118.0 08:21:59 INFO - PROCESS | 25411 | 08:21:59 INFO - PROCESS | 25411 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.20 Median:143.00 stddev:6.37 (4.5%) stddev-sans-first:6.68 08:21:59 INFO - PROCESS | 25411 | Values: 145.0 136.0 143.0 142.0 141.0 131.0 143.0 143.0 156.0 142.0 08:21:59 INFO - PROCESS | 25411 | 08:21:59 INFO - PROCESS | 25411 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 08:21:59 INFO - PROCESS | 25411 | Values: 65.0 67.0 66.0 65.0 65.0 66.0 66.0 67.0 65.0 65.0 08:21:59 INFO - PROCESS | 25411 | -------- Summary: end -------- 08:21:59 INFO - PROCESS | 25411 | 08:22:00 INFO - TEST-INFO | 25411: exit 0 08:22:00 INFO - TEST-OK | kraken | took 60069ms 08:22:00 INFO - TEST-START | v8_7 08:22:00 INFO - operating with platform_type : linux_ 08:22:00 INFO - Initialising browser for v8_7 test... 08:22:00 INFO - TEST-INFO | started process 25660 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDW2j0m/profile http://localhost:34962/getInfo.html) 08:22:04 INFO - PROCESS | 25660 | __metrics Screen width/height:1600/1200 08:22:04 INFO - PROCESS | 25660 | colorDepth:24 08:22:04 INFO - PROCESS | 25660 | Browser inner width/height: 1024/697 08:22:04 INFO - PROCESS | 25660 | __metrics 08:22:05 INFO - PROCESS | 25660 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:22:05 INFO - PROCESS | 25660 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:22:06 INFO - TEST-INFO | 25660: exit 0 08:22:06 INFO - Browser initialized. 08:22:06 INFO - Running cycle 1/1 for v8_7 test... 08:22:06 INFO - TEST-INFO | started process 25746 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDW2j0m/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:22:18 INFO - PROCESS | 25746 | RSS: Main: 149307392 08:22:18 INFO - PROCESS | 25746 | 08:22:40 INFO - PROCESS | 25746 | Cycle 1(1): loaded http://localhost:34962/tests/v8_7/run.html (next: http://localhost:34962/tests/v8_7/run.html) 08:22:41 INFO - PROCESS | 25746 | RSS: Main: 580370432 08:22:41 INFO - PROCESS | 25746 | 08:22:41 INFO - PROCESS | 25746 | __start_tp_report 08:22:41 INFO - PROCESS | 25746 | _x_x_mozilla_page_load 08:22:41 INFO - PROCESS | 25746 | _x_x_mozilla_page_load_details 08:22:41 INFO - PROCESS | 25746 | |i|pagename|runs| 08:22:41 INFO - PROCESS | 25746 | |0;Richards;167.78523489932886 08:22:41 INFO - PROCESS | 25746 | |1;DeltaBlue;188.14675446848543 08:22:41 INFO - PROCESS | 25746 | |2;Encrypt;280.58361391694723 08:22:41 INFO - PROCESS | 25746 | |3;Decrypt;5256.544502617801 08:22:41 INFO - PROCESS | 25746 | |4;RayTrace;1116.0714285714287 08:22:41 INFO - PROCESS | 25746 | |5;Earley;781.25 08:22:41 INFO - PROCESS | 25746 | |6;Boyer;12304.878048780487 08:22:41 INFO - PROCESS | 25746 | |7;RegExp;42562.5 08:22:41 INFO - PROCESS | 25746 | |8;Splay;546.448087431694 08:22:41 INFO - PROCESS | 25746 | |9;NavierStokes;4854.368932038835 08:22:41 INFO - PROCESS | 25746 | __end_tp_report 08:22:41 INFO - PROCESS | 25746 | __startTimestamp1453220561103__endTimestamp 08:22:41 INFO - PROCESS | 25746 | 08:22:41 INFO - PROCESS | 25746 | ------- Summary: start ------- 08:22:41 INFO - PROCESS | 25746 | Number of tests: 10 08:22:41 INFO - PROCESS | 25746 | 08:22:41 INFO - PROCESS | 25746 | [#0] Richards Cycles:1 Average:167.79 Median:167.79 stddev:0.00 (0.0%) 08:22:41 INFO - PROCESS | 25746 | Values: 167.8 08:22:41 INFO - PROCESS | 25746 | 08:22:41 INFO - PROCESS | 25746 | [#1] DeltaBlue Cycles:1 Average:188.15 Median:188.15 stddev:0.00 (0.0%) 08:22:41 INFO - PROCESS | 25746 | Values: 188.1 08:22:41 INFO - PROCESS | 25746 | 08:22:41 INFO - PROCESS | 25746 | [#2] Encrypt Cycles:1 Average:280.58 Median:280.58 stddev:0.00 (0.0%) 08:22:41 INFO - PROCESS | 25746 | Values: 280.6 08:22:41 INFO - PROCESS | 25746 | 08:22:41 INFO - PROCESS | 25746 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 08:22:41 INFO - PROCESS | 25746 | Values: 5256.5 08:22:41 INFO - PROCESS | 25746 | 08:22:41 INFO - PROCESS | 25746 | [#4] RayTrace Cycles:1 Average:1116.07 Median:1116.07 stddev:0.00 (0.0%) 08:22:41 INFO - PROCESS | 25746 | Values: 1116.1 08:22:41 INFO - PROCESS | 25746 | 08:22:41 INFO - PROCESS | 25746 | [#5] Earley Cycles:1 Average:781.25 Median:781.25 stddev:0.00 (0.0%) 08:22:41 INFO - PROCESS | 25746 | Values: 781.3 08:22:41 INFO - PROCESS | 25746 | 08:22:41 INFO - PROCESS | 25746 | [#6] Boyer Cycles:1 Average:12304.88 Median:12304.88 stddev:0.00 (0.0%) 08:22:41 INFO - PROCESS | 25746 | Values: 12304.9 08:22:41 INFO - PROCESS | 25746 | 08:22:41 INFO - PROCESS | 25746 | [#7] RegExp Cycles:1 Average:42562.50 Median:42562.50 stddev:0.00 (0.0%) 08:22:41 INFO - PROCESS | 25746 | Values: 42562.5 08:22:41 INFO - PROCESS | 25746 | 08:22:41 INFO - PROCESS | 25746 | [#8] Splay Cycles:1 Average:546.45 Median:546.45 stddev:0.00 (0.0%) 08:22:41 INFO - PROCESS | 25746 | Values: 546.4 08:22:41 INFO - PROCESS | 25746 | 08:22:41 INFO - PROCESS | 25746 | [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 08:22:41 INFO - PROCESS | 25746 | Values: 4854.4 08:22:41 INFO - PROCESS | 25746 | -------- Summary: end -------- 08:22:41 INFO - PROCESS | 25746 | 08:22:42 INFO - TEST-INFO | 25746: exit 0 08:22:42 INFO - TEST-OK | v8_7 | took 41670ms 08:22:42 INFO - SUITE-END | took 1215s 08:22:42 INFO - Completed test suite (00:20:15) 08:22:42 INFO - Working with test: dromaeo_css 08:22:42 INFO - Generating results file: dromaeo_css 08:22:42 INFO - Working with test: kraken 08:22:42 INFO - Generating results file: kraken 08:22:42 INFO - javascript benchmark 08:22:42 INFO - Working with test: v8_7 08:22:42 INFO - Generating results file: v8_7 08:22:42 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:22:42 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 08:22:42 INFO - process_Request line: dromaeo_css 6880.27 graph.html#tests=[[72,201,35]] 08:22:42 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:22:42 INFO - process_Request line: kraken 1490.50 graph.html#tests=[[232,201,35]] 08:22:42 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:22:42 INFO - process_Request line: v8_7 20183.96 graph.html#tests=[[230,201,35]] 08:22:42 INFO - RETURN: dromaeo_css: 6880.27 08:22:42 INFO - RETURN: kraken: 1490.50 08:22:42 INFO - RETURN: v8_7: 20183.96 08:22:42 INFO - javascript benchmark 08:22:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3111.377724455109, 3165.4460469417877, 3185.697358750918, 3187.5856138701965, 3215.4533729266013, 5163.044836705203, 5269.81555645552, 5270.0, 5282.313299271094, 5285.841424757254, 5179.896402071966, 5205.16717325228, 5229.764660590273, 5230.7123108229125, 5236.2931004314405, 4787.61699064074, 4843.515648435164, 4857.489963553829, 4876.756162191894, 4900.607951363901, 339.9511091818782, 4853.199222128363, 4883.926741098869, 4886.926696099544, 4886.926696099561, 4798.808047678106, 4816.903661926759, 4818.277258411266, 4820.927686084711, 4829.7343646099625, 4823.445303790038, 4824.710517368934, 4826.131296366652, 4833.057553777015, 4864.708117512925, 4699.154152252593, 4856.562909338141, 4896.534829191221, 4897.0, 4902.975485122552, 5047.041062198171, 5091.66904151229, 5104.64267501275, 5138.409082955471, 5154.561862241714, 5555.138953462219, 5564.693941833198, 5576.776928922838, 5577.191307260425, 5581.776728930838, 5600.411956744565, 5609.242752228438, 5610.074337734269, 5615.0, 5683.886322273573, 5243.344581927259, 5277.47225277473, 5298.417174110845, 5299.2845965794895, 5303.814366497154, 5781.5952883298605, 5805.158252053428, 5822.33043200029, 5826.737796799154, 5838.095095260242, 5423.05096608092, 5580.246666700024, 5583.134614134816, 5584.050711379075, 5588.133839254922, 5558.44415558441, 5598.412166722517, 5642.238297829823, 5651.350094739158, 5685.658860468385, 5600.52395546375, 5602.831915042555, 5610.410906854803, 5615.0, 5619.466150715675, 5512.0, 5593.720313984366, 5597.776088956396, 5603.915941260884, 5612.382637909908, 4310.698251122454, 4326.372675961968, 4377.9124417511475, 4413.073254616503, 4424.955750442518, 3920.549136849299, 3931.0, 3938.3107956107565, 3950.9802450987563, 3968.940465893014, 5141.434442211354, 5200.193969934666, 5208.114620514521, 5212.166053431432, 5213.765380557884, 5531.557475401958, 5542.39033706292, 5582.413846546136, 5611.7474713637985, 5642.04085305499, 5214.217867319932, 5242.633015688942, 5255.605829562722, 5259.579233661298, 5265.157574788015, 4727.078219747116, 4842.491538388489, 4845.491223421561, 4845.6123510119105, 4873.561379475864, 5788.18965344852, 5875.177475153482, 5902.173695682608, 5903.616264942765, 5918.970405147947, 5576.693281869536, 5592.552595792408, 5636.239107720406, 5647.7176141193595, 5654.943450565442, 5713.285839270091, 5827.562932779973, 5857.47282744555, 5872.588918775816, 5884.411558844081, 5504.504594586507, 5551.195076713934, 5604.271444712162, 5609.326880774333, 5619.297587801525, 5602.467765562265, 5603.1875378069135, 5607.5513958884, 5613.298337707786, 5618.101103823368, 5412.891742165056, 5484.396716361117, 5494.862628434321, 5503.587230957774, 5552.7223638818705, 5394.622376433769, 5481.67109973387, 5506.669599824023, 5552.944470555242, 5588.944110559005, 5343.519083282523, 5344.251804747416, 5345.438728933562, 5348.144296912631, 5369.704666243394, 5431.83704488866, 5432.239486471818, 5459.863503412446, 5497.0, 5525.723713814213, 5300.3904550975585, 5318.441563635917, 5368.0, 5394.244805727123, 5396.325459317585], "unit": "score", "name": "dojo.html", "value": 5159.919515268731}, {"lowerIsBetter": false, "replicates": [527.0565687419519, 542.8073034072904, 553.2724467325469, 556.6326224691703, 600.9519238460921, 27776.305592360175, 28140.0, 34995.82502087492, 35671.4649280261, 35692.643073569256, 38028.0, 38520.22959540808, 38523.22953540928, 38527.229455410874, 38569.421458678145, 8468.534230617313, 8590.226879580836, 8613.827723445527, 8662.13378662135, 8676.045634980148, 8367.748967530984, 8434.325253979698, 8475.660973561051, 8495.065542790288, 8496.702615408461, 8671.69649062283, 8697.826043479126, 8726.650933962666, 8746.344024198179, 8752.387332886701, 8658.61036253367, 8661.956690216572, 8703.042665306875, 8730.079382535832, 8737.257333126692, 8553.0, 8698.652053917836, 8704.651813927436, 8711.259542938858, 8716.302695784321, 39224.80387598044, 39649.40525892114, 39662.20675586501, 39703.205935881124, 39770.0, 3245.789023713451, 3262.902112936592, 3305.9504107438406, 3342.799432034086, 3359.7648164628486, 28901.421971560452, 29169.41661166786, 29174.708252917622, 29424.264393390124, 29483.70516294831, 3845.7500262483127, 3932.4494570760116, 4002.939955900664, 4031.7984100794843, 4058.715889887709, 254071.0, 254346.0, 254710.0, 254923.0, 255440.0, 51626.22560661593, 52337.0, 55586.72206638941, 55890.720546397824, 55949.0, 62087.068693969624, 62115.689421552604, 62192.37807621866, 63055.0, 63167.68416157982, 12919.677008074685, 13136.27750473733, 13159.802602960963, 13166.078374513692, 13175.538856139989, 9254.722358329262, 9413.717588472357, 9560.90439095614, 9638.614455421844, 9827.47674110514, 18619.39328494012, 19260.229590816492, 19321.51696207606, 19371.709424358647, 19375.90312048431, 7555.886661700079, 7752.7674169775, 7767.805804854924, 7801.531908085533, 7893.894854720344, 922.9077092290718, 932.6083045121065, 989.4113002763344, 991.1872264742842, 1112.5160555158532, 27881.30296742557, 27915.16254512368, 28847.0, 29058.564121538195, 29090.563641545396, 989.3668052446296, 1078.2613909472036, 1095.27164435651, 1103.812351900179, 1121.5681962444355, 13474.797878031837, 13679.726405471834, 13770.242636654879, 13908.443662253396, 13909.721805564035, 257406.0, 259479.0, 259545.0, 260154.0, 261028.0, 45045.32432013522, 48515.51484485181, 48673.51326486761, 48735.75632121817, 48801.51198488041, 1302.9348532573333, 1303.3939218263363, 1323.2854258700386, 1324.4702119152223, 1327.230206480239, 26627.733722662524, 27267.0, 27888.16335509938, 27900.58149127805, 27915.860420697765, 44031.33952990772, 44320.77839610782, 44425.55574444344, 44470.332945005204, 44529.55470445254, 294005.0, 295442.0, 295569.0, 297494.0, 297772.0, 27395.86302068477, 30652.555379469406, 30943.535846962764, 31350.0, 31450.0, 35897.28205435929, 37198.814005929795, 37280.62719372771, 37318.62681373151, 37680.623193767715, 32238.35523289568, 33786.32427351488, 33885.32229355448, 34053.148671283416, 34190.0, 27863.44273114486, 32383.190420239684, 32747.83626081854, 34550.48174277337, 34835.0, 30997.225069373446, 34451.655483445844, 35506.644933550335, 35529.28941421105, 35555.288894221456, 27923.860380698778, 31178.37643247077, 32518.34963300768, 33381.83309083439, 34315.14212144716, 24019.159329423386, 24087.397815054763, 24159.03363865426, 24378.390540236636, 24471.75528244695], "unit": "score", "name": "ext.html", "value": 17578.629093229425}, {"lowerIsBetter": false, "replicates": [368.04675889446327, 369.89273110797865, 371.5782586764022, 372.5678213272603, 379.83287353564447, 13817.51638692646, 14666.486672966448, 15734.921325393372, 16834.326626934922, 17522.299108035695, 16061.277242524086, 16487.17564121795, 16529.25618347174, 16765.91617041916, 17497.73753393697, 4401.471823381199, 5859.912101318484, 6048.183495228154, 6050.092486127072, 6052.394760523935, 4531.456225252974, 6400.327965563619, 6660.034295027218, 6667.533272670915, 6678.833029174285, 6390.904136437957, 6669.633170175638, 6674.466042716595, 6677.4991875609285, 6701.396874281314, 6485.383888530582, 6667.566608170453, 6694.531382803206, 6725.09211256479, 6740.662966851638, 6209.037599172136, 6458.870822583522, 6459.418652321267, 6460.3862633049785, 6511.218653761532, 19817.405477835688, 20183.495412614655, 20536.79463205379, 22094.0, 22142.0, 2240.2719116287108, 2320.8955596998176, 2337.31049340445, 2387.248016874679, 2415.7946574541184, 12617.242965422103, 12899.161554498927, 13381.732365352736, 13575.52485662997, 13731.794023089662, 1835.9816401835944, 1878.445858471754, 1925.3935010471657, 1931.420573827846, 1980.99009504953, 58026.7098664504, 60234.09648855271, 60406.39593604096, 61166.38833611696, 62879.0, 14933.0, 15109.47116850905, 15150.500167472464, 15193.468228611946, 15198.924005379902, 23266.53466930652, 23301.7669823303, 23464.06143754265, 23611.409714756926, 23620.40948976255, 6578.0, 6817.420519255819, 6904.689288982008, 6920.9653951730925, 6955.478339124586, 6379.3301703320485, 6387.297397286295, 6392.169018027626, 6488.124103246001, 6499.317571655003, 4175.060611362419, 4308.482982042175, 4315.892102697395, 4447.533009034069, 4507.0, 1731.2036463227057, 1742.7908650961965, 1764.8676349273856, 1768.2043080613776, 1780.9554761131076, 780.2587541835279, 823.1768231768232, 881.2421317666801, 905.2395987370641, 1019.1999280564869, 13320.33398330099, 14095.71808563823, 15228.619284517754, 15339.923300383427, 15456.381744730084, 876.0363600039905, 894.2532984957503, 916.2212119698203, 953.3040880157524, 954.737447202025, 7723.845523089507, 8728.825423491495, 8865.64537418509, 9133.132352426508, 10048.944860789657, 502783.0, 510282.0, 511962.0, 526418.0, 529072.0, 70148.0, 71671.64164179146, 71873.0, 72441.0, 73298.63350683212, 1053.794510070529, 1058.444316733721, 1080.6866008857344, 1081.864766904137, 1094.5348227003492, 14899.0, 14983.175925324213, 15085.24315259927, 15170.544883653509, 15448.536543903701, 29991.85004075053, 30865.537016944316, 32950.83524582362, 33842.3231535363, 35762.960148387676, 43223.60068378813, 44714.10571788611, 46583.76708116573, 46666.300005499266, 46766.76616616895, 10094.54574544162, 10160.745981350525, 10319.071283584213, 10332.535035923553, 10377.976294622476, 11448.3703396314, 11837.289762614271, 12127.00898498869, 12213.084018698812, 12563.93718031404, 10293.794124117327, 10324.845127322946, 10566.947165264432, 10722.303050301705, 10905.34567925927, 7620.771376858703, 7677.500962437423, 7991.600419979094, 10317.226208034277, 10745.570177192825, 3100.3334283128333, 3942.014496375906, 5203.869903252449, 7614.238576142341, 7829.530228186327, 8303.626336814737, 10567.260291779809, 10614.628488002883, 10786.460676965964, 10841.728956776144, 10445.164386848883, 10706.197035222234, 10713.785724285315, 10787.298825576312, 10928.672139835817], "unit": "score", "name": "jquery.html", "value": 8668.553863989468}, {"lowerIsBetter": false, "replicates": [1269.1433282534288, 1440.6038339456652, 1450.9709805803884, 1599.7440409534477, 1757.507897788619, 6854.485913556485, 7240.601766902825, 7301.817454563638, 7378.262173782619, 7400.851982960337, 7452.366548843342, 7613.581253031081, 7639.00692909921, 7667.654955527, 7679.0, 2057.660486019812, 2108.5150415404464, 2308.976910230893, 2322.291701031189, 2345.6481527770884, 2334.6964894563685, 2335.684682567857, 2339.3099035784485, 2341.3327201747506, 2341.7658234176615, 2256.4810093678466, 2323.465602911331, 2325.732540757818, 2329.04509151248, 2329.452578644017, 2291.713535808024, 2330.475642980333, 2336.439254578906, 2339.649052642109, 2341.1454818991115, 2316.501952080294, 2321.2339927823778, 2323.907043718249, 2340.871252081135, 2345.519168570439, 7740.574268415235, 7747.225277472207, 7752.7674169775, 7765.72819951299, 7770.57261850598, 4761.166795810719, 4856.708597484162, 4891.0, 4892.755362231874, 4892.996935628188, 3216.4210442120407, 3265.6244531878665, 3275.7543184261276, 3307.0244277937827, 3322.750793690483, 1078.3152698036724, 1085.1915323084352, 1090.1278976818514, 1102.1238115698038, 1119.8432219489196, 10630.25588208818, 10647.787044259148, 10663.946680266548, 10676.0, 10696.946515267451, 4354.521002689701, 4367.235733746582, 4430.313301438282, 4433.645308375322, 4448.644108471314, 9181.311401644904, 9187.26501879848, 9190.218831399272, 9193.448393096436, 9220.170184683411, 4923.556879880828, 4926.8768280793265, 4955.157623204064, 4964.131277026506, 4964.354633897642, 4443.711158774734, 4487.461504619467, 4522.29904364824, 4523.570260825217, 4526.909461810811, 3461.688448039638, 3528.929421411609, 3532.876349327761, 3649.39784935488, 3765.642263984917, 1191.0531127753457, 1213.5691829400437, 1234.2656119608819, 1234.2964510229083, 1236.7650146472142, 1315.0728736240926, 1323.1862404621088, 1330.9267990260435, 1349.2174538767492, 1353.1204716933876, 7170.856582868418, 7311.122665280094, 7331.083614548182, 7336.193018767931, 7355.77932662021, 1078.7896360209684, 1084.0893649334596, 1123.2193625430411, 1138.2544433396138, 1150.6333464502234, 5697.259356283656, 5707.543396528268, 5728.656280623092, 5768.394318596487, 5827.912581311284, 8939.150780675825, 9024.684136055337, 9219.17027467531, 9370.90629093714, 9388.906110938804, 9239.815203696024, 9241.861372079424, 9249.583768730423, 9250.259979201648, 9269.258459323239, 7203.89194162088, 7274.054372931485, 7325.560466372035, 7333.779986600411, 7390.150132734804, 7090.255523170199, 7101.254368291255, 7102.18324892644, 7148.678309475982, 7188.209296977433, 8082.474639148437, 8191.385646076687, 8375.371847111614, 8524.232819046316, 8529.616167272363, 8425.578721064045, 8556.914430855611, 8576.099509551657, 8675.739727808175, 8691.565421729014, 6600.867982640416, 6758.966205169139, 6765.9661701691175, 6766.729330826909, 6771.45828333742, 6515.934840651723, 6632.038354438483, 7086.787396378117, 7301.379382752313, 7309.926900731138, 6929.618870961944, 6932.133483314586, 7066.752663656747, 7123.25205853378, 7162.820929476597, 6764.458843292623, 6786.151731033621, 6883.105196324445, 6988.301169883174, 7018.157821061301, 6967.581945083311, 6980.6509674515055, 7017.964910175417, 7019.3682568569075, 7037.437005039482, 6500.479961602966, 6525.314841941527, 6563.146790917151, 6577.177852768404, 6585.769498067544, 6590.868182636416, 6657.700403481952, 6662.100616416916, 6668.366505182, 6673.065770791996], "unit": "score", "name": "mootools.html", "value": 4532.574851793781}, {"lowerIsBetter": false, "replicates": [342.0815111425822, 345.85819813876316, 348.02379325990586, 348.9127718070484, 350.5617977528089, 5660.915086273709, 5751.942480575193, 5783.38065341704, 5785.913211301834, 5837.737301821423, 5620.91568626471, 5762.56780741445, 5792.0, 5795.681237531934, 5803.506701930341, 4523.5024147343765, 4525.298578720303, 4545.818167273322, 4552.772361381934, 4558.27067669173, 4351.564843515639, 4427.977860110695, 4479.507254202035, 4534.9546504534865, 4548.590626843584, 4498.50516443191, 4499.617532509724, 4501.347304640825, 4505.053938672882, 4528.320751887227, 4485.753283569403, 4512.1426928883575, 4519.299508576176, 4519.457665080178, 4528.796204170821, 3994.1811928554575, 4000.3599424092295, 4001.099752555681, 4001.459802926626, 4002.7598344099447, 5394.32570928634, 5552.222688823568, 5553.750081246354, 5575.107982722745, 5577.52591029763, 5156.535911767922, 5163.406208286057, 5167.534921857014, 5170.948290517084, 5172.767225474862, 5876.853078673024, 6093.390660933871, 6101.969490152565, 6104.847378815521, 6203.2245969253845, 4225.176090662322, 4239.533651298355, 4345.41336919515, 4389.648828093745, 4394.670399720034, 6304.873902521924, 6424.00427933671, 6424.100625912376, 6425.1326070980285, 6425.357464253537, 4434.224010798098, 4435.778211089432, 4437.711548749321, 4438.977805110953, 4441.578050085237, 4372.628326592276, 4483.574060464251, 4485.977570112129, 4496.977515112403, 4520.9827788747925, 5190.169572868398, 5197.688138711689, 5206.0, 5209.374875014947, 5221.034108689904, 6174.228221472316, 6210.31686514483, 6223.222097237845, 6227.595206311576, 6228.4705800007505, 1565.2799712132546, 1589.61849156204, 1590.3956496531243, 1591.9204039797964, 1592.936282548685, 1057.9153667706564, 1059.7615536504225, 1064.206811522587, 1068.5084860963889, 1091.579741799397, 5843.29880414353, 5852.4147585241135, 5853.2976042875125, 5853.853653658607, 5855.912161317584, 6329.525285603599, 6333.651649159248, 6337.302896681362, 6343.619382837044, 6349.650769207646, 5834.766609335664, 5843.970780146072, 5844.620099693591, 5848.707564621837, 5849.151872978395, 3309.4539400998565, 3419.65803419661, 3419.777714448553, 3421.3157368526395, 3422.880199193066, 6577.901331480031, 6615.801525954229, 6618.933810661832, 6620.337966203341, 6623.4038936495945, 6491.480681545465, 6498.057781621733, 6501.99219121037, 6508.934910650928, 6511.0, 6477.514186436036, 6572.244191917895, 6599.1091202687985, 6670.699818508082, 6676.26561078281, 6121.755129794758, 6226.346233645402, 6409.4231519163495, 6411.134496842867, 6421.775237866652, 6210.7515699371515, 6328.620282782864, 6334.049892516159, 6348.714307856065, 6348.71430785625, 6647.202335719745, 6655.534112612071, 6656.334366563498, 6658.766943156967, 6658.866822663616, 4332.4367832181615, 4432.800523976364, 4461.776911154364, 4469.575390337913, 4472.731636101845, 6322.146510221061, 6362.491000720024, 6374.617522948638, 6377.362263773771, 6381.074744162163, 6160.476359509313, 6190.164327815687, 6209.565330426827, 6214.5028397728975, 6219.595726277777, 6096.390360964046, 6188.876222475616, 6198.318184999556, 6201.596896201732, 6203.06953956892, 6059.363766804422, 6067.453929146398, 6071.635701857903, 6074.574779765374, 6077.544184186292, 6206.348333424925, 6268.341824108586, 6277.937220627735, 6289.7169627365965, 6296.653684047238, 5961.761529538943, 6150.969245153925, 6158.0, 6159.507239420746, 6164.630122192682], "unit": "score", "name": "prototype.html", "value": 4684.105327006903}, {"lowerIsBetter": false, "replicates": [717.3364637710118, 778.8870613761003, 826.4091174810013, 827.770760420775, 859.2567429173766, 12904.290264035475, 13119.672008199788, 13184.34078296085, 13300.068995170343, 13301.866981330184, 11822.822657660121, 12226.877731222685, 12521.248725076479, 12546.0, 12724.809127863089, 799.7800604833674, 807.0235015631093, 814.5764202614637, 814.775936617432, 816.1512027491402, 803.2088392932985, 804.2480280937342, 804.2841870735022, 804.3685706720197, 804.8350088231928, 843.3084870406269, 843.6077224090797, 845.7082306604211, 846.3736834742308, 847.3348421489133, 834.5576844272546, 837.8701301298308, 839.6515446089866, 840.9873851892196, 843.4517563583659, 618.8855061813579, 622.8474023864137, 623.1151764494383, 625.0998562070649, 627.7143899525751, 11793.823092653616, 11832.112591555668, 11848.822267665906, 11856.822147667706, 11876.406179691066, 11055.115590752801, 11277.266977646426, 11433.0, 11772.941135294355, 11896.869797369236, 9765.121139097444, 9916.0, 9929.404235745806, 10050.497475126214, 10118.494075296207, 3529.294141171776, 3593.586737525166, 3633.94549081764, 3672.210474747942, 3713.702903767692, 47658.5234147661, 48181.0, 49477.50522494801, 49939.75030124826, 51137.23294150591, 10157.187425005981, 10219.182465402899, 10240.846387304196, 10280.280380373451, 10310.123639490577, 17935.551611209823, 17944.282228710967, 17957.461276161735, 18144.546386340447, 18359.63280734378, 7567.3189412952, 7703.229677032252, 7724.111727151337, 7806.57063861493, 7999.920000800034, 4230.576942305806, 4279.764612946318, 4332.696711230246, 4400.15568706895, 4436.179306828247, 3142.4343618148496, 3145.7011583899493, 3152.4798408262836, 3154.085315258595, 3156.873725051018, 597.7818096394872, 617.8177437655902, 619.1517620859362, 627.8179327994922, 636.662568838507, 523.2439125463668, 620.602814198913, 628.4155735166339, 630.4200135875006, 643.3727116061802, 8443.873341899876, 9182.989871114172, 9639.662611808693, 9706.70879873605, 9744.220462362993, 580.6458060583041, 615.2463232540192, 694.5763084518439, 698.1064237775655, 719.7588807749357, 3850.8442311696826, 4044.272031034442, 4093.570175131628, 4133.256013917524, 4151.56408577095, 57995.0, 59285.70357148186, 59598.0, 59661.0, 59712.2374091374, 48010.75994620074, 49960.75019624879, 52727.73636131795, 52929.47070529322, 53734.462655373725, 44836.775816121364, 47376.157430554274, 47830.04339913182, 48460.515394846305, 48948.75525622349, 7804.2585954334245, 8114.472559283628, 8232.794180145544, 8340.249377555807, 8986.820263594822, 33936.66063339335, 35770.28459430745, 36042.4593631101, 36794.816025919696, 36966.26067478689, 46528.767356163, 47180.0, 47369.0, 47399.28901066418, 47424.28863567118, 10920.235583509078, 10924.289921155418, 10933.726656833644, 10943.28868623537, 11034.503447345049, 12348.567800127312, 12355.505779769068, 12947.611571652866, 12961.22232666043, 13375.514643436962, 11837.644870653894, 11878.346690932081, 11981.0, 12000.939995300318, 12396.504139834306, 11656.708582285171, 12132.393380331125, 12142.939285303517, 12481.251124932533, 12535.310557919402, 12136.514539418678, 12270.263784172977, 12519.56181533642, 12535.686607834512, 12562.371881406076, 9408.0, 9720.562574684298, 9762.46306453152, 9991.900080999098, 10051.346662466916, 8784.077671844365, 9054.864177037482, 9612.1829644481, 9688.612455501983, 9718.465484398143], "unit": "score", "name": "yui.html", "value": 6354.0138032900395}], "name": "dromaeo_css", "value": 6880.26630147931}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 110.0, 107.0, 108.0, 109.0, 110.0, 110.0, 110.0, 103.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.1}, {"lowerIsBetter": true, "replicates": [157.0, 126.0, 157.0, 176.0, 126.0, 148.0, 148.0, 127.0, 169.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 146.3}, {"lowerIsBetter": true, "replicates": [161.0, 159.0, 161.0, 159.0, 161.0, 158.0, 159.0, 159.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.1}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 105.0, 94.0, 71.0, 72.0, 72.0, 123.0, 93.0, 72.0], "unit": "score", "name": "audio-fft", "value": 84.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 139.0, 94.0, 96.0, 96.0, 138.0, 96.0, 95.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 108.5}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 108.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 54.0, 62.0, 56.0, 56.0, 55.0, 55.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 68.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [80.0, 80.0, 81.0, 81.0, 85.0, 82.0, 83.0, 91.0, 91.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.5}, {"lowerIsBetter": true, "replicates": [118.0, 119.0, 112.0, 117.0, 112.0, 114.0, 116.0, 118.0, 119.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.3}, {"lowerIsBetter": true, "replicates": [145.0, 136.0, 143.0, 142.0, 141.0, 131.0, 143.0, 143.0, 156.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.2}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 66.0, 65.0, 65.0, 66.0, 66.0, 67.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.7}], "name": "kraken", "value": 1490.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.78523489932886], "unit": "score", "name": "Richards", "value": 210.39992}, {"lowerIsBetter": false, "replicates": [188.14675446848543], "unit": "score", "name": "DeltaBlue", "value": 351.41717}, {"lowerIsBetter": false, "replicates": [280.58361391694723], "unit": "score", "name": "Encrypt", "value": 948.6690839999999}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1116.0714285714287], "unit": "score", "name": "RayTrace", "value": 663.0301440000001}, {"lowerIsBetter": false, "replicates": [781.25], "unit": "score", "name": "Earley", "value": 853.0726399999998}, {"lowerIsBetter": false, "replicates": [12304.878048780487], "unit": "score", "name": "Boyer", "value": 54.16250346878094}, {"lowerIsBetter": false, "replicates": [42562.5], "unit": "score", "name": "RegExp", "value": 21.403465491923626}, {"lowerIsBetter": false, "replicates": [546.448087431694], "unit": "score", "name": "Splay", "value": 149.12853}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 20183.963469616046}]} 08:22:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20183.96"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1490.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6880.27"}}} 08:22:42 INFO - Return code: 0 08:22:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:22:42 INFO - # TBPL SUCCESS # 08:22:42 INFO - Running post-action listener: _resource_record_post_action 08:22:42 INFO - Running post-run listener: _resource_record_post_run 08:22:44 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 565825536; Read time: 0; Write time: 1211580 08:22:44 INFO - install - Wall time: 17s; CPU: 19.0%; Read bytes: 0; Write bytes: 237514752; Read time: 0; Write time: 766868 08:22:44 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 0; Write bytes: 311631872; Read time: 0; Write time: 438388 08:22:44 INFO - Running post-run listener: _upload_blobber_files 08:22:44 INFO - Blob upload gear active. 08:22:44 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:22:44 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 08:22:44 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'] 08:22:44 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 08:22:44 INFO - (blobuploader) - INFO - Open directory for files ... 08:22:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:22:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:22:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:45 INFO - (blobuploader) - INFO - Done attempting. 08:22:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:22:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:22:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:46 INFO - (blobuploader) - INFO - Done attempting. 08:22:46 INFO - (blobuploader) - INFO - Iteration through files over. 08:22:46 INFO - Return code: 0 08:22:46 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:22:46 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:22:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/39376d140a91c34efc5c3d58e20c97e15d74e64e03d86d522137d6e5838383c049081669f20e451fc1615884ea6ff07cb9406d33e698719b5bb7bc1381b11886", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ad1642a1a029ca7a474334d2edcb7af833cb3a8c9b382851325d90d735d777d85f16e0bedc1ece138e938c3ccdd8a9fd176b753b5621bb61467b5699bd19612c"} 08:22:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:22:46 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:22:46 INFO - Contents: 08:22:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/39376d140a91c34efc5c3d58e20c97e15d74e64e03d86d522137d6e5838383c049081669f20e451fc1615884ea6ff07cb9406d33e698719b5bb7bc1381b11886", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ad1642a1a029ca7a474334d2edcb7af833cb3a8c9b382851325d90d735d777d85f16e0bedc1ece138e938c3ccdd8a9fd176b753b5621bb61467b5699bd19612c"} 08:22:46 INFO - Running post-run listener: copy_logs_to_upload_dir 08:22:46 INFO - Copying logs to upload dir... 08:22:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 08:22:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.053320 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-19 08:22:46.243897) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 08:22:46.248000) ========= 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=745a4373a2a16df560f216e000000264-1453218942.685824-467089513 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/39376d140a91c34efc5c3d58e20c97e15d74e64e03d86d522137d6e5838383c049081669f20e451fc1615884ea6ff07cb9406d33e698719b5bb7bc1381b11886", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ad1642a1a029ca7a474334d2edcb7af833cb3a8c9b382851325d90d735d777d85f16e0bedc1ece138e938c3ccdd8a9fd176b753b5621bb61467b5699bd19612c"} build_url:https://queue.taskcluster.net/v1/task/JCag0h65Tn6u3LzkARxNUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011422 build_url: 'https://queue.taskcluster.net/v1/task/JCag0h65Tn6u3LzkARxNUQ/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/39376d140a91c34efc5c3d58e20c97e15d74e64e03d86d522137d6e5838383c049081669f20e451fc1615884ea6ff07cb9406d33e698719b5bb7bc1381b11886", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ad1642a1a029ca7a474334d2edcb7af833cb3a8c9b382851325d90d735d777d85f16e0bedc1ece138e938c3ccdd8a9fd176b753b5621bb61467b5699bd19612c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 08:22:46.274133) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 08:22:46.274553) ========= 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=745a4373a2a16df560f216e000000264-1453218942.685824-467089513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 08:22:46.356569) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 08:22:46.356957) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 08:22:46.357299) ========= ========= Total master_lag: 0.33 =========