builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1452549511.64 results: success (0) buildid: 20160111113021 builduid: 821eeb1d582848818d9c971a8e1ecf30 revision: ae1f40f9c26c1f837e7a78696e0b986befcda539 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 13:58:31.641958) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 13:58:31.642425) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 13:58:31.642732) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006290 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 13:58:31.665864) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 13:58:31.666171) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 13:58:31.680918) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 13:58:31.681465) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004713 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 13:58:31.731254) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 13:58:31.731628) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 13:58:31.731998) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 13:58:31.732299) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-11 13:58:31-- 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% 226M=0s 2016-01-11 13:58:32 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157950 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 13:58:31.903987) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 13:58:31.904307) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017509 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 13:58:31.954356) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 13:58:31.954720) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev ae1f40f9c26c1f837e7a78696e0b986befcda539 --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 ae1f40f9c26c1f837e7a78696e0b986befcda539 --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=fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-11 13:58:32,258 truncating revision to first 12 chars 2016-01-11 13:58:32,258 Setting DEBUG logging. 2016-01-11 13:58:32,258 attempt 1/10 2016-01-11 13:58:32,258 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/ae1f40f9c26c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-11 13:58:32,522 unpacking tar archive at: b2g-inbound-ae1f40f9c26c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.564729 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 13:58:32.532253) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 13:58:32.532585) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 13:58:32.542340) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 13:58:32.542623) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 13:58:32.543008) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-01-11 13:58:32.543289) ========= /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=fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:58:32 INFO - MultiFileLogger online at 20160111 13:58:32 in /builds/slave/test-pgo 13:58: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 13:58:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:58:32 INFO - {'append_to_log': False, 13:58:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:58:32 INFO - 'blob_upload_branch': 'B2G-Inbound', 13:58:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:58:32 INFO - 'branch': 'B2G-Inbound', 13:58:32 INFO - 'buildbot_json_path': 'buildprops.json', 13:58:32 INFO - 'config_files': ('talos/linux_config.py',), 13:58:32 INFO - 'default_actions': ('clobber', 13:58:32 INFO - 'read-buildbot-config', 13:58:32 INFO - 'download-and-extract', 13:58:32 INFO - 'populate-webroot', 13:58:32 INFO - 'create-virtualenv', 13:58:32 INFO - 'install', 13:58:32 INFO - 'run-tests'), 13:58:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:58:32 INFO - 'download_minidump_stackwalk': True, 13:58:32 INFO - 'download_symbols': 'ondemand', 13:58:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:58:32 INFO - 'tooltool.py': '/tools/tooltool.py', 13:58:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:58:32 INFO - '/tools/misc-python/virtualenv.py')}, 13:58:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:58:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:58:32 INFO - 'installer_path': 'installer.exe', 13:58:32 INFO - 'log_level': 'info', 13:58:32 INFO - 'log_name': 'talos', 13:58:32 INFO - 'log_to_console': True, 13:58:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:58:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:58:32 INFO - 'opt_config_files': (), 13:58:32 INFO - 'pip_index': False, 13:58:32 INFO - 'sps_profile': False, 13:58:32 INFO - 'sps_profile_interval': 0, 13:58:32 INFO - 'suite': 'dromaeojs', 13:58:32 INFO - 'system_bits': '32', 13:58:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:58:32 INFO - 'title': 'talos-linux64-ix-014', 13:58:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:58:32 INFO - 'use_talos_json': True, 13:58:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:58:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:58:32 INFO - 'work_dir': 'build'} 13:58:32 INFO - ##### 13:58:32 INFO - ##### Running clobber step. 13:58:32 INFO - ##### 13:58:32 INFO - Running pre-action listener: _resource_record_pre_action 13:58:32 INFO - Running main action method: clobber 13:58:32 INFO - rmtree: /builds/slave/test-pgo/build 13:58:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:58:33 INFO - Running post-action listener: _resource_record_post_action 13:58:33 INFO - ##### 13:58:33 INFO - ##### Running read-buildbot-config step. 13:58:33 INFO - ##### 13:58:33 INFO - Running pre-action listener: _resource_record_pre_action 13:58:33 INFO - Running main action method: read_buildbot_config 13:58:33 INFO - Using buildbot properties: 13:58:33 INFO - { 13:58:33 INFO - "project": "", 13:58:33 INFO - "product": "firefox", 13:58:33 INFO - "script_repo_revision": "production", 13:58:33 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 13:58:33 INFO - "repository": "", 13:58:33 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 13:58:33 INFO - "buildid": "20160111113021", 13:58:33 INFO - "pgo_build": "True", 13:58:33 INFO - "basedir": "/builds/slave/test-pgo", 13:58:33 INFO - "buildnumber": 200, 13:58:33 INFO - "slavename": "talos-linux64-ix-014", 13:58:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:58:33 INFO - "platform": "ubuntu64_hw", 13:58:33 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 13:58:33 INFO - "branch": "b2g-inbound", 13:58:33 INFO - "repo_path": "integration/b2g-inbound", 13:58:33 INFO - "revision": "ae1f40f9c26c1f837e7a78696e0b986befcda539", 13:58:33 INFO - "stage_platform": "linux64-pgo", 13:58:33 INFO - "builduid": "821eeb1d582848818d9c971a8e1ecf30", 13:58:33 INFO - "slavebuilddir": "test" 13:58:33 INFO - } 13:58:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/PFR1WJEaSvOlaeMfH9VchA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 13:58:33 INFO - Running post-action listener: _resource_record_post_action 13:58:33 INFO - ##### 13:58:33 INFO - ##### Running download-and-extract step. 13:58:33 INFO - ##### 13:58:33 INFO - Running pre-action listener: _resource_record_pre_action 13:58:33 INFO - Running main action method: download_and_extract 13:58:33 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:58: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')]} 13:58:33 INFO - https://queue.taskcluster.net/v1/task/PFR1WJEaSvOlaeMfH9VchA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:58:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFR1WJEaSvOlaeMfH9VchA/artifacts/public/build/test_packages.json 13:58:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFR1WJEaSvOlaeMfH9VchA/artifacts/public/build/test_packages.json 13:58:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFR1WJEaSvOlaeMfH9VchA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:58:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFR1WJEaSvOlaeMfH9VchA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:58:34 INFO - Downloaded 1302 bytes. 13:58:34 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:58:34 INFO - Using the following test package requirements: 13:58:34 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:58:34 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:58:34 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:34 INFO - u'jsshell-linux-x86_64.zip'], 13:58:34 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:58:34 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:58:34 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:58:34 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:58:34 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:58:34 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:58:34 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:58:34 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:58:34 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')]} 13:58:34 INFO - https://queue.taskcluster.net/v1/task/PFR1WJEaSvOlaeMfH9VchA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:58:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFR1WJEaSvOlaeMfH9VchA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:58:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFR1WJEaSvOlaeMfH9VchA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:58:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFR1WJEaSvOlaeMfH9VchA/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 13:58:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFR1WJEaSvOlaeMfH9VchA/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 13:58:36 INFO - Downloaded 24028582 bytes. 13:58:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 13:58:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:58:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:58:37 INFO - Return code: 0 13:58:37 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 13:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:37 INFO - https://queue.taskcluster.net/v1/task/PFR1WJEaSvOlaeMfH9VchA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:58:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFR1WJEaSvOlaeMfH9VchA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:58:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFR1WJEaSvOlaeMfH9VchA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:58:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFR1WJEaSvOlaeMfH9VchA/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 13:58:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFR1WJEaSvOlaeMfH9VchA/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 13:58:44 INFO - Downloaded 24028582 bytes. 13:58:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 13:58:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:58:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:58:45 INFO - Return code: 0 13:58:45 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')]} 13:58:45 INFO - https://queue.taskcluster.net/v1/task/PFR1WJEaSvOlaeMfH9VchA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:58:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFR1WJEaSvOlaeMfH9VchA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:58:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFR1WJEaSvOlaeMfH9VchA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:58:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFR1WJEaSvOlaeMfH9VchA/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 13:58:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFR1WJEaSvOlaeMfH9VchA/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 13:58:48 INFO - Downloaded 11132285 bytes. 13:58:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 13:58:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:58:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 13:58:48 INFO - Return code: 0 13:58: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')]} 13:58:48 INFO - https://queue.taskcluster.net/v1/task/PFR1WJEaSvOlaeMfH9VchA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:58:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFR1WJEaSvOlaeMfH9VchA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:58:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFR1WJEaSvOlaeMfH9VchA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:58:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFR1WJEaSvOlaeMfH9VchA/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 13:58:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFR1WJEaSvOlaeMfH9VchA/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 13:59:08 INFO - Downloaded 55926165 bytes. 13:59:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PFR1WJEaSvOlaeMfH9VchA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:59:08 INFO - mkdir: /builds/slave/test-pgo/properties 13:59:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:59:08 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:59:08 INFO - Contents: 13:59:08 INFO - build_url:https://queue.taskcluster.net/v1/task/PFR1WJEaSvOlaeMfH9VchA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:59:08 INFO - Running post-action listener: _resource_record_post_action 13:59:08 INFO - Running post-action listener: set_extra_try_arguments 13:59:08 INFO - ##### 13:59:08 INFO - ##### Running populate-webroot step. 13:59:08 INFO - ##### 13:59:08 INFO - Running pre-action listener: _resource_record_pre_action 13:59:08 INFO - Running main action method: populate_webroot 13:59:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:59:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:59:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:59:08 INFO - '--tppagecycles', 13:59:08 INFO - '7'], 13:59:08 INFO - 'tests': ['tsvgm']}}, 13:59:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:59:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:59:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:59:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:59:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:59:08 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:59:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:59:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:08 INFO - 'talos_options': ['--e10s'], 13:59:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:59:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:08 INFO - 'tests': ['damp', 'tps']}, 13:59:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:08 INFO - 'talos_options': ['--e10s'], 13:59:08 INFO - 'tests': ['damp', 'tps']}, 13:59:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:59:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:59:08 INFO - 'other': {'tests': ['a11yr', 13:59:08 INFO - 'ts_paint', 13:59:08 INFO - 'tpaint', 13:59:08 INFO - 'sessionrestore', 13:59:08 INFO - 'sessionrestore_no_auto_restore']}, 13:59:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:59:08 INFO - 'tests': ['a11yr', 13:59:08 INFO - 'ts_paint', 13:59:08 INFO - 'tpaint', 13:59:08 INFO - 'sessionrestore', 13:59:08 INFO - 'sessionrestore_no_auto_restore']}, 13:59:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:59:08 INFO - 'tests': ['a11yr', 13:59:08 INFO - 'ts_paint', 13:59:08 INFO - 'tpaint', 13:59:08 INFO - 'sessionrestore', 13:59:08 INFO - 'sessionrestore_no_auto_restore']}, 13:59:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:59:08 INFO - 'tests': ['a11yr', 13:59:08 INFO - 'ts_paint', 13:59:08 INFO - 'tpaint', 13:59:08 INFO - 'sessionrestore', 13:59:08 INFO - 'sessionrestore_no_auto_restore']}, 13:59:08 INFO - 'other_l64': {'tests': ['a11yr', 13:59:08 INFO - 'ts_paint', 13:59:08 INFO - 'tpaint', 13:59:08 INFO - 'sessionrestore', 13:59:08 INFO - 'sessionrestore_no_auto_restore']}, 13:59:08 INFO - 'other_nol64': {'tests': ['a11yr', 13:59:08 INFO - 'ts_paint', 13:59:08 INFO - 'tpaint', 13:59:08 INFO - 'sessionrestore', 13:59:08 INFO - 'sessionrestore_no_auto_restore']}, 13:59:08 INFO - 'svgr': {'tests': ['tsvgx', 13:59:08 INFO - 'tsvgr_opacity', 13:59:08 INFO - 'tart', 13:59:08 INFO - 'tscrollx', 13:59:08 INFO - 'cart']}, 13:59:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:59:08 INFO - 'tests': ['tsvgx', 13:59:08 INFO - 'tsvgr_opacity', 13:59:08 INFO - 'tart', 13:59:08 INFO - 'tscrollx', 13:59:08 INFO - 'cart']}, 13:59:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:08 INFO - 'tests': ['tp5o']}, 13:59:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:08 INFO - 'talos_options': ['--e10s'], 13:59:08 INFO - 'tests': ['tp5o']}, 13:59:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:08 INFO - 'talos_options': ['--xperf_path', 13:59:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:59:08 INFO - 'tests': ['tp5n']}, 13:59:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:08 INFO - 'talos_options': ['--e10s', 13:59:08 INFO - '--xperf_path', 13:59:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:59:08 INFO - 'tests': ['tp5n']}}, 13:59:08 INFO - 'talos.zip': {'path': '', 13:59:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:59:08 INFO - Running post-action listener: _resource_record_post_action 13:59:08 INFO - ##### 13:59:08 INFO - ##### Running create-virtualenv step. 13:59:08 INFO - ##### 13:59:08 INFO - Running pre-action listener: _resource_record_pre_action 13:59:08 INFO - Running main action method: create_virtualenv 13:59:08 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:59:08 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 13:59:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:59:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:59:08 INFO - Using real prefix '/usr' 13:59:08 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:59:08 INFO - Installing distribute.............................................................................................................................................................................................done. 13:59:10 INFO - Installing pip.................done. 13:59:10 INFO - Return code: 0 13:59:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:59:10 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')]} 13:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:10 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')]} 13:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:10 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 0x7f855e77df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1656840>, '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 0x15c36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c3b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338', '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 13:59:10 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 13:59:10 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 13:59:10 INFO - Using env: {'DISPLAY': ':0', 13:59:10 INFO - 'HOME': '/home/cltbld', 13:59:10 INFO - 'LANG': 'en_US.UTF-8', 13:59:10 INFO - 'LANGUAGE': 'en_US:en', 13:59:10 INFO - 'LOGNAME': 'cltbld', 13:59:10 INFO - 'MAIL': '/var/mail/cltbld', 13:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:10 INFO - 'MOZ_NO_REMOTE': '1', 13:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:10 INFO - 'NO_EM_RESTART': '1', 13:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:10 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:10 INFO - 'SHELL': '/bin/bash', 13:59:10 INFO - 'SHLVL': '1', 13:59:10 INFO - 'TERM': 'linux', 13:59:10 INFO - 'TMOUT': '86400', 13:59:10 INFO - 'USER': 'cltbld', 13:59:10 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338', 13:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:10 INFO - '_': '/tools/buildbot/bin/python'} 13:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:10 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 13:59:10 INFO - Cleaning up... 13:59:10 INFO - Return code: 0 13:59:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:59:10 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')]} 13:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:10 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')]} 13:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:10 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 0x7f855e77df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1656840>, '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 0x15c36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c3b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338', '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 13:59:10 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 13:59:10 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 13:59:10 INFO - Using env: {'DISPLAY': ':0', 13:59:10 INFO - 'HOME': '/home/cltbld', 13:59:10 INFO - 'LANG': 'en_US.UTF-8', 13:59:10 INFO - 'LANGUAGE': 'en_US:en', 13:59:10 INFO - 'LOGNAME': 'cltbld', 13:59:10 INFO - 'MAIL': '/var/mail/cltbld', 13:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:10 INFO - 'MOZ_NO_REMOTE': '1', 13:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:10 INFO - 'NO_EM_RESTART': '1', 13:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:10 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:10 INFO - 'SHELL': '/bin/bash', 13:59:10 INFO - 'SHLVL': '1', 13:59:10 INFO - 'TERM': 'linux', 13:59:10 INFO - 'TMOUT': '86400', 13:59:10 INFO - 'USER': 'cltbld', 13:59:10 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338', 13:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:10 INFO - '_': '/tools/buildbot/bin/python'} 13:59:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:11 INFO - Downloading/unpacking psutil>=0.7.1 13:59:11 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 13:59:11 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 13:59:11 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 13:59:11 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 13:59:11 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 13:59:11 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 13:59:12 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 13:59:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:59:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:59:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:59:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:59:12 INFO - Installing collected packages: psutil 13:59:12 INFO - Running setup.py install for psutil 13:59:12 INFO - building 'psutil._psutil_linux' extension 13:59:12 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 13:59:13 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 13:59:13 INFO - building 'psutil._psutil_posix' extension 13:59:13 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 13:59:13 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 13:59:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:59:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:59:13 INFO - Successfully installed psutil 13:59:13 INFO - Cleaning up... 13:59:13 INFO - Return code: 0 13:59:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:59:13 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')]} 13:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:13 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')]} 13:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:13 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 0x7f855e77df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1656840>, '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 0x15c36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c3b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338', '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 13:59:13 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 13:59:13 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 13:59:13 INFO - Using env: {'DISPLAY': ':0', 13:59:13 INFO - 'HOME': '/home/cltbld', 13:59:13 INFO - 'LANG': 'en_US.UTF-8', 13:59:13 INFO - 'LANGUAGE': 'en_US:en', 13:59:13 INFO - 'LOGNAME': 'cltbld', 13:59:13 INFO - 'MAIL': '/var/mail/cltbld', 13:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:13 INFO - 'MOZ_NO_REMOTE': '1', 13:59:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:13 INFO - 'NO_EM_RESTART': '1', 13:59:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:13 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:13 INFO - 'SHELL': '/bin/bash', 13:59:13 INFO - 'SHLVL': '1', 13:59:13 INFO - 'TERM': 'linux', 13:59:13 INFO - 'TMOUT': '86400', 13:59:13 INFO - 'USER': 'cltbld', 13:59:13 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338', 13:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:13 INFO - '_': '/tools/buildbot/bin/python'} 13:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:59:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:59:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:59:15 INFO - Installing collected packages: mozsystemmonitor 13:59:15 INFO - Running setup.py install for mozsystemmonitor 13:59:15 INFO - Successfully installed mozsystemmonitor 13:59:15 INFO - Cleaning up... 13:59:15 INFO - Return code: 0 13:59:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:15 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 0x7f855e77df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1656840>, '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 0x15c36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c3b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338', '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 13:59:15 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 13:59:15 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 13:59:15 INFO - Using env: {'DISPLAY': ':0', 13:59:15 INFO - 'HOME': '/home/cltbld', 13:59:15 INFO - 'LANG': 'en_US.UTF-8', 13:59:15 INFO - 'LANGUAGE': 'en_US:en', 13:59:15 INFO - 'LOGNAME': 'cltbld', 13:59:15 INFO - 'MAIL': '/var/mail/cltbld', 13:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:15 INFO - 'MOZ_NO_REMOTE': '1', 13:59:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:15 INFO - 'NO_EM_RESTART': '1', 13:59:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:15 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:15 INFO - 'SHELL': '/bin/bash', 13:59:15 INFO - 'SHLVL': '1', 13:59:15 INFO - 'TERM': 'linux', 13:59:15 INFO - 'TMOUT': '86400', 13:59:15 INFO - 'USER': 'cltbld', 13:59:15 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338', 13:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:15 INFO - '_': '/tools/buildbot/bin/python'} 13:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:15 INFO - Downloading/unpacking blobuploader==1.2.4 13:59:15 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 13:59:15 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 13:59:15 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 13:59:15 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 13:59:15 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 13:59:15 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 13:59:17 INFO - Downloading blobuploader-1.2.4.tar.gz 13:59:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:59:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:59:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:59:17 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 13:59:17 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 13:59:17 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 13:59:17 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 13:59:17 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 13:59:17 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 13:59:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:59:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:59:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:18 INFO - Downloading docopt-0.6.1.tar.gz 13:59:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:59:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:59:18 INFO - Installing collected packages: blobuploader, requests, docopt 13:59:18 INFO - Running setup.py install for blobuploader 13:59:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:59:18 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:59:18 INFO - Running setup.py install for requests 13:59:19 INFO - Running setup.py install for docopt 13:59:19 INFO - Successfully installed blobuploader requests docopt 13:59:19 INFO - Cleaning up... 13:59:19 INFO - Return code: 0 13:59:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:59:19 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')]} 13:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:19 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')]} 13:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:19 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 0x7f855e77df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1656840>, '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 0x15c36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c3b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338', '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 13:59:19 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 13:59:19 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 13:59:19 INFO - Using env: {'DISPLAY': ':0', 13:59:19 INFO - 'HOME': '/home/cltbld', 13:59:19 INFO - 'LANG': 'en_US.UTF-8', 13:59:19 INFO - 'LANGUAGE': 'en_US:en', 13:59:19 INFO - 'LOGNAME': 'cltbld', 13:59:19 INFO - 'MAIL': '/var/mail/cltbld', 13:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:19 INFO - 'MOZ_NO_REMOTE': '1', 13:59:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:19 INFO - 'NO_EM_RESTART': '1', 13:59:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:19 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:19 INFO - 'SHELL': '/bin/bash', 13:59:19 INFO - 'SHLVL': '1', 13:59:19 INFO - 'TERM': 'linux', 13:59:19 INFO - 'TMOUT': '86400', 13:59:19 INFO - 'USER': 'cltbld', 13:59:19 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338', 13:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:19 INFO - '_': '/tools/buildbot/bin/python'} 13:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:59:19 INFO - Running setup.py (path:/tmp/pip-u5h80S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:59:19 INFO - Running setup.py (path:/tmp/pip-sPVq5n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:59:19 INFO - Running setup.py (path:/tmp/pip-Jr5oNA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:59:19 INFO - Running setup.py (path:/tmp/pip-RvEIo_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:59:19 INFO - Running setup.py (path:/tmp/pip-O3Pbrp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:59:19 INFO - Running setup.py (path:/tmp/pip-IospbA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:59:19 INFO - Running setup.py (path:/tmp/pip-FAGKD3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:59:19 INFO - Running setup.py (path:/tmp/pip-CPdpD1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:59:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:59:20 INFO - Running setup.py (path:/tmp/pip-xQkY4Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:59:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:59:20 INFO - Running setup.py (path:/tmp/pip-VmKuW8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:59:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:59:20 INFO - Running setup.py (path:/tmp/pip-35QRI7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:59:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:59:20 INFO - Running setup.py (path:/tmp/pip-kZsguy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:59:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:59:20 INFO - Running setup.py (path:/tmp/pip-svUDze-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:59:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:59:20 INFO - Running setup.py (path:/tmp/pip-XLOm3O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:59:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:59:20 INFO - Running setup.py (path:/tmp/pip-iqR7Un-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:59:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:59:20 INFO - Running setup.py (path:/tmp/pip-fCvz97-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:59:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:59:20 INFO - Running setup.py (path:/tmp/pip-DxmuIO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:59:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:59:20 INFO - Running setup.py install for manifestparser 13:59:20 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:59:20 INFO - Running setup.py install for mozcrash 13:59:20 INFO - Running setup.py install for mozdebug 13:59:20 INFO - Running setup.py install for mozdevice 13:59:21 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:59:21 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:59:21 INFO - Running setup.py install for mozfile 13:59:21 INFO - Running setup.py install for mozhttpd 13:59:21 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:59:21 INFO - Running setup.py install for mozinfo 13:59:21 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:59:21 INFO - Running setup.py install for mozInstall 13:59:21 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:59:21 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:59:21 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:59:21 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:59:21 INFO - Running setup.py install for mozleak 13:59:21 INFO - Running setup.py install for mozlog 13:59:21 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:59:21 INFO - Running setup.py install for moznetwork 13:59:21 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:59:21 INFO - Running setup.py install for mozprocess 13:59:21 INFO - Running setup.py install for mozprofile 13:59:22 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:59:22 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:59:22 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:59:22 INFO - Running setup.py install for mozrunner 13:59:22 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:59:22 INFO - Running setup.py install for mozscreenshot 13:59:22 INFO - Running setup.py install for moztest 13:59:22 INFO - Running setup.py install for mozversion 13:59:22 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:59:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:59:22 INFO - Cleaning up... 13:59:22 INFO - Return code: 0 13:59:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:59:22 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')]} 13:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:22 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')]} 13:59:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:22 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 0x7f855e77df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1656840>, '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 0x15c36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c3b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338', '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 13:59:22 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 13:59:22 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 13:59:22 INFO - Using env: {'DISPLAY': ':0', 13:59:22 INFO - 'HOME': '/home/cltbld', 13:59:22 INFO - 'LANG': 'en_US.UTF-8', 13:59:22 INFO - 'LANGUAGE': 'en_US:en', 13:59:22 INFO - 'LOGNAME': 'cltbld', 13:59:22 INFO - 'MAIL': '/var/mail/cltbld', 13:59:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:22 INFO - 'MOZ_NO_REMOTE': '1', 13:59:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:22 INFO - 'NO_EM_RESTART': '1', 13:59:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:22 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:22 INFO - 'SHELL': '/bin/bash', 13:59:22 INFO - 'SHLVL': '1', 13:59:22 INFO - 'TERM': 'linux', 13:59:22 INFO - 'TMOUT': '86400', 13:59:22 INFO - 'USER': 'cltbld', 13:59:22 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338', 13:59:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:22 INFO - '_': '/tools/buildbot/bin/python'} 13:59:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:59:22 INFO - Running setup.py (path:/tmp/pip-TKRmVy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:59:22 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)) 13:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:59:22 INFO - Running setup.py (path:/tmp/pip-SieP1k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:59:22 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)) 13:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:59:23 INFO - Running setup.py (path:/tmp/pip-cfhu3F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:59:23 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)) 13:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:59:23 INFO - Running setup.py (path:/tmp/pip-4UDfNb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:59:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:59:23 INFO - Running setup.py (path:/tmp/pip-I9vF7H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:59:23 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)) 13:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:59:23 INFO - Running setup.py (path:/tmp/pip-wZKHer-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:59:23 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)) 13:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:59:23 INFO - Running setup.py (path:/tmp/pip-I1zpMr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:59:23 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)) 13:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:59:23 INFO - Running setup.py (path:/tmp/pip-REG7dQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:59:23 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)) 13:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:59:23 INFO - Running setup.py (path:/tmp/pip-AGpi4U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:59:23 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)) 13:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:59:23 INFO - Running setup.py (path:/tmp/pip-ZxD9Za-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:59:23 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)) 13:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:59:23 INFO - Running setup.py (path:/tmp/pip-q5XfRo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:59:24 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)) 13:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:59:24 INFO - Running setup.py (path:/tmp/pip-nUOO8t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:59:24 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)) 13:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:59:24 INFO - Running setup.py (path:/tmp/pip-l0FckF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:59:24 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)) 13:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:59:24 INFO - Running setup.py (path:/tmp/pip-aJgTkH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:59:24 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)) 13:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:59:24 INFO - Running setup.py (path:/tmp/pip-oEorxz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:59:24 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)) 13:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:59:24 INFO - Running setup.py (path:/tmp/pip-YxtKlD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:59:24 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)) 13:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:59:24 INFO - Running setup.py (path:/tmp/pip-HPg47d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:59:24 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)) 13:59:24 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)) 13:59:24 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)) 13:59:24 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)) 13:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:59:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:59:24 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 13:59:24 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 13:59:24 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 13:59:24 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 13:59:24 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 13:59:24 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 13:59:26 INFO - Downloading blessings-1.5.1.tar.gz 13:59:26 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 13:59:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:59:26 INFO - Installing collected packages: blessings 13:59:26 INFO - Running setup.py install for blessings 13:59:26 INFO - Successfully installed blessings 13:59:26 INFO - Cleaning up... 13:59:26 INFO - Return code: 0 13:59:26 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:59:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:59:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:59:26 INFO - Reading from file tmpfile_stdout 13:59:26 INFO - Current package versions: 13:59:26 INFO - argparse == 1.2.1 13:59:26 INFO - blessings == 1.5.1 13:59:26 INFO - blobuploader == 1.2.4 13:59:26 INFO - docopt == 0.6.1 13:59:26 INFO - manifestparser == 1.1 13:59:26 INFO - mozInstall == 1.12 13:59:26 INFO - mozcrash == 0.16 13:59:26 INFO - mozdebug == 0.1 13:59:26 INFO - mozdevice == 0.47 13:59:26 INFO - mozfile == 1.2 13:59:26 INFO - mozhttpd == 0.7 13:59:26 INFO - mozinfo == 0.9 13:59:26 INFO - mozleak == 0.1 13:59:26 INFO - mozlog == 3.1 13:59:26 INFO - moznetwork == 0.27 13:59:26 INFO - mozprocess == 0.22 13:59:26 INFO - mozprofile == 0.28 13:59:26 INFO - mozrunner == 6.11 13:59:26 INFO - mozscreenshot == 0.1 13:59:26 INFO - mozsystemmonitor == 0.0 13:59:26 INFO - moztest == 0.7 13:59:26 INFO - mozversion == 1.4 13:59:26 INFO - psutil == 3.1.1 13:59:26 INFO - requests == 1.2.3 13:59:26 INFO - wsgiref == 0.1.2 13:59:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:26 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 0x7f855e77df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1656840>, '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 0x15c36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c3b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338', '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 13:59:26 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 13:59:26 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 13:59:26 INFO - Using env: {'DISPLAY': ':0', 13:59:26 INFO - 'HOME': '/home/cltbld', 13:59:26 INFO - 'LANG': 'en_US.UTF-8', 13:59:26 INFO - 'LANGUAGE': 'en_US:en', 13:59:26 INFO - 'LOGNAME': 'cltbld', 13:59:26 INFO - 'MAIL': '/var/mail/cltbld', 13:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:26 INFO - 'MOZ_NO_REMOTE': '1', 13:59:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:26 INFO - 'NO_EM_RESTART': '1', 13:59:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:26 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:26 INFO - 'SHELL': '/bin/bash', 13:59:26 INFO - 'SHLVL': '1', 13:59:26 INFO - 'TERM': 'linux', 13:59:26 INFO - 'TMOUT': '86400', 13:59:26 INFO - 'USER': 'cltbld', 13:59:26 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338', 13:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:26 INFO - '_': '/tools/buildbot/bin/python'} 13:59:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:26 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)) 13:59:26 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)) 13:59:26 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)) 13:59:26 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)) 13:59:26 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)) 13:59:26 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)) 13:59:26 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)) 13:59:26 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)) 13:59:26 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)) 13:59:26 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)) 13:59:26 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)) 13:59:26 INFO - Cleaning up... 13:59:26 INFO - Return code: 0 13:59:26 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:26 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 0x7f855e77df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1656840>, '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 0x15c36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c3b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338', '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 13:59:26 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 13:59:26 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 13:59:26 INFO - Using env: {'DISPLAY': ':0', 13:59:26 INFO - 'HOME': '/home/cltbld', 13:59:26 INFO - 'LANG': 'en_US.UTF-8', 13:59:26 INFO - 'LANGUAGE': 'en_US:en', 13:59:26 INFO - 'LOGNAME': 'cltbld', 13:59:26 INFO - 'MAIL': '/var/mail/cltbld', 13:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:26 INFO - 'MOZ_NO_REMOTE': '1', 13:59:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:26 INFO - 'NO_EM_RESTART': '1', 13:59:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:26 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:26 INFO - 'SHELL': '/bin/bash', 13:59:26 INFO - 'SHLVL': '1', 13:59:26 INFO - 'TERM': 'linux', 13:59:26 INFO - 'TMOUT': '86400', 13:59:26 INFO - 'USER': 'cltbld', 13:59:26 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338', 13:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:26 INFO - '_': '/tools/buildbot/bin/python'} 13:59:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:27 INFO - Downloading/unpacking jsonschema 13:59:27 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 13:59:27 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 13:59:27 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 13:59:27 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 13:59:27 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 13:59:27 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 13:59:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:59:28 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 13:59:28 INFO - Downloading/unpacking functools32 (from jsonschema) 13:59:28 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 13:59:28 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 13:59:28 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 13:59:28 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 13:59:28 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 13:59:28 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 13:59:28 INFO - Downloading functools32-3.2.3-2.tar.gz 13:59:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:59:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:59:29 INFO - warning: no files found matching '*.txt' 13:59:29 INFO - no previously-included directories found matching 'build' 13:59:29 INFO - no previously-included directories found matching 'dist' 13:59:29 INFO - no previously-included directories found matching '.git*' 13:59:29 INFO - Installing collected packages: jsonschema, functools32 13:59:29 INFO - Running setup.py install for functools32 13:59:29 INFO - warning: no files found matching '*.txt' 13:59:29 INFO - no previously-included directories found matching 'build' 13:59:29 INFO - no previously-included directories found matching 'dist' 13:59:29 INFO - no previously-included directories found matching '.git*' 13:59:29 INFO - Successfully installed jsonschema functools32 13:59:29 INFO - Cleaning up... 13:59:29 INFO - Return code: 0 13:59:29 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:59:29 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')]} 13:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:29 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')]} 13:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:29 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 0x7f855e77df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1656840>, '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 0x15c36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c3b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338', '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 13:59:29 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 13:59:29 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 13:59:29 INFO - Using env: {'DISPLAY': ':0', 13:59:29 INFO - 'HOME': '/home/cltbld', 13:59:29 INFO - 'LANG': 'en_US.UTF-8', 13:59:29 INFO - 'LANGUAGE': 'en_US:en', 13:59:29 INFO - 'LOGNAME': 'cltbld', 13:59:29 INFO - 'MAIL': '/var/mail/cltbld', 13:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:29 INFO - 'MOZ_NO_REMOTE': '1', 13:59:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:29 INFO - 'NO_EM_RESTART': '1', 13:59:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:29 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:29 INFO - 'SHELL': '/bin/bash', 13:59:29 INFO - 'SHLVL': '1', 13:59:29 INFO - 'TERM': 'linux', 13:59:29 INFO - 'TMOUT': '86400', 13:59:29 INFO - 'USER': 'cltbld', 13:59:29 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338', 13:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:29 INFO - '_': '/tools/buildbot/bin/python'} 13:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:29 INFO - Downloading/unpacking flake8 13:59:29 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 13:59:29 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 13:59:29 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 13:59:29 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 13:59:29 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 13:59:29 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 13:59:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:59:31 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 13:59:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:59:31 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 13:59:31 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 13:59:31 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 13:59:31 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 13:59:31 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 13:59:31 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 13:59:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:59:31 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 13:59:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:59:31 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 13:59:31 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 13:59:31 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 13:59:31 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 13:59:31 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 13:59:31 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 13:59:31 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 13:59:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:59:31 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 13:59:31 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 13:59:31 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 13:59:31 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 13:59:31 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 13:59:31 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 13:59:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:59:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:59:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:59:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:59:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:59:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:59:31 INFO - no previously-included directories found matching 'docs/_build' 13:59:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:59:31 INFO - Running setup.py install for pep8 13:59:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:59:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:59:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:59:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:59:31 INFO - no previously-included directories found matching 'docs/_build' 13:59:32 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:59:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:59:32 INFO - Cleaning up... 13:59:32 INFO - Return code: 0 13:59:32 INFO - Running post-action listener: _resource_record_post_action 13:59:32 INFO - Running post-action listener: _start_resource_monitoring 13:59:32 INFO - Starting resource monitoring. 13:59:32 INFO - ##### 13:59:32 INFO - ##### Running install step. 13:59:32 INFO - ##### 13:59:32 INFO - Running pre-action listener: _resource_record_pre_action 13:59:32 INFO - Running main action method: install 13:59:32 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:59:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:59:32 INFO - Reading from file tmpfile_stdout 13:59:32 INFO - Detecting whether we're running mozinstall >=1.0... 13:59:32 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:59:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:59:32 INFO - Reading from file tmpfile_stdout 13:59:32 INFO - Output received: 13:59:32 INFO - Usage: mozinstall [options] installer 13:59:32 INFO - Options: 13:59:32 INFO - -h, --help show this help message and exit 13:59:32 INFO - -d DEST, --destination=DEST 13:59:32 INFO - Directory to install application into. [default: 13:59:32 INFO - "/builds/slave/test-pgo"] 13:59:32 INFO - --app=APP Application being installed. [default: firefox] 13:59:32 INFO - mkdir: /builds/slave/test-pgo/build/application 13:59:32 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'] 13:59:32 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 13:59:48 INFO - Reading from file tmpfile_stdout 13:59:48 INFO - Output received: 13:59:48 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:59:48 INFO - Running post-action listener: _resource_record_post_action 13:59:48 INFO - ##### 13:59:48 INFO - ##### Running run-tests step. 13:59:48 INFO - ##### 13:59:48 INFO - Running pre-action listener: _resource_record_pre_action 13:59:48 INFO - Running main action method: run_tests 13:59:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:59:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:59:48 INFO - Python 2.7.3 13:59:48 INFO - Return code: 0 13:59:48 INFO - grabbing minidump binary from tooltool 13:59: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')]} 13:59:48 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 0x1656840>, '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 0x15c36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c3b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:59:48 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 13:59:48 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 13:59:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:59:48 INFO - Return code: 0 13:59:48 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:59:48 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:59:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:59:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:59:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:59:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:59:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:59:49 INFO - Return code: 0 13:59:49 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/PFR1WJEaSvOlaeMfH9VchA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 13:59:49 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/PFR1WJEaSvOlaeMfH9VchA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 13:59:49 INFO - Using env: {'DISPLAY': ':0', 13:59:49 INFO - 'HOME': '/home/cltbld', 13:59:49 INFO - 'LANG': 'en_US.UTF-8', 13:59:49 INFO - 'LANGUAGE': 'en_US:en', 13:59:49 INFO - 'LOGNAME': 'cltbld', 13:59:49 INFO - 'MAIL': '/var/mail/cltbld', 13:59:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:59:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:49 INFO - 'MOZ_NO_REMOTE': '1', 13:59:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:59:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:49 INFO - 'NO_EM_RESTART': '1', 13:59:49 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:49 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:49 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:59:49 INFO - 'SHELL': '/bin/bash', 13:59:49 INFO - 'SHLVL': '1', 13:59:49 INFO - 'TERM': 'linux', 13:59:49 INFO - 'TMOUT': '86400', 13:59:49 INFO - 'USER': 'cltbld', 13:59:49 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338', 13:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:49 INFO - '_': '/tools/buildbot/bin/python'} 13:59:49 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/PFR1WJEaSvOlaeMfH9VchA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 13:59:49 INFO - mozversion application_buildid: 20160111113021 13:59:49 INFO - mozversion application_changeset: ae1f40f9c26c1f837e7a78696e0b986befcda539 13:59:49 INFO - mozversion application_display_name: Nightly 13:59:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:59:49 INFO - mozversion application_name: Firefox 13:59:49 INFO - mozversion application_remotingname: firefox 13:59:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 13:59:49 INFO - mozversion application_vendor: Mozilla 13:59:49 INFO - mozversion application_version: 46.0a1 13:59:49 INFO - mozversion platform_buildid: 20160111113021 13:59:49 INFO - mozversion platform_changeset: ae1f40f9c26c1f837e7a78696e0b986befcda539 13:59:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 13:59:49 INFO - mozversion platform_version: 46.0a1 13:59:49 INFO - using testdate: 1452549589 13:59:49 INFO - actual date: 1452549589 13:59:49 INFO - starting webserver on 'localhost:34469' 13:59:49 INFO - SUITE-START | Running 3 tests 13:59:49 INFO - TEST-START | dromaeo_css 13:59:49 INFO - operating with platform_type : linux_ 13:59:49 INFO - Initialising browser for dromaeo_css test... 13:59:49 INFO - TEST-INFO | started process 10441 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6aAGew/profile http://localhost:34469/getInfo.html) 13:59:53 INFO - PROCESS | 10441 | __metrics Screen width/height:1600/1200 13:59:53 INFO - PROCESS | 10441 | colorDepth:24 13:59:53 INFO - PROCESS | 10441 | Browser inner width/height: 1024/697 13:59:53 INFO - PROCESS | 10441 | __metrics 13:59:53 INFO - PROCESS | 10441 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:59:53 INFO - PROCESS | 10441 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:59:54 INFO - TEST-INFO | 10441: exit 0 13:59:54 INFO - Browser initialized. 13:59:54 INFO - Running cycle 1/1 for dromaeo_css test... 13:59:54 INFO - TEST-INFO | started process 10533 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6aAGew/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:00:06 INFO - PROCESS | 10533 | RSS: Main: 148209664 14:00:06 INFO - PROCESS | 10533 | 14:00:58 INFO - PROCESS | 10533 | 1452549658004 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:03:05 INFO - PROCESS | 10533 | Cycle 1(1): loaded http://localhost:34469/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34469/tests/dromaeo/cssquery-ext.html) 14:03:07 INFO - PROCESS | 10533 | RSS: Main: 347123712 14:03:07 INFO - PROCESS | 10533 | 14:06:10 INFO - PROCESS | 10533 | Cycle 1(1): loaded http://localhost:34469/tests/dromaeo/cssquery-ext.html (next: http://localhost:34469/tests/dromaeo/cssquery-jquery.html) 14:06:10 INFO - PROCESS | 10533 | RSS: Main: 236335104 14:06:10 INFO - PROCESS | 10533 | 14:09:13 INFO - PROCESS | 10533 | Cycle 1(1): loaded http://localhost:34469/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34469/tests/dromaeo/cssquery-mootools.html) 14:09:13 INFO - PROCESS | 10533 | RSS: Main: 233033728 14:09:13 INFO - PROCESS | 10533 | 14:12:15 INFO - PROCESS | 10533 | Cycle 1(1): loaded http://localhost:34469/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34469/tests/dromaeo/cssquery-prototype.html) 14:12:16 INFO - PROCESS | 10533 | RSS: Main: 218292224 14:12:16 INFO - PROCESS | 10533 | 14:15:18 INFO - PROCESS | 10533 | Cycle 1(1): loaded http://localhost:34469/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34469/tests/dromaeo/cssquery-yui.html) 14:15:19 INFO - PROCESS | 10533 | RSS: Main: 220065792 14:15:19 INFO - PROCESS | 10533 | 14:18:21 INFO - PROCESS | 10533 | Cycle 1(1): loaded http://localhost:34469/tests/dromaeo/cssquery-yui.html (next: http://localhost:34469/tests/dromaeo/cssquery-dojo.html) 14:18:22 INFO - PROCESS | 10533 | RSS: Main: 261242880 14:18:22 INFO - PROCESS | 10533 | 14:18:22 INFO - PROCESS | 10533 | __start_tp_report 14:18:22 INFO - PROCESS | 10533 | _x_x_mozilla_page_load 14:18:22 INFO - PROCESS | 10533 | _x_x_mozilla_page_load_details 14:18:22 INFO - PROCESS | 10533 | |i|pagename|runs| 14:18:22 INFO - PROCESS | 10533 | |0;dojo.html;3086.5215891536814;3150.5746724192227;3192.6009248843893;3195.5046967720014;3222.9355412891737;5063.5949124070075;5101.413337466192;5131.025105230004;5168.328117344745;5177.068127737015;5113.38639363276;5192.662476938996;5259.053370393328;5288.629795914288;5295.602829787772;4689.859304220879;4691.88270293242;4735.857924262269;4847.951520484803;4870.586000189988;4777.498362671921;4837.443693975185;4859.757012149396;4920.3111564381015;4927.704337739729;4570.360149579062;4642.953570464286;4678.228092364756;4713.222318317474;4724.055188962187;4656.092062047902;4658.464276608166;4672.57946784791;4677.204875171229;4702.247640377524;4531.229690952546;4651.674382793206;4658.277966915133;4681.578657920803;4692.436907571113;4964.304997300381;4990.600751939836;5068.822591209327;5070.062038522885;5076.822311219126;5515.751791169407;5515.944840551583;5524.309461317335;5532.917006244909;5533.253010843565;5370.382406023318;5455.072637651609;5546.83673367387;5594.832155035356;5595.300587426572;5145.485451454824;5174.068667639824;5271.05121078202;5279.604029697788;5298.443663415324;5706.172604972338;5710.229119068873;5724.427557244326;5751;5792.623479473821;5340.172273297568;5456.508914197741;5527.336719593674;5528.032594295983;5533.335999680065;5469.726513674301;5513.42109078549;5604.103343465026;5611.354694210218;5612.579056570774;5510.393856675762;5516.255305533782;5519.089350257243;5521.365043020024;5526.281583394213;5462.071447853875;5520.57482685787;5523.25436066134;5527.944720552743;5580.693061881636;4183.330667093251;4236.915261694749;4274.252005899018;4316.395704601358;4336.046069864625;3859.421086836941;3864.2851072551666;3874.9031274217805;3876.127871228951;3902.2585708715255;5057.519535644108;5187.662801917863;5193.221016847503;5196.53231209193;5243.606729495303;5449.891002180014;5456.945430545723;5503.449655034465;5566.805161819317;5621.690807005572;5147.536721695065;5194.27280180775;5199.142141546678;5199.662021968636;5201.505856943584;4634.652401069933;4780.976095119572;4786.282057691375;4790.976045119752;4830.396200474941;5597.244372009808;5723.6851973141875;5790.768369265266;5802.361740208658;5845.123231515222;5496.917546236729;5499.890002200013;5501.339839219159;5502.339719233718;5506.614536982373;5699.116636921284;5715.39988301239;5719.0277652798295;5719.3136823581435;5741.339745929272;5417.349918009864;5449.400565937823;5454.754536045808;5470.753816078206;5509.421510741475;5569.916451253315;5573.526250268773;5573.749181286771;5574.637648552831;5580;5281.973590132025;5328.706921119376;5381.542568881689;5480;5482.122860342326;5285.392179899207;5335.67985920846;5339.519443250126;5343.171808369709;5343.839684809462;5253.159494480865;5256.789728410974;5261.631685781958;5261.684298942076;5274.1034024215205;5295.073362161684;5336.412994570516;5347.251384806053;5360.490753378423;5373.382061063028;5308.230306605597;5399;5407.810726624549;5422.8373148805595;5422.945770542244 14:18:22 INFO - PROCESS | 10533 | |1;ext.html;526.2133110999057;545.4409230538698;562.1764115570688;565.6464709556527;577.1026054485276;27852.164435066956;28566.57150142747;34866.953991380266;35300.646993530056;35366.46950295748;38615.42076868842;38986.41520377197;38992.61007389925;39024;39079;8463.492190468562;8688.56557172142;8690.522021288827;8691.652333906668;8696.478211307342;7454.068241469817;7637.083549973983;9889.159421449185;10101.343412678189;10102.545385457672;10114.089731924125;10237.334573252714;10255.692329230134;10256.179505639531;10263.076323130917;7486.5508069516;7684.769456916301;10040;10085.243606729488;10207.693769186937;7413.666385012633;9929.90070099297;10120.9373015833;10181.490925453698;10227.386356818615;35005.824970875234;35363.64636353655;35408.46887296693;35489.29021419583;35511.4673279901;3297.159224397787;3352;3366.764326497146;3397.4903764435285;3763.8306276217636;27770.16689499318;28011.859940700167;28198.295042623893;28246.293842654097;30744.2313942151;3969.861054863095;3993.1414745829784;4003.179348233605;4141.316682747343;4198.895027624303;259574;259740;260092;260093;260564;51523.22715159276;52247.73876130595;57562;60134;61067.389326107055;54259;54752;54983;55058.72470637621;55109.1733623996;14863.777043344358;15063.397464101532;15082.321295541728;15107.093574385572;15109.244537773067;11181.993620574187;11252.943735281271;11261.324320540794;11262.04272636835;11474.48364823585;20037.398878033684;20280.290189843283;20302.390928272176;20362.898185509275;20368.166864982224;7170.2471240520035;7303.963480182671;7308.926910730931;7368.189499155089;7428.182899881009;876.3471213945651;966.1160038564634;1008.9041541053588;1041.4376236832177;1065.3394895164893;28085.35726241211;28801.711982880322;29245.268868278465;29454.558181627293;29495.410091798472;1009.1271050541376;1053.8524606555088;1067.3595842494597;1108.9833652495058;1130.745582244005;13736.65658358529;14201.644958876112;14350.856491435161;14470;14535;443303;448159;449517;450882;453186;49369;49682.50317496851;49774.50225497771;49803.50196498061;49824.25263621048;1327.794191900257;1328.4354149486624;1331.261150061725;1334.7797613393682;1372.2246930484243;27403.725962740118;28330.716692833634;28413;28568.428631427672;28615.28461788472;43559;44217.33673994828;44264.77867610641;44293;44309.77845110754;237573;238880;239175;240090;240309;27997.300067498476;31369.37261254808;31802.204944876565;32000.6799932007;32272.83863580761;37710;39832.90501185749;40207.19585608213;40845.591544085364;41057.58942410657;34365.48451773275;34630.480542792386;34855.651443486255;34927.12682182864;35476.64523354734;30302.848485758313;32801.50797738084;34671.65328346684;35558.822205888806;37127;32613.18467038343;32772.672273277916;35235.47146792852;35845;35919.82040089783;28208.717912820608;29715.702842972158;30271.18372897633;30400.84799575988;30407.239819004702;23146.884265578563;23480.882595586914;23527.529449411257;23634.172803952468;23801 14:18:22 INFO - PROCESS | 10533 | |2;jquery.html;352.56986476498673;356.24476110645435;359.4249201277954;360.67178867230825;362.3387318144386;13330;13786.310684465787;16092.678146437063;16674.49976500704;17887.64224715505;15129.789616830654;16264.593385165348;16732;16909.323627054902;16970.745438818398;5308.893822123555;5484.2596249506205;5488.725563721798;5497.532709719659;5503.036968530511;3956.0703234739813;4126.09225970286;5215.243789650498;5297.814576489824;5838.2702162229725;5996.2804463464445;6008.879822403549;6036.577439579231;6040.818775436744;6041.395860413945;5085.847424577269;5274.894502109936;5279.04977104123;5289.285946397225;5290.947090529084;4903.877403064952;5083.186690129562;5092.363454568179;5183.870403239912;5185;19097.61804763911;19668.311609093755;19777;19782;19929;2017.798220177985;2029.9492512687152;2047.2936836791282;2076.719642848211;2159.5680863827142;9160.954195229047;9577.952110239474;9795.461249631267;11953.581624643095;12482.50069997199;1800.5768644368563;1874.8031456696988;1897.155765684271;1952.8632995690307;1963.8330741886957;48524;49893.25160122601;53385.733071334784;55577.72211138919;56261;9504.809903801885;9524.666636667684;9592.76018099553;9711.611535538641;10065.295429320024;12784.04119691027;12834.871651283367;12866.48534058646;12878.162919410208;12918.547850825176;7234.674439650228;7260.310270524292;7350.77947661571;7434.1822399536;7531.924680753232;7089.89365159523;7347.228541003117;7360.889586656204;7363.484556081023;7389.630518474162;4305.612494875476;4349.891252718708;4354.194474022316;4367.27939889921;4384.934225986613;1673.9665206695797;1731.6709825133184;1748.4492384898717;1775.9931277656167;1809.4209852847225;857.5455008845322;915.4507295622573;918.081918081918;950.6625148072335;1014.9949250253701;15523.37906483728;15652.608684782972;16352.75470867938;16519.421820236235;16873.915630422016;943.3019565521465;946.4557879219476;979.3780949097232;997.4464172384252;1031.3811712972156;9422.764430889145;9542.713718588453;9606.27952903535;9623.663171789094;9786.902130978599;355576;506777;507659;521862;533225;55455.44544554583;70086.64956675185;72436.275637244;73020;73883.63058184675;1006.0744115413837;1017.9847302290472;1022.4785359466576;1023.1916785739331;1051.101308381323;11172.55309787632;13308.401121949342;14832.925835370754;15009.549713508612;15334.846651533342;28538;29112.12663620095;32182;32863;33000.00999969909;38928.805355974175;38972;39709.40435893406;40189;40382.79808601056;7163.892541611985;7186.964065179641;7219.530730502501;7303.123625165014;7420.072490938633;10790.622328218475;11379.63444386679;11411;11442.37066961325;11535.826962595736;9507.857382139135;9602.183814375578;9651.9034809651;9904;10014.19886409071;9653.855192171983;10011.849822252818;10025.097741203326;10124.60672090981;10201.234907381828;9465.432074075577;9544.809103818023;9993.400395976265;10152.796944061225;10178.541965611417;7428.628568571442;7452.21751716062;7453.515521491086;7546.584937828253;7563.319301262913;9176.128267814547;9714.465704386326;10112.342697724624;10183.643572474928;10303.639372621923 14:18:22 INFO - PROCESS | 10533 | |3;mootools.html;1314.5530519623326;1430.349191118041;1443.213448670475;1578.4948816378756;1743.8779285450007;6749.156355455568;7359.300866417689;7480.214577469362;7484.738034168805;7494.362979146766;7419.591922444263;7612.543247405146;7616.847663046736;7617.885731714029;7626.245963428415;1953.7753158386754;2007.3074789197703;2165.8375621828345;2218.367765186922;2283.383486458655;2353.6940197774265;2357.49313897512;2361.622140457527;2365.858048517086;2365.89353479093;2189.430748005522;2199.0434161139874;2199.813015893651;2203.6914831923464;2205.7683943185975;2238.373255488466;2244.02384962541;2299.137823316265;2312.8727919964394;2317.953640927189;2276.2147059264526;2299.1493147535352;2308.319045881469;2312.9421764455856;2312.97687023131;7643.273888980538;7685.154632990367;7687.923120768776;7692.230776922263;7699.730509432143;4705;4787.425508938914;4802.207635740134;4829.227323628203;4838.806447742121;3100.3334283129234;3121.4069326828057;3150.8582113804705;3157.037103683376;3193.5688682028094;1023.5649848814224;1035.5909415780725;1073.849661047454;1076.6285631457135;1085.6200329884557;10625.149988000941;10692.358458492516;10712.46437678113;10719.6784096478;10726.624568140156;4213.662906967435;4308.987387963826;4325.416068830667;4328.935065974013;4344.565543445693;9126.36115471924;9133.77165570866;9135.497547634812;9136.725898223063;9138.13187747163;4789.353437285991;4800.303955926371;4834.927476087862;4835.0571638530855;4843.055604157226;4398.978005110018;4400.4939431965095;4401.2517871961845;4404.07514421975;4405.493368262691;3336.115929278743;3435.9828200858838;3441.294534620397;3529.94705079424;3595.9820200899353;1175.9470823812949;1189.7858385490522;1189.9583514576948;1201.7956947318976;1236.9010479161645;1298.9870101298866;1315.5921664284103;1338.732253549294;1347.5418357758408;1348.4269185596083;6980.965095174492;7082.681279342442;7092.822679433056;7092.822679433056;7182.102237220348;1086.2884810449168;1091.9344839309667;1095.1676725688376;1112.8330750387506;1116.9553217871194;5685.3177618685195;5812.680302583399;5814.767409303665;5819.767209311664;5820.563457740686;9329.486878221764;9411.905880941104;9498.810023799486;9631.277654175965;9662.855057174149;9419.15227629503;9420.152186303128;9506.33455658111;9511.714648560554;9518.714438566854;7266.63666816657;7394.112706475257;7480.139783924809;7486.4759466836795;7494.962525187449;7099.325564071405;7104.325089116525;7137.85724285501;7144.3212894774915;7156.606386648784;8177.550234736908;8398.370122240734;8453.239208471266;8614.82770344602;8633.740987770378;8658.91341086581;8856.114388561093;8858.557072146237;8868.822623547621;8874.290056795311;6919.342662447059;6995.125609298838;6998;7008.5094043416475;7026.262242464468;6551.705173267119;6687.431568316748;7134.536255143399;7212.4951253411755;7247.9637601811655;6630.668466576555;6728.629925354153;6863.10779598649;6918.896216556856;6991.126109236346;6601.636909969998;6650.800475985535;6661.733530658719;6777.491688123312;6782.389584937379;6701.430378417889;6727.932720672927;6746.123004009447;6754;6754.054432379373;6050.667213303311;6294.464970477377;6309.053641953744;6491.902621460777;6527.086207930988;6425.293217746138;6434.581752186093;6475.64383958868;6481.125048118633;6486.805395838132 14:18:22 INFO - PROCESS | 10533 | |4;prototype.html;327.3600111781467;328.93256882339125;334.1245935648601;337.2714935738805;341.69589065731503;5751.137329400592;5886.617369870961;5892.440218179271;5892.587518873681;5904.1734157218025;5646.6894320812335;5808.2449281593335;5815.098659707742;5820.854478638036;5823.970880145594;4467.218236808561;4517.390152329426;4517.977410112945;4521.7286962782255;4525.2533332000185;4298.376735373369;4367.759773212472;4383.9342409863875;4493.662975276868;4506.639468842501;4435.955640443586;4437.977810110961;4443.5556444355625;4444.799904025911;4448.998975230564;4440.955590444087;4445.333200019991;4450.443694538183;4454.042380888092;4468.843590474317;3949.2891279569667;3959.742616729903;3963.6036396360423;3965.504311961005;3976.8608098716695;5407.378151512547;5537.390887002426;5548.472895074961;5556.416576259475;5563.415841336682;5198.168293073128;5214.739263036833;5218.6868787872845;5222.8694282642855;5223.08595995703;6170.598911070811;6172.660503672296;6174.722137503823;6184.84537886552;6187.783427580058;4371.650267978586;4374.475062992461;4377.23398405281;4377.781110944472;4379.343098535245;5944.554158438134;6037.516998640098;6390.392912673335;6471.5146364022885;6509.990951402588;4448.4439445069365;4467.843625473093;4472.418585583919;4474.038081812426;4479.865604031885;4527.366168736379;4532.70537415067;4536.138133754576;4539.31910213464;4539.432570928634;5044.974775126174;5179.585633149414;5191.896162076738;5192.584593232532;5200.479952004769;6245.781397651152;6252.124702541648;6261.342559031327;6263.655498947602;6263.812085637438;1582.5806161367248;1603.7995250593676;1604.4464659692387;1604.5747876812654;1606.437746788638;1082.53992053377;1090.334895713614;1111.2943281016612;1114.3091283404178;1117.4692021289984;5914.970425147847;5935.198748168942;5961.479822645198;5962.791302304486;5964.403559644001;6373.681315934185;6380.042993551005;6385.712642931079;6388.840278993062;6401.07184458251;5952.345242023374;5956;5957.4042595740075;5963.582549221513;5964.254468191476;3352.6479719629087;3442.2599141184764;3454.464557993465;3455.585329760445;3463.7229021678204;6689.230738465041;6773.695183716744;6781.152355955505;6790.660466976631;6795.082663840417;6627.900581491282;6631.23740769808;6631.86736265272;6634.270230274666;6640.468762498988;6587.670616469158;6745.224299205556;6760.459163266927;6761.966190169116;6764.695588698521;6426.967865160645;6458.515611329263;6468;6470.773522926675;6471.123374221611;6097.298810636834;6343.492520598249;6378.553501254868;6387.968060159669;6403.935960640334;6376.298607153117;6630.403263706289;6705.195376554844;6744.62904540255;6748.312921769558;4370.497392799869;4429.68992170545;4433.135538569948;4437.179121862466;4439.089986552814;6341.175647165839;6426.4537514311805;6444.065610486359;6454.354564543696;6472.902906456313;6306.495480361652;6307.684615769102;6313.084602732486;6315.778947736991;6319.115323854756;6238.500919926304;6249.812505624838;6285.905711414424;6292.244930608356;6292.244930608356;6030;6160.075988601567;6177.4749146323065;6178.443940045418;6182.072689096672;6316.084167795736;6316.399942005502;6318.052292156213;6320.336364681642;6325.778597749057;6156.969215153896;6159.907601385893;6167.259928808572;6171;6175.023992322594 14:18:22 INFO - PROCESS | 10533 | |5;yui.html;736.8378956629541;827.8344331133771;835.7618078847526;846.3483117999139;866.1035827918106;13129.934350328247;13312.334383280833;13344.733105337911;13352.33238338084;13365.331733413315;10886.455677216127;11119.610813621524;12213.084018698612;12277.938610306936;12333.814992775115;776.1423626892288;779.5089093870881;780.321120625057;781.468601351081;784.5175217241413;782.2099679323895;786.5713186313444;786.7285786403681;787.1656044592721;787.3189690917344;824.8391563645091;829.9668013279462;830.3357314148657;830.6469750356105;831.787894087007;827.4952279109739;827.5862068965517;828.8383765165765;829.1294141151767;829.4981536170591;617.0312609203552;617.1606615003592;617.6633734614646;617.8826023055605;617.9134921111048;11957.521699132025;11994.16040877139;12017.759644807142;12026.518939242507;12030.939845300718;10663.413512256822;10764.892351076545;10776.245662803607;10877.619283325124;10899.073578745816;9654.27592930533;9763.511824408823;9843.557039933221;9856.162226210781;9900.306978511508;3480.3735327641016;3586.336527742376;3615.349237137314;3622.873199438007;3631.9818400907825;42149.78925105386;43710.344344834855;43905.78047109776;44128.33807492858;44160.012799424105;8336.666533338599;8603.139686031347;8614.91385086141;8722.30221582272;8752.168543988311;16177.514674559781;16274.43039493612;16289.837101628833;16351.182440877908;16382.508524744277;7822.804429889185;7959.8408031839035;7977.960110199412;8001.359891208689;8046.718364857319;4343.609075183249;4403.075354175595;4479.171353299585;4481.036577135931;4631.675782695179;3072.830994295335;3109.3159504908886;3115.3613509230554;3116.6104236970377;3123.6563977962405;562.5612022622361;566.3656704490996;566.931968163823;569.4647031790187;589.5401586762332;618.3630860213987;646.9223693156852;670.276101810044;676.1885737115481;679.741698154698;8086.83826323482;8393.916060839436;8500.787480313042;8568.828623427622;8835.425697329652;512.6206607110786;578.869754305278;583.8306891001562;616.6669998201011;713.7822963996031;3825.5218097737784;3928.52857657083;3986.3023970804993;4158.272302347138;4166.584173117691;52028;52182;55423;59127.70436147792;60446.697766510886;47052;47556;47575.5242447578;47602.76198618985;47662.28506572404;42159.36760948588;42265;43617;44125.33811992823;47408.5259147411;8697;8711.695090671796;8778.648854046021;8781.385303028726;8862;33780.3243935115;33838.66161338454;34616;34653.82673086618;34808.30383392267;39760.60239397685;39801.00497487586;41593.58406416018;42315.78842105893;44933.775331123135;10361.481925903825;10440.37357758537;10595.523201455799;10869.43501696958;11229.3262404256;11336.206465547333;11682.591109311134;11823.920747342154;11957.581484647995;12079.698007549881;10811.6215932442;10818.783624327627;10876;10894.509747061244;10896.291741036806;10615.203859710708;10885.673429797118;10903.78192436131;11034.503447344729;11090.112790976864;11258.437078146224;11497.137714671266;11499.367534785668;11500.907413795676;11556.884431155917;8595.957020214859;9018.323625727966;9088.272938164799;9208.493532855757;9328.39365441244;8757.430767000125;9030.142136497023;9337;9479.383840050376;9556.139947404767 14:18:22 INFO - PROCESS | 10533 | __end_tp_report 14:18:22 INFO - PROCESS | 10533 | __start_cc_report 14:18:22 INFO - PROCESS | 10533 | _x_x_mozilla_cycle_collect,1646 14:18:22 INFO - PROCESS | 10533 | __end_cc_report 14:18:22 INFO - PROCESS | 10533 | __startTimestamp1452550702003__endTimestamp 14:18:22 INFO - PROCESS | 10533 | 14:18:22 INFO - PROCESS | 10533 | ------- Summary: start ------- 14:18:22 INFO - PROCESS | 10533 | Number of tests: 6 14:18:22 INFO - PROCESS | 10533 | 14:18:22 INFO - PROCESS | 10533 | [#0] dojo.html Cycles:165 Average:5144.88 Median:5298.44 stddev:555.43 (10.5%) stddev-sans-first:533.14 14:18:22 INFO - PROCESS | 10533 | Values: 3086.5 3150.6 3192.6 3195.5 3222.9 5063.6 5101.4 5131.0 5168.3 5177.1 5113.4 5192.7 5259.1 5288.6 5295.6 4689.9 4691.9 4735.9 4848.0 4870.6 4777.5 4837.4 4859.8 4920.3 4927.7 4570.4 4643.0 4678.2 4713.2 4724.1 4656.1 4658.5 4672.6 4677.2 4702.2 4531.2 4651.7 4658.3 4681.6 4692.4 4964.3 4990.6 5068.8 5070.1 5076.8 5515.8 5515.9 5524.3 5532.9 5533.3 5370.4 5455.1 5546.8 5594.8 5595.3 5145.5 5174.1 5271.1 5279.6 5298.4 5706.2 5710.2 5724.4 5751.0 5792.6 5340.2 5456.5 5527.3 5528.0 5533.3 5469.7 5513.4 5604.1 5611.4 5612.6 5510.4 5516.3 5519.1 5521.4 5526.3 5462.1 5520.6 5523.3 5527.9 5580.7 4183.3 4236.9 4274.3 4316.4 4336.0 3859.4 3864.3 3874.9 3876.1 3902.3 5057.5 5187.7 5193.2 5196.5 5243.6 5449.9 5456.9 5503.4 5566.8 5621.7 5147.5 5194.3 5199.1 5199.7 5201.5 4634.7 4781.0 4786.3 4791.0 4830.4 5597.2 5723.7 5790.8 5802.4 5845.1 5496.9 5499.9 5501.3 5502.3 5506.6 5699.1 5715.4 5719.0 5719.3 5741.3 5417.3 5449.4 5454.8 5470.8 5509.4 5569.9 5573.5 5573.7 5574.6 5580.0 5282.0 5328.7 5381.5 5480.0 5482.1 5285.4 5335.7 5339.5 5343.2 5343.8 5253.2 5256.8 5261.6 5261.7 5274.1 5295.1 5336.4 5347.3 5360.5 5373.4 5308.2 5399.0 5407.8 5422.8 5422.9 14:18:22 INFO - PROCESS | 10533 | 14:18:22 INFO - PROCESS | 10533 | [#1] ext.html Cycles:180 Average:47220.13 Median:32787.09 stddev:87192.40 (265.9%) stddev-sans-first:87366.52 14:18:22 INFO - PROCESS | 10533 | Values: 526.2 545.4 562.2 565.6 577.1 27852.2 28566.6 34867.0 35300.6 35366.5 38615.4 38986.4 38992.6 39024.0 39079.0 8463.5 8688.6 8690.5 8691.7 8696.5 7454.1 7637.1 9889.2 10101.3 10102.5 10114.1 10237.3 10255.7 10256.2 10263.1 7486.6 7684.8 10040.0 10085.2 10207.7 7413.7 9929.9 10120.9 10181.5 10227.4 35005.8 35363.6 35408.5 35489.3 35511.5 3297.2 3352.0 3366.8 3397.5 3763.8 27770.2 28011.9 28198.3 28246.3 30744.2 3969.9 3993.1 4003.2 4141.3 4198.9 259574.0 259740.0 260092.0 260093.0 260564.0 51523.2 52247.7 57562.0 60134.0 61067.4 54259.0 54752.0 54983.0 55058.7 55109.2 14863.8 15063.4 15082.3 15107.1 15109.2 11182.0 11252.9 11261.3 11262.0 11474.5 20037.4 20280.3 20302.4 20362.9 20368.2 7170.2 7304.0 7308.9 7368.2 7428.2 876.3 966.1 1008.9 1041.4 1065.3 28085.4 28801.7 29245.3 29454.6 29495.4 1009.1 1053.9 1067.4 1109.0 1130.7 13736.7 14201.6 14350.9 14470.0 14535.0 443303.0 448159.0 449517.0 450882.0 453186.0 49369.0 49682.5 49774.5 49803.5 49824.3 1327.8 1328.4 1331.3 1334.8 1372.2 27403.7 28330.7 28413.0 28568.4 28615.3 43559.0 44217.3 44264.8 44293.0 44309.8 237573.0 238880.0 239175.0 240090.0 240309.0 27997.3 31369.4 31802.2 32000.7 32272.8 37710.0 39832.9 40207.2 40845.6 41057.6 34365.5 34630.5 34855.7 34927.1 35476.6 30302.8 32801.5 34671.7 35558.8 37127.0 32613.2 32772.7 35235.5 35845.0 35919.8 28208.7 29715.7 30271.2 30400.8 30407.2 23146.9 23480.9 23527.5 23634.2 23801.0 14:18:22 INFO - PROCESS | 10533 | 14:18:22 INFO - PROCESS | 10533 | [#2] jquery.html Cycles:180 Average:25617.92 Median:4360.74 stddev:79940.35 (1833.2%) stddev-sans-first:80142.09 14:18:22 INFO - PROCESS | 10533 | Values: 352.6 356.2 359.4 360.7 362.3 13330.0 13786.3 16092.7 16674.5 17887.6 15129.8 16264.6 16732.0 16909.3 16970.7 5308.9 5484.3 5488.7 5497.5 5503.0 3956.1 4126.1 5215.2 5297.8 5838.3 5996.3 6008.9 6036.6 6040.8 6041.4 5085.8 5274.9 5279.0 5289.3 5290.9 4903.9 5083.2 5092.4 5183.9 5185.0 19097.6 19668.3 19777.0 19782.0 19929.0 2017.8 2029.9 2047.3 2076.7 2159.6 9161.0 9578.0 9795.5 11953.6 12482.5 1800.6 1874.8 1897.2 1952.9 1963.8 48524.0 49893.3 53385.7 55577.7 56261.0 9504.8 9524.7 9592.8 9711.6 10065.3 12784.0 12834.9 12866.5 12878.2 12918.5 7234.7 7260.3 7350.8 7434.2 7531.9 7089.9 7347.2 7360.9 7363.5 7389.6 4305.6 4349.9 4354.2 4367.3 4384.9 1674.0 1731.7 1748.4 1776.0 1809.4 857.5 915.5 918.1 950.7 1015.0 15523.4 15652.6 16352.8 16519.4 16873.9 943.3 946.5 979.4 997.4 1031.4 9422.8 9542.7 9606.3 9623.7 9786.9 355576.0 506777.0 507659.0 521862.0 533225.0 55455.4 70086.6 72436.3 73020.0 73883.6 1006.1 1018.0 1022.5 1023.2 1051.1 11172.6 13308.4 14832.9 15009.5 15334.8 28538.0 29112.1 32182.0 32863.0 33000.0 38928.8 38972.0 39709.4 40189.0 40382.8 7163.9 7187.0 7219.5 7303.1 7420.1 10790.6 11379.6 11411.0 11442.4 11535.8 9507.9 9602.2 9651.9 9904.0 10014.2 9653.9 10011.8 10025.1 10124.6 10201.2 9465.4 9544.8 9993.4 10152.8 10178.5 7428.6 7452.2 7453.5 7546.6 7563.3 9176.1 9714.5 10112.3 10183.6 10303.6 14:18:22 INFO - PROCESS | 10533 | 14:18:22 INFO - PROCESS | 10533 | [#3] mootools.html Cycles:180 Average:5430.46 Median:6172.57 stddev:2801.52 (45.4%) stddev-sans-first:2792.30 14:18:22 INFO - PROCESS | 10533 | Values: 1314.6 1430.3 1443.2 1578.5 1743.9 6749.2 7359.3 7480.2 7484.7 7494.4 7419.6 7612.5 7616.8 7617.9 7626.2 1953.8 2007.3 2165.8 2218.4 2283.4 2353.7 2357.5 2361.6 2365.9 2365.9 2189.4 2199.0 2199.8 2203.7 2205.8 2238.4 2244.0 2299.1 2312.9 2318.0 2276.2 2299.1 2308.3 2312.9 2313.0 7643.3 7685.2 7687.9 7692.2 7699.7 4705.0 4787.4 4802.2 4829.2 4838.8 3100.3 3121.4 3150.9 3157.0 3193.6 1023.6 1035.6 1073.8 1076.6 1085.6 10625.1 10692.4 10712.5 10719.7 10726.6 4213.7 4309.0 4325.4 4328.9 4344.6 9126.4 9133.8 9135.5 9136.7 9138.1 4789.4 4800.3 4834.9 4835.1 4843.1 4399.0 4400.5 4401.3 4404.1 4405.5 3336.1 3436.0 3441.3 3529.9 3596.0 1175.9 1189.8 1190.0 1201.8 1236.9 1299.0 1315.6 1338.7 1347.5 1348.4 6981.0 7082.7 7092.8 7092.8 7182.1 1086.3 1091.9 1095.2 1112.8 1117.0 5685.3 5812.7 5814.8 5819.8 5820.6 9329.5 9411.9 9498.8 9631.3 9662.9 9419.2 9420.2 9506.3 9511.7 9518.7 7266.6 7394.1 7480.1 7486.5 7495.0 7099.3 7104.3 7137.9 7144.3 7156.6 8177.6 8398.4 8453.2 8614.8 8633.7 8658.9 8856.1 8858.6 8868.8 8874.3 6919.3 6995.1 6998.0 7008.5 7026.3 6551.7 6687.4 7134.5 7212.5 7248.0 6630.7 6728.6 6863.1 6918.9 6991.1 6601.6 6650.8 6661.7 6777.5 6782.4 6701.4 6727.9 6746.1 6754.0 6754.1 6050.7 6294.5 6309.1 6491.9 6527.1 6425.3 6434.6 6475.6 6481.1 6486.8 14:18:22 INFO - PROCESS | 10533 | 14:18:22 INFO - PROCESS | 10533 | [#4] prototype.html Cycles:180 Average:5216.26 Median:5925.08 stddev:1568.33 (26.5%) stddev-sans-first:1529.20 14:18:22 INFO - PROCESS | 10533 | Values: 327.4 328.9 334.1 337.3 341.7 5751.1 5886.6 5892.4 5892.6 5904.2 5646.7 5808.2 5815.1 5820.9 5824.0 4467.2 4517.4 4518.0 4521.7 4525.3 4298.4 4367.8 4383.9 4493.7 4506.6 4436.0 4438.0 4443.6 4444.8 4449.0 4441.0 4445.3 4450.4 4454.0 4468.8 3949.3 3959.7 3963.6 3965.5 3976.9 5407.4 5537.4 5548.5 5556.4 5563.4 5198.2 5214.7 5218.7 5222.9 5223.1 6170.6 6172.7 6174.7 6184.8 6187.8 4371.7 4374.5 4377.2 4377.8 4379.3 5944.6 6037.5 6390.4 6471.5 6510.0 4448.4 4467.8 4472.4 4474.0 4479.9 4527.4 4532.7 4536.1 4539.3 4539.4 5045.0 5179.6 5191.9 5192.6 5200.5 6245.8 6252.1 6261.3 6263.7 6263.8 1582.6 1603.8 1604.4 1604.6 1606.4 1082.5 1090.3 1111.3 1114.3 1117.5 5915.0 5935.2 5961.5 5962.8 5964.4 6373.7 6380.0 6385.7 6388.8 6401.1 5952.3 5956.0 5957.4 5963.6 5964.3 3352.6 3442.3 3454.5 3455.6 3463.7 6689.2 6773.7 6781.2 6790.7 6795.1 6627.9 6631.2 6631.9 6634.3 6640.5 6587.7 6745.2 6760.5 6762.0 6764.7 6427.0 6458.5 6468.0 6470.8 6471.1 6097.3 6343.5 6378.6 6388.0 6403.9 6376.3 6630.4 6705.2 6744.6 6748.3 4370.5 4429.7 4433.1 4437.2 4439.1 6341.2 6426.5 6444.1 6454.4 6472.9 6306.5 6307.7 6313.1 6315.8 6319.1 6238.5 6249.8 6285.9 6292.2 6292.2 6030.0 6160.1 6177.5 6178.4 6182.1 6316.1 6316.4 6318.1 6320.3 6325.8 6157.0 6159.9 6167.3 6171.0 6175.0 14:18:22 INFO - PROCESS | 10533 | 14:18:22 INFO - PROCESS | 10533 | [#5] yui.html Cycles:180 Average:13064.15 Median:47482.26 stddev:15016.75 (31.6%) stddev-sans-first:15030.34 14:18:22 INFO - PROCESS | 10533 | Values: 736.8 827.8 835.8 846.3 866.1 13129.9 13312.3 13344.7 13352.3 13365.3 10886.5 11119.6 12213.1 12277.9 12333.8 776.1 779.5 780.3 781.5 784.5 782.2 786.6 786.7 787.2 787.3 824.8 830.0 830.3 830.6 831.8 827.5 827.6 828.8 829.1 829.5 617.0 617.2 617.7 617.9 617.9 11957.5 11994.2 12017.8 12026.5 12030.9 10663.4 10764.9 10776.2 10877.6 10899.1 9654.3 9763.5 9843.6 9856.2 9900.3 3480.4 3586.3 3615.3 3622.9 3632.0 42149.8 43710.3 43905.8 44128.3 44160.0 8336.7 8603.1 8614.9 8722.3 8752.2 16177.5 16274.4 16289.8 16351.2 16382.5 7822.8 7959.8 7978.0 8001.4 8046.7 4343.6 4403.1 4479.2 4481.0 4631.7 3072.8 3109.3 3115.4 3116.6 3123.7 562.6 566.4 566.9 569.5 589.5 618.4 646.9 670.3 676.2 679.7 8086.8 8393.9 8500.8 8568.8 8835.4 512.6 578.9 583.8 616.7 713.8 3825.5 3928.5 3986.3 4158.3 4166.6 52028.0 52182.0 55423.0 59127.7 60446.7 47052.0 47556.0 47575.5 47602.8 47662.3 42159.4 42265.0 43617.0 44125.3 47408.5 8697.0 8711.7 8778.6 8781.4 8862.0 33780.3 33838.7 34616.0 34653.8 34808.3 39760.6 39801.0 41593.6 42315.8 44933.8 10361.5 10440.4 10595.5 10869.4 11229.3 11336.2 11682.6 11823.9 11957.6 12079.7 10811.6 10818.8 10876.0 10894.5 10896.3 10615.2 10885.7 10903.8 11034.5 11090.1 11258.4 11497.1 11499.4 11500.9 11556.9 8596.0 9018.3 9088.3 9208.5 9328.4 8757.4 9030.1 9337.0 9479.4 9556.1 14:18:22 INFO - PROCESS | 10533 | -------- Summary: end -------- 14:18:22 INFO - PROCESS | 10533 | 14:18:22 INFO - TEST-INFO | 10533: exit 0 14:18:22 INFO - TEST-OK | dromaeo_css | took 1112971ms 14:18:22 INFO - TEST-START | kraken 14:18:22 INFO - operating with platform_type : linux_ 14:18:22 INFO - Initialising browser for kraken test... 14:18:22 INFO - TEST-INFO | started process 10729 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQbCps2/profile http://localhost:34469/getInfo.html) 14:18:26 INFO - PROCESS | 10729 | __metrics Screen width/height:1600/1200 14:18:26 INFO - PROCESS | 10729 | colorDepth:24 14:18:26 INFO - PROCESS | 10729 | Browser inner width/height: 1024/697 14:18:26 INFO - PROCESS | 10729 | __metrics 14:18:27 INFO - PROCESS | 10729 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:18:27 INFO - PROCESS | 10729 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:18:27 INFO - TEST-INFO | 10729: exit 0 14:18:27 INFO - Browser initialized. 14:18:27 INFO - Running cycle 1/1 for kraken test... 14:18:27 INFO - TEST-INFO | started process 10814 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQbCps2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:18:39 INFO - PROCESS | 10814 | RSS: Main: 149127168 14:18:39 INFO - PROCESS | 10814 | 14:18:42 INFO - PROCESS | 10814 | Cycle 1(1): loaded http://localhost:34469/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34469/tests/kraken/driver.html?testName=audio-beat-detection) 14:18:42 INFO - PROCESS | 10814 | RSS: Main: 186601472 14:18:42 INFO - PROCESS | 10814 | 14:18:45 INFO - PROCESS | 10814 | Cycle 1(1): loaded http://localhost:34469/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34469/tests/kraken/driver.html?testName=audio-dft) 14:18:46 INFO - PROCESS | 10814 | RSS: Main: 177410048 14:18:46 INFO - PROCESS | 10814 | 14:18:48 INFO - PROCESS | 10814 | Cycle 1(1): loaded http://localhost:34469/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34469/tests/kraken/driver.html?testName=audio-fft) 14:18:49 INFO - PROCESS | 10814 | RSS: Main: 161378304 14:18:49 INFO - PROCESS | 10814 | 14:18:51 INFO - PROCESS | 10814 | Cycle 1(1): loaded http://localhost:34469/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34469/tests/kraken/driver.html?testName=audio-oscillator) 14:18:52 INFO - PROCESS | 10814 | RSS: Main: 163028992 14:18:52 INFO - PROCESS | 10814 | 14:18:54 INFO - PROCESS | 10814 | Cycle 1(1): loaded http://localhost:34469/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34469/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:18:54 INFO - PROCESS | 10814 | RSS: Main: 164380672 14:18:54 INFO - PROCESS | 10814 | 14:18:57 INFO - PROCESS | 10814 | Cycle 1(1): loaded http://localhost:34469/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34469/tests/kraken/driver.html?testName=imaging-darkroom) 14:18:58 INFO - PROCESS | 10814 | RSS: Main: 165773312 14:18:58 INFO - PROCESS | 10814 | 14:19:01 INFO - PROCESS | 10814 | Cycle 1(1): loaded http://localhost:34469/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34469/tests/kraken/driver.html?testName=imaging-desaturate) 14:19:02 INFO - PROCESS | 10814 | RSS: Main: 166670336 14:19:02 INFO - PROCESS | 10814 | 14:19:05 INFO - PROCESS | 10814 | Cycle 1(1): loaded http://localhost:34469/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34469/tests/kraken/driver.html?testName=json-parse-financial) 14:19:05 INFO - PROCESS | 10814 | RSS: Main: 166559744 14:19:05 INFO - PROCESS | 10814 | 14:19:07 INFO - PROCESS | 10814 | Cycle 1(1): loaded http://localhost:34469/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34469/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:19:07 INFO - PROCESS | 10814 | RSS: Main: 174288896 14:19:07 INFO - PROCESS | 10814 | 14:19:09 INFO - PROCESS | 10814 | Cycle 1(1): loaded http://localhost:34469/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34469/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:19:10 INFO - PROCESS | 10814 | RSS: Main: 173305856 14:19:10 INFO - PROCESS | 10814 | 14:19:12 INFO - PROCESS | 10814 | Cycle 1(1): loaded http://localhost:34469/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34469/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:19:12 INFO - PROCESS | 10814 | RSS: Main: 185319424 14:19:12 INFO - PROCESS | 10814 | 14:19:15 INFO - PROCESS | 10814 | Cycle 1(1): loaded http://localhost:34469/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34469/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:19:15 INFO - PROCESS | 10814 | RSS: Main: 192495616 14:19:15 INFO - PROCESS | 10814 | 14:19:18 INFO - PROCESS | 10814 | Cycle 1(1): loaded http://localhost:34469/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34469/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:19:18 INFO - PROCESS | 10814 | RSS: Main: 191975424 14:19:18 INFO - PROCESS | 10814 | 14:19:20 INFO - PROCESS | 10814 | Cycle 1(1): loaded http://localhost:34469/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34469/tests/kraken/driver.html?testName=ai-astar) 14:19:20 INFO - PROCESS | 10814 | RSS: Main: 250818560 14:19:20 INFO - PROCESS | 10814 | 14:19:20 INFO - PROCESS | 10814 | __start_tp_report 14:19:20 INFO - PROCESS | 10814 | _x_x_mozilla_page_load 14:19:20 INFO - PROCESS | 10814 | _x_x_mozilla_page_load_details 14:19:20 INFO - PROCESS | 10814 | |i|pagename|runs| 14:19:20 INFO - PROCESS | 10814 | |0;ai-astar;109;110;103;109;109;110;99;109;110;117 14:19:20 INFO - PROCESS | 10814 | |1;audio-beat-detection;147;124;145;164;126;149;151;124;169;126 14:19:20 INFO - PROCESS | 10814 | |2;audio-dft;160;163;159;160;161;160;162;162;161;162 14:19:20 INFO - PROCESS | 10814 | |3;audio-fft;71;72;80;101;72;71;72;120;103;71 14:19:20 INFO - PROCESS | 10814 | |4;audio-oscillator;98;95;151;96;96;96;136;94;97;136 14:19:20 INFO - PROCESS | 10814 | |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;109 14:19:20 INFO - PROCESS | 10814 | |6;imaging-darkroom;147;146;147;145;146;148;145;147;146;145 14:19:20 INFO - PROCESS | 10814 | |7;imaging-desaturate;95;95;96;96;96;96;96;96;96;96 14:19:20 INFO - PROCESS | 10814 | |8;json-parse-financial;56;56;55;56;55;56;56;64;55;62 14:19:20 INFO - PROCESS | 10814 | |9;json-stringify-tinderbox;68;68;67;68;68;68;68;67;67;68 14:19:20 INFO - PROCESS | 10814 | |10;stanford-crypto-aes;83;85;85;85;84;85;86;93;85;92 14:19:20 INFO - PROCESS | 10814 | |11;stanford-crypto-ccm;131;122;121;118;117;120;125;132;115;119 14:19:20 INFO - PROCESS | 10814 | |12;stanford-crypto-pbkdf2;152;145;151;149;151;139;155;154;150;140 14:19:20 INFO - PROCESS | 10814 | |13;stanford-crypto-sha256-iterative;67;67;68;69;66;69;68;68;67;69 14:19:20 INFO - PROCESS | 10814 | __end_tp_report 14:19:20 INFO - PROCESS | 10814 | __start_cc_report 14:19:20 INFO - PROCESS | 10814 | _x_x_mozilla_cycle_collect,946 14:19:20 INFO - PROCESS | 10814 | __end_cc_report 14:19:20 INFO - PROCESS | 10814 | __startTimestamp1452550760868__endTimestamp 14:19:20 INFO - PROCESS | 10814 | 14:19:20 INFO - PROCESS | 10814 | ------- Summary: start ------- 14:19:20 INFO - PROCESS | 10814 | Number of tests: 14 14:19:20 INFO - PROCESS | 10814 | 14:19:20 INFO - PROCESS | 10814 | [#0] ai-astar Cycles:10 Average:108.50 Median:110.00 stddev:4.72 (4.3%) stddev-sans-first:5.00 14:19:20 INFO - PROCESS | 10814 | Values: 109.0 110.0 103.0 109.0 109.0 110.0 99.0 109.0 110.0 117.0 14:19:20 INFO - PROCESS | 10814 | 14:19:20 INFO - PROCESS | 10814 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:148.00 stddev:16.78 (11.3%) stddev-sans-first:17.72 14:19:20 INFO - PROCESS | 10814 | Values: 147.0 124.0 145.0 164.0 126.0 149.0 151.0 124.0 169.0 126.0 14:19:20 INFO - PROCESS | 10814 | 14:19:20 INFO - PROCESS | 10814 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.27 14:19:20 INFO - PROCESS | 10814 | Values: 160.0 163.0 159.0 160.0 161.0 160.0 162.0 162.0 161.0 162.0 14:19:20 INFO - PROCESS | 10814 | 14:19:20 INFO - PROCESS | 10814 | [#3] audio-fft Cycles:10 Average:83.30 Median:71.50 stddev:17.94 (25.1%) stddev-sans-first:18.47 14:19:20 INFO - PROCESS | 10814 | Values: 71.0 72.0 80.0 101.0 72.0 71.0 72.0 120.0 103.0 71.0 14:19:20 INFO - PROCESS | 10814 | 14:19:20 INFO - PROCESS | 10814 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:96.00 stddev:22.14 (23.1%) stddev-sans-first:23.09 14:19:20 INFO - PROCESS | 10814 | Values: 98.0 95.0 151.0 96.0 96.0 96.0 136.0 94.0 97.0 136.0 14:19:20 INFO - PROCESS | 10814 | 14:19:20 INFO - PROCESS | 10814 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 14:19:20 INFO - PROCESS | 10814 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 14:19:20 INFO - PROCESS | 10814 | 14:19:20 INFO - PROCESS | 10814 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:1.03 (0.7%) stddev-sans-first:1.05 14:19:20 INFO - PROCESS | 10814 | Values: 147.0 146.0 147.0 145.0 146.0 148.0 145.0 147.0 146.0 145.0 14:19:20 INFO - PROCESS | 10814 | 14:19:20 INFO - PROCESS | 10814 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 14:19:20 INFO - PROCESS | 10814 | Values: 95.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 14:19:20 INFO - PROCESS | 10814 | 14:19:20 INFO - PROCESS | 10814 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:56.00 stddev:3.18 (5.7%) stddev-sans-first:3.35 14:19:20 INFO - PROCESS | 10814 | Values: 56.0 56.0 55.0 56.0 55.0 56.0 56.0 64.0 55.0 62.0 14:19:20 INFO - PROCESS | 10814 | 14:19:20 INFO - PROCESS | 10814 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 14:19:20 INFO - PROCESS | 10814 | Values: 68.0 68.0 67.0 68.0 68.0 68.0 68.0 67.0 67.0 68.0 14:19:20 INFO - PROCESS | 10814 | 14:19:20 INFO - PROCESS | 10814 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:85.00 stddev:3.37 (4.0%) stddev-sans-first:3.35 14:19:20 INFO - PROCESS | 10814 | Values: 83.0 85.0 85.0 85.0 84.0 85.0 86.0 93.0 85.0 92.0 14:19:20 INFO - PROCESS | 10814 | 14:19:20 INFO - PROCESS | 10814 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:121.50 stddev:5.72 (4.7%) stddev-sans-first:5.05 14:19:20 INFO - PROCESS | 10814 | Values: 131.0 122.0 121.0 118.0 117.0 120.0 125.0 132.0 115.0 119.0 14:19:20 INFO - PROCESS | 10814 | 14:19:20 INFO - PROCESS | 10814 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.60 Median:151.00 stddev:5.52 (3.7%) stddev-sans-first:5.72 14:19:20 INFO - PROCESS | 10814 | Values: 152.0 145.0 151.0 149.0 151.0 139.0 155.0 154.0 150.0 140.0 14:19:20 INFO - PROCESS | 10814 | 14:19:20 INFO - PROCESS | 10814 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.03 (1.5%) stddev-sans-first:1.05 14:19:20 INFO - PROCESS | 10814 | Values: 67.0 67.0 68.0 69.0 66.0 69.0 68.0 68.0 67.0 69.0 14:19:20 INFO - PROCESS | 10814 | -------- Summary: end -------- 14:19:20 INFO - PROCESS | 10814 | 14:19:21 INFO - TEST-INFO | 10814: exit 0 14:19:21 INFO - TEST-OK | kraken | took 59137ms 14:19:21 INFO - TEST-START | v8_7 14:19:21 INFO - operating with platform_type : linux_ 14:19:21 INFO - Initialising browser for v8_7 test... 14:19:21 INFO - TEST-INFO | started process 11064 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfRLgPT/profile http://localhost:34469/getInfo.html) 14:19:25 INFO - PROCESS | 11064 | __metrics Screen width/height:1600/1200 14:19:25 INFO - PROCESS | 11064 | colorDepth:24 14:19:25 INFO - PROCESS | 11064 | Browser inner width/height: 1024/697 14:19:25 INFO - PROCESS | 11064 | __metrics 14:19:25 INFO - PROCESS | 11064 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:19:25 INFO - PROCESS | 11064 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:19:27 INFO - TEST-INFO | 11064: exit 0 14:19:27 INFO - Browser initialized. 14:19:27 INFO - Running cycle 1/1 for v8_7 test... 14:19:27 INFO - TEST-INFO | started process 11147 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfRLgPT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:19:38 INFO - PROCESS | 11147 | RSS: Main: 148828160 14:19:38 INFO - PROCESS | 11147 | 14:20:01 INFO - PROCESS | 11147 | Cycle 1(1): loaded http://localhost:34469/tests/v8_7/run.html (next: http://localhost:34469/tests/v8_7/run.html) 14:20:01 INFO - PROCESS | 11147 | RSS: Main: 585568256 14:20:01 INFO - PROCESS | 11147 | 14:20:01 INFO - PROCESS | 11147 | __start_tp_report 14:20:01 INFO - PROCESS | 11147 | _x_x_mozilla_page_load 14:20:01 INFO - PROCESS | 11147 | _x_x_mozilla_page_load_details 14:20:01 INFO - PROCESS | 11147 | |i|pagename|runs| 14:20:01 INFO - PROCESS | 11147 | |0;Richards;169.37669376693768 14:20:01 INFO - PROCESS | 11147 | |1;DeltaBlue;189.3580761219466 14:20:01 INFO - PROCESS | 11147 | |2;Encrypt;279.56388034665923 14:20:01 INFO - PROCESS | 11147 | |3;Decrypt;5256.544502617801 14:20:01 INFO - PROCESS | 11147 | |4;RayTrace;2000 14:20:01 INFO - PROCESS | 11147 | |5;Earley;791.1392405063291 14:20:01 INFO - PROCESS | 11147 | |6;Boyer;12048.192771084337 14:20:01 INFO - PROCESS | 11147 | |7;RegExp;42854.166666666664 14:20:01 INFO - PROCESS | 11147 | |8;Splay;645.9948320413437 14:20:01 INFO - PROCESS | 11147 | |9;NavierStokes;4830.917874396136 14:20:01 INFO - PROCESS | 11147 | __end_tp_report 14:20:01 INFO - PROCESS | 11147 | __startTimestamp1452550801516__endTimestamp 14:20:01 INFO - PROCESS | 11147 | 14:20:01 INFO - PROCESS | 11147 | ------- Summary: start ------- 14:20:01 INFO - PROCESS | 11147 | Number of tests: 10 14:20:01 INFO - PROCESS | 11147 | 14:20:01 INFO - PROCESS | 11147 | [#0] Richards Cycles:1 Average:169.38 Median:169.38 stddev:0.00 (0.0%) 14:20:01 INFO - PROCESS | 11147 | Values: 169.4 14:20:01 INFO - PROCESS | 11147 | 14:20:01 INFO - PROCESS | 11147 | [#1] DeltaBlue Cycles:1 Average:189.36 Median:189.36 stddev:0.00 (0.0%) 14:20:01 INFO - PROCESS | 11147 | Values: 189.4 14:20:01 INFO - PROCESS | 11147 | 14:20:01 INFO - PROCESS | 11147 | [#2] Encrypt Cycles:1 Average:279.56 Median:279.56 stddev:0.00 (0.0%) 14:20:01 INFO - PROCESS | 11147 | Values: 279.6 14:20:01 INFO - PROCESS | 11147 | 14:20:01 INFO - PROCESS | 11147 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 14:20:01 INFO - PROCESS | 11147 | Values: 5256.5 14:20:01 INFO - PROCESS | 11147 | 14:20:01 INFO - PROCESS | 11147 | [#4] RayTrace Cycles:1 Average:2000.00 Median:2000.00 stddev:0.00 (0.0%) 14:20:01 INFO - PROCESS | 11147 | Values: 2000.0 14:20:01 INFO - PROCESS | 11147 | 14:20:01 INFO - PROCESS | 11147 | [#5] Earley Cycles:1 Average:791.14 Median:791.14 stddev:0.00 (0.0%) 14:20:01 INFO - PROCESS | 11147 | Values: 791.1 14:20:01 INFO - PROCESS | 11147 | 14:20:01 INFO - PROCESS | 11147 | [#6] Boyer Cycles:1 Average:12048.19 Median:12048.19 stddev:0.00 (0.0%) 14:20:01 INFO - PROCESS | 11147 | Values: 12048.2 14:20:01 INFO - PROCESS | 11147 | 14:20:01 INFO - PROCESS | 11147 | [#7] RegExp Cycles:1 Average:42854.17 Median:42854.17 stddev:0.00 (0.0%) 14:20:01 INFO - PROCESS | 11147 | Values: 42854.2 14:20:01 INFO - PROCESS | 11147 | 14:20:01 INFO - PROCESS | 11147 | [#8] Splay Cycles:1 Average:645.99 Median:645.99 stddev:0.00 (0.0%) 14:20:01 INFO - PROCESS | 11147 | Values: 646.0 14:20:01 INFO - PROCESS | 11147 | 14:20:01 INFO - PROCESS | 11147 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 14:20:01 INFO - PROCESS | 11147 | Values: 4830.9 14:20:01 INFO - PROCESS | 11147 | -------- Summary: end -------- 14:20:01 INFO - PROCESS | 11147 | 14:20:02 INFO - TEST-INFO | 11147: exit 0 14:20:02 INFO - TEST-OK | v8_7 | took 40615ms 14:20:02 INFO - SUITE-END | took 1212s 14:20:02 INFO - Completed test suite (00:20:12) 14:20:02 INFO - Working with test: dromaeo_css 14:20:02 INFO - Generating results file: dromaeo_css 14:20:02 INFO - Working with test: kraken 14:20:02 INFO - Generating results file: kraken 14:20:02 INFO - javascript benchmark 14:20:02 INFO - Working with test: v8_7 14:20:02 INFO - Generating results file: v8_7 14:20:02 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:20:06 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 14:20:06 INFO - process_Request line: dromaeo_css 6765.22 graph.html#tests=[[72,201,35]] 14:20:06 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:20:06 INFO - process_Request line: kraken 1505.30 graph.html#tests=[[232,201,35]] 14:20:06 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:20:06 INFO - process_Request line: v8_7 18710.80 graph.html#tests=[[230,201,35]] 14:20:06 INFO - RETURN: dromaeo_css: 6765.22 14:20:06 INFO - RETURN: kraken: 1505.30 14:20:06 INFO - RETURN: v8_7: 18710.80 14:20:06 INFO - javascript benchmark 14:20:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3086.5215891536814, 3150.5746724192227, 3192.6009248843893, 3195.5046967720014, 3222.9355412891737, 5063.5949124070075, 5101.413337466192, 5131.025105230004, 5168.328117344745, 5177.068127737015, 5113.38639363276, 5192.662476938996, 5259.053370393328, 5288.629795914288, 5295.602829787772, 4689.859304220879, 4691.88270293242, 4735.857924262269, 4847.951520484803, 4870.586000189988, 4777.498362671921, 4837.443693975185, 4859.757012149396, 4920.3111564381015, 4927.704337739729, 4570.360149579062, 4642.953570464286, 4678.228092364756, 4713.222318317474, 4724.055188962187, 4656.092062047902, 4658.464276608166, 4672.57946784791, 4677.204875171229, 4702.247640377524, 4531.229690952546, 4651.674382793206, 4658.277966915133, 4681.578657920803, 4692.436907571113, 4964.304997300381, 4990.600751939836, 5068.822591209327, 5070.062038522885, 5076.822311219126, 5515.751791169407, 5515.944840551583, 5524.309461317335, 5532.917006244909, 5533.253010843565, 5370.382406023318, 5455.072637651609, 5546.83673367387, 5594.832155035356, 5595.300587426572, 5145.485451454824, 5174.068667639824, 5271.05121078202, 5279.604029697788, 5298.443663415324, 5706.172604972338, 5710.229119068873, 5724.427557244326, 5751.0, 5792.623479473821, 5340.172273297568, 5456.508914197741, 5527.336719593674, 5528.032594295983, 5533.335999680065, 5469.726513674301, 5513.42109078549, 5604.103343465026, 5611.354694210218, 5612.579056570774, 5510.393856675762, 5516.255305533782, 5519.089350257243, 5521.365043020024, 5526.281583394213, 5462.071447853875, 5520.57482685787, 5523.25436066134, 5527.944720552743, 5580.693061881636, 4183.330667093251, 4236.915261694749, 4274.252005899018, 4316.395704601358, 4336.046069864625, 3859.421086836941, 3864.2851072551666, 3874.9031274217805, 3876.127871228951, 3902.2585708715255, 5057.519535644108, 5187.662801917863, 5193.221016847503, 5196.53231209193, 5243.606729495303, 5449.891002180014, 5456.945430545723, 5503.449655034465, 5566.805161819317, 5621.690807005572, 5147.536721695065, 5194.27280180775, 5199.142141546678, 5199.662021968636, 5201.505856943584, 4634.652401069933, 4780.976095119572, 4786.282057691375, 4790.976045119752, 4830.396200474941, 5597.244372009808, 5723.6851973141875, 5790.768369265266, 5802.361740208658, 5845.123231515222, 5496.917546236729, 5499.890002200013, 5501.339839219159, 5502.339719233718, 5506.614536982373, 5699.116636921284, 5715.39988301239, 5719.0277652798295, 5719.3136823581435, 5741.339745929272, 5417.349918009864, 5449.400565937823, 5454.754536045808, 5470.753816078206, 5509.421510741475, 5569.916451253315, 5573.526250268773, 5573.749181286771, 5574.637648552831, 5580.0, 5281.973590132025, 5328.706921119376, 5381.542568881689, 5480.0, 5482.122860342326, 5285.392179899207, 5335.67985920846, 5339.519443250126, 5343.171808369709, 5343.839684809462, 5253.159494480865, 5256.789728410974, 5261.631685781958, 5261.684298942076, 5274.1034024215205, 5295.073362161684, 5336.412994570516, 5347.251384806053, 5360.490753378423, 5373.382061063028, 5308.230306605597, 5399.0, 5407.810726624549, 5422.8373148805595, 5422.945770542244], "unit": "score", "name": "dojo.html", "value": 5110.255783563451}, {"lowerIsBetter": false, "replicates": [526.2133110999057, 545.4409230538698, 562.1764115570688, 565.6464709556527, 577.1026054485276, 27852.164435066956, 28566.57150142747, 34866.953991380266, 35300.646993530056, 35366.46950295748, 38615.42076868842, 38986.41520377197, 38992.61007389925, 39024.0, 39079.0, 8463.492190468562, 8688.56557172142, 8690.522021288827, 8691.652333906668, 8696.478211307342, 7454.068241469817, 7637.083549973983, 9889.159421449185, 10101.343412678189, 10102.545385457672, 10114.089731924125, 10237.334573252714, 10255.692329230134, 10256.179505639531, 10263.076323130917, 7486.5508069516, 7684.769456916301, 10040.0, 10085.243606729488, 10207.693769186937, 7413.666385012633, 9929.90070099297, 10120.9373015833, 10181.490925453698, 10227.386356818615, 35005.824970875234, 35363.64636353655, 35408.46887296693, 35489.29021419583, 35511.4673279901, 3297.159224397787, 3352.0, 3366.764326497146, 3397.4903764435285, 3763.8306276217636, 27770.16689499318, 28011.859940700167, 28198.295042623893, 28246.293842654097, 30744.2313942151, 3969.861054863095, 3993.1414745829784, 4003.179348233605, 4141.316682747343, 4198.895027624303, 259574.0, 259740.0, 260092.0, 260093.0, 260564.0, 51523.22715159276, 52247.73876130595, 57562.0, 60134.0, 61067.389326107055, 54259.0, 54752.0, 54983.0, 55058.72470637621, 55109.1733623996, 14863.777043344358, 15063.397464101532, 15082.321295541728, 15107.093574385572, 15109.244537773067, 11181.993620574187, 11252.943735281271, 11261.324320540794, 11262.04272636835, 11474.48364823585, 20037.398878033684, 20280.290189843283, 20302.390928272176, 20362.898185509275, 20368.166864982224, 7170.2471240520035, 7303.963480182671, 7308.926910730931, 7368.189499155089, 7428.182899881009, 876.3471213945651, 966.1160038564634, 1008.9041541053588, 1041.4376236832177, 1065.3394895164893, 28085.35726241211, 28801.711982880322, 29245.268868278465, 29454.558181627293, 29495.410091798472, 1009.1271050541376, 1053.8524606555088, 1067.3595842494597, 1108.9833652495058, 1130.745582244005, 13736.65658358529, 14201.644958876112, 14350.856491435161, 14470.0, 14535.0, 443303.0, 448159.0, 449517.0, 450882.0, 453186.0, 49369.0, 49682.50317496851, 49774.50225497771, 49803.50196498061, 49824.25263621048, 1327.794191900257, 1328.4354149486624, 1331.261150061725, 1334.7797613393682, 1372.2246930484243, 27403.725962740118, 28330.716692833634, 28413.0, 28568.428631427672, 28615.28461788472, 43559.0, 44217.33673994828, 44264.77867610641, 44293.0, 44309.77845110754, 237573.0, 238880.0, 239175.0, 240090.0, 240309.0, 27997.300067498476, 31369.37261254808, 31802.204944876565, 32000.6799932007, 32272.83863580761, 37710.0, 39832.90501185749, 40207.19585608213, 40845.591544085364, 41057.58942410657, 34365.48451773275, 34630.480542792386, 34855.651443486255, 34927.12682182864, 35476.64523354734, 30302.848485758313, 32801.50797738084, 34671.65328346684, 35558.822205888806, 37127.0, 32613.18467038343, 32772.672273277916, 35235.47146792852, 35845.0, 35919.82040089783, 28208.717912820608, 29715.702842972158, 30271.18372897633, 30400.84799575988, 30407.239819004702, 23146.884265578563, 23480.882595586914, 23527.529449411257, 23634.172803952468, 23801.0], "unit": "score", "name": "ext.html", "value": 18118.829831275565}, {"lowerIsBetter": false, "replicates": [352.56986476498673, 356.24476110645435, 359.4249201277954, 360.67178867230825, 362.3387318144386, 13330.0, 13786.310684465787, 16092.678146437063, 16674.49976500704, 17887.64224715505, 15129.789616830654, 16264.593385165348, 16732.0, 16909.323627054902, 16970.745438818398, 5308.893822123555, 5484.2596249506205, 5488.725563721798, 5497.532709719659, 5503.036968530511, 3956.0703234739813, 4126.09225970286, 5215.243789650498, 5297.814576489824, 5838.2702162229725, 5996.2804463464445, 6008.879822403549, 6036.577439579231, 6040.818775436744, 6041.395860413945, 5085.847424577269, 5274.894502109936, 5279.04977104123, 5289.285946397225, 5290.947090529084, 4903.877403064952, 5083.186690129562, 5092.363454568179, 5183.870403239912, 5185.0, 19097.61804763911, 19668.311609093755, 19777.0, 19782.0, 19929.0, 2017.798220177985, 2029.9492512687152, 2047.2936836791282, 2076.719642848211, 2159.5680863827142, 9160.954195229047, 9577.952110239474, 9795.461249631267, 11953.581624643095, 12482.50069997199, 1800.5768644368563, 1874.8031456696988, 1897.155765684271, 1952.8632995690307, 1963.8330741886957, 48524.0, 49893.25160122601, 53385.733071334784, 55577.72211138919, 56261.0, 9504.809903801885, 9524.666636667684, 9592.76018099553, 9711.611535538641, 10065.295429320024, 12784.04119691027, 12834.871651283367, 12866.48534058646, 12878.162919410208, 12918.547850825176, 7234.674439650228, 7260.310270524292, 7350.77947661571, 7434.1822399536, 7531.924680753232, 7089.89365159523, 7347.228541003117, 7360.889586656204, 7363.484556081023, 7389.630518474162, 4305.612494875476, 4349.891252718708, 4354.194474022316, 4367.27939889921, 4384.934225986613, 1673.9665206695797, 1731.6709825133184, 1748.4492384898717, 1775.9931277656167, 1809.4209852847225, 857.5455008845322, 915.4507295622573, 918.081918081918, 950.6625148072335, 1014.9949250253701, 15523.37906483728, 15652.608684782972, 16352.75470867938, 16519.421820236235, 16873.915630422016, 943.3019565521465, 946.4557879219476, 979.3780949097232, 997.4464172384252, 1031.3811712972156, 9422.764430889145, 9542.713718588453, 9606.27952903535, 9623.663171789094, 9786.902130978599, 355576.0, 506777.0, 507659.0, 521862.0, 533225.0, 55455.44544554583, 70086.64956675185, 72436.275637244, 73020.0, 73883.63058184675, 1006.0744115413837, 1017.9847302290472, 1022.4785359466576, 1023.1916785739331, 1051.101308381323, 11172.55309787632, 13308.401121949342, 14832.925835370754, 15009.549713508612, 15334.846651533342, 28538.0, 29112.12663620095, 32182.0, 32863.0, 33000.00999969909, 38928.805355974175, 38972.0, 39709.40435893406, 40189.0, 40382.79808601056, 7163.892541611985, 7186.964065179641, 7219.530730502501, 7303.123625165014, 7420.072490938633, 10790.622328218475, 11379.63444386679, 11411.0, 11442.37066961325, 11535.826962595736, 9507.857382139135, 9602.183814375578, 9651.9034809651, 9904.0, 10014.19886409071, 9653.855192171983, 10011.849822252818, 10025.097741203326, 10124.60672090981, 10201.234907381828, 9465.432074075577, 9544.809103818023, 9993.400395976265, 10152.796944061225, 10178.541965611417, 7428.628568571442, 7452.21751716062, 7453.515521491086, 7546.584937828253, 7563.319301262913, 9176.128267814547, 9714.465704386326, 10112.342697724624, 10183.643572474928, 10303.639372621923], "unit": "score", "name": "jquery.html", "value": 8058.684126205358}, {"lowerIsBetter": false, "replicates": [1314.5530519623326, 1430.349191118041, 1443.213448670475, 1578.4948816378756, 1743.8779285450007, 6749.156355455568, 7359.300866417689, 7480.214577469362, 7484.738034168805, 7494.362979146766, 7419.591922444263, 7612.543247405146, 7616.847663046736, 7617.885731714029, 7626.245963428415, 1953.7753158386754, 2007.3074789197703, 2165.8375621828345, 2218.367765186922, 2283.383486458655, 2353.6940197774265, 2357.49313897512, 2361.622140457527, 2365.858048517086, 2365.89353479093, 2189.430748005522, 2199.0434161139874, 2199.813015893651, 2203.6914831923464, 2205.7683943185975, 2238.373255488466, 2244.02384962541, 2299.137823316265, 2312.8727919964394, 2317.953640927189, 2276.2147059264526, 2299.1493147535352, 2308.319045881469, 2312.9421764455856, 2312.97687023131, 7643.273888980538, 7685.154632990367, 7687.923120768776, 7692.230776922263, 7699.730509432143, 4705.0, 4787.425508938914, 4802.207635740134, 4829.227323628203, 4838.806447742121, 3100.3334283129234, 3121.4069326828057, 3150.8582113804705, 3157.037103683376, 3193.5688682028094, 1023.5649848814224, 1035.5909415780725, 1073.849661047454, 1076.6285631457135, 1085.6200329884557, 10625.149988000941, 10692.358458492516, 10712.46437678113, 10719.6784096478, 10726.624568140156, 4213.662906967435, 4308.987387963826, 4325.416068830667, 4328.935065974013, 4344.565543445693, 9126.36115471924, 9133.77165570866, 9135.497547634812, 9136.725898223063, 9138.13187747163, 4789.353437285991, 4800.303955926371, 4834.927476087862, 4835.0571638530855, 4843.055604157226, 4398.978005110018, 4400.4939431965095, 4401.2517871961845, 4404.07514421975, 4405.493368262691, 3336.115929278743, 3435.9828200858838, 3441.294534620397, 3529.94705079424, 3595.9820200899353, 1175.9470823812949, 1189.7858385490522, 1189.9583514576948, 1201.7956947318976, 1236.9010479161645, 1298.9870101298866, 1315.5921664284103, 1338.732253549294, 1347.5418357758408, 1348.4269185596083, 6980.965095174492, 7082.681279342442, 7092.822679433056, 7092.822679433056, 7182.102237220348, 1086.2884810449168, 1091.9344839309667, 1095.1676725688376, 1112.8330750387506, 1116.9553217871194, 5685.3177618685195, 5812.680302583399, 5814.767409303665, 5819.767209311664, 5820.563457740686, 9329.486878221764, 9411.905880941104, 9498.810023799486, 9631.277654175965, 9662.855057174149, 9419.15227629503, 9420.152186303128, 9506.33455658111, 9511.714648560554, 9518.714438566854, 7266.63666816657, 7394.112706475257, 7480.139783924809, 7486.4759466836795, 7494.962525187449, 7099.325564071405, 7104.325089116525, 7137.85724285501, 7144.3212894774915, 7156.606386648784, 8177.550234736908, 8398.370122240734, 8453.239208471266, 8614.82770344602, 8633.740987770378, 8658.91341086581, 8856.114388561093, 8858.557072146237, 8868.822623547621, 8874.290056795311, 6919.342662447059, 6995.125609298838, 6998.0, 7008.5094043416475, 7026.262242464468, 6551.705173267119, 6687.431568316748, 7134.536255143399, 7212.4951253411755, 7247.9637601811655, 6630.668466576555, 6728.629925354153, 6863.10779598649, 6918.896216556856, 6991.126109236346, 6601.636909969998, 6650.800475985535, 6661.733530658719, 6777.491688123312, 6782.389584937379, 6701.430378417889, 6727.932720672927, 6746.123004009447, 6754.0, 6754.054432379373, 6050.667213303311, 6294.464970477377, 6309.053641953744, 6491.902621460777, 6527.086207930988, 6425.293217746138, 6434.581752186093, 6475.64383958868, 6481.125048118633, 6486.805395838132], "unit": "score", "name": "mootools.html", "value": 4484.089902565013}, {"lowerIsBetter": false, "replicates": [327.3600111781467, 328.93256882339125, 334.1245935648601, 337.2714935738805, 341.69589065731503, 5751.137329400592, 5886.617369870961, 5892.440218179271, 5892.587518873681, 5904.1734157218025, 5646.6894320812335, 5808.2449281593335, 5815.098659707742, 5820.854478638036, 5823.970880145594, 4467.218236808561, 4517.390152329426, 4517.977410112945, 4521.7286962782255, 4525.2533332000185, 4298.376735373369, 4367.759773212472, 4383.9342409863875, 4493.662975276868, 4506.639468842501, 4435.955640443586, 4437.977810110961, 4443.5556444355625, 4444.799904025911, 4448.998975230564, 4440.955590444087, 4445.333200019991, 4450.443694538183, 4454.042380888092, 4468.843590474317, 3949.2891279569667, 3959.742616729903, 3963.6036396360423, 3965.504311961005, 3976.8608098716695, 5407.378151512547, 5537.390887002426, 5548.472895074961, 5556.416576259475, 5563.415841336682, 5198.168293073128, 5214.739263036833, 5218.6868787872845, 5222.8694282642855, 5223.08595995703, 6170.598911070811, 6172.660503672296, 6174.722137503823, 6184.84537886552, 6187.783427580058, 4371.650267978586, 4374.475062992461, 4377.23398405281, 4377.781110944472, 4379.343098535245, 5944.554158438134, 6037.516998640098, 6390.392912673335, 6471.5146364022885, 6509.990951402588, 4448.4439445069365, 4467.843625473093, 4472.418585583919, 4474.038081812426, 4479.865604031885, 4527.366168736379, 4532.70537415067, 4536.138133754576, 4539.31910213464, 4539.432570928634, 5044.974775126174, 5179.585633149414, 5191.896162076738, 5192.584593232532, 5200.479952004769, 6245.781397651152, 6252.124702541648, 6261.342559031327, 6263.655498947602, 6263.812085637438, 1582.5806161367248, 1603.7995250593676, 1604.4464659692387, 1604.5747876812654, 1606.437746788638, 1082.53992053377, 1090.334895713614, 1111.2943281016612, 1114.3091283404178, 1117.4692021289984, 5914.970425147847, 5935.198748168942, 5961.479822645198, 5962.791302304486, 5964.403559644001, 6373.681315934185, 6380.042993551005, 6385.712642931079, 6388.840278993062, 6401.07184458251, 5952.345242023374, 5956.0, 5957.4042595740075, 5963.582549221513, 5964.254468191476, 3352.6479719629087, 3442.2599141184764, 3454.464557993465, 3455.585329760445, 3463.7229021678204, 6689.230738465041, 6773.695183716744, 6781.152355955505, 6790.660466976631, 6795.082663840417, 6627.900581491282, 6631.23740769808, 6631.86736265272, 6634.270230274666, 6640.468762498988, 6587.670616469158, 6745.224299205556, 6760.459163266927, 6761.966190169116, 6764.695588698521, 6426.967865160645, 6458.515611329263, 6468.0, 6470.773522926675, 6471.123374221611, 6097.298810636834, 6343.492520598249, 6378.553501254868, 6387.968060159669, 6403.935960640334, 6376.298607153117, 6630.403263706289, 6705.195376554844, 6744.62904540255, 6748.312921769558, 4370.497392799869, 4429.68992170545, 4433.135538569948, 4437.179121862466, 4439.089986552814, 6341.175647165839, 6426.4537514311805, 6444.065610486359, 6454.354564543696, 6472.902906456313, 6306.495480361652, 6307.684615769102, 6313.084602732486, 6315.778947736991, 6319.115323854756, 6238.500919926304, 6249.812505624838, 6285.905711414424, 6292.244930608356, 6292.244930608356, 6030.0, 6160.075988601567, 6177.4749146323065, 6178.443940045418, 6182.072689096672, 6316.084167795736, 6316.399942005502, 6318.052292156213, 6320.336364681642, 6325.778597749057, 6156.969215153896, 6159.907601385893, 6167.259928808572, 6171.0, 6175.023992322594], "unit": "score", "name": "prototype.html", "value": 4711.453522817384}, {"lowerIsBetter": false, "replicates": [736.8378956629541, 827.8344331133771, 835.7618078847526, 846.3483117999139, 866.1035827918106, 13129.934350328247, 13312.334383280833, 13344.733105337911, 13352.33238338084, 13365.331733413315, 10886.455677216127, 11119.610813621524, 12213.084018698612, 12277.938610306936, 12333.814992775115, 776.1423626892288, 779.5089093870881, 780.321120625057, 781.468601351081, 784.5175217241413, 782.2099679323895, 786.5713186313444, 786.7285786403681, 787.1656044592721, 787.3189690917344, 824.8391563645091, 829.9668013279462, 830.3357314148657, 830.6469750356105, 831.787894087007, 827.4952279109739, 827.5862068965517, 828.8383765165765, 829.1294141151767, 829.4981536170591, 617.0312609203552, 617.1606615003592, 617.6633734614646, 617.8826023055605, 617.9134921111048, 11957.521699132025, 11994.16040877139, 12017.759644807142, 12026.518939242507, 12030.939845300718, 10663.413512256822, 10764.892351076545, 10776.245662803607, 10877.619283325124, 10899.073578745816, 9654.27592930533, 9763.511824408823, 9843.557039933221, 9856.162226210781, 9900.306978511508, 3480.3735327641016, 3586.336527742376, 3615.349237137314, 3622.873199438007, 3631.9818400907825, 42149.78925105386, 43710.344344834855, 43905.78047109776, 44128.33807492858, 44160.012799424105, 8336.666533338599, 8603.139686031347, 8614.91385086141, 8722.30221582272, 8752.168543988311, 16177.514674559781, 16274.43039493612, 16289.837101628833, 16351.182440877908, 16382.508524744277, 7822.804429889185, 7959.8408031839035, 7977.960110199412, 8001.359891208689, 8046.718364857319, 4343.609075183249, 4403.075354175595, 4479.171353299585, 4481.036577135931, 4631.675782695179, 3072.830994295335, 3109.3159504908886, 3115.3613509230554, 3116.6104236970377, 3123.6563977962405, 562.5612022622361, 566.3656704490996, 566.931968163823, 569.4647031790187, 589.5401586762332, 618.3630860213987, 646.9223693156852, 670.276101810044, 676.1885737115481, 679.741698154698, 8086.83826323482, 8393.916060839436, 8500.787480313042, 8568.828623427622, 8835.425697329652, 512.6206607110786, 578.869754305278, 583.8306891001562, 616.6669998201011, 713.7822963996031, 3825.5218097737784, 3928.52857657083, 3986.3023970804993, 4158.272302347138, 4166.584173117691, 52028.0, 52182.0, 55423.0, 59127.70436147792, 60446.697766510886, 47052.0, 47556.0, 47575.5242447578, 47602.76198618985, 47662.28506572404, 42159.36760948588, 42265.0, 43617.0, 44125.33811992823, 47408.5259147411, 8697.0, 8711.695090671796, 8778.648854046021, 8781.385303028726, 8862.0, 33780.3243935115, 33838.66161338454, 34616.0, 34653.82673086618, 34808.30383392267, 39760.60239397685, 39801.00497487586, 41593.58406416018, 42315.78842105893, 44933.775331123135, 10361.481925903825, 10440.37357758537, 10595.523201455799, 10869.43501696958, 11229.3262404256, 11336.206465547333, 11682.591109311134, 11823.920747342154, 11957.581484647995, 12079.698007549881, 10811.6215932442, 10818.783624327627, 10876.0, 10894.509747061244, 10896.291741036806, 10615.203859710708, 10885.673429797118, 10903.78192436131, 11034.503447344729, 11090.112790976864, 11258.437078146224, 11497.137714671266, 11499.367534785668, 11500.907413795676, 11556.884431155917, 8595.957020214859, 9018.323625727966, 9088.272938164799, 9208.493532855757, 9328.39365441244, 8757.430767000125, 9030.142136497023, 9337.0, 9479.383840050376, 9556.139947404767], "unit": "score", "name": "yui.html", "value": 6081.183006969664}], "name": "dromaeo_css", "value": 6765.22202575872}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 103.0, 109.0, 109.0, 110.0, 99.0, 109.0, 110.0, 117.0], "unit": "score", "name": "ai-astar", "value": 108.5}, {"lowerIsBetter": true, "replicates": [147.0, 124.0, 145.0, 164.0, 126.0, 149.0, 151.0, 124.0, 169.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 142.5}, {"lowerIsBetter": true, "replicates": [160.0, 163.0, 159.0, 160.0, 161.0, 160.0, 162.0, 162.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 80.0, 101.0, 72.0, 71.0, 72.0, 120.0, 103.0, 71.0], "unit": "score", "name": "audio-fft", "value": 83.3}, {"lowerIsBetter": true, "replicates": [98.0, 95.0, 151.0, 96.0, 96.0, 96.0, 136.0, 94.0, 97.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 145.0, 146.0, 148.0, 145.0, 147.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 55.0, 56.0, 55.0, 56.0, 56.0, 64.0, 55.0, 62.0], "unit": "score", "name": "json-parse-financial", "value": 57.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 85.0, 85.0, 84.0, 85.0, 86.0, 93.0, 85.0, 92.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.3}, {"lowerIsBetter": true, "replicates": [131.0, 122.0, 121.0, 118.0, 117.0, 120.0, 125.0, 132.0, 115.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.0}, {"lowerIsBetter": true, "replicates": [152.0, 145.0, 151.0, 149.0, 151.0, 139.0, 155.0, 154.0, 150.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.6}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 69.0, 66.0, 69.0, 68.0, 68.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1505.2999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.37669376693768], "unit": "score", "name": "Richards", "value": 208.42300800000004}, {"lowerIsBetter": false, "replicates": [189.3580761219466], "unit": "score", "name": "DeltaBlue", "value": 349.16915799999987}, {"lowerIsBetter": false, "replicates": [279.56388034665923], "unit": "score", "name": "Encrypt", "value": 952.1294369999999}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [2000.0], "unit": "score", "name": "RayTrace", "value": 369.9945}, {"lowerIsBetter": false, "replicates": [791.1392405063291], "unit": "score", "name": "Earley", "value": 842.4092320000002}, {"lowerIsBetter": false, "replicates": [12048.192771084337], "unit": "score", "name": "Boyer", "value": 55.31642899999996}, {"lowerIsBetter": false, "replicates": [42854.166666666664], "unit": "score", "name": "RegExp", "value": 21.257792902284876}, {"lowerIsBetter": false, "replicates": [645.9948320413437], "unit": "score", "name": "Splay", "value": 126.148068}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 18710.798259712134}]} 14:20:06 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "18710.80"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1505.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6765.22"}}} 14:20:06 INFO - Return code: 0 14:20:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:20:06 INFO - # TBPL SUCCESS # 14:20:06 INFO - Running post-action listener: _resource_record_post_action 14:20:06 INFO - Running post-run listener: _resource_record_post_run 14:20:07 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 340217856; Read time: 0; Write time: 222148 14:20:08 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 20844544; Read time: 0; Write time: 4948 14:20:08 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 319373312; Read time: 0; Write time: 217200 14:20:08 INFO - Running post-run listener: _upload_blobber_files 14:20:08 INFO - Blob upload gear active. 14:20:08 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:20:08 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:20:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 14:20:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 14:20:08 INFO - (blobuploader) - INFO - Open directory for files ... 14:20:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:20:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:20:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:20:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:20:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:20:09 INFO - (blobuploader) - INFO - Done attempting. 14:20:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:20:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:20:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:20:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:20:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:20:10 INFO - (blobuploader) - INFO - Done attempting. 14:20:10 INFO - (blobuploader) - INFO - Iteration through files over. 14:20:10 INFO - Return code: 0 14:20:10 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:20:10 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:20:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ff37a888d5c0686f63cd0fa640a00afbcc504f3f54175a4130c32f38ec988a875c8107aec1541bbc71adb1ab30abf82f756f2dfb2e07b538c0a0879b3e36f938", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/a72902919755a5ffb5ca15c88bff7f6e9bbd5e452933b2829c934145c4d9b3f697837e5778dcfc2502e021b72ac2af9bcf3aa1a2273b79e0e7f45db8c918a5f9"} 14:20:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:20:10 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:20:10 INFO - Contents: 14:20:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ff37a888d5c0686f63cd0fa640a00afbcc504f3f54175a4130c32f38ec988a875c8107aec1541bbc71adb1ab30abf82f756f2dfb2e07b538c0a0879b3e36f938", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/a72902919755a5ffb5ca15c88bff7f6e9bbd5e452933b2829c934145c4d9b3f697837e5778dcfc2502e021b72ac2af9bcf3aa1a2273b79e0e7f45db8c918a5f9"} 14:20:10 INFO - Copying logs to upload dir... 14:20:10 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1297.522273 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-01-11 14:20:10.084507) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 14:20:10.088100) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338 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/ff37a888d5c0686f63cd0fa640a00afbcc504f3f54175a4130c32f38ec988a875c8107aec1541bbc71adb1ab30abf82f756f2dfb2e07b538c0a0879b3e36f938", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/a72902919755a5ffb5ca15c88bff7f6e9bbd5e452933b2829c934145c4d9b3f697837e5778dcfc2502e021b72ac2af9bcf3aa1a2273b79e0e7f45db8c918a5f9"} build_url:https://queue.taskcluster.net/v1/task/PFR1WJEaSvOlaeMfH9VchA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011457 build_url: 'https://queue.taskcluster.net/v1/task/PFR1WJEaSvOlaeMfH9VchA/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/ff37a888d5c0686f63cd0fa640a00afbcc504f3f54175a4130c32f38ec988a875c8107aec1541bbc71adb1ab30abf82f756f2dfb2e07b538c0a0879b3e36f938", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/a72902919755a5ffb5ca15c88bff7f6e9bbd5e452933b2829c934145c4d9b3f697837e5778dcfc2502e021b72ac2af9bcf3aa1a2273b79e0e7f45db8c918a5f9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 14:20:10.113053) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 14:20:10.113414) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452549254.356605-464866338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004566 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 14:20:10.197725) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 14:20:10.198090) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 14:20:10.198433) ========= ========= Total master_lag: 0.23 =========