builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-007 starttime: 1451886509.2 results: success (0) buildid: 20160103193144 builduid: 7270c7ddc1b4482ea7844f7d9cebdb1f revision: 6aedf1738475bac8518ae801b9df94dec0ade363 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-03 21:48:29.197722) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-03 21:48:29.198214) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-03 21:48:29.198658) ========= 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=6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006304 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-03 21:48:29.237456) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-03 21:48:29.237765) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-03 21:48:29.256099) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 21:48:29.256481) ========= 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=6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 21:48:29.312494) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-03 21:48:29.312943) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-03 21:48:29.313563) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 21:48:29.314023) ========= 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=6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-03 21:48:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.6M=0s 2016-01-03 21:48:29 (43.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164560 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 21:48:29.497066) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 21:48:29.497412) ========= 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=6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015089 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 21:48:29.548326) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 21:48:29.548667) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 6aedf1738475bac8518ae801b9df94dec0ade363 --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/mozilla-inbound --rev 6aedf1738475bac8518ae801b9df94dec0ade363 --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=6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-03 21:48:30,102 truncating revision to first 12 chars 2016-01-03 21:48:30,103 Setting DEBUG logging. 2016-01-03 21:48:30,103 attempt 1/10 2016-01-03 21:48:30,103 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/6aedf1738475?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-03 21:48:30,338 unpacking tar archive at: mozilla-inbound-6aedf1738475/testing/mozharness/ program finished with exit code 0 elapsedTime=0.522127 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 21:48:30.085156) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-03 21:48:30.085467) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-03 21:48:30.095845) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-03 21:48:30.096169) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-03 21:48:30.096625) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-03 21:48:30.096954) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-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=6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:48:30 INFO - MultiFileLogger online at 20160103 21:48:30 in /builds/slave/test-pgo 21:48:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 21:48:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:48:30 INFO - {'append_to_log': False, 21:48:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:48:30 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:48:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:48:30 INFO - 'branch': 'Mozilla-Inbound', 21:48:30 INFO - 'buildbot_json_path': 'buildprops.json', 21:48:30 INFO - 'config_files': ('talos/linux_config.py',), 21:48:30 INFO - 'default_actions': ('clobber', 21:48:30 INFO - 'read-buildbot-config', 21:48:30 INFO - 'download-and-extract', 21:48:30 INFO - 'populate-webroot', 21:48:30 INFO - 'create-virtualenv', 21:48:30 INFO - 'install', 21:48:30 INFO - 'run-tests'), 21:48:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:48:30 INFO - 'download_minidump_stackwalk': True, 21:48:30 INFO - 'download_symbols': 'ondemand', 21:48:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:48:30 INFO - 'tooltool.py': '/tools/tooltool.py', 21:48:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:48:30 INFO - '/tools/misc-python/virtualenv.py')}, 21:48:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:48:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:48:30 INFO - 'installer_path': 'installer.exe', 21:48:30 INFO - 'log_level': 'info', 21:48:30 INFO - 'log_name': 'talos', 21:48:30 INFO - 'log_to_console': True, 21:48:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:48:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:48:30 INFO - 'opt_config_files': (), 21:48:30 INFO - 'pip_index': False, 21:48:30 INFO - 'sps_profile': False, 21:48:30 INFO - 'sps_profile_interval': 0, 21:48:30 INFO - 'suite': 'dromaeojs-e10s', 21:48:30 INFO - 'system_bits': '32', 21:48:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:48:30 INFO - 'title': 'talos-linux64-ix-007', 21:48:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:48:30 INFO - 'use_talos_json': True, 21:48:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:48:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:48:30 INFO - 'work_dir': 'build'} 21:48:30 INFO - ##### 21:48:30 INFO - ##### Running clobber step. 21:48:30 INFO - ##### 21:48:30 INFO - Running pre-action listener: _resource_record_pre_action 21:48:30 INFO - Running main action method: clobber 21:48:30 INFO - rmtree: /builds/slave/test-pgo/build 21:48:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:48:31 INFO - Running post-action listener: _resource_record_post_action 21:48:31 INFO - ##### 21:48:31 INFO - ##### Running read-buildbot-config step. 21:48:31 INFO - ##### 21:48:31 INFO - Running pre-action listener: _resource_record_pre_action 21:48:31 INFO - Running main action method: read_buildbot_config 21:48:31 INFO - Using buildbot properties: 21:48:31 INFO - { 21:48:31 INFO - "project": "", 21:48:31 INFO - "product": "firefox", 21:48:31 INFO - "script_repo_revision": "production", 21:48:31 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 21:48:31 INFO - "repository": "", 21:48:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 21:48:31 INFO - "buildid": "20160103193144", 21:48:31 INFO - "pgo_build": "True", 21:48:31 INFO - "basedir": "/builds/slave/test-pgo", 21:48:31 INFO - "buildnumber": 282, 21:48:31 INFO - "slavename": "talos-linux64-ix-007", 21:48:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:48:31 INFO - "platform": "ubuntu64_hw", 21:48:31 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:48:31 INFO - "branch": "mozilla-inbound", 21:48:31 INFO - "repo_path": "integration/mozilla-inbound", 21:48:31 INFO - "revision": "6aedf1738475bac8518ae801b9df94dec0ade363", 21:48:31 INFO - "stage_platform": "linux64-pgo", 21:48:31 INFO - "builduid": "7270c7ddc1b4482ea7844f7d9cebdb1f", 21:48:31 INFO - "slavebuilddir": "test" 21:48:31 INFO - } 21:48:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/SKziSzxRQCW8FAkBXJQkAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 21:48:31 INFO - Running post-action listener: _resource_record_post_action 21:48:31 INFO - ##### 21:48:31 INFO - ##### Running download-and-extract step. 21:48:31 INFO - ##### 21:48:31 INFO - Running pre-action listener: _resource_record_pre_action 21:48:31 INFO - Running main action method: download_and_extract 21:48:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:48:31 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')]} 21:48:31 INFO - https://queue.taskcluster.net/v1/task/SKziSzxRQCW8FAkBXJQkAA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:48:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKziSzxRQCW8FAkBXJQkAA/artifacts/public/build/test_packages.json 21:48:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKziSzxRQCW8FAkBXJQkAA/artifacts/public/build/test_packages.json 21:48:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKziSzxRQCW8FAkBXJQkAA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:48:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKziSzxRQCW8FAkBXJQkAA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:48:36 INFO - Downloaded 1302 bytes. 21:48:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:48:36 INFO - Using the following test package requirements: 21:48:36 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:48:36 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:48:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:48:36 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:48:36 INFO - u'jsshell-linux-x86_64.zip'], 21:48:36 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:48:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:48:36 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:48:36 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:48:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:48:36 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:48:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:48:36 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:48:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:48:36 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:48:36 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:48:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:48:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:36 INFO - https://queue.taskcluster.net/v1/task/SKziSzxRQCW8FAkBXJQkAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:48:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKziSzxRQCW8FAkBXJQkAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:48:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKziSzxRQCW8FAkBXJQkAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:48:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKziSzxRQCW8FAkBXJQkAA/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 21:48:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKziSzxRQCW8FAkBXJQkAA/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 21:48:43 INFO - Downloaded 23198084 bytes. 21:48:43 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 21:48:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:48:43 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 21:48:44 INFO - Return code: 0 21:48:44 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 21:48:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:44 INFO - https://queue.taskcluster.net/v1/task/SKziSzxRQCW8FAkBXJQkAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:48:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKziSzxRQCW8FAkBXJQkAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:48:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKziSzxRQCW8FAkBXJQkAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:48:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKziSzxRQCW8FAkBXJQkAA/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 21:48:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKziSzxRQCW8FAkBXJQkAA/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 21:48:46 INFO - Downloaded 23198084 bytes. 21:48:46 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 21:48:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:48:46 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 21:48:47 INFO - Return code: 0 21:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:47 INFO - https://queue.taskcluster.net/v1/task/SKziSzxRQCW8FAkBXJQkAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:48:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKziSzxRQCW8FAkBXJQkAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:48:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKziSzxRQCW8FAkBXJQkAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:48:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKziSzxRQCW8FAkBXJQkAA/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 21:48:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKziSzxRQCW8FAkBXJQkAA/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 21:48:48 INFO - Downloaded 11132285 bytes. 21:48: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 21:48:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:48: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 21:48:48 INFO - Return code: 0 21:48: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')]} 21:48:48 INFO - https://queue.taskcluster.net/v1/task/SKziSzxRQCW8FAkBXJQkAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:48:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKziSzxRQCW8FAkBXJQkAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:48:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKziSzxRQCW8FAkBXJQkAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:48:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKziSzxRQCW8FAkBXJQkAA/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 21:48:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKziSzxRQCW8FAkBXJQkAA/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 21:48:49 INFO - Downloaded 54983574 bytes. 21:48:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SKziSzxRQCW8FAkBXJQkAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:48:49 INFO - mkdir: /builds/slave/test-pgo/properties 21:48:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:48:49 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:48:49 INFO - Contents: 21:48:49 INFO - build_url:https://queue.taskcluster.net/v1/task/SKziSzxRQCW8FAkBXJQkAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:48:49 INFO - Running post-action listener: _resource_record_post_action 21:48:49 INFO - Running post-action listener: set_extra_try_arguments 21:48:49 INFO - ##### 21:48:49 INFO - ##### Running populate-webroot step. 21:48:49 INFO - ##### 21:48:49 INFO - Running pre-action listener: _resource_record_pre_action 21:48:49 INFO - Running main action method: populate_webroot 21:48:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:48:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:48:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:48:49 INFO - '--tppagecycles', 21:48:49 INFO - '7'], 21:48:49 INFO - 'tests': ['tsvgm']}}, 21:48:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:48:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:48:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:48:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:48:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:48:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:48:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:48:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:49 INFO - 'talos_options': ['--e10s'], 21:48:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:48:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:49 INFO - 'tests': ['damp', 'tps']}, 21:48:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:49 INFO - 'talos_options': ['--e10s'], 21:48:49 INFO - 'tests': ['damp', 'tps']}, 21:48:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:48:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:48:49 INFO - 'other': {'tests': ['a11yr', 21:48:49 INFO - 'ts_paint', 21:48:49 INFO - 'tpaint', 21:48:49 INFO - 'sessionrestore', 21:48:49 INFO - 'sessionrestore_no_auto_restore']}, 21:48:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:48:49 INFO - 'tests': ['a11yr', 21:48:49 INFO - 'ts_paint', 21:48:49 INFO - 'tpaint', 21:48:49 INFO - 'sessionrestore', 21:48:49 INFO - 'sessionrestore_no_auto_restore']}, 21:48:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:48:49 INFO - 'tests': ['a11yr', 21:48:49 INFO - 'ts_paint', 21:48:49 INFO - 'tpaint', 21:48:49 INFO - 'sessionrestore', 21:48:49 INFO - 'sessionrestore_no_auto_restore']}, 21:48:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:48:49 INFO - 'tests': ['a11yr', 21:48:49 INFO - 'ts_paint', 21:48:49 INFO - 'tpaint', 21:48:49 INFO - 'sessionrestore', 21:48:49 INFO - 'sessionrestore_no_auto_restore']}, 21:48:49 INFO - 'other_l64': {'tests': ['a11yr', 21:48:49 INFO - 'ts_paint', 21:48:49 INFO - 'tpaint', 21:48:49 INFO - 'sessionrestore', 21:48:49 INFO - 'sessionrestore_no_auto_restore']}, 21:48:49 INFO - 'other_nol64': {'tests': ['a11yr', 21:48:49 INFO - 'ts_paint', 21:48:49 INFO - 'tpaint', 21:48:49 INFO - 'sessionrestore', 21:48:49 INFO - 'sessionrestore_no_auto_restore']}, 21:48:49 INFO - 'svgr': {'tests': ['tsvgx', 21:48:49 INFO - 'tsvgr_opacity', 21:48:49 INFO - 'tart', 21:48:49 INFO - 'tscrollx', 21:48:49 INFO - 'cart']}, 21:48:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:48:49 INFO - 'tests': ['tsvgx', 21:48:49 INFO - 'tsvgr_opacity', 21:48:49 INFO - 'tart', 21:48:49 INFO - 'tscrollx', 21:48:49 INFO - 'cart']}, 21:48:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:49 INFO - 'tests': ['tp5o']}, 21:48:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:49 INFO - 'talos_options': ['--e10s'], 21:48:49 INFO - 'tests': ['tp5o']}, 21:48:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:49 INFO - 'talos_options': ['--xperf_path', 21:48:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:48:49 INFO - 'tests': ['tp5n']}, 21:48:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:49 INFO - 'talos_options': ['--e10s', 21:48:49 INFO - '--xperf_path', 21:48:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:48:49 INFO - 'tests': ['tp5n']}}, 21:48:49 INFO - 'talos.zip': {'path': '', 21:48:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:48:49 INFO - Running post-action listener: _resource_record_post_action 21:48:49 INFO - ##### 21:48:49 INFO - ##### Running create-virtualenv step. 21:48:49 INFO - ##### 21:48:49 INFO - Running pre-action listener: _resource_record_pre_action 21:48:49 INFO - Running main action method: create_virtualenv 21:48:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:48:49 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 21:48:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:48:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:48:50 INFO - Using real prefix '/usr' 21:48:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:48:50 INFO - Installing distribute.............................................................................................................................................................................................done. 21:48:52 INFO - Installing pip.................done. 21:48:52 INFO - Return code: 0 21:48:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4824f18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5c360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdeb540>, '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 0xdec440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdec8f0>, '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': '6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805', '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 21:48:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 21:48:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:48:52 INFO - Using env: {'DISPLAY': ':0', 21:48:52 INFO - 'HOME': '/home/cltbld', 21:48:52 INFO - 'LANG': 'en_US.UTF-8', 21:48:52 INFO - 'LANGUAGE': 'en_US:en', 21:48:52 INFO - 'LOGNAME': 'cltbld', 21:48:52 INFO - 'MAIL': '/var/mail/cltbld', 21:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:52 INFO - 'MOZ_NO_REMOTE': '1', 21:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:52 INFO - 'NO_EM_RESTART': '1', 21:48:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:48:52 INFO - 'PWD': '/builds/slave/test-pgo', 21:48:52 INFO - 'SHELL': '/bin/bash', 21:48:52 INFO - 'SHLVL': '1', 21:48:52 INFO - 'TERM': 'linux', 21:48:52 INFO - 'TMOUT': '86400', 21:48:52 INFO - 'USER': 'cltbld', 21:48:52 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805', 21:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:52 INFO - '_': '/tools/buildbot/bin/python'} 21:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:52 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 21:48:52 INFO - Cleaning up... 21:48:52 INFO - Return code: 0 21:48:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4824f18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5c360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdeb540>, '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 0xdec440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdec8f0>, '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': '6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805', '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 21:48:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 21:48:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:48:52 INFO - Using env: {'DISPLAY': ':0', 21:48:52 INFO - 'HOME': '/home/cltbld', 21:48:52 INFO - 'LANG': 'en_US.UTF-8', 21:48:52 INFO - 'LANGUAGE': 'en_US:en', 21:48:52 INFO - 'LOGNAME': 'cltbld', 21:48:52 INFO - 'MAIL': '/var/mail/cltbld', 21:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:52 INFO - 'MOZ_NO_REMOTE': '1', 21:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:52 INFO - 'NO_EM_RESTART': '1', 21:48:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:48:52 INFO - 'PWD': '/builds/slave/test-pgo', 21:48:52 INFO - 'SHELL': '/bin/bash', 21:48:52 INFO - 'SHLVL': '1', 21:48:52 INFO - 'TERM': 'linux', 21:48:52 INFO - 'TMOUT': '86400', 21:48:52 INFO - 'USER': 'cltbld', 21:48:52 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805', 21:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:52 INFO - '_': '/tools/buildbot/bin/python'} 21:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:52 INFO - Downloading/unpacking psutil>=0.7.1 21:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:54 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:48:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:48:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:48:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:48:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:48:54 INFO - Installing collected packages: psutil 21:48:54 INFO - Running setup.py install for psutil 21:48:54 INFO - building 'psutil._psutil_linux' extension 21:48:54 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 21:48:55 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 21:48:55 INFO - building 'psutil._psutil_posix' extension 21:48:55 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 21:48:55 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 21:48:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:48:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:48:55 INFO - Successfully installed psutil 21:48:55 INFO - Cleaning up... 21:48:55 INFO - Return code: 0 21:48:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:48:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:55 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 0x7f4824f18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5c360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdeb540>, '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 0xdec440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdec8f0>, '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': '6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805', '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 21:48:55 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 21:48:55 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 21:48:55 INFO - Using env: {'DISPLAY': ':0', 21:48:55 INFO - 'HOME': '/home/cltbld', 21:48:55 INFO - 'LANG': 'en_US.UTF-8', 21:48:55 INFO - 'LANGUAGE': 'en_US:en', 21:48:55 INFO - 'LOGNAME': 'cltbld', 21:48:55 INFO - 'MAIL': '/var/mail/cltbld', 21:48:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:55 INFO - 'MOZ_NO_REMOTE': '1', 21:48:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:55 INFO - 'NO_EM_RESTART': '1', 21:48:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:48:55 INFO - 'PWD': '/builds/slave/test-pgo', 21:48:55 INFO - 'SHELL': '/bin/bash', 21:48:55 INFO - 'SHLVL': '1', 21:48:55 INFO - 'TERM': 'linux', 21:48:55 INFO - 'TMOUT': '86400', 21:48:55 INFO - 'USER': 'cltbld', 21:48:55 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805', 21:48:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:55 INFO - '_': '/tools/buildbot/bin/python'} 21:48:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:48:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:48:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:48:57 INFO - Installing collected packages: mozsystemmonitor 21:48:57 INFO - Running setup.py install for mozsystemmonitor 21:48:57 INFO - Successfully installed mozsystemmonitor 21:48:57 INFO - Cleaning up... 21:48:57 INFO - Return code: 0 21:48:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:57 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 0x7f4824f18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5c360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdeb540>, '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 0xdec440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdec8f0>, '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': '6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805', '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 21:48:57 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 21:48:57 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 21:48:57 INFO - Using env: {'DISPLAY': ':0', 21:48:57 INFO - 'HOME': '/home/cltbld', 21:48:57 INFO - 'LANG': 'en_US.UTF-8', 21:48:57 INFO - 'LANGUAGE': 'en_US:en', 21:48:57 INFO - 'LOGNAME': 'cltbld', 21:48:57 INFO - 'MAIL': '/var/mail/cltbld', 21:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:57 INFO - 'MOZ_NO_REMOTE': '1', 21:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:57 INFO - 'NO_EM_RESTART': '1', 21:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:48:57 INFO - 'PWD': '/builds/slave/test-pgo', 21:48:57 INFO - 'SHELL': '/bin/bash', 21:48:57 INFO - 'SHLVL': '1', 21:48:57 INFO - 'TERM': 'linux', 21:48:57 INFO - 'TMOUT': '86400', 21:48:57 INFO - 'USER': 'cltbld', 21:48:57 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805', 21:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:57 INFO - '_': '/tools/buildbot/bin/python'} 21:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:57 INFO - Downloading/unpacking blobuploader==1.2.4 21:48:57 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 21:48:57 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 21:48:57 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 21:48:57 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 21:48:57 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 21:48:57 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 21:48:59 INFO - Downloading blobuploader-1.2.4.tar.gz 21:48:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:48:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:48:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:48:59 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 21:48:59 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 21:48:59 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 21:48:59 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 21:48:59 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 21:48:59 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 21:48:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:48:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:48:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:48:59 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 21:48:59 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 21:48:59 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 21:48:59 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 21:48:59 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 21:48:59 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 21:49:00 INFO - Downloading docopt-0.6.1.tar.gz 21:49:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:49:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:49:00 INFO - Installing collected packages: blobuploader, requests, docopt 21:49:00 INFO - Running setup.py install for blobuploader 21:49:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:49:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:49:00 INFO - Running setup.py install for requests 21:49:00 INFO - Running setup.py install for docopt 21:49:00 INFO - Successfully installed blobuploader requests docopt 21:49:00 INFO - Cleaning up... 21:49:00 INFO - Return code: 0 21:49:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:00 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 0x7f4824f18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5c360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdeb540>, '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 0xdec440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdec8f0>, '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': '6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805', '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 21:49:00 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 21:49:00 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 21:49:00 INFO - Using env: {'DISPLAY': ':0', 21:49:00 INFO - 'HOME': '/home/cltbld', 21:49:00 INFO - 'LANG': 'en_US.UTF-8', 21:49:00 INFO - 'LANGUAGE': 'en_US:en', 21:49:00 INFO - 'LOGNAME': 'cltbld', 21:49:00 INFO - 'MAIL': '/var/mail/cltbld', 21:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:00 INFO - 'MOZ_NO_REMOTE': '1', 21:49:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:00 INFO - 'NO_EM_RESTART': '1', 21:49:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:49:00 INFO - 'PWD': '/builds/slave/test-pgo', 21:49:00 INFO - 'SHELL': '/bin/bash', 21:49:00 INFO - 'SHLVL': '1', 21:49:00 INFO - 'TERM': 'linux', 21:49:00 INFO - 'TMOUT': '86400', 21:49:00 INFO - 'USER': 'cltbld', 21:49:00 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805', 21:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:00 INFO - '_': '/tools/buildbot/bin/python'} 21:49:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:49:00 INFO - Running setup.py (path:/tmp/pip-xLfipP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:49:01 INFO - Running setup.py (path:/tmp/pip-2SoLXt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:49:01 INFO - Running setup.py (path:/tmp/pip-R4GBYa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:49:01 INFO - Running setup.py (path:/tmp/pip-84Ldo3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:49:01 INFO - Running setup.py (path:/tmp/pip-2H2qSH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:49:01 INFO - Running setup.py (path:/tmp/pip-9Fzan6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:49:01 INFO - Running setup.py (path:/tmp/pip-UPJwsS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:49:01 INFO - Running setup.py (path:/tmp/pip-KFtU3T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:49:01 INFO - Running setup.py (path:/tmp/pip-rmzumF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:49:01 INFO - Running setup.py (path:/tmp/pip-vQfzN3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:49:01 INFO - Running setup.py (path:/tmp/pip-hVuMSX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:49:01 INFO - Running setup.py (path:/tmp/pip-miuIDd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:49:01 INFO - Running setup.py (path:/tmp/pip-FKZX0b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:49:01 INFO - Running setup.py (path:/tmp/pip-x67Exr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:49:01 INFO - Running setup.py (path:/tmp/pip-OKZ8e8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:49:02 INFO - Running setup.py (path:/tmp/pip-nxMpmH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:49:02 INFO - Running setup.py (path:/tmp/pip-eWsac0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:49:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:49:02 INFO - Running setup.py install for manifestparser 21:49:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:49:02 INFO - Running setup.py install for mozcrash 21:49:02 INFO - Running setup.py install for mozdebug 21:49:02 INFO - Running setup.py install for mozdevice 21:49:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:49:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:49:02 INFO - Running setup.py install for mozfile 21:49:02 INFO - Running setup.py install for mozhttpd 21:49:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:49:02 INFO - Running setup.py install for mozinfo 21:49:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:49:02 INFO - Running setup.py install for mozInstall 21:49:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:49:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:49:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:49:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:49:02 INFO - Running setup.py install for mozleak 21:49:03 INFO - Running setup.py install for mozlog 21:49:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:49:03 INFO - Running setup.py install for moznetwork 21:49:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:49:03 INFO - Running setup.py install for mozprocess 21:49:03 INFO - Running setup.py install for mozprofile 21:49:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:49:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:49:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:49:03 INFO - Running setup.py install for mozrunner 21:49:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:49:03 INFO - Running setup.py install for mozscreenshot 21:49:03 INFO - Running setup.py install for moztest 21:49:03 INFO - Running setup.py install for mozversion 21:49:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:49:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:49:03 INFO - Cleaning up... 21:49:03 INFO - Return code: 0 21:49:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:49:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f4824f18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5c360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdeb540>, '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 0xdec440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdec8f0>, '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': '6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805', '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 21:49:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 21:49:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 21:49:03 INFO - Using env: {'DISPLAY': ':0', 21:49:03 INFO - 'HOME': '/home/cltbld', 21:49:03 INFO - 'LANG': 'en_US.UTF-8', 21:49:03 INFO - 'LANGUAGE': 'en_US:en', 21:49:03 INFO - 'LOGNAME': 'cltbld', 21:49:03 INFO - 'MAIL': '/var/mail/cltbld', 21:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:03 INFO - 'MOZ_NO_REMOTE': '1', 21:49:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:03 INFO - 'NO_EM_RESTART': '1', 21:49:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:49:03 INFO - 'PWD': '/builds/slave/test-pgo', 21:49:03 INFO - 'SHELL': '/bin/bash', 21:49:03 INFO - 'SHLVL': '1', 21:49:03 INFO - 'TERM': 'linux', 21:49:03 INFO - 'TMOUT': '86400', 21:49:03 INFO - 'USER': 'cltbld', 21:49:03 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805', 21:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:03 INFO - '_': '/tools/buildbot/bin/python'} 21:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:49:04 INFO - Running setup.py (path:/tmp/pip-_Bg4TJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:49:04 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)) 21:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:49:04 INFO - Running setup.py (path:/tmp/pip-iXDgyz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:49:04 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)) 21:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:49:04 INFO - Running setup.py (path:/tmp/pip-1UifGp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:49:04 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)) 21:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:49:04 INFO - Running setup.py (path:/tmp/pip-81kQcu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:49:04 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)) 21:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:49:04 INFO - Running setup.py (path:/tmp/pip-Pre4b7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:49:04 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)) 21:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:49:04 INFO - Running setup.py (path:/tmp/pip-PRLskf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:49:04 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)) 21:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:49:04 INFO - Running setup.py (path:/tmp/pip-iFpU7X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:49:04 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)) 21:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:49:04 INFO - Running setup.py (path:/tmp/pip-dGMHtM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:49:04 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)) 21:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:49:04 INFO - Running setup.py (path:/tmp/pip-VVOVoL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:49:04 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)) 21:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:49:04 INFO - Running setup.py (path:/tmp/pip-tCkvzN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:49:04 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)) 21:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:49:04 INFO - Running setup.py (path:/tmp/pip-tFO0cn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:49:04 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)) 21:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:49:04 INFO - Running setup.py (path:/tmp/pip-aqvVcO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:49:05 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)) 21:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:49:05 INFO - Running setup.py (path:/tmp/pip-yoXyU8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:49:05 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)) 21:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:49:05 INFO - Running setup.py (path:/tmp/pip-WZIBC9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:49:05 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)) 21:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:49:05 INFO - Running setup.py (path:/tmp/pip-cn145C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:49:05 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)) 21:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:49:05 INFO - Running setup.py (path:/tmp/pip-vAuLKy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:49:05 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)) 21:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:49:05 INFO - Running setup.py (path:/tmp/pip-ad3ozJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:49:05 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)) 21:49:05 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)) 21:49:05 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)) 21:49:05 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)) 21:49:05 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)) 21:49:05 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)) 21:49:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:49:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:49:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:49:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:49:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:49:07 INFO - Downloading blessings-1.5.1.tar.gz 21:49:07 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 21:49:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:49:07 INFO - Installing collected packages: blessings 21:49:07 INFO - Running setup.py install for blessings 21:49:07 INFO - Successfully installed blessings 21:49:07 INFO - Cleaning up... 21:49:07 INFO - Return code: 0 21:49:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:49:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:49:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:49:07 INFO - Reading from file tmpfile_stdout 21:49:07 INFO - Current package versions: 21:49:07 INFO - argparse == 1.2.1 21:49:07 INFO - blessings == 1.5.1 21:49:07 INFO - blobuploader == 1.2.4 21:49:07 INFO - docopt == 0.6.1 21:49:07 INFO - manifestparser == 1.1 21:49:07 INFO - mozInstall == 1.12 21:49:07 INFO - mozcrash == 0.16 21:49:07 INFO - mozdebug == 0.1 21:49:07 INFO - mozdevice == 0.47 21:49:07 INFO - mozfile == 1.2 21:49:07 INFO - mozhttpd == 0.7 21:49:07 INFO - mozinfo == 0.9 21:49:07 INFO - mozleak == 0.1 21:49:07 INFO - mozlog == 3.1 21:49:07 INFO - moznetwork == 0.27 21:49:07 INFO - mozprocess == 0.22 21:49:07 INFO - mozprofile == 0.28 21:49:07 INFO - mozrunner == 6.11 21:49:07 INFO - mozscreenshot == 0.1 21:49:07 INFO - mozsystemmonitor == 0.0 21:49:07 INFO - moztest == 0.7 21:49:07 INFO - mozversion == 1.4 21:49:07 INFO - psutil == 3.1.1 21:49:07 INFO - requests == 1.2.3 21:49:07 INFO - wsgiref == 0.1.2 21:49:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f4824f18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5c360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdeb540>, '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 0xdec440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdec8f0>, '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': '6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805', '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 21:49:07 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 21:49:07 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 21:49:07 INFO - Using env: {'DISPLAY': ':0', 21:49:07 INFO - 'HOME': '/home/cltbld', 21:49:07 INFO - 'LANG': 'en_US.UTF-8', 21:49:07 INFO - 'LANGUAGE': 'en_US:en', 21:49:07 INFO - 'LOGNAME': 'cltbld', 21:49:07 INFO - 'MAIL': '/var/mail/cltbld', 21:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:07 INFO - 'MOZ_NO_REMOTE': '1', 21:49:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:07 INFO - 'NO_EM_RESTART': '1', 21:49:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:49:07 INFO - 'PWD': '/builds/slave/test-pgo', 21:49:07 INFO - 'SHELL': '/bin/bash', 21:49:07 INFO - 'SHLVL': '1', 21:49:07 INFO - 'TERM': 'linux', 21:49:07 INFO - 'TMOUT': '86400', 21:49:07 INFO - 'USER': 'cltbld', 21:49:07 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805', 21:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:07 INFO - '_': '/tools/buildbot/bin/python'} 21:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:07 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)) 21:49:07 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)) 21:49:07 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)) 21:49:07 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)) 21:49:07 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)) 21:49:07 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)) 21:49:07 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)) 21:49:07 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)) 21:49:07 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)) 21:49:07 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)) 21:49:07 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)) 21:49:07 INFO - Cleaning up... 21:49:07 INFO - Return code: 0 21:49:07 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 21:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4824f18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5c360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdeb540>, '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 0xdec440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdec8f0>, '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': '6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805', '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 21:49:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 21:49:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:49:07 INFO - Using env: {'DISPLAY': ':0', 21:49:07 INFO - 'HOME': '/home/cltbld', 21:49:07 INFO - 'LANG': 'en_US.UTF-8', 21:49:07 INFO - 'LANGUAGE': 'en_US:en', 21:49:07 INFO - 'LOGNAME': 'cltbld', 21:49:07 INFO - 'MAIL': '/var/mail/cltbld', 21:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:07 INFO - 'MOZ_NO_REMOTE': '1', 21:49:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:07 INFO - 'NO_EM_RESTART': '1', 21:49:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:49:07 INFO - 'PWD': '/builds/slave/test-pgo', 21:49:07 INFO - 'SHELL': '/bin/bash', 21:49:07 INFO - 'SHLVL': '1', 21:49:07 INFO - 'TERM': 'linux', 21:49:07 INFO - 'TMOUT': '86400', 21:49:07 INFO - 'USER': 'cltbld', 21:49:07 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805', 21:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:07 INFO - '_': '/tools/buildbot/bin/python'} 21:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:07 INFO - Downloading/unpacking jsonschema 21:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:49:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:49:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:49:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:49:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:49:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:49:09 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 21:49:09 INFO - Downloading/unpacking functools32 (from jsonschema) 21:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:49:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:49:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:49:09 INFO - Downloading functools32-3.2.3-2.tar.gz 21:49:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 21:49:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 21:49:09 INFO - warning: no files found matching '*.txt' 21:49:09 INFO - no previously-included directories found matching 'build' 21:49:09 INFO - no previously-included directories found matching 'dist' 21:49:09 INFO - no previously-included directories found matching '.git*' 21:49:09 INFO - Installing collected packages: jsonschema, functools32 21:49:09 INFO - Running setup.py install for functools32 21:49:10 INFO - warning: no files found matching '*.txt' 21:49:10 INFO - no previously-included directories found matching 'build' 21:49:10 INFO - no previously-included directories found matching 'dist' 21:49:10 INFO - no previously-included directories found matching '.git*' 21:49:10 INFO - Successfully installed jsonschema functools32 21:49:10 INFO - Cleaning up... 21:49:10 INFO - Return code: 0 21:49:10 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 21:49: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')]} 21:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49: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')]} 21:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4824f18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5c360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdeb540>, '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 0xdec440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdec8f0>, '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': '6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805', '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 21:49: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', 'flake8'] in /builds/slave/test-pgo/build 21:49: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 flake8 21:49:10 INFO - Using env: {'DISPLAY': ':0', 21:49:10 INFO - 'HOME': '/home/cltbld', 21:49:10 INFO - 'LANG': 'en_US.UTF-8', 21:49:10 INFO - 'LANGUAGE': 'en_US:en', 21:49:10 INFO - 'LOGNAME': 'cltbld', 21:49:10 INFO - 'MAIL': '/var/mail/cltbld', 21:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:10 INFO - 'MOZ_NO_REMOTE': '1', 21:49:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:10 INFO - 'NO_EM_RESTART': '1', 21:49:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:49:10 INFO - 'PWD': '/builds/slave/test-pgo', 21:49:10 INFO - 'SHELL': '/bin/bash', 21:49:10 INFO - 'SHLVL': '1', 21:49:10 INFO - 'TERM': 'linux', 21:49:10 INFO - 'TMOUT': '86400', 21:49:10 INFO - 'USER': 'cltbld', 21:49:10 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805', 21:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:10 INFO - '_': '/tools/buildbot/bin/python'} 21:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:10 INFO - Downloading/unpacking flake8 21:49:10 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 21:49:10 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 21:49:10 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 21:49:10 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 21:49:10 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 21:49:10 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 21:49:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:49:12 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 21:49:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:49:12 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 21:49:12 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 21:49:12 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 21:49:12 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 21:49:12 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 21:49:12 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 21:49:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:49:12 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 21:49:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:49:12 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 21:49:12 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 21:49:12 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 21:49:12 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 21:49:12 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 21:49:12 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 21:49:12 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 21:49:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:49:12 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 21:49:12 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 21:49:12 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 21:49:12 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 21:49:12 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 21:49:12 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 21:49:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 21:49:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 21:49:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:49:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:49:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:49:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:49:12 INFO - no previously-included directories found matching 'docs/_build' 21:49:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:49:12 INFO - Running setup.py install for pep8 21:49:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:49:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:49:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:49:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:49:12 INFO - no previously-included directories found matching 'docs/_build' 21:49:12 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 21:49:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:49:12 INFO - Cleaning up... 21:49:12 INFO - Return code: 0 21:49:12 INFO - Running post-action listener: _resource_record_post_action 21:49:12 INFO - Running post-action listener: _start_resource_monitoring 21:49:12 INFO - Starting resource monitoring. 21:49:12 INFO - ##### 21:49:12 INFO - ##### Running install step. 21:49:12 INFO - ##### 21:49:12 INFO - Running pre-action listener: _resource_record_pre_action 21:49:12 INFO - Running main action method: install 21:49:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:49:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:49:13 INFO - Reading from file tmpfile_stdout 21:49:13 INFO - Detecting whether we're running mozinstall >=1.0... 21:49:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:49:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:49:13 INFO - Reading from file tmpfile_stdout 21:49:13 INFO - Output received: 21:49:13 INFO - Usage: mozinstall [options] installer 21:49:13 INFO - Options: 21:49:13 INFO - -h, --help show this help message and exit 21:49:13 INFO - -d DEST, --destination=DEST 21:49:13 INFO - Directory to install application into. [default: 21:49:13 INFO - "/builds/slave/test-pgo"] 21:49:13 INFO - --app=APP Application being installed. [default: firefox] 21:49:13 INFO - mkdir: /builds/slave/test-pgo/build/application 21:49:13 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'] 21:49:13 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 21:49:29 INFO - Reading from file tmpfile_stdout 21:49:29 INFO - Output received: 21:49:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:49:29 INFO - Running post-action listener: _resource_record_post_action 21:49:29 INFO - ##### 21:49:29 INFO - ##### Running run-tests step. 21:49:29 INFO - ##### 21:49:29 INFO - Running pre-action listener: _resource_record_pre_action 21:49:29 INFO - Running main action method: run_tests 21:49:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:49:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:49:29 INFO - Python 2.7.3 21:49:29 INFO - Return code: 0 21:49:29 INFO - grabbing minidump binary from tooltool 21:49: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')]} 21:49:29 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 0xdeb540>, '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 0xdec440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdec8f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:49:29 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 21:49:29 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 21:49:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:49:29 INFO - Return code: 0 21:49:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:49:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:49:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:49:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:49:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:49:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 21:49:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 21:49:30 INFO - Return code: 0 21:49:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SKziSzxRQCW8FAkBXJQkAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 21:49:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SKziSzxRQCW8FAkBXJQkAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:49:30 INFO - Using env: {'DISPLAY': ':0', 21:49:30 INFO - 'HOME': '/home/cltbld', 21:49:30 INFO - 'LANG': 'en_US.UTF-8', 21:49:30 INFO - 'LANGUAGE': 'en_US:en', 21:49:30 INFO - 'LOGNAME': 'cltbld', 21:49:30 INFO - 'MAIL': '/var/mail/cltbld', 21:49:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:49:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:30 INFO - 'MOZ_NO_REMOTE': '1', 21:49:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:49:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:30 INFO - 'NO_EM_RESTART': '1', 21:49:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:49:30 INFO - 'PWD': '/builds/slave/test-pgo', 21:49:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:49:30 INFO - 'SHELL': '/bin/bash', 21:49:30 INFO - 'SHLVL': '1', 21:49:30 INFO - 'TERM': 'linux', 21:49:30 INFO - 'TMOUT': '86400', 21:49:30 INFO - 'USER': 'cltbld', 21:49:30 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805', 21:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:30 INFO - '_': '/tools/buildbot/bin/python'} 21:49:30 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SKziSzxRQCW8FAkBXJQkAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:49:30 INFO - mozversion application_buildid: 20160103193144 21:49:30 INFO - mozversion application_changeset: 6aedf1738475bac8518ae801b9df94dec0ade363 21:49:30 INFO - mozversion application_display_name: Nightly 21:49:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:49:30 INFO - mozversion application_name: Firefox 21:49:30 INFO - mozversion application_remotingname: firefox 21:49:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:49:30 INFO - mozversion application_vendor: Mozilla 21:49:30 INFO - mozversion application_version: 46.0a1 21:49:30 INFO - mozversion platform_buildid: 20160103193144 21:49:30 INFO - mozversion platform_changeset: 6aedf1738475bac8518ae801b9df94dec0ade363 21:49:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:49:30 INFO - mozversion platform_version: 46.0a1 21:49:30 INFO - using testdate: 1451886570 21:49:30 INFO - actual date: 1451886570 21:49:30 INFO - starting webserver on 'localhost:52641' 21:49:30 INFO - SUITE-START | Running 3 tests 21:49:30 INFO - TEST-START | dromaeo_css 21:49:30 INFO - operating with platform_type : linux_ 21:49:30 INFO - Initialising browser for dromaeo_css test... 21:49:30 INFO - TEST-INFO | started process 21060 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiCUlsN/profile http://localhost:52641/getInfo.html) 21:49:35 INFO - PROCESS | 21060 | __metrics Screen width/height:1600/1200 21:49:35 INFO - PROCESS | 21060 | colorDepth:24 21:49:35 INFO - PROCESS | 21060 | Browser inner width/height: 1024/697 21:49:35 INFO - PROCESS | 21060 | __metrics 21:49:35 INFO - PROCESS | 21060 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:49:36 INFO - TEST-INFO | 21060: exit 0 21:49:36 INFO - Browser initialized. 21:49:36 INFO - Running cycle 1/1 for dromaeo_css test... 21:49:36 INFO - TEST-INFO | started process 21194 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiCUlsN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:49:47 INFO - PROCESS | 21194 | RSS: Main: 150536192 21:49:47 INFO - PROCESS | 21194 | 21:50:37 INFO - PROCESS | 21194 | 1451886637502 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] 21:52:46 INFO - PROCESS | 21194 | Cycle 1(1): loaded http://localhost:52641/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52641/tests/dromaeo/cssquery-ext.html) 21:52:47 INFO - PROCESS | 21194 | RSS: Main: 157052928 21:52:47 INFO - PROCESS | 21194 | 21:55:49 INFO - PROCESS | 21194 | Cycle 1(1): loaded http://localhost:52641/tests/dromaeo/cssquery-ext.html (next: http://localhost:52641/tests/dromaeo/cssquery-jquery.html) 21:55:49 INFO - PROCESS | 21194 | RSS: Main: 152453120 21:55:49 INFO - PROCESS | 21194 | 21:58:51 INFO - PROCESS | 21194 | Cycle 1(1): loaded http://localhost:52641/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52641/tests/dromaeo/cssquery-mootools.html) 21:58:52 INFO - PROCESS | 21194 | RSS: Main: 154906624 21:58:52 INFO - PROCESS | 21194 | 22:01:53 INFO - PROCESS | 21194 | Cycle 1(1): loaded http://localhost:52641/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52641/tests/dromaeo/cssquery-prototype.html) 22:01:54 INFO - PROCESS | 21194 | RSS: Main: 152330240 22:01:54 INFO - PROCESS | 21194 | 22:04:56 INFO - PROCESS | 21194 | Cycle 1(1): loaded http://localhost:52641/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52641/tests/dromaeo/cssquery-yui.html) 22:04:57 INFO - PROCESS | 21194 | RSS: Main: 152121344 22:04:57 INFO - PROCESS | 21194 | 22:07:59 INFO - PROCESS | 21194 | Cycle 1(1): loaded http://localhost:52641/tests/dromaeo/cssquery-yui.html (next: http://localhost:52641/tests/dromaeo/cssquery-dojo.html) 22:08:00 INFO - PROCESS | 21194 | RSS: Main: 154537984 22:08:00 INFO - PROCESS | 21194 | 22:08:00 INFO - PROCESS | 21194 | __start_tp_report 22:08:00 INFO - PROCESS | 21194 | _x_x_mozilla_page_load 22:08:00 INFO - PROCESS | 21194 | _x_x_mozilla_page_load_details 22:08:00 INFO - PROCESS | 21194 | |i|pagename|runs| 22:08:00 INFO - PROCESS | 21194 | |0;dojo.html;3145.7955232909862;3191.0107866561366;3208.3262514871876;3223.290876007279;3225.9516107258396;5252.238425428311;5355.437679043703;5356.892862142755;5382.865428364293;5387.676739395634;5302.1781623848265;5307.044731948247;5366.892662146754;5370.812021579245;5393.73031348432;4876.829310974108;4880.536349046835;4940.382452193476;4946.826861059863;4991.900161996758;4945.579625731799;4949.406071271453;4972.105021096201;4994.300797888299;5008.098542262392;4816.253480710478;4824.34871292378;4907.852764417074;4934.605231581465;4936.160852655057;4883.365162528884;4885.316055752198;4885.584725298354;4901.534354236342;4924.704517728947;4738.952610473885;4873.951260487385;4876.097921884463;4887.413510378778;4943.975280123613;5145.897082058375;5156.587473002151;5188.403333616645;5196.974015129938;5226.608004399647;5768.567357448208;5771.422857714237;5785.27684039495;5787.189793428924;5788.363280039192;5633.746481408305;5816.709164541756;5817.156512305692;5833.7083145842535;5847.06446968483;5373.247745315659;5430.212619170198;5449.809256675997;5461.5357694596405;5487.533559647435;5890.793822216202;5892.646441213456;5928.703564821742;5930.436608522184;5944.0786678064105;5575.860603484945;5679.829605111853;5680.431956804369;5681.744321505542;5728.341240757283;5763.193152958589;5771.422857714195;5771.538276937835;5781.913271300934;5801.82594522165;5674.517665998354;5715.399883012307;5723;5735.0250457422335;5747.166660834156;5645.1532270159805;5668.26312579362;5698.230738850202;5764.193012978187;5824.359320474744;4484.865454036384;4487.282034874404;4488.3940668010055;4490.438695163105;4518.683692141584;3943.507061617298;3983.1237127831832;3985.980070099631;4018.8995275118355;4026.335654617014;5308.548773354231;5337.81317653888;5382.973085134628;5392.56859451243;5432.891342173134;5743.827685169452;5755.625884317506;5762.94237057624;5772.6536407815665;5781.566382521243;5294.2852714883;5414.106672399089;5422.240886275846;5438.102713052381;5480.3971563128025;4862.07620552094;4863.878403039882;4928.063667903159;4942.629302802232;4965.4041515018425;5922.585419020627;5962.880742385128;5968.40315968391;5968.671723055187;5981.790637327673;5628.437156284339;5716.142578613241;5750.798722044876;5754.510866576388;5765.164051212634;5925.970370148294;6010.759569617167;6016.368281330398;6022.969885150546;6108.847278818065;5696.174054762119;5728.226689396878;5734.741936612946;5738.053221218453;5740.397258287987;5663.178839068394;5784.698442850325;5840.240768700041;5845.386234445492;5849.064149736022;5628.155776633538;5672.5745569081655;5703.287089113861;5719.428057194247;5745.195672605755;5553.305836770403;5644.887102258014;5646.661200327993;5660.264165658438;5672.205891175321;5451.155070964007;5497.230387745799;5532.5020748132865;5549.445055494418;5573.6098473106495;5609.607327487037;5625.184348269396;5629.634073785191;5654.123610840326;5692.402297758676;5558.833235002957;5560.860978475571;5566.109422492382;5571.275734154534;5583.469570390806 22:08:00 INFO - PROCESS | 21194 | |1;ext.html;498.87029372363196;521.4420569990112;545.9099248623977;564.4750382144606;566.7761234312445;27790.722092779066;35269.11827204321;35637.109072273204;35683;35747.82126089366;38608;39106.413403798964;39196.80401597995;39307.41038884419;39347.21305573887;8401.117882622313;8495.36284778641;8539.957300213522;8564.571771411436;8576.185262400062;8187.590620468983;8338.291245244161;8372.079071302152;8399.62201700925;8402.831943361129;8321.542315172663;8347.83304333913;8440;8455.492670439762;8491.830163396728;8252.711155109542;8360.12218717032;8379;8384.832303353898;8414.705485307984;8155.143709910433;8206.507609543387;8275.213854683796;8277.296429803473;8431.367647426467;39408.408873866916;40116.79941600273;40201.39697904534;40212.79893600543;40243.195136097114;3258.934821303584;3659.5791483979415;3680.871169509081;3694.242680250542;3804.4863943367845;30281.697183028107;30366.696333036827;30898.53652195219;30936.690633093607;30960.380792384025;3684.907877303062;3710.888673339804;3741.5136032315895;3893.201893611803;3908.257431088084;209584;210023;210659.99999999846;210932;211788;53831.73084134554;54364.45635543673;54423.72788136034;54906.72546637241;55141;63914.36085639084;64419.355806442276;64938.67530662316;65161;65292;14266.643333916527;14396.496122635657;14515.201663908587;14516.782248266285;14517.491887783877;10716.678499645022;10772.94613526943;10783.406912619725;10806.891931080589;10834.187435942336;19226.327078552462;19411.126499307564;20135.496612584804;20344.49138771513;20440.795592044185;7842.607869606497;7907.0906845712325;7992;8042.678292868337;8069.193080691884;875.6183181745641;966.8066386722684;991.8809742830762;993.5380048277585;1158.2529268621693;28503.28741781472;28884;30419;30834.229144271572;31177.688223117933;1003.3929472669076;1003.9096481316717;1059.0521483272428;1077.956881724738;1124.2804605052772;14038.1577105374;14292.642683932776;14563.563093107225;16033.278502467418;16220.188990550661;376812;385552;385967;386119;388117;55532.44467555353;56274.43725562692;56355.436445635016;56562;56642;1334.5796074236584;1334.6529902225298;1336.832895888014;1341.5304643374936;1350.837899452072;29287.70712292935;30580.541291881083;30627.387452251274;31151.688483115784;31418.21454463565;45225.773871130434;45253.09493810171;45455.772721136185;45614.31578526391;45853.54146458493;223993;224230;226162;226535;226879;38113.618863811;41976.790116049226;42229.15541689088;42614.36078458764;43261;38577.842664720105;39347.213055739296;39390.60609393984;39486.40770388389;40010.59989400069;35551.82224088863;35877.82061089678;36807.44788828223;36909.44635830411;37547;35263.82368088143;35670.64329356673;36188.819055904554;36430.4535431974;36789.26421471609;35515.82242088773;36440;36525.63474365223;36577.81711091428;36730.63269367272;30683;32463;32796.83601581977;33649.15877103092;33681.83159084189;25375.111871084424;25379.74620253774;25530.23409297724;25691.614625781003;26012.869935650957 22:08:00 INFO - PROCESS | 21194 | |2;jquery.html;356.7984088989719;360.28483460331256;363.56735484773134;364.32054218881785;368.35170100622906;16356.345746170155;17507.91246043771;18113.728294075565;18527.72208416875;18804.24783008678;11176.776464470706;11206.215564910459;11215.887841121586;11543.01884339832;16292;4810.350602668647;4813.879653008667;4926.285688575154;4954.207326827708;4955.900881982377;4884.902301953976;4915.090708218973;4924.359833221676;4927.581155601778;4930.087933732253;4925.901481970359;4951.504849515056;4966.180580204262;5131.923021154667;5138.126518491847;5111.999999999963;5126.461721519243;5142.66572672777;5152.92270615941;5157.381114266312;5221.503957124067;5222;5228.738563071831;5244.239585260116;5252.474752524755;18800.059997000095;18841.905790471097;19031.80968190314;19075.61848763017;19085.522861928424;2062.845286603496;2098.674705420662;2134.6157691615504;2164.848460607758;2167.425632207466;9153.954230228874;9427;9580.425174489554;9717;10051.748706282327;1644.2600829626715;1646.325006747228;1672.774175486306;1677.2620047179203;1693.3057446447021;57501.13748293779;61593.38406615921;62496;65280.347196528375;66453.66773166151;9975.45135017581;10379.065884070318;10424.947875260576;10442.582296708199;10446.68659940203;13370.26463544495;13417.0608057437;13449.865501345057;13450;13484.662883427796;7463;7472.589007604634;7478.140013898363;7500.624968751541;7562.130355009134;7123.786286411416;7138.785836424916;7169.6773645186095;7210.783676489714;7232.674529646179;4450.109978004412;4498.6626003049905;4501.7974191161475;4506.008678090815;4537.636989040935;1892.0823400650672;1931.9567433585705;1935.3613307608455;1962.5093726568357;1962.5682349883002;410.4540960522498;411.91967566324877;417.83704355301455;438.1827890983293;444.72871548355477;10017.849732254022;10388.909164537767;16822.158892055348;17305.65388692219;17993.460196194133;877.6401675313091;936.4521754773398;956.5743244256379;957.7501360724183;975.2295686407658;7739.806504837312;9026.638934442548;9148;9197.402168859137;9293.210077143383;417787;420085;423932;426669;579656;76468;79043;81428;83274;83516.58241708753;1136.0627482327113;1158.0851127609262;1169.929804211733;1186.246733324328;1186.786378451887;14535.563933082025;14572.344244508811;14655.413783448543;14708.264586770405;14840.10959342443;32773;33306;34076.82961585176;34205.486917696755;34628.134296642784;45646.31530527111;45891.31163032624;47274.527254727014;48868;49162.50837491579;9361.4383137012;9405.670801521914;9511.286653501153;9529.618815247313;9599.712008639752;11064.114870810155;11098.833517497405;11189.160812939224;12492.875071249535;17533;12283.447244873823;12480.563180288646;13073.084884058024;13604.115732477358;14618.707625847635;13212.801807973081;13267.734645306848;13425;13734.45062197501;13945;13962.869676239645;14212.431502740188;14812.62968425798;14983.250837457865;15095.24523773785;9079.409838360485;9374.343795934492;9508.239340852577;9529.285303602397;9634.277429192698;10220.284580079324;12097.939510302393;14099;14305.356258968162;14423.92788036053 22:08:00 INFO - PROCESS | 21194 | |3;mootools.html;1487.2415068315158;1502.9854847977615;1660.8671306295498;1776.618027124168;1797.290070422184;6895.275996020421;7015.228324884259;7565.5460672359695;7880.054393472777;7905.288524032836;7507.24927507249;7588.051493563305;7616.162222155573;7665.386769058476;7692.269234422721;2174.4346469917855;2234.240358278185;2236.027328112268;2236.2173239366175;2236.944076398087;2243.147603910512;2278.28234106256;2284.23478134825;2288.5651726171973;2294.9443256102213;2224.0547767198955;2235.7540670526228;2263.8981245843975;2268.61433556295;2270.829687773415;2230.2640128757553;2245.69683092782;2249.0441562336023;2263.321003698884;2267.9092836286527;2274.044901141508;2294.38051726033;2306.2158865985643;2307;2308.5267520158327;7788;7842.137364889858;7877.487963282369;7902.446828721992;7909.920900790976;4682.742449165295;4686.484486706459;4732.526747325274;4743.051389722035;4771.355866957951;3022.486177349856;3022.501287287617;3089.351236240392;3118.7349075328625;3133;986.8519722041751;987.0918754745651;1007.8135544924139;1018.2668478695327;1032.9690109296732;10881.075108615698;10901.781964360747;10949.45252737368;10959.780804383867;10992.725181870437;4224.556421575752;4252.255855225323;4279.229738647011;4294.914101717948;4313.051128751669;9340.159385655188;9376.062393760569;9384.95307523458;9402.106799854002;9409.294302927308;4690.460597031317;4698.88252793676;4700.271457924027;4720.622350211975;4740.739259340769;4142.834286628501;4260.531341552427;4292.720973136736;4317.805698743564;4349.499807522176;3456.1359660084977;3476.774009689362;3479.460683594047;3497.143199915986;3497.8600855965983;1061.9575216991234;1064.4092528646675;1071.8713754349371;1084.7179733269406;1085.8642669666292;981.293468702533;991.9305648604528;994.6817018553993;1106.4080716816466;1339.5713371720956;7336.339729424378;7371.557706537625;7377.77866664001;7396.96301518489;7409.740659076906;1170.9180357375071;1202.4108186988487;1208.9818652720217;1211.3035004872233;1242.8446444194476;5904.645721256738;5913;5958.761649534057;5967.433093856077;6015.218021657157;9521.190698790542;9697.418154910587;9776.071273229032;9778.07108324708;9862.950685246527;9343.672971445967;9574.47340396271;9624.711258662252;9644.565994530263;9695.854562181574;7440.441966852508;7452.850942981218;7459.477836551389;7487.1389790173735;7531;6891.6780300391;6967.651617419007;6977.895331570132;6993.790186294419;6995.79012629622;8405.411621186458;8481.2366886978;8556.614952327285;8613.2248097669;8735.606897689746;8539.274161696325;8744.825103498022;8784.429012114193;8861.556922153995;8904.955475222583;6520.413162815369;6598.90101648466;6770.01834733951;6900.758473453606;6915.343042410963;7355.080614923135;7374.1151061872915;7401.407887369105;7429;7443.627818608939;6881.518293719391;7007.369336759716;7047.189573199148;7164.570125792469;7193.2087470379265;7073.787786366417;7105.360517553445;7131.536450130725;7199.676014579251;7220.638968051681;6553.705083271169;6609.4712423007;6658.6337751424135;6667.733290668319;7116.323949224816;6504.804855854332;6562.081308616893;6594.637294948824;6597.439217666552;6606.9008964866525;6352.110704501281;6353.459955903615;6394.136791533269;6403.3276505966205;6425.1968503937005 22:08:00 INFO - PROCESS | 21194 | |4;prototype.html;335.44986222594946;336.0959020235566;336.29713897953303;341.95383623210876;347.71834813800825;6290.559660823733;6294.08735733319;6297.2128483939505;6307.905381419277;6447.677616119198;6198.59709118907;6240.84397890053;6241.21984751906;6256.937430625692;6282.842928926768;4735.124002059612;4736.100140973204;4747.810087596492;4752.5485078917445;4753.738544380067;4740.739259340752;4753.239481682931;4755.262934245197;4757.452892917307;4760.952390476085;4566.611837993774;4703.694259873115;4705.223638099709;4706.929396059062;4711.623070154396;4659.4408670959365;4672.528153631595;4675.812967481331;4686.53134686532;4723.905521889543;4072.409500622423;4092.3043082676018;4104.404861295126;4104.794760261975;4116.670666346715;5965.075413310944;5982.700864956735;5993.460588547052;6014.75940962361;6031.095335699636;5319.787208511655;5426.077566813651;5462.617616766828;5472.644278121949;5512.118061110203;6498.9350106498805;6528.11870397495;6531.8693626127215;6576.243731970789;6577.539572229945;4471.575200355961;4473.194824931511;4502.392177056088;4505.279155335131;4508.143452744001;6758.9324106758795;6816.182058153054;6859;6897.3447522485285;6929.3070692930305;4624.722516649012;4626.907461850744;4635.953640463552;4647.6281897448125;4649.070185962821;4670.346151538787;4700.2949557566635;4708.8351907683755;4711.505291944365;4712.363830882856;5453.890922181614;5461.672299662033;5464.726763661801;5465;5466.180072989084;6505.642189679518;6664.266930637626;6664.86670266592;6666.500012499082;6672;1624.236608793865;1650.257384177125;1652.5785924589152;1653.8676905847503;1655.222045638548;1097.1332647208617;1100.5817789240198;1102.6361300770886;1102.652664410708;1111.0445017285128;6159.3224745277985;6170.907436388457;6194.287656919512;6200.844978875564;6206.813795586139;6750.966245168743;6753.08833307507;6761.8647627047185;6763.898541521881;6765.8646827063185;6074.51403887688;6177.938220617736;6183.536234782409;6186.690665466709;6197.96901015492;3631.927361452809;3646.890593282206;3665.5051568038507;3673.779573225615;3675.22820207754;6980.965095174492;6994.965025174842;7018.894716579255;7023.086998690138;7033.859322813515;6760.492963027793;6900.447964162855;6926.930730692729;6939.757108501179;6952.339527744856;6985.545939513915;6992.650367481708;7001.369876711018;7023.578585284899;7039.472039597051;6741.258461569321;6757.594544327356;6759.729610815512;6762.661866906733;6765.154355705537;6573.244076931214;6627.138471998609;6640.701168447528;6666.666666666744;6669.066330713801;6946.44428445713;6989.860202796017;7002.75490357835;7011.579305241702;7018.192907815463;4586.518415566317;4589.242774942097;4594.494605593315;4603.010352774169;4603.884902877321;6744.494162937897;6763.391294783493;6774.288699686462;6800.251972282946;6880.58716476993;6604.207495100619;6609.4712423005085;6668.333166683293;6676.566023208476;6707.094542236736;6652.401283884474;6660.134182556237;6683.866322673616;6706.6646667665445;6716.932830671631;6473.417392434703;6540.705668245036;6564.704588293634;6568.113304703804;6580.934190658032;6681.699323530355;6720.731170753311;6722.831929201809;6723.932760672331;6740.988851672289;6551;6552.901706474311;6564.540482166202;6573.3098024706715;6582.3746744059235 22:08:00 INFO - PROCESS | 21194 | |5;yui.html;803.0844836885948;806.8144326804835;817.9325979596624;825.2696363718109;855.6876739989901;13390.12964157329;13507.25710085945;13511.797323040162;13538.526151584696;13595.660108497292;12717.109802313842;12732.681682957931;12747.107702460831;12771.361431928413;12783.680407989805;806.7660378490231;814.3851392198882;823.6664151018847;823.9382046346518;824.2334628795218;804.2600807257309;807.4711064252924;809.017044291186;811.0753740735566;811.3549727966251;858.4248553469159;860.8794768732382;861.6897916749965;863.7236084452946;864.6022829498438;853.21504216121;854.2439940652505;856.2422256303154;857.3355649371756;858.8497013022696;617.9938200617981;624.2446639566131;629.2700467457773;629.5372900917822;630.1398590923357;13707.45170193201;13741.312934353342;13744.381502832297;13777.448902043907;13810.309484525835;11080.501377438035;11266.32402055871;11506.942465287704;11518.308901465854;11643.59247426336;9503.90496095037;9537.046295370477;9573.808523829553;10080.14318782897;10440.738981525446;3390.542276792626;3396.083057574466;3419.675130862564;3437.2781715839456;3453.5510383649967;47748.761256193844;47988.520114798754;48438.75780621074;48558.75720621374;48801.267980980316;7788.649510772028;8472.136130051378;8852.557372131496;9068.274538036942;9111.863322050041;17582.296708131787;17681.204345804468;17722.46832595024;17722.734158987627;17724.11379431049;6547.377999090078;6868.965655171693;7016.228214896358;7103.82240443993;7348.934404511316;3613.1328481164855;3751.568569614529;3768.9246215075545;3769.302679004338;3832.4442955771256;3015.9547606785914;3053.4045861057325;3057.8165310081467;3061.7244447999788;3063.5864158338786;523.6936392210523;539.5063516882009;548.5310059898729;549.1789774287386;552.6877314317397;539.919012148181;573.824983380073;584.2171490203148;631.2330518420141;645.2063961327593;8227.8354432911;8801.559922003875;8867.201951824367;8975;9181.127792859801;532.866783304174;612.7671484835734;642.4924309795209;693.3517161454057;709.9280087068564;3691.501647277637;3701.222743223899;3831.8850434486453;3872.3997780344093;3980.9402858957137;52297.47702523002;57217.42782572204;57228;57339.13991290134;57585.42414575884;44892.3266151008;46222.768886155354;47184;47428.525714743104;49444.75277623661;45637.543624563994;46482.76758616253;46527.534724653;46629;46642.30036549454;8409;8530.232279094664;8781.517016563896;8796.164364385373;9007.189352958265;34744.30511389809;35237;35282;35530.46704299489;35839.64160358467;41090.1781964365;41120.79439602783;44196.55803441924;45249.77375113103;46190;9979.850302245617;10217.744556385853;10599.311044782064;10719.14246860265;10818.51316690735;11805.23265987708;11911.642650720492;12041.458134383798;12522.499100035897;12527.060470464934;9710.17463515609;9898.901010990086;9931.553080111267;10007.09936105754;11063.225574209728;9716.222702183666;9742.415455072718;10403.219758518293;10423.739406514898;10465.267431280043;9782.119609235204;10175.745606359604;10216.489175541343;10529.684109476728;10734.248602597743;8910.955445222733;9131.269498440242;9260.166585007382;9766.804663906823;10003.049710277512;8209.79020979021;8786.868196976922;9147.77130571741;9272.397294175857;9322.720318390458 22:08:00 INFO - PROCESS | 21194 | __end_tp_report 22:08:00 INFO - PROCESS | 21194 | __start_cc_report 22:08:00 INFO - PROCESS | 21194 | _x_x_mozilla_cycle_collect,315 22:08:00 INFO - PROCESS | 21194 | __end_cc_report 22:08:00 INFO - PROCESS | 21194 | __startTimestamp1451887680119__endTimestamp 22:08:00 INFO - PROCESS | 21194 | 22:08:00 INFO - PROCESS | 21194 | ------- Summary: start ------- 22:08:00 INFO - PROCESS | 21194 | Number of tests: 6 22:08:00 INFO - PROCESS | 21194 | 22:08:00 INFO - PROCESS | 21194 | [#0] dojo.html Cycles:165 Average:5353.43 Median:5566.11 stddev:593.77 (10.7%) stddev-sans-first:569.78 22:08:00 INFO - PROCESS | 21194 | Values: 3145.8 3191.0 3208.3 3223.3 3226.0 5252.2 5355.4 5356.9 5382.9 5387.7 5302.2 5307.0 5366.9 5370.8 5393.7 4876.8 4880.5 4940.4 4946.8 4991.9 4945.6 4949.4 4972.1 4994.3 5008.1 4816.3 4824.3 4907.9 4934.6 4936.2 4883.4 4885.3 4885.6 4901.5 4924.7 4739.0 4874.0 4876.1 4887.4 4944.0 5145.9 5156.6 5188.4 5197.0 5226.6 5768.6 5771.4 5785.3 5787.2 5788.4 5633.7 5816.7 5817.2 5833.7 5847.1 5373.2 5430.2 5449.8 5461.5 5487.5 5890.8 5892.6 5928.7 5930.4 5944.1 5575.9 5679.8 5680.4 5681.7 5728.3 5763.2 5771.4 5771.5 5781.9 5801.8 5674.5 5715.4 5723.0 5735.0 5747.2 5645.2 5668.3 5698.2 5764.2 5824.4 4484.9 4487.3 4488.4 4490.4 4518.7 3943.5 3983.1 3986.0 4018.9 4026.3 5308.5 5337.8 5383.0 5392.6 5432.9 5743.8 5755.6 5762.9 5772.7 5781.6 5294.3 5414.1 5422.2 5438.1 5480.4 4862.1 4863.9 4928.1 4942.6 4965.4 5922.6 5962.9 5968.4 5968.7 5981.8 5628.4 5716.1 5750.8 5754.5 5765.2 5926.0 6010.8 6016.4 6023.0 6108.8 5696.2 5728.2 5734.7 5738.1 5740.4 5663.2 5784.7 5840.2 5845.4 5849.1 5628.2 5672.6 5703.3 5719.4 5745.2 5553.3 5644.9 5646.7 5660.3 5672.2 5451.2 5497.2 5532.5 5549.4 5573.6 5609.6 5625.2 5629.6 5654.1 5692.4 5558.8 5560.9 5566.1 5571.3 5583.5 22:08:00 INFO - PROCESS | 21194 | 22:08:00 INFO - PROCESS | 21194 | [#1] ext.html Cycles:180 Average:44881.45 Median:3726.20 stddev:74822.70 (2008.0%) stddev-sans-first:74958.39 22:08:00 INFO - PROCESS | 21194 | Values: 498.9 521.4 545.9 564.5 566.8 27790.7 35269.1 35637.1 35683.0 35747.8 38608.0 39106.4 39196.8 39307.4 39347.2 8401.1 8495.4 8540.0 8564.6 8576.2 8187.6 8338.3 8372.1 8399.6 8402.8 8321.5 8347.8 8440.0 8455.5 8491.8 8252.7 8360.1 8379.0 8384.8 8414.7 8155.1 8206.5 8275.2 8277.3 8431.4 39408.4 40116.8 40201.4 40212.8 40243.2 3258.9 3659.6 3680.9 3694.2 3804.5 30281.7 30366.7 30898.5 30936.7 30960.4 3684.9 3710.9 3741.5 3893.2 3908.3 209584.0 210023.0 210660.0 210932.0 211788.0 53831.7 54364.5 54423.7 54906.7 55141.0 63914.4 64419.4 64938.7 65161.0 65292.0 14266.6 14396.5 14515.2 14516.8 14517.5 10716.7 10772.9 10783.4 10806.9 10834.2 19226.3 19411.1 20135.5 20344.5 20440.8 7842.6 7907.1 7992.0 8042.7 8069.2 875.6 966.8 991.9 993.5 1158.3 28503.3 28884.0 30419.0 30834.2 31177.7 1003.4 1003.9 1059.1 1078.0 1124.3 14038.2 14292.6 14563.6 16033.3 16220.2 376812.0 385552.0 385967.0 386119.0 388117.0 55532.4 56274.4 56355.4 56562.0 56642.0 1334.6 1334.7 1336.8 1341.5 1350.8 29287.7 30580.5 30627.4 31151.7 31418.2 45225.8 45253.1 45455.8 45614.3 45853.5 223993.0 224230.0 226162.0 226535.0 226879.0 38113.6 41976.8 42229.2 42614.4 43261.0 38577.8 39347.2 39390.6 39486.4 40010.6 35551.8 35877.8 36807.4 36909.4 37547.0 35263.8 35670.6 36188.8 36430.5 36789.3 35515.8 36440.0 36525.6 36577.8 36730.6 30683.0 32463.0 32796.8 33649.2 33681.8 25375.1 25379.7 25530.2 25691.6 26012.9 22:08:00 INFO - PROCESS | 21194 | 22:08:00 INFO - PROCESS | 21194 | [#2] jquery.html Cycles:180 Average:26046.48 Median:411.19 stddev:75167.50 (18280.6%) stddev-sans-first:75353.61 22:08:00 INFO - PROCESS | 21194 | Values: 356.8 360.3 363.6 364.3 368.4 16356.3 17507.9 18113.7 18527.7 18804.2 11176.8 11206.2 11215.9 11543.0 16292.0 4810.4 4813.9 4926.3 4954.2 4955.9 4884.9 4915.1 4924.4 4927.6 4930.1 4925.9 4951.5 4966.2 5131.9 5138.1 5112.0 5126.5 5142.7 5152.9 5157.4 5221.5 5222.0 5228.7 5244.2 5252.5 18800.1 18841.9 19031.8 19075.6 19085.5 2062.8 2098.7 2134.6 2164.8 2167.4 9154.0 9427.0 9580.4 9717.0 10051.7 1644.3 1646.3 1672.8 1677.3 1693.3 57501.1 61593.4 62496.0 65280.3 66453.7 9975.5 10379.1 10424.9 10442.6 10446.7 13370.3 13417.1 13449.9 13450.0 13484.7 7463.0 7472.6 7478.1 7500.6 7562.1 7123.8 7138.8 7169.7 7210.8 7232.7 4450.1 4498.7 4501.8 4506.0 4537.6 1892.1 1932.0 1935.4 1962.5 1962.6 410.5 411.9 417.8 438.2 444.7 10017.8 10388.9 16822.2 17305.7 17993.5 877.6 936.5 956.6 957.8 975.2 7739.8 9026.6 9148.0 9197.4 9293.2 417787.0 420085.0 423932.0 426669.0 579656.0 76468.0 79043.0 81428.0 83274.0 83516.6 1136.1 1158.1 1169.9 1186.2 1186.8 14535.6 14572.3 14655.4 14708.3 14840.1 32773.0 33306.0 34076.8 34205.5 34628.1 45646.3 45891.3 47274.5 48868.0 49162.5 9361.4 9405.7 9511.3 9529.6 9599.7 11064.1 11098.8 11189.2 12492.9 17533.0 12283.4 12480.6 13073.1 13604.1 14618.7 13212.8 13267.7 13425.0 13734.5 13945.0 13962.9 14212.4 14812.6 14983.3 15095.2 9079.4 9374.3 9508.2 9529.3 9634.3 10220.3 12097.9 14099.0 14305.4 14423.9 22:08:00 INFO - PROCESS | 21194 | 22:08:00 INFO - PROCESS | 21194 | [#3] mootools.html Cycles:180 Average:5486.99 Median:6512.61 stddev:2876.07 (44.2%) stddev-sans-first:2868.42 22:08:00 INFO - PROCESS | 21194 | Values: 1487.2 1503.0 1660.9 1776.6 1797.3 6895.3 7015.2 7565.5 7880.1 7905.3 7507.2 7588.1 7616.2 7665.4 7692.3 2174.4 2234.2 2236.0 2236.2 2236.9 2243.1 2278.3 2284.2 2288.6 2294.9 2224.1 2235.8 2263.9 2268.6 2270.8 2230.3 2245.7 2249.0 2263.3 2267.9 2274.0 2294.4 2306.2 2307.0 2308.5 7788.0 7842.1 7877.5 7902.4 7909.9 4682.7 4686.5 4732.5 4743.1 4771.4 3022.5 3022.5 3089.4 3118.7 3133.0 986.9 987.1 1007.8 1018.3 1033.0 10881.1 10901.8 10949.5 10959.8 10992.7 4224.6 4252.3 4279.2 4294.9 4313.1 9340.2 9376.1 9385.0 9402.1 9409.3 4690.5 4698.9 4700.3 4720.6 4740.7 4142.8 4260.5 4292.7 4317.8 4349.5 3456.1 3476.8 3479.5 3497.1 3497.9 1062.0 1064.4 1071.9 1084.7 1085.9 981.3 991.9 994.7 1106.4 1339.6 7336.3 7371.6 7377.8 7397.0 7409.7 1170.9 1202.4 1209.0 1211.3 1242.8 5904.6 5913.0 5958.8 5967.4 6015.2 9521.2 9697.4 9776.1 9778.1 9863.0 9343.7 9574.5 9624.7 9644.6 9695.9 7440.4 7452.9 7459.5 7487.1 7531.0 6891.7 6967.7 6977.9 6993.8 6995.8 8405.4 8481.2 8556.6 8613.2 8735.6 8539.3 8744.8 8784.4 8861.6 8905.0 6520.4 6598.9 6770.0 6900.8 6915.3 7355.1 7374.1 7401.4 7429.0 7443.6 6881.5 7007.4 7047.2 7164.6 7193.2 7073.8 7105.4 7131.5 7199.7 7220.6 6553.7 6609.5 6658.6 6667.7 7116.3 6504.8 6562.1 6594.6 6597.4 6606.9 6352.1 6353.5 6394.1 6403.3 6425.2 22:08:00 INFO - PROCESS | 21194 | 22:08:00 INFO - PROCESS | 21194 | [#4] prototype.html Cycles:180 Average:5500.02 Median:6223.83 stddev:1669.66 (26.8%) stddev-sans-first:1628.73 22:08:00 INFO - PROCESS | 21194 | Values: 335.4 336.1 336.3 342.0 347.7 6290.6 6294.1 6297.2 6307.9 6447.7 6198.6 6240.8 6241.2 6256.9 6282.8 4735.1 4736.1 4747.8 4752.5 4753.7 4740.7 4753.2 4755.3 4757.5 4761.0 4566.6 4703.7 4705.2 4706.9 4711.6 4659.4 4672.5 4675.8 4686.5 4723.9 4072.4 4092.3 4104.4 4104.8 4116.7 5965.1 5982.7 5993.5 6014.8 6031.1 5319.8 5426.1 5462.6 5472.6 5512.1 6498.9 6528.1 6531.9 6576.2 6577.5 4471.6 4473.2 4502.4 4505.3 4508.1 6758.9 6816.2 6859.0 6897.3 6929.3 4624.7 4626.9 4636.0 4647.6 4649.1 4670.3 4700.3 4708.8 4711.5 4712.4 5453.9 5461.7 5464.7 5465.0 5466.2 6505.6 6664.3 6664.9 6666.5 6672.0 1624.2 1650.3 1652.6 1653.9 1655.2 1097.1 1100.6 1102.6 1102.7 1111.0 6159.3 6170.9 6194.3 6200.8 6206.8 6751.0 6753.1 6761.9 6763.9 6765.9 6074.5 6177.9 6183.5 6186.7 6198.0 3631.9 3646.9 3665.5 3673.8 3675.2 6981.0 6995.0 7018.9 7023.1 7033.9 6760.5 6900.4 6926.9 6939.8 6952.3 6985.5 6992.7 7001.4 7023.6 7039.5 6741.3 6757.6 6759.7 6762.7 6765.2 6573.2 6627.1 6640.7 6666.7 6669.1 6946.4 6989.9 7002.8 7011.6 7018.2 4586.5 4589.2 4594.5 4603.0 4603.9 6744.5 6763.4 6774.3 6800.3 6880.6 6604.2 6609.5 6668.3 6676.6 6707.1 6652.4 6660.1 6683.9 6706.7 6716.9 6473.4 6540.7 6564.7 6568.1 6580.9 6681.7 6720.7 6722.8 6723.9 6741.0 6551.0 6552.9 6564.5 6573.3 6582.4 22:08:00 INFO - PROCESS | 21194 | 22:08:00 INFO - PROCESS | 21194 | [#5] yui.html Cycles:180 Average:13366.41 Median:50871.11 stddev:15625.55 (30.7%) stddev-sans-first:15640.90 22:08:00 INFO - PROCESS | 21194 | Values: 803.1 806.8 817.9 825.3 855.7 13390.1 13507.3 13511.8 13538.5 13595.7 12717.1 12732.7 12747.1 12771.4 12783.7 806.8 814.4 823.7 823.9 824.2 804.3 807.5 809.0 811.1 811.4 858.4 860.9 861.7 863.7 864.6 853.2 854.2 856.2 857.3 858.8 618.0 624.2 629.3 629.5 630.1 13707.5 13741.3 13744.4 13777.4 13810.3 11080.5 11266.3 11506.9 11518.3 11643.6 9503.9 9537.0 9573.8 10080.1 10440.7 3390.5 3396.1 3419.7 3437.3 3453.6 47748.8 47988.5 48438.8 48558.8 48801.3 7788.6 8472.1 8852.6 9068.3 9111.9 17582.3 17681.2 17722.5 17722.7 17724.1 6547.4 6869.0 7016.2 7103.8 7348.9 3613.1 3751.6 3768.9 3769.3 3832.4 3016.0 3053.4 3057.8 3061.7 3063.6 523.7 539.5 548.5 549.2 552.7 539.9 573.8 584.2 631.2 645.2 8227.8 8801.6 8867.2 8975.0 9181.1 532.9 612.8 642.5 693.4 709.9 3691.5 3701.2 3831.9 3872.4 3980.9 52297.5 57217.4 57228.0 57339.1 57585.4 44892.3 46222.8 47184.0 47428.5 49444.8 45637.5 46482.8 46527.5 46629.0 46642.3 8409.0 8530.2 8781.5 8796.2 9007.2 34744.3 35237.0 35282.0 35530.5 35839.6 41090.2 41120.8 44196.6 45249.8 46190.0 9979.9 10217.7 10599.3 10719.1 10818.5 11805.2 11911.6 12041.5 12522.5 12527.1 9710.2 9898.9 9931.6 10007.1 11063.2 9716.2 9742.4 10403.2 10423.7 10465.3 9782.1 10175.7 10216.5 10529.7 10734.2 8911.0 9131.3 9260.2 9766.8 10003.0 8209.8 8786.9 9147.8 9272.4 9322.7 22:08:00 INFO - PROCESS | 21194 | -------- Summary: end -------- 22:08:00 INFO - PROCESS | 21194 | 22:08:00 INFO - TEST-INFO | 21194: exit 0 22:08:00 INFO - TEST-OK | dromaeo_css | took 1110572ms 22:08:00 INFO - TEST-START | kraken 22:08:00 INFO - operating with platform_type : linux_ 22:08:00 INFO - Initialising browser for kraken test... 22:08:00 INFO - TEST-INFO | started process 21431 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQzz9zF/profile http://localhost:52641/getInfo.html) 22:08:05 INFO - PROCESS | 21431 | __metrics Screen width/height:1600/1200 22:08:05 INFO - PROCESS | 21431 | colorDepth:24 22:08:05 INFO - PROCESS | 21431 | Browser inner width/height: 1024/697 22:08:05 INFO - PROCESS | 21431 | __metrics 22:08:05 INFO - PROCESS | 21431 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:08:06 INFO - TEST-INFO | 21431: exit 0 22:08:06 INFO - Browser initialized. 22:08:06 INFO - Running cycle 1/1 for kraken test... 22:08:06 INFO - TEST-INFO | started process 21556 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQzz9zF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:08:18 INFO - PROCESS | 21556 | RSS: Main: 150462464 22:08:18 INFO - PROCESS | 21556 | 22:08:20 INFO - PROCESS | 21556 | Cycle 1(1): loaded http://localhost:52641/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52641/tests/kraken/driver.html?testName=audio-beat-detection) 22:08:21 INFO - PROCESS | 21556 | RSS: Main: 151564288 22:08:21 INFO - PROCESS | 21556 | 22:08:24 INFO - PROCESS | 21556 | Cycle 1(1): loaded http://localhost:52641/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52641/tests/kraken/driver.html?testName=audio-dft) 22:08:24 INFO - PROCESS | 21556 | RSS: Main: 149966848 22:08:24 INFO - PROCESS | 21556 | 22:08:27 INFO - PROCESS | 21556 | Cycle 1(1): loaded http://localhost:52641/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52641/tests/kraken/driver.html?testName=audio-fft) 22:08:28 INFO - PROCESS | 21556 | RSS: Main: 146300928 22:08:28 INFO - PROCESS | 21556 | 22:08:30 INFO - PROCESS | 21556 | Cycle 1(1): loaded http://localhost:52641/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52641/tests/kraken/driver.html?testName=audio-oscillator) 22:08:30 INFO - PROCESS | 21556 | RSS: Main: 146067456 22:08:30 INFO - PROCESS | 21556 | 22:08:32 INFO - PROCESS | 21556 | Cycle 1(1): loaded http://localhost:52641/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52641/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:08:33 INFO - PROCESS | 21556 | RSS: Main: 146268160 22:08:33 INFO - PROCESS | 21556 | 22:08:36 INFO - PROCESS | 21556 | Cycle 1(1): loaded http://localhost:52641/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52641/tests/kraken/driver.html?testName=imaging-darkroom) 22:08:37 INFO - PROCESS | 21556 | RSS: Main: 146923520 22:08:37 INFO - PROCESS | 21556 | 22:08:40 INFO - PROCESS | 21556 | Cycle 1(1): loaded http://localhost:52641/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52641/tests/kraken/driver.html?testName=imaging-desaturate) 22:08:41 INFO - PROCESS | 21556 | RSS: Main: 148250624 22:08:41 INFO - PROCESS | 21556 | 22:08:43 INFO - PROCESS | 21556 | Cycle 1(1): loaded http://localhost:52641/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52641/tests/kraken/driver.html?testName=json-parse-financial) 22:08:44 INFO - PROCESS | 21556 | RSS: Main: 148267008 22:08:44 INFO - PROCESS | 21556 | 22:08:46 INFO - PROCESS | 21556 | Cycle 1(1): loaded http://localhost:52641/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52641/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:08:46 INFO - PROCESS | 21556 | RSS: Main: 148135936 22:08:46 INFO - PROCESS | 21556 | 22:08:48 INFO - PROCESS | 21556 | Cycle 1(1): loaded http://localhost:52641/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52641/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:08:49 INFO - PROCESS | 21556 | RSS: Main: 148635648 22:08:49 INFO - PROCESS | 21556 | 22:08:51 INFO - PROCESS | 21556 | Cycle 1(1): loaded http://localhost:52641/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52641/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:08:51 INFO - PROCESS | 21556 | RSS: Main: 149073920 22:08:51 INFO - PROCESS | 21556 | 22:08:54 INFO - PROCESS | 21556 | Cycle 1(1): loaded http://localhost:52641/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52641/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:08:54 INFO - PROCESS | 21556 | RSS: Main: 149434368 22:08:54 INFO - PROCESS | 21556 | 22:08:57 INFO - PROCESS | 21556 | Cycle 1(1): loaded http://localhost:52641/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52641/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:08:57 INFO - PROCESS | 21556 | RSS: Main: 148525056 22:08:57 INFO - PROCESS | 21556 | 22:08:59 INFO - PROCESS | 21556 | Cycle 1(1): loaded http://localhost:52641/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52641/tests/kraken/driver.html?testName=ai-astar) 22:08:59 INFO - PROCESS | 21556 | RSS: Main: 148893696 22:08:59 INFO - PROCESS | 21556 | 22:08:59 INFO - PROCESS | 21556 | __start_tp_report 22:08:59 INFO - PROCESS | 21556 | _x_x_mozilla_page_load 22:08:59 INFO - PROCESS | 21556 | _x_x_mozilla_page_load_details 22:08:59 INFO - PROCESS | 21556 | |i|pagename|runs| 22:08:59 INFO - PROCESS | 21556 | |0;ai-astar;111;104;111;109;111;121;110;111;112;109 22:08:59 INFO - PROCESS | 21556 | |1;audio-beat-detection;156;126;157;161;125;149;153;128;169;126 22:08:59 INFO - PROCESS | 21556 | |2;audio-dft;162;161;165;162;162;161;161;166;173;164 22:08:59 INFO - PROCESS | 21556 | |3;audio-fft;74;75;72;74;71;76;142;72;74;72 22:08:59 INFO - PROCESS | 21556 | |4;audio-oscillator;96;97;135;96;96;97;138;97;98;139 22:08:59 INFO - PROCESS | 21556 | |5;imaging-gaussian-blur;109;109;109;110;109;110;110;110;110;109 22:08:59 INFO - PROCESS | 21556 | |6;imaging-darkroom;148;148;147;146;146;147;147;148;147;148 22:08:59 INFO - PROCESS | 21556 | |7;imaging-desaturate;96;98;96;96;96;98;96;96;96;97 22:08:59 INFO - PROCESS | 21556 | |8;json-parse-financial;60;61;60;60;60;60;60;63;57;58 22:08:59 INFO - PROCESS | 21556 | |9;json-stringify-tinderbox;67;67;67;68;68;67;71;67;71;67 22:08:59 INFO - PROCESS | 21556 | |10;stanford-crypto-aes;87;87;87;94;86;86;88;85;87;87 22:08:59 INFO - PROCESS | 21556 | |11;stanford-crypto-ccm;119;124;124;126;132;123;129;129;128;122 22:08:59 INFO - PROCESS | 21556 | |12;stanford-crypto-pbkdf2;145;155;154;155;154;143;144;153;144;143 22:08:59 INFO - PROCESS | 21556 | |13;stanford-crypto-sha256-iterative;71;69;69;70;70;76;69;71;70;69 22:08:59 INFO - PROCESS | 21556 | __end_tp_report 22:08:59 INFO - PROCESS | 21556 | __start_cc_report 22:08:59 INFO - PROCESS | 21556 | _x_x_mozilla_cycle_collect,782 22:08:59 INFO - PROCESS | 21556 | __end_cc_report 22:08:59 INFO - PROCESS | 21556 | __startTimestamp1451887739962__endTimestamp 22:08:59 INFO - PROCESS | 21556 | 22:08:59 INFO - PROCESS | 21556 | ------- Summary: start ------- 22:08:59 INFO - PROCESS | 21556 | Number of tests: 14 22:08:59 INFO - PROCESS | 21556 | 22:08:59 INFO - PROCESS | 21556 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:4.20 (3.8%) stddev-sans-first:4.46 22:08:59 INFO - PROCESS | 21556 | Values: 111.0 104.0 111.0 109.0 111.0 121.0 110.0 111.0 112.0 109.0 22:08:59 INFO - PROCESS | 21556 | 22:08:59 INFO - PROCESS | 21556 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:154.50 stddev:16.96 (11.0%) stddev-sans-first:17.51 22:08:59 INFO - PROCESS | 21556 | Values: 156.0 126.0 157.0 161.0 125.0 149.0 153.0 128.0 169.0 126.0 22:08:59 INFO - PROCESS | 21556 | 22:08:59 INFO - PROCESS | 21556 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:3.71 (2.3%) stddev-sans-first:3.89 22:08:59 INFO - PROCESS | 21556 | Values: 162.0 161.0 165.0 162.0 162.0 161.0 161.0 166.0 173.0 164.0 22:08:59 INFO - PROCESS | 21556 | 22:08:59 INFO - PROCESS | 21556 | [#3] audio-fft Cycles:10 Average:80.20 Median:74.00 stddev:21.77 (29.4%) stddev-sans-first:22.98 22:08:59 INFO - PROCESS | 21556 | Values: 74.0 75.0 72.0 74.0 71.0 76.0 142.0 72.0 74.0 72.0 22:08:59 INFO - PROCESS | 21556 | 22:08:59 INFO - PROCESS | 21556 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:96.50 stddev:19.66 (20.4%) stddev-sans-first:20.29 22:08:59 INFO - PROCESS | 21556 | Values: 96.0 97.0 135.0 96.0 96.0 97.0 138.0 97.0 98.0 139.0 22:08:59 INFO - PROCESS | 21556 | 22:08:59 INFO - PROCESS | 21556 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 22:08:59 INFO - PROCESS | 21556 | Values: 109.0 109.0 109.0 110.0 109.0 110.0 110.0 110.0 110.0 109.0 22:08:59 INFO - PROCESS | 21556 | 22:08:59 INFO - PROCESS | 21556 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 22:08:59 INFO - PROCESS | 21556 | Values: 148.0 148.0 147.0 146.0 146.0 147.0 147.0 148.0 147.0 148.0 22:08:59 INFO - PROCESS | 21556 | 22:08:59 INFO - PROCESS | 21556 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:0.85 (0.9%) stddev-sans-first:0.88 22:08:59 INFO - PROCESS | 21556 | Values: 96.0 98.0 96.0 96.0 96.0 98.0 96.0 96.0 96.0 97.0 22:08:59 INFO - PROCESS | 21556 | 22:08:59 INFO - PROCESS | 21556 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:60.00 stddev:1.60 (2.7%) stddev-sans-first:1.69 22:08:59 INFO - PROCESS | 21556 | Values: 60.0 61.0 60.0 60.0 60.0 60.0 60.0 63.0 57.0 58.0 22:08:59 INFO - PROCESS | 21556 | 22:08:59 INFO - PROCESS | 21556 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:67.50 stddev:1.63 (2.4%) stddev-sans-first:1.69 22:08:59 INFO - PROCESS | 21556 | Values: 67.0 67.0 67.0 68.0 68.0 67.0 71.0 67.0 71.0 67.0 22:08:59 INFO - PROCESS | 21556 | 22:08:59 INFO - PROCESS | 21556 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:87.00 stddev:2.46 (2.8%) stddev-sans-first:2.60 22:08:59 INFO - PROCESS | 21556 | Values: 87.0 87.0 87.0 94.0 86.0 86.0 88.0 85.0 87.0 87.0 22:08:59 INFO - PROCESS | 21556 | 22:08:59 INFO - PROCESS | 21556 | [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:127.00 stddev:3.92 (3.1%) stddev-sans-first:3.35 22:08:59 INFO - PROCESS | 21556 | Values: 119.0 124.0 124.0 126.0 132.0 123.0 129.0 129.0 128.0 122.0 22:08:59 INFO - PROCESS | 21556 | 22:08:59 INFO - PROCESS | 21556 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.00 Median:153.50 stddev:5.54 (3.6%) stddev-sans-first:5.68 22:08:59 INFO - PROCESS | 21556 | Values: 145.0 155.0 154.0 155.0 154.0 143.0 144.0 153.0 144.0 143.0 22:08:59 INFO - PROCESS | 21556 | 22:08:59 INFO - PROCESS | 21556 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.00 stddev:2.12 (3.0%) stddev-sans-first:2.24 22:08:59 INFO - PROCESS | 21556 | Values: 71.0 69.0 69.0 70.0 70.0 76.0 69.0 71.0 70.0 69.0 22:08:59 INFO - PROCESS | 21556 | -------- Summary: end -------- 22:08:59 INFO - PROCESS | 21556 | 22:09:00 INFO - TEST-INFO | 21556: exit 0 22:09:00 INFO - TEST-OK | kraken | took 60042ms 22:09:00 INFO - TEST-START | v8_7 22:09:00 INFO - operating with platform_type : linux_ 22:09:00 INFO - Initialising browser for v8_7 test... 22:09:00 INFO - TEST-INFO | started process 21842 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpT_aK7S/profile http://localhost:52641/getInfo.html) 22:09:05 INFO - PROCESS | 21842 | __metrics Screen width/height:1600/1200 22:09:05 INFO - PROCESS | 21842 | colorDepth:24 22:09:05 INFO - PROCESS | 21842 | Browser inner width/height: 1024/697 22:09:05 INFO - PROCESS | 21842 | __metrics 22:09:05 INFO - PROCESS | 21842 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:09:06 INFO - TEST-INFO | 21842: exit 0 22:09:06 INFO - Browser initialized. 22:09:06 INFO - Running cycle 1/1 for v8_7 test... 22:09:06 INFO - TEST-INFO | started process 21964 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpT_aK7S/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:09:18 INFO - PROCESS | 21964 | RSS: Main: 150216704 22:09:18 INFO - PROCESS | 21964 | 22:09:39 INFO - PROCESS | 21964 | Cycle 1(1): loaded http://localhost:52641/tests/v8_7/run.html (next: http://localhost:52641/tests/v8_7/run.html) 22:09:40 INFO - PROCESS | 21964 | RSS: Main: 146792448 22:09:40 INFO - PROCESS | 21964 | 22:09:40 INFO - PROCESS | 21964 | __start_tp_report 22:09:40 INFO - PROCESS | 21964 | _x_x_mozilla_page_load 22:09:40 INFO - PROCESS | 21964 | _x_x_mozilla_page_load_details 22:09:40 INFO - PROCESS | 21964 | |i|pagename|runs| 22:09:40 INFO - PROCESS | 21964 | |0;Richards;167.02856188408217 22:09:40 INFO - PROCESS | 21964 | |1;DeltaBlue;188.7504718761797 22:09:40 INFO - PROCESS | 21964 | |2;Encrypt;281.928390188892 22:09:40 INFO - PROCESS | 21964 | |3;Decrypt;5246.073298429319 22:09:40 INFO - PROCESS | 21964 | |4;RayTrace;1062.6992561105208 22:09:40 INFO - PROCESS | 21964 | |5;Earley;704.2253521126761 22:09:40 INFO - PROCESS | 21964 | |6;Boyer;12268.292682926829 22:09:40 INFO - PROCESS | 21964 | |7;RegExp;25475 22:09:40 INFO - PROCESS | 21964 | |8;Splay;556.1735261401557 22:09:40 INFO - PROCESS | 21964 | |9;NavierStokes;4878.048780487805 22:09:40 INFO - PROCESS | 21964 | __end_tp_report 22:09:40 INFO - PROCESS | 21964 | __startTimestamp1451887780026__endTimestamp 22:09:40 INFO - PROCESS | 21964 | 22:09:40 INFO - PROCESS | 21964 | ------- Summary: start ------- 22:09:40 INFO - PROCESS | 21964 | Number of tests: 10 22:09:40 INFO - PROCESS | 21964 | 22:09:40 INFO - PROCESS | 21964 | [#0] Richards Cycles:1 Average:167.03 Median:167.03 stddev:0.00 (0.0%) 22:09:40 INFO - PROCESS | 21964 | Values: 167.0 22:09:40 INFO - PROCESS | 21964 | 22:09:40 INFO - PROCESS | 21964 | [#1] DeltaBlue Cycles:1 Average:188.75 Median:188.75 stddev:0.00 (0.0%) 22:09:40 INFO - PROCESS | 21964 | Values: 188.8 22:09:40 INFO - PROCESS | 21964 | 22:09:40 INFO - PROCESS | 21964 | [#2] Encrypt Cycles:1 Average:281.93 Median:281.93 stddev:0.00 (0.0%) 22:09:40 INFO - PROCESS | 21964 | Values: 281.9 22:09:40 INFO - PROCESS | 21964 | 22:09:40 INFO - PROCESS | 21964 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 22:09:40 INFO - PROCESS | 21964 | Values: 5246.1 22:09:40 INFO - PROCESS | 21964 | 22:09:40 INFO - PROCESS | 21964 | [#4] RayTrace Cycles:1 Average:1062.70 Median:1062.70 stddev:0.00 (0.0%) 22:09:40 INFO - PROCESS | 21964 | Values: 1062.7 22:09:40 INFO - PROCESS | 21964 | 22:09:40 INFO - PROCESS | 21964 | [#5] Earley Cycles:1 Average:704.23 Median:704.23 stddev:0.00 (0.0%) 22:09:40 INFO - PROCESS | 21964 | Values: 704.2 22:09:40 INFO - PROCESS | 21964 | 22:09:40 INFO - PROCESS | 21964 | [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 22:09:40 INFO - PROCESS | 21964 | Values: 12268.3 22:09:40 INFO - PROCESS | 21964 | 22:09:40 INFO - PROCESS | 21964 | [#7] RegExp Cycles:1 Average:25475.00 Median:25475.00 stddev:0.00 (0.0%) 22:09:40 INFO - PROCESS | 21964 | Values: 25475.0 22:09:40 INFO - PROCESS | 21964 | 22:09:40 INFO - PROCESS | 21964 | [#8] Splay Cycles:1 Average:556.17 Median:556.17 stddev:0.00 (0.0%) 22:09:40 INFO - PROCESS | 21964 | Values: 556.2 22:09:40 INFO - PROCESS | 21964 | 22:09:40 INFO - PROCESS | 21964 | [#9] NavierStokes Cycles:1 Average:4878.05 Median:4878.05 stddev:0.00 (0.0%) 22:09:40 INFO - PROCESS | 21964 | Values: 4878.0 22:09:40 INFO - PROCESS | 21964 | -------- Summary: end -------- 22:09:40 INFO - PROCESS | 21964 | 22:09:40 INFO - TEST-INFO | 21964: exit 0 22:09:40 INFO - TEST-OK | v8_7 | took 39960ms 22:09:40 INFO - SUITE-END | took 1210s 22:09:41 INFO - Completed test suite (00:20:10) 22:09:41 INFO - Working with test: dromaeo_css 22:09:41 INFO - Generating results file: dromaeo_css 22:09:41 INFO - Working with test: kraken 22:09:41 INFO - Generating results file: kraken 22:09:41 INFO - javascript benchmark 22:09:41 INFO - Working with test: v8_7 22:09:41 INFO - Generating results file: v8_7 22:09:41 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:09:41 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 22:09:41 INFO - process_Request line: dromaeo_css 6916.82 graph.html#tests=[[72,63,43]] 22:09:41 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:09:41 INFO - process_Request line: kraken 1522.20 graph.html#tests=[[232,63,43]] 22:09:41 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:09:41 INFO - process_Request line: v8_7 21496.14 graph.html#tests=[[230,63,43]] 22:09:41 INFO - RETURN: dromaeo_css: 6916.82 22:09:41 INFO - RETURN: kraken: 1522.20 22:09:41 INFO - RETURN: v8_7: 21496.14 22:09:41 INFO - javascript benchmark 22:09:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3145.7955232909862, 3191.0107866561366, 3208.3262514871876, 3223.290876007279, 3225.9516107258396, 5252.238425428311, 5355.437679043703, 5356.892862142755, 5382.865428364293, 5387.676739395634, 5302.1781623848265, 5307.044731948247, 5366.892662146754, 5370.812021579245, 5393.73031348432, 4876.829310974108, 4880.536349046835, 4940.382452193476, 4946.826861059863, 4991.900161996758, 4945.579625731799, 4949.406071271453, 4972.105021096201, 4994.300797888299, 5008.098542262392, 4816.253480710478, 4824.34871292378, 4907.852764417074, 4934.605231581465, 4936.160852655057, 4883.365162528884, 4885.316055752198, 4885.584725298354, 4901.534354236342, 4924.704517728947, 4738.952610473885, 4873.951260487385, 4876.097921884463, 4887.413510378778, 4943.975280123613, 5145.897082058375, 5156.587473002151, 5188.403333616645, 5196.974015129938, 5226.608004399647, 5768.567357448208, 5771.422857714237, 5785.27684039495, 5787.189793428924, 5788.363280039192, 5633.746481408305, 5816.709164541756, 5817.156512305692, 5833.7083145842535, 5847.06446968483, 5373.247745315659, 5430.212619170198, 5449.809256675997, 5461.5357694596405, 5487.533559647435, 5890.793822216202, 5892.646441213456, 5928.703564821742, 5930.436608522184, 5944.0786678064105, 5575.860603484945, 5679.829605111853, 5680.431956804369, 5681.744321505542, 5728.341240757283, 5763.193152958589, 5771.422857714195, 5771.538276937835, 5781.913271300934, 5801.82594522165, 5674.517665998354, 5715.399883012307, 5723.0, 5735.0250457422335, 5747.166660834156, 5645.1532270159805, 5668.26312579362, 5698.230738850202, 5764.193012978187, 5824.359320474744, 4484.865454036384, 4487.282034874404, 4488.3940668010055, 4490.438695163105, 4518.683692141584, 3943.507061617298, 3983.1237127831832, 3985.980070099631, 4018.8995275118355, 4026.335654617014, 5308.548773354231, 5337.81317653888, 5382.973085134628, 5392.56859451243, 5432.891342173134, 5743.827685169452, 5755.625884317506, 5762.94237057624, 5772.6536407815665, 5781.566382521243, 5294.2852714883, 5414.106672399089, 5422.240886275846, 5438.102713052381, 5480.3971563128025, 4862.07620552094, 4863.878403039882, 4928.063667903159, 4942.629302802232, 4965.4041515018425, 5922.585419020627, 5962.880742385128, 5968.40315968391, 5968.671723055187, 5981.790637327673, 5628.437156284339, 5716.142578613241, 5750.798722044876, 5754.510866576388, 5765.164051212634, 5925.970370148294, 6010.759569617167, 6016.368281330398, 6022.969885150546, 6108.847278818065, 5696.174054762119, 5728.226689396878, 5734.741936612946, 5738.053221218453, 5740.397258287987, 5663.178839068394, 5784.698442850325, 5840.240768700041, 5845.386234445492, 5849.064149736022, 5628.155776633538, 5672.5745569081655, 5703.287089113861, 5719.428057194247, 5745.195672605755, 5553.305836770403, 5644.887102258014, 5646.661200327993, 5660.264165658438, 5672.205891175321, 5451.155070964007, 5497.230387745799, 5532.5020748132865, 5549.445055494418, 5573.6098473106495, 5609.607327487037, 5625.184348269396, 5629.634073785191, 5654.123610840326, 5692.402297758676, 5558.833235002957, 5560.860978475571, 5566.109422492382, 5571.275734154534, 5583.469570390806], "unit": "score", "name": "dojo.html", "value": 5314.813958127512}, {"lowerIsBetter": false, "replicates": [498.87029372363196, 521.4420569990112, 545.9099248623977, 564.4750382144606, 566.7761234312445, 27790.722092779066, 35269.11827204321, 35637.109072273204, 35683.0, 35747.82126089366, 38608.0, 39106.413403798964, 39196.80401597995, 39307.41038884419, 39347.21305573887, 8401.117882622313, 8495.36284778641, 8539.957300213522, 8564.571771411436, 8576.185262400062, 8187.590620468983, 8338.291245244161, 8372.079071302152, 8399.62201700925, 8402.831943361129, 8321.542315172663, 8347.83304333913, 8440.0, 8455.492670439762, 8491.830163396728, 8252.711155109542, 8360.12218717032, 8379.0, 8384.832303353898, 8414.705485307984, 8155.143709910433, 8206.507609543387, 8275.213854683796, 8277.296429803473, 8431.367647426467, 39408.408873866916, 40116.79941600273, 40201.39697904534, 40212.79893600543, 40243.195136097114, 3258.934821303584, 3659.5791483979415, 3680.871169509081, 3694.242680250542, 3804.4863943367845, 30281.697183028107, 30366.696333036827, 30898.53652195219, 30936.690633093607, 30960.380792384025, 3684.907877303062, 3710.888673339804, 3741.5136032315895, 3893.201893611803, 3908.257431088084, 209584.0, 210023.0, 210659.99999999846, 210932.0, 211788.0, 53831.73084134554, 54364.45635543673, 54423.72788136034, 54906.72546637241, 55141.0, 63914.36085639084, 64419.355806442276, 64938.67530662316, 65161.0, 65292.0, 14266.643333916527, 14396.496122635657, 14515.201663908587, 14516.782248266285, 14517.491887783877, 10716.678499645022, 10772.94613526943, 10783.406912619725, 10806.891931080589, 10834.187435942336, 19226.327078552462, 19411.126499307564, 20135.496612584804, 20344.49138771513, 20440.795592044185, 7842.607869606497, 7907.0906845712325, 7992.0, 8042.678292868337, 8069.193080691884, 875.6183181745641, 966.8066386722684, 991.8809742830762, 993.5380048277585, 1158.2529268621693, 28503.28741781472, 28884.0, 30419.0, 30834.229144271572, 31177.688223117933, 1003.3929472669076, 1003.9096481316717, 1059.0521483272428, 1077.956881724738, 1124.2804605052772, 14038.1577105374, 14292.642683932776, 14563.563093107225, 16033.278502467418, 16220.188990550661, 376812.0, 385552.0, 385967.0, 386119.0, 388117.0, 55532.44467555353, 56274.43725562692, 56355.436445635016, 56562.0, 56642.0, 1334.5796074236584, 1334.6529902225298, 1336.832895888014, 1341.5304643374936, 1350.837899452072, 29287.70712292935, 30580.541291881083, 30627.387452251274, 31151.688483115784, 31418.21454463565, 45225.773871130434, 45253.09493810171, 45455.772721136185, 45614.31578526391, 45853.54146458493, 223993.0, 224230.0, 226162.0, 226535.0, 226879.0, 38113.618863811, 41976.790116049226, 42229.15541689088, 42614.36078458764, 43261.0, 38577.842664720105, 39347.213055739296, 39390.60609393984, 39486.40770388389, 40010.59989400069, 35551.82224088863, 35877.82061089678, 36807.44788828223, 36909.44635830411, 37547.0, 35263.82368088143, 35670.64329356673, 36188.819055904554, 36430.4535431974, 36789.26421471609, 35515.82242088773, 36440.0, 36525.63474365223, 36577.81711091428, 36730.63269367272, 30683.0, 32463.0, 32796.83601581977, 33649.15877103092, 33681.83159084189, 25375.111871084424, 25379.74620253774, 25530.23409297724, 25691.614625781003, 26012.869935650957], "unit": "score", "name": "ext.html", "value": 18262.528697071542}, {"lowerIsBetter": false, "replicates": [356.7984088989719, 360.28483460331256, 363.56735484773134, 364.32054218881785, 368.35170100622906, 16356.345746170155, 17507.91246043771, 18113.728294075565, 18527.72208416875, 18804.24783008678, 11176.776464470706, 11206.215564910459, 11215.887841121586, 11543.01884339832, 16292.0, 4810.350602668647, 4813.879653008667, 4926.285688575154, 4954.207326827708, 4955.900881982377, 4884.902301953976, 4915.090708218973, 4924.359833221676, 4927.581155601778, 4930.087933732253, 4925.901481970359, 4951.504849515056, 4966.180580204262, 5131.923021154667, 5138.126518491847, 5111.999999999963, 5126.461721519243, 5142.66572672777, 5152.92270615941, 5157.381114266312, 5221.503957124067, 5222.0, 5228.738563071831, 5244.239585260116, 5252.474752524755, 18800.059997000095, 18841.905790471097, 19031.80968190314, 19075.61848763017, 19085.522861928424, 2062.845286603496, 2098.674705420662, 2134.6157691615504, 2164.848460607758, 2167.425632207466, 9153.954230228874, 9427.0, 9580.425174489554, 9717.0, 10051.748706282327, 1644.2600829626715, 1646.325006747228, 1672.774175486306, 1677.2620047179203, 1693.3057446447021, 57501.13748293779, 61593.38406615921, 62496.0, 65280.347196528375, 66453.66773166151, 9975.45135017581, 10379.065884070318, 10424.947875260576, 10442.582296708199, 10446.68659940203, 13370.26463544495, 13417.0608057437, 13449.865501345057, 13450.0, 13484.662883427796, 7463.0, 7472.589007604634, 7478.140013898363, 7500.624968751541, 7562.130355009134, 7123.786286411416, 7138.785836424916, 7169.6773645186095, 7210.783676489714, 7232.674529646179, 4450.109978004412, 4498.6626003049905, 4501.7974191161475, 4506.008678090815, 4537.636989040935, 1892.0823400650672, 1931.9567433585705, 1935.3613307608455, 1962.5093726568357, 1962.5682349883002, 410.4540960522498, 411.91967566324877, 417.83704355301455, 438.1827890983293, 444.72871548355477, 10017.849732254022, 10388.909164537767, 16822.158892055348, 17305.65388692219, 17993.460196194133, 877.6401675313091, 936.4521754773398, 956.5743244256379, 957.7501360724183, 975.2295686407658, 7739.806504837312, 9026.638934442548, 9148.0, 9197.402168859137, 9293.210077143383, 417787.0, 420085.0, 423932.0, 426669.0, 579656.0, 76468.0, 79043.0, 81428.0, 83274.0, 83516.58241708753, 1136.0627482327113, 1158.0851127609262, 1169.929804211733, 1186.246733324328, 1186.786378451887, 14535.563933082025, 14572.344244508811, 14655.413783448543, 14708.264586770405, 14840.10959342443, 32773.0, 33306.0, 34076.82961585176, 34205.486917696755, 34628.134296642784, 45646.31530527111, 45891.31163032624, 47274.527254727014, 48868.0, 49162.50837491579, 9361.4383137012, 9405.670801521914, 9511.286653501153, 9529.618815247313, 9599.712008639752, 11064.114870810155, 11098.833517497405, 11189.160812939224, 12492.875071249535, 17533.0, 12283.447244873823, 12480.563180288646, 13073.084884058024, 13604.115732477358, 14618.707625847635, 13212.801807973081, 13267.734645306848, 13425.0, 13734.45062197501, 13945.0, 13962.869676239645, 14212.431502740188, 14812.62968425798, 14983.250837457865, 15095.24523773785, 9079.409838360485, 9374.343795934492, 9508.239340852577, 9529.285303602397, 9634.277429192698, 10220.284580079324, 12097.939510302393, 14099.0, 14305.356258968162, 14423.92788036053], "unit": "score", "name": "jquery.html", "value": 8324.976932197927}, {"lowerIsBetter": false, "replicates": [1487.2415068315158, 1502.9854847977615, 1660.8671306295498, 1776.618027124168, 1797.290070422184, 6895.275996020421, 7015.228324884259, 7565.5460672359695, 7880.054393472777, 7905.288524032836, 7507.24927507249, 7588.051493563305, 7616.162222155573, 7665.386769058476, 7692.269234422721, 2174.4346469917855, 2234.240358278185, 2236.027328112268, 2236.2173239366175, 2236.944076398087, 2243.147603910512, 2278.28234106256, 2284.23478134825, 2288.5651726171973, 2294.9443256102213, 2224.0547767198955, 2235.7540670526228, 2263.8981245843975, 2268.61433556295, 2270.829687773415, 2230.2640128757553, 2245.69683092782, 2249.0441562336023, 2263.321003698884, 2267.9092836286527, 2274.044901141508, 2294.38051726033, 2306.2158865985643, 2307.0, 2308.5267520158327, 7788.0, 7842.137364889858, 7877.487963282369, 7902.446828721992, 7909.920900790976, 4682.742449165295, 4686.484486706459, 4732.526747325274, 4743.051389722035, 4771.355866957951, 3022.486177349856, 3022.501287287617, 3089.351236240392, 3118.7349075328625, 3133.0, 986.8519722041751, 987.0918754745651, 1007.8135544924139, 1018.2668478695327, 1032.9690109296732, 10881.075108615698, 10901.781964360747, 10949.45252737368, 10959.780804383867, 10992.725181870437, 4224.556421575752, 4252.255855225323, 4279.229738647011, 4294.914101717948, 4313.051128751669, 9340.159385655188, 9376.062393760569, 9384.95307523458, 9402.106799854002, 9409.294302927308, 4690.460597031317, 4698.88252793676, 4700.271457924027, 4720.622350211975, 4740.739259340769, 4142.834286628501, 4260.531341552427, 4292.720973136736, 4317.805698743564, 4349.499807522176, 3456.1359660084977, 3476.774009689362, 3479.460683594047, 3497.143199915986, 3497.8600855965983, 1061.9575216991234, 1064.4092528646675, 1071.8713754349371, 1084.7179733269406, 1085.8642669666292, 981.293468702533, 991.9305648604528, 994.6817018553993, 1106.4080716816466, 1339.5713371720956, 7336.339729424378, 7371.557706537625, 7377.77866664001, 7396.96301518489, 7409.740659076906, 1170.9180357375071, 1202.4108186988487, 1208.9818652720217, 1211.3035004872233, 1242.8446444194476, 5904.645721256738, 5913.0, 5958.761649534057, 5967.433093856077, 6015.218021657157, 9521.190698790542, 9697.418154910587, 9776.071273229032, 9778.07108324708, 9862.950685246527, 9343.672971445967, 9574.47340396271, 9624.711258662252, 9644.565994530263, 9695.854562181574, 7440.441966852508, 7452.850942981218, 7459.477836551389, 7487.1389790173735, 7531.0, 6891.6780300391, 6967.651617419007, 6977.895331570132, 6993.790186294419, 6995.79012629622, 8405.411621186458, 8481.2366886978, 8556.614952327285, 8613.2248097669, 8735.606897689746, 8539.274161696325, 8744.825103498022, 8784.429012114193, 8861.556922153995, 8904.955475222583, 6520.413162815369, 6598.90101648466, 6770.01834733951, 6900.758473453606, 6915.343042410963, 7355.080614923135, 7374.1151061872915, 7401.407887369105, 7429.0, 7443.627818608939, 6881.518293719391, 7007.369336759716, 7047.189573199148, 7164.570125792469, 7193.2087470379265, 7073.787786366417, 7105.360517553445, 7131.536450130725, 7199.676014579251, 7220.638968051681, 6553.705083271169, 6609.4712423007, 6658.6337751424135, 6667.733290668319, 7116.323949224816, 6504.804855854332, 6562.081308616893, 6594.637294948824, 6597.439217666552, 6606.9008964866525, 6352.110704501281, 6353.459955903615, 6394.136791533269, 6403.3276505966205, 6425.1968503937005], "unit": "score", "name": "mootools.html", "value": 4493.376949998013}, {"lowerIsBetter": false, "replicates": [335.44986222594946, 336.0959020235566, 336.29713897953303, 341.95383623210876, 347.71834813800825, 6290.559660823733, 6294.08735733319, 6297.2128483939505, 6307.905381419277, 6447.677616119198, 6198.59709118907, 6240.84397890053, 6241.21984751906, 6256.937430625692, 6282.842928926768, 4735.124002059612, 4736.100140973204, 4747.810087596492, 4752.5485078917445, 4753.738544380067, 4740.739259340752, 4753.239481682931, 4755.262934245197, 4757.452892917307, 4760.952390476085, 4566.611837993774, 4703.694259873115, 4705.223638099709, 4706.929396059062, 4711.623070154396, 4659.4408670959365, 4672.528153631595, 4675.812967481331, 4686.53134686532, 4723.905521889543, 4072.409500622423, 4092.3043082676018, 4104.404861295126, 4104.794760261975, 4116.670666346715, 5965.075413310944, 5982.700864956735, 5993.460588547052, 6014.75940962361, 6031.095335699636, 5319.787208511655, 5426.077566813651, 5462.617616766828, 5472.644278121949, 5512.118061110203, 6498.9350106498805, 6528.11870397495, 6531.8693626127215, 6576.243731970789, 6577.539572229945, 4471.575200355961, 4473.194824931511, 4502.392177056088, 4505.279155335131, 4508.143452744001, 6758.9324106758795, 6816.182058153054, 6859.0, 6897.3447522485285, 6929.3070692930305, 4624.722516649012, 4626.907461850744, 4635.953640463552, 4647.6281897448125, 4649.070185962821, 4670.346151538787, 4700.2949557566635, 4708.8351907683755, 4711.505291944365, 4712.363830882856, 5453.890922181614, 5461.672299662033, 5464.726763661801, 5465.0, 5466.180072989084, 6505.642189679518, 6664.266930637626, 6664.86670266592, 6666.500012499082, 6672.0, 1624.236608793865, 1650.257384177125, 1652.5785924589152, 1653.8676905847503, 1655.222045638548, 1097.1332647208617, 1100.5817789240198, 1102.6361300770886, 1102.652664410708, 1111.0445017285128, 6159.3224745277985, 6170.907436388457, 6194.287656919512, 6200.844978875564, 6206.813795586139, 6750.966245168743, 6753.08833307507, 6761.8647627047185, 6763.898541521881, 6765.8646827063185, 6074.51403887688, 6177.938220617736, 6183.536234782409, 6186.690665466709, 6197.96901015492, 3631.927361452809, 3646.890593282206, 3665.5051568038507, 3673.779573225615, 3675.22820207754, 6980.965095174492, 6994.965025174842, 7018.894716579255, 7023.086998690138, 7033.859322813515, 6760.492963027793, 6900.447964162855, 6926.930730692729, 6939.757108501179, 6952.339527744856, 6985.545939513915, 6992.650367481708, 7001.369876711018, 7023.578585284899, 7039.472039597051, 6741.258461569321, 6757.594544327356, 6759.729610815512, 6762.661866906733, 6765.154355705537, 6573.244076931214, 6627.138471998609, 6640.701168447528, 6666.666666666744, 6669.066330713801, 6946.44428445713, 6989.860202796017, 7002.75490357835, 7011.579305241702, 7018.192907815463, 4586.518415566317, 4589.242774942097, 4594.494605593315, 4603.010352774169, 4603.884902877321, 6744.494162937897, 6763.391294783493, 6774.288699686462, 6800.251972282946, 6880.58716476993, 6604.207495100619, 6609.4712423005085, 6668.333166683293, 6676.566023208476, 6707.094542236736, 6652.401283884474, 6660.134182556237, 6683.866322673616, 6706.6646667665445, 6716.932830671631, 6473.417392434703, 6540.705668245036, 6564.704588293634, 6568.113304703804, 6580.934190658032, 6681.699323530355, 6720.731170753311, 6722.831929201809, 6723.932760672331, 6740.988851672289, 6551.0, 6552.901706474311, 6564.540482166202, 6573.3098024706715, 6582.3746744059235], "unit": "score", "name": "prototype.html", "value": 4952.405348614923}, {"lowerIsBetter": false, "replicates": [803.0844836885948, 806.8144326804835, 817.9325979596624, 825.2696363718109, 855.6876739989901, 13390.12964157329, 13507.25710085945, 13511.797323040162, 13538.526151584696, 13595.660108497292, 12717.109802313842, 12732.681682957931, 12747.107702460831, 12771.361431928413, 12783.680407989805, 806.7660378490231, 814.3851392198882, 823.6664151018847, 823.9382046346518, 824.2334628795218, 804.2600807257309, 807.4711064252924, 809.017044291186, 811.0753740735566, 811.3549727966251, 858.4248553469159, 860.8794768732382, 861.6897916749965, 863.7236084452946, 864.6022829498438, 853.21504216121, 854.2439940652505, 856.2422256303154, 857.3355649371756, 858.8497013022696, 617.9938200617981, 624.2446639566131, 629.2700467457773, 629.5372900917822, 630.1398590923357, 13707.45170193201, 13741.312934353342, 13744.381502832297, 13777.448902043907, 13810.309484525835, 11080.501377438035, 11266.32402055871, 11506.942465287704, 11518.308901465854, 11643.59247426336, 9503.90496095037, 9537.046295370477, 9573.808523829553, 10080.14318782897, 10440.738981525446, 3390.542276792626, 3396.083057574466, 3419.675130862564, 3437.2781715839456, 3453.5510383649967, 47748.761256193844, 47988.520114798754, 48438.75780621074, 48558.75720621374, 48801.267980980316, 7788.649510772028, 8472.136130051378, 8852.557372131496, 9068.274538036942, 9111.863322050041, 17582.296708131787, 17681.204345804468, 17722.46832595024, 17722.734158987627, 17724.11379431049, 6547.377999090078, 6868.965655171693, 7016.228214896358, 7103.82240443993, 7348.934404511316, 3613.1328481164855, 3751.568569614529, 3768.9246215075545, 3769.302679004338, 3832.4442955771256, 3015.9547606785914, 3053.4045861057325, 3057.8165310081467, 3061.7244447999788, 3063.5864158338786, 523.6936392210523, 539.5063516882009, 548.5310059898729, 549.1789774287386, 552.6877314317397, 539.919012148181, 573.824983380073, 584.2171490203148, 631.2330518420141, 645.2063961327593, 8227.8354432911, 8801.559922003875, 8867.201951824367, 8975.0, 9181.127792859801, 532.866783304174, 612.7671484835734, 642.4924309795209, 693.3517161454057, 709.9280087068564, 3691.501647277637, 3701.222743223899, 3831.8850434486453, 3872.3997780344093, 3980.9402858957137, 52297.47702523002, 57217.42782572204, 57228.0, 57339.13991290134, 57585.42414575884, 44892.3266151008, 46222.768886155354, 47184.0, 47428.525714743104, 49444.75277623661, 45637.543624563994, 46482.76758616253, 46527.534724653, 46629.0, 46642.30036549454, 8409.0, 8530.232279094664, 8781.517016563896, 8796.164364385373, 9007.189352958265, 34744.30511389809, 35237.0, 35282.0, 35530.46704299489, 35839.64160358467, 41090.1781964365, 41120.79439602783, 44196.55803441924, 45249.77375113103, 46190.0, 9979.850302245617, 10217.744556385853, 10599.311044782064, 10719.14246860265, 10818.51316690735, 11805.23265987708, 11911.642650720492, 12041.458134383798, 12522.499100035897, 12527.060470464934, 9710.17463515609, 9898.901010990086, 9931.553080111267, 10007.09936105754, 11063.225574209728, 9716.222702183666, 9742.415455072718, 10403.219758518293, 10423.739406514898, 10465.267431280043, 9782.119609235204, 10175.745606359604, 10216.489175541343, 10529.684109476728, 10734.248602597743, 8910.955445222733, 9131.269498440242, 9260.166585007382, 9766.804663906823, 10003.049710277512, 8209.79020979021, 8786.868196976922, 9147.77130571741, 9272.397294175857, 9322.720318390458], "unit": "score", "name": "yui.html", "value": 6089.472071824279}], "name": "dromaeo_css", "value": 6916.815862884167}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 104.0, 111.0, 109.0, 111.0, 121.0, 110.0, 111.0, 112.0, 109.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [156.0, 126.0, 157.0, 161.0, 125.0, 149.0, 153.0, 128.0, 169.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 145.0}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 165.0, 162.0, 162.0, 161.0, 161.0, 166.0, 173.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 72.0, 74.0, 71.0, 76.0, 142.0, 72.0, 74.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 135.0, 96.0, 96.0, 97.0, 138.0, 97.0, 98.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 147.0, 146.0, 146.0, 147.0, 147.0, 148.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 96.0, 96.0, 96.0, 98.0, 96.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0, 63.0, 57.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 59.9}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 68.0, 68.0, 67.0, 71.0, 67.0, 71.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [87.0, 87.0, 87.0, 94.0, 86.0, 86.0, 88.0, 85.0, 87.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.4}, {"lowerIsBetter": true, "replicates": [119.0, 124.0, 124.0, 126.0, 132.0, 123.0, 129.0, 129.0, 128.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.6}, {"lowerIsBetter": true, "replicates": [145.0, 155.0, 154.0, 155.0, 154.0, 143.0, 144.0, 153.0, 144.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.0}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 69.0, 70.0, 70.0, 76.0, 69.0, 71.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1522.2000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.02856188408217], "unit": "score", "name": "Richards", "value": 211.35307400000002}, {"lowerIsBetter": false, "replicates": [188.7504718761797], "unit": "score", "name": "DeltaBlue", "value": 350.2931640000001}, {"lowerIsBetter": false, "replicates": [281.928390188892], "unit": "score", "name": "Encrypt", "value": 944.1440070000003}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [1062.6992561105208], "unit": "score", "name": "RayTrace", "value": 696.3296489999998}, {"lowerIsBetter": false, "replicates": [704.2253521126761], "unit": "score", "name": "Earley", "value": 946.3774600000002}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [25475.0], "unit": "score", "name": "RegExp", "value": 35.759960745829254}, {"lowerIsBetter": false, "replicates": [556.1735261401557], "unit": "score", "name": "Splay", "value": 146.52081800000005}, {"lowerIsBetter": false, "replicates": [4878.048780487805], "unit": "score", "name": "NavierStokes", "value": 304.2200000000002}], "name": "v8_7", "value": 21496.139827768275}]} 22:09:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21496.14"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1522.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6916.82"}}} 22:09:41 INFO - Return code: 0 22:09:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:09:41 INFO - # TBPL SUCCESS # 22:09:41 INFO - Running post-action listener: _resource_record_post_action 22:09:41 INFO - Running post-run listener: _resource_record_post_run 22:09:42 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 555487232; Read time: 12; Write time: 470764 22:09:42 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235257856; Read time: 0; Write time: 277380 22:09:42 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 319918080; Read time: 12; Write time: 193356 22:09:42 INFO - Running post-run listener: _upload_blobber_files 22:09:42 INFO - Blob upload gear active. 22:09:42 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:09:42 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 22:09:42 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', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:09:42 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 Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:09:42 INFO - (blobuploader) - INFO - Open directory for files ... 22:09:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:09:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:09:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:09:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:09:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:09:43 INFO - (blobuploader) - INFO - Done attempting. 22:09:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:09:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:09:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:09:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:09:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:09:44 INFO - (blobuploader) - INFO - Done attempting. 22:09:44 INFO - (blobuploader) - INFO - Iteration through files over. 22:09:44 INFO - Return code: 0 22:09:44 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:09:44 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:09:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5403670bb892ad6aebc43b21d6138da990900b6bc20a1dd50636963c7133d22227ccbfb31e8063cd834f910affc4e26871808babc8beed5d9f7b31d5896c0202", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4f406ad630d6c4adde74cc9e286a9b63ec43b156f46d151142386fe6b3429c127cf230fe40322a90fa615d429fe08cbccf2c0e75fd73d51250bad188253e9440"} 22:09:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:09:44 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:09:44 INFO - Contents: 22:09:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5403670bb892ad6aebc43b21d6138da990900b6bc20a1dd50636963c7133d22227ccbfb31e8063cd834f910affc4e26871808babc8beed5d9f7b31d5896c0202", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4f406ad630d6c4adde74cc9e286a9b63ec43b156f46d151142386fe6b3429c127cf230fe40322a90fa615d429fe08cbccf2c0e75fd73d51250bad188253e9440"} 22:09:44 INFO - Copying logs to upload dir... 22:09:44 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1273.840945 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-03 22:09:43.966947) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-03 22:09:43.970991) ========= 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=6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5403670bb892ad6aebc43b21d6138da990900b6bc20a1dd50636963c7133d22227ccbfb31e8063cd834f910affc4e26871808babc8beed5d9f7b31d5896c0202", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4f406ad630d6c4adde74cc9e286a9b63ec43b156f46d151142386fe6b3429c127cf230fe40322a90fa615d429fe08cbccf2c0e75fd73d51250bad188253e9440"} build_url:https://queue.taskcluster.net/v1/task/SKziSzxRQCW8FAkBXJQkAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011442 build_url: 'https://queue.taskcluster.net/v1/task/SKziSzxRQCW8FAkBXJQkAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5403670bb892ad6aebc43b21d6138da990900b6bc20a1dd50636963c7133d22227ccbfb31e8063cd834f910affc4e26871808babc8beed5d9f7b31d5896c0202", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4f406ad630d6c4adde74cc9e286a9b63ec43b156f46d151142386fe6b3429c127cf230fe40322a90fa615d429fe08cbccf2c0e75fd73d51250bad188253e9440"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-03 22:09:43.997008) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 22:09:43.997588) ========= 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=6ef107882637bc5fc02d78b7000001c2-1451882413.10511-949508805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 22:09:44.082112) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-03 22:09:44.082461) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-03 22:09:44.082806) ========= ========= Total master_lag: 0.28 =========