builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1450462772.96 results: success (0) buildid: 20151218073244 builduid: ddea8cfbb6f44175893863ff6d91f77e revision: c5cb194cc9cb56d742fb3a7a826f0080b0404edc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 10:19:32.957352) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 10:19:32.957793) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 10:19:32.958076) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004444 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 10:19:32.975121) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 10:19:32.975391) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 10:19:32.984654) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:19:32.984909) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004218 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:19:33.033190) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 10:19:33.033503) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 10:19:33.033890) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:19:33.034163) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 10:19:33-- 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.3M=0s 2015-12-18 10:19:33 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182343 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:19:33.228830) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:19:33.229141) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016780 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:19:33.278317) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-18 10:19:33.278692) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c5cb194cc9cb56d742fb3a7a826f0080b0404edc --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c5cb194cc9cb56d742fb3a7a826f0080b0404edc --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=fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 10:19:33,965 truncating revision to first 12 chars 2015-12-18 10:19:33,965 Setting DEBUG logging. 2015-12-18 10:19:33,965 attempt 1/10 2015-12-18 10:19:33,965 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c5cb194cc9cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 10:19:34,744 unpacking tar archive at: mozilla-central-c5cb194cc9cb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.231502 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-18 10:19:34.523045) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 10:19:34.523362) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 10:19:34.531956) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 10:19:34.532206) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 10:19:34.532593) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-18 10:19:34.532879) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:19:35 INFO - MultiFileLogger online at 20151218 10:19:35 in /builds/slave/test-pgo 10:19:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:19:35 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:19:35 INFO - {'append_to_log': False, 10:19:35 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:19:35 INFO - 'blob_upload_branch': 'Firefox', 10:19:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:19:35 INFO - 'branch': 'Firefox', 10:19:35 INFO - 'buildbot_json_path': 'buildprops.json', 10:19:35 INFO - 'config_files': ('talos/linux_config.py',), 10:19:35 INFO - 'default_actions': ('clobber', 10:19:35 INFO - 'read-buildbot-config', 10:19:35 INFO - 'download-and-extract', 10:19:35 INFO - 'populate-webroot', 10:19:35 INFO - 'create-virtualenv', 10:19:35 INFO - 'install', 10:19:35 INFO - 'run-tests'), 10:19:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:19:35 INFO - 'download_minidump_stackwalk': True, 10:19:35 INFO - 'download_symbols': 'ondemand', 10:19:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:19:35 INFO - 'tooltool.py': '/tools/tooltool.py', 10:19:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:19:35 INFO - '/tools/misc-python/virtualenv.py')}, 10:19:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:19:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:19:35 INFO - 'installer_path': 'installer.exe', 10:19:35 INFO - 'log_level': 'info', 10:19:35 INFO - 'log_name': 'talos', 10:19:35 INFO - 'log_to_console': True, 10:19:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:19:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:19:35 INFO - 'opt_config_files': (), 10:19:35 INFO - 'pip_index': False, 10:19:35 INFO - 'sps_profile': False, 10:19:35 INFO - 'sps_profile_interval': 0, 10:19:35 INFO - 'suite': 'dromaeojs', 10:19:35 INFO - 'system_bits': '64', 10:19:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:19:35 INFO - 'title': 'talos-linux64-ix-020', 10:19:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:19:35 INFO - 'use_talos_json': True, 10:19:35 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:19:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:19:35 INFO - 'work_dir': 'build'} 10:19:35 INFO - ##### 10:19:35 INFO - ##### Running clobber step. 10:19:35 INFO - ##### 10:19:35 INFO - Running pre-action listener: _resource_record_pre_action 10:19:35 INFO - Running main action method: clobber 10:19:35 INFO - rmtree: /builds/slave/test-pgo/build 10:19:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:19:36 INFO - Running post-action listener: _resource_record_post_action 10:19:36 INFO - ##### 10:19:36 INFO - ##### Running read-buildbot-config step. 10:19:36 INFO - ##### 10:19:36 INFO - Running pre-action listener: _resource_record_pre_action 10:19:36 INFO - Running main action method: read_buildbot_config 10:19:36 INFO - Using buildbot properties: 10:19:36 INFO - { 10:19:36 INFO - "project": "", 10:19:36 INFO - "product": "firefox", 10:19:36 INFO - "script_repo_revision": "production", 10:19:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:19:36 INFO - "repository": "", 10:19:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:19:36 INFO - "buildid": "20151218073244", 10:19:36 INFO - "pgo_build": "True", 10:19:36 INFO - "basedir": "/builds/slave/test-pgo", 10:19:36 INFO - "buildnumber": 144, 10:19:36 INFO - "slavename": "talos-linux64-ix-020", 10:19:36 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:19:36 INFO - "platform": "ubuntu64_hw", 10:19:36 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:19:36 INFO - "branch": "mozilla-central", 10:19:36 INFO - "repo_path": "mozilla-central", 10:19:36 INFO - "revision": "c5cb194cc9cb56d742fb3a7a826f0080b0404edc", 10:19:36 INFO - "stage_platform": "linux64-pgo", 10:19:36 INFO - "builduid": "ddea8cfbb6f44175893863ff6d91f77e", 10:19:36 INFO - "slavebuilddir": "test" 10:19:36 INFO - } 10:19:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:19:36 INFO - Running post-action listener: _resource_record_post_action 10:19:36 INFO - ##### 10:19:36 INFO - ##### Running download-and-extract step. 10:19:36 INFO - ##### 10:19:36 INFO - Running pre-action listener: _resource_record_pre_action 10:19:36 INFO - Running main action method: download_and_extract 10:19:36 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:19: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')]} 10:19:36 INFO - https://queue.taskcluster.net/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:19:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/artifacts/public/build/test_packages.json 10:19:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/artifacts/public/build/test_packages.json 10:19:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:19:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:19:37 INFO - Downloaded 1302 bytes. 10:19:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:19:37 INFO - Using the following test package requirements: 10:19:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:19:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:19:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:37 INFO - u'jsshell-linux-x86_64.zip'], 10:19:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:19:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:19:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:19:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:19:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:19:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:19:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:19:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:37 INFO - https://queue.taskcluster.net/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:19:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:19:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:19:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/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 10:19:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/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 10:19:43 INFO - Downloaded 23121202 bytes. 10:19: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 10:19:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:19: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 10:19:44 INFO - Return code: 0 10:19: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 10:19: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')]} 10:19:44 INFO - https://queue.taskcluster.net/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:19:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:19:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:19:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/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 10:19:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/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 10:19:49 INFO - Downloaded 23121202 bytes. 10:19:49 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 10:19:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:19:49 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 10:19:51 INFO - Return code: 0 10:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:51 INFO - https://queue.taskcluster.net/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:19:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:19:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:19:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/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 10:19:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/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 10:19:53 INFO - Downloaded 11132039 bytes. 10:19:53 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 10:19:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:19:53 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 10:19:53 INFO - Return code: 0 10:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:53 INFO - https://queue.taskcluster.net/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:19:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:19:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:19:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/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 10:19:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/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 10:19:56 INFO - Downloaded 54646641 bytes. 10:19:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:19:56 INFO - mkdir: /builds/slave/test-pgo/properties 10:19:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:19:56 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:19:56 INFO - Contents: 10:19:56 INFO - build_url:https://queue.taskcluster.net/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:19:56 INFO - Running post-action listener: _resource_record_post_action 10:19:56 INFO - Running post-action listener: set_extra_try_arguments 10:19:56 INFO - ##### 10:19:56 INFO - ##### Running populate-webroot step. 10:19:56 INFO - ##### 10:19:56 INFO - Running pre-action listener: _resource_record_pre_action 10:19:56 INFO - Running main action method: populate_webroot 10:19:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:19:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:19:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:19:56 INFO - '--tppagecycles', 10:19:56 INFO - '7'], 10:19:56 INFO - 'tests': ['tsvgm']}}, 10:19:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:19:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:19:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:19:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:19:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:19:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:19:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:56 INFO - 'talos_options': ['--e10s'], 10:19:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:56 INFO - 'tests': ['damp', 'tps']}, 10:19:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:56 INFO - 'talos_options': ['--e10s'], 10:19:56 INFO - 'tests': ['damp', 'tps']}, 10:19:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:19:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:19:56 INFO - 'other': {'tests': ['a11yr', 10:19:56 INFO - 'ts_paint', 10:19:56 INFO - 'tpaint', 10:19:56 INFO - 'sessionrestore', 10:19:56 INFO - 'sessionrestore_no_auto_restore']}, 10:19:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:19:56 INFO - 'tests': ['a11yr', 10:19:56 INFO - 'ts_paint', 10:19:56 INFO - 'tpaint', 10:19:56 INFO - 'sessionrestore', 10:19:56 INFO - 'sessionrestore_no_auto_restore']}, 10:19:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:19:56 INFO - 'tests': ['a11yr', 10:19:56 INFO - 'ts_paint', 10:19:56 INFO - 'tpaint', 10:19:56 INFO - 'sessionrestore', 10:19:56 INFO - 'sessionrestore_no_auto_restore']}, 10:19:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:19:56 INFO - 'tests': ['a11yr', 10:19:56 INFO - 'ts_paint', 10:19:56 INFO - 'tpaint', 10:19:56 INFO - 'sessionrestore', 10:19:56 INFO - 'sessionrestore_no_auto_restore']}, 10:19:56 INFO - 'other_l64': {'tests': ['a11yr', 10:19:56 INFO - 'ts_paint', 10:19:56 INFO - 'tpaint', 10:19:56 INFO - 'sessionrestore', 10:19:56 INFO - 'sessionrestore_no_auto_restore']}, 10:19:56 INFO - 'other_nol64': {'tests': ['a11yr', 10:19:56 INFO - 'ts_paint', 10:19:56 INFO - 'tpaint', 10:19:56 INFO - 'sessionrestore', 10:19:56 INFO - 'sessionrestore_no_auto_restore']}, 10:19:56 INFO - 'svgr': {'tests': ['tsvgx', 10:19:56 INFO - 'tsvgr_opacity', 10:19:56 INFO - 'tart', 10:19:56 INFO - 'tscrollx', 10:19:56 INFO - 'cart']}, 10:19:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:19:56 INFO - 'tests': ['tsvgx', 10:19:56 INFO - 'tsvgr_opacity', 10:19:56 INFO - 'tart', 10:19:56 INFO - 'tscrollx', 10:19:56 INFO - 'cart']}, 10:19:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:56 INFO - 'tests': ['tp5o']}, 10:19:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:56 INFO - 'talos_options': ['--e10s'], 10:19:56 INFO - 'tests': ['tp5o']}, 10:19:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:56 INFO - 'talos_options': ['--xperf_path', 10:19:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:56 INFO - 'tests': ['tp5n']}, 10:19:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:56 INFO - 'talos_options': ['--e10s', 10:19:56 INFO - '--xperf_path', 10:19:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:56 INFO - 'tests': ['tp5n']}}, 10:19:56 INFO - 'talos.zip': {'path': '', 10:19:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:19:56 INFO - Running post-action listener: _resource_record_post_action 10:19:56 INFO - ##### 10:19:56 INFO - ##### Running create-virtualenv step. 10:19:56 INFO - ##### 10:19:56 INFO - Running pre-action listener: _resource_record_pre_action 10:19:56 INFO - Running main action method: create_virtualenv 10:19:56 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:19:56 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 10:19:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:19:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:19:57 INFO - Using real prefix '/usr' 10:19:57 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:19:57 INFO - Installing distribute.............................................................................................................................................................................................done. 10:19:59 INFO - Installing pip.................done. 10:19:59 INFO - Return code: 0 10:19:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:19:59 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')]} 10:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:59 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')]} 10:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:59 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 0x7f03cc36af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c350>, '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 0x290d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d6e0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467', '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 10:19:59 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 10:19:59 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 10:19:59 INFO - Using env: {'DISPLAY': ':0', 10:19:59 INFO - 'HOME': '/home/cltbld', 10:19:59 INFO - 'LANG': 'en_US.UTF-8', 10:19:59 INFO - 'LANGUAGE': 'en_US:en', 10:19:59 INFO - 'LOGNAME': 'cltbld', 10:19:59 INFO - 'MAIL': '/var/mail/cltbld', 10:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:59 INFO - 'MOZ_NO_REMOTE': '1', 10:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:59 INFO - 'NO_EM_RESTART': '1', 10:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:19:59 INFO - 'PWD': '/builds/slave/test-pgo', 10:19:59 INFO - 'SHELL': '/bin/bash', 10:19:59 INFO - 'SHLVL': '1', 10:19:59 INFO - 'TERM': 'linux', 10:19:59 INFO - 'TMOUT': '86400', 10:19:59 INFO - 'USER': 'cltbld', 10:19:59 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467', 10:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:59 INFO - '_': '/tools/buildbot/bin/python'} 10:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:59 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 10:19:59 INFO - Cleaning up... 10:19:59 INFO - Return code: 0 10:19:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:19:59 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')]} 10:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:59 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')]} 10:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:59 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 0x7f03cc36af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c350>, '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 0x290d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d6e0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467', '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 10:19:59 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 10:19:59 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 10:19:59 INFO - Using env: {'DISPLAY': ':0', 10:19:59 INFO - 'HOME': '/home/cltbld', 10:19:59 INFO - 'LANG': 'en_US.UTF-8', 10:19:59 INFO - 'LANGUAGE': 'en_US:en', 10:19:59 INFO - 'LOGNAME': 'cltbld', 10:19:59 INFO - 'MAIL': '/var/mail/cltbld', 10:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:59 INFO - 'MOZ_NO_REMOTE': '1', 10:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:59 INFO - 'NO_EM_RESTART': '1', 10:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:19:59 INFO - 'PWD': '/builds/slave/test-pgo', 10:19:59 INFO - 'SHELL': '/bin/bash', 10:19:59 INFO - 'SHLVL': '1', 10:19:59 INFO - 'TERM': 'linux', 10:19:59 INFO - 'TMOUT': '86400', 10:19:59 INFO - 'USER': 'cltbld', 10:19:59 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467', 10:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:59 INFO - '_': '/tools/buildbot/bin/python'} 10:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:59 INFO - Downloading/unpacking psutil>=0.7.1 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:20:01 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:20:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:20:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:20:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:20:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:20:01 INFO - Installing collected packages: psutil 10:20:01 INFO - Running setup.py install for psutil 10:20:01 INFO - building 'psutil._psutil_linux' extension 10:20:01 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 10:20:02 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 10:20:02 INFO - building 'psutil._psutil_posix' extension 10:20:02 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 10:20:02 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 10:20:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:20:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:20:02 INFO - Successfully installed psutil 10:20:02 INFO - Cleaning up... 10:20:02 INFO - Return code: 0 10:20:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f03cc36af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c350>, '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 0x290d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d6e0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467', '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 10:20:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:20:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:20:02 INFO - Using env: {'DISPLAY': ':0', 10:20:02 INFO - 'HOME': '/home/cltbld', 10:20:02 INFO - 'LANG': 'en_US.UTF-8', 10:20:02 INFO - 'LANGUAGE': 'en_US:en', 10:20:02 INFO - 'LOGNAME': 'cltbld', 10:20:02 INFO - 'MAIL': '/var/mail/cltbld', 10:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:02 INFO - 'MOZ_NO_REMOTE': '1', 10:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:02 INFO - 'NO_EM_RESTART': '1', 10:20:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:20:02 INFO - 'PWD': '/builds/slave/test-pgo', 10:20:02 INFO - 'SHELL': '/bin/bash', 10:20:02 INFO - 'SHLVL': '1', 10:20:02 INFO - 'TERM': 'linux', 10:20:02 INFO - 'TMOUT': '86400', 10:20:02 INFO - 'USER': 'cltbld', 10:20:02 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467', 10:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:02 INFO - '_': '/tools/buildbot/bin/python'} 10:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:20:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:20:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:20:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:20:04 INFO - Installing collected packages: mozsystemmonitor 10:20:04 INFO - Running setup.py install for mozsystemmonitor 10:20:04 INFO - Successfully installed mozsystemmonitor 10:20:04 INFO - Cleaning up... 10:20:04 INFO - Return code: 0 10:20:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:20:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:20:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f03cc36af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c350>, '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 0x290d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d6e0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467', '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 10:20:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 10:20:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:20:04 INFO - Using env: {'DISPLAY': ':0', 10:20:04 INFO - 'HOME': '/home/cltbld', 10:20:04 INFO - 'LANG': 'en_US.UTF-8', 10:20:04 INFO - 'LANGUAGE': 'en_US:en', 10:20:04 INFO - 'LOGNAME': 'cltbld', 10:20:04 INFO - 'MAIL': '/var/mail/cltbld', 10:20:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:04 INFO - 'MOZ_NO_REMOTE': '1', 10:20:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:04 INFO - 'NO_EM_RESTART': '1', 10:20:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:20:04 INFO - 'PWD': '/builds/slave/test-pgo', 10:20:04 INFO - 'SHELL': '/bin/bash', 10:20:04 INFO - 'SHLVL': '1', 10:20:04 INFO - 'TERM': 'linux', 10:20:04 INFO - 'TMOUT': '86400', 10:20:04 INFO - 'USER': 'cltbld', 10:20:04 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467', 10:20:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:04 INFO - '_': '/tools/buildbot/bin/python'} 10:20:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:04 INFO - Downloading/unpacking blobuploader==1.2.4 10:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:06 INFO - Downloading blobuploader-1.2.4.tar.gz 10:20:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:20:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:20:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:20:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:20:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:06 INFO - Downloading docopt-0.6.1.tar.gz 10:20:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:20:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:20:07 INFO - Installing collected packages: blobuploader, requests, docopt 10:20:07 INFO - Running setup.py install for blobuploader 10:20:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:20:07 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:20:07 INFO - Running setup.py install for requests 10:20:07 INFO - Running setup.py install for docopt 10:20:07 INFO - Successfully installed blobuploader requests docopt 10:20:07 INFO - Cleaning up... 10:20:07 INFO - Return code: 0 10:20:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:20: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')]} 10:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20: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')]} 10:20:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:07 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 0x7f03cc36af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c350>, '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 0x290d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d6e0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467', '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 10:20:07 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 10:20:07 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 10:20:07 INFO - Using env: {'DISPLAY': ':0', 10:20:07 INFO - 'HOME': '/home/cltbld', 10:20:07 INFO - 'LANG': 'en_US.UTF-8', 10:20:07 INFO - 'LANGUAGE': 'en_US:en', 10:20:07 INFO - 'LOGNAME': 'cltbld', 10:20:07 INFO - 'MAIL': '/var/mail/cltbld', 10:20:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:07 INFO - 'MOZ_NO_REMOTE': '1', 10:20:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:07 INFO - 'NO_EM_RESTART': '1', 10:20:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:20:07 INFO - 'PWD': '/builds/slave/test-pgo', 10:20:07 INFO - 'SHELL': '/bin/bash', 10:20:07 INFO - 'SHLVL': '1', 10:20:07 INFO - 'TERM': 'linux', 10:20:07 INFO - 'TMOUT': '86400', 10:20:07 INFO - 'USER': 'cltbld', 10:20:07 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467', 10:20:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:07 INFO - '_': '/tools/buildbot/bin/python'} 10:20:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:20:07 INFO - Running setup.py (path:/tmp/pip-Ass50A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:20:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:20:07 INFO - Running setup.py (path:/tmp/pip-2XpeeL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:20:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:20:07 INFO - Running setup.py (path:/tmp/pip-McYbGp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:20:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:20:08 INFO - Running setup.py (path:/tmp/pip-2vVG62-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:20:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:20:08 INFO - Running setup.py (path:/tmp/pip-VBcYmO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:20:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:20:08 INFO - Running setup.py (path:/tmp/pip-gk4nwL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:20:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:20:08 INFO - Running setup.py (path:/tmp/pip-IfdHCI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:20:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:20:08 INFO - Running setup.py (path:/tmp/pip-Puphlq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:20:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:20:08 INFO - Running setup.py (path:/tmp/pip-nRylL2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:20:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:20:08 INFO - Running setup.py (path:/tmp/pip-BCzS0g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:20:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:20:08 INFO - Running setup.py (path:/tmp/pip-l1K9Ho-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:20:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:20:08 INFO - Running setup.py (path:/tmp/pip-uUqLAP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:20:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:20:08 INFO - Running setup.py (path:/tmp/pip-YFZSM6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:20:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:20:08 INFO - Running setup.py (path:/tmp/pip-amLAco-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:20:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:20:08 INFO - Running setup.py (path:/tmp/pip-UpjpBT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:20:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:20:08 INFO - Running setup.py (path:/tmp/pip-ryW45J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:20:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:20:08 INFO - Running setup.py (path:/tmp/pip-A4xBt0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:20:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:20:09 INFO - Running setup.py install for manifestparser 10:20:09 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:20:09 INFO - Running setup.py install for mozcrash 10:20:09 INFO - Running setup.py install for mozdebug 10:20:09 INFO - Running setup.py install for mozdevice 10:20:09 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:20:09 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:20:09 INFO - Running setup.py install for mozfile 10:20:09 INFO - Running setup.py install for mozhttpd 10:20:09 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:20:09 INFO - Running setup.py install for mozinfo 10:20:09 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:20:09 INFO - Running setup.py install for mozInstall 10:20:09 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:20:09 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:20:09 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:20:09 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:20:09 INFO - Running setup.py install for mozleak 10:20:09 INFO - Running setup.py install for mozlog 10:20:10 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:20:10 INFO - Running setup.py install for moznetwork 10:20:10 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:20:10 INFO - Running setup.py install for mozprocess 10:20:10 INFO - Running setup.py install for mozprofile 10:20:10 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:20:10 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:20:10 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:20:10 INFO - Running setup.py install for mozrunner 10:20:10 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:20:10 INFO - Running setup.py install for mozscreenshot 10:20:10 INFO - Running setup.py install for moztest 10:20:10 INFO - Running setup.py install for mozversion 10:20:10 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:20:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:20:10 INFO - Cleaning up... 10:20:10 INFO - Return code: 0 10:20:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:20: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')]} 10:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20: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')]} 10:20:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20: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', '-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 0x7f03cc36af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c350>, '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 0x290d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d6e0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467', '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 10:20:10 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 10:20:10 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 10:20:10 INFO - Using env: {'DISPLAY': ':0', 10:20:10 INFO - 'HOME': '/home/cltbld', 10:20:10 INFO - 'LANG': 'en_US.UTF-8', 10:20:10 INFO - 'LANGUAGE': 'en_US:en', 10:20:10 INFO - 'LOGNAME': 'cltbld', 10:20:10 INFO - 'MAIL': '/var/mail/cltbld', 10:20:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:10 INFO - 'MOZ_NO_REMOTE': '1', 10:20:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:10 INFO - 'NO_EM_RESTART': '1', 10:20:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:20:10 INFO - 'PWD': '/builds/slave/test-pgo', 10:20:10 INFO - 'SHELL': '/bin/bash', 10:20:10 INFO - 'SHLVL': '1', 10:20:10 INFO - 'TERM': 'linux', 10:20:10 INFO - 'TMOUT': '86400', 10:20:10 INFO - 'USER': 'cltbld', 10:20:10 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467', 10:20:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:10 INFO - '_': '/tools/buildbot/bin/python'} 10:20:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:20:11 INFO - Running setup.py (path:/tmp/pip-HUra6Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:20:11 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)) 10:20:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:20:11 INFO - Running setup.py (path:/tmp/pip-n8VFvk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:20:11 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)) 10:20:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:20:11 INFO - Running setup.py (path:/tmp/pip-4DMJMK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:20:11 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)) 10:20:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:20:11 INFO - Running setup.py (path:/tmp/pip-wuVD_l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:20:11 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)) 10:20:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:20:11 INFO - Running setup.py (path:/tmp/pip-QSO8qa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:20:11 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)) 10:20:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:20:11 INFO - Running setup.py (path:/tmp/pip-kfY5lU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:20:11 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)) 10:20:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:20:11 INFO - Running setup.py (path:/tmp/pip-mbRcA_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:20:11 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)) 10:20:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:20:11 INFO - Running setup.py (path:/tmp/pip-h9AE2v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:20:11 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)) 10:20:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:20:11 INFO - Running setup.py (path:/tmp/pip-Iw32Te-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:20:11 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)) 10:20:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:20:11 INFO - Running setup.py (path:/tmp/pip-MCloeg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:20:11 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)) 10:20:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:20:11 INFO - Running setup.py (path:/tmp/pip-qNto1M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:20:11 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)) 10:20:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:20:11 INFO - Running setup.py (path:/tmp/pip-O6G__z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:20:11 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)) 10:20:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:20:11 INFO - Running setup.py (path:/tmp/pip-wywT6P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:20:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 10:20:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:20:11 INFO - Running setup.py (path:/tmp/pip-Z2yGt2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:20:12 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)) 10:20:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:20:12 INFO - Running setup.py (path:/tmp/pip-TYCoDc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:20:12 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)) 10:20:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:20:12 INFO - Running setup.py (path:/tmp/pip-jj_0cj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:20:12 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)) 10:20:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:20:12 INFO - Running setup.py (path:/tmp/pip-GKpNbA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:20:12 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)) 10:20:12 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)) 10:20:12 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)) 10:20:12 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)) 10:20:12 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)) 10:20:12 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)) 10:20:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:20: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 10:20: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 10:20: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 10:20: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 10:20: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 10:20: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 10:20:13 INFO - Downloading blessings-1.5.1.tar.gz 10:20:13 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 10:20:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:20:14 INFO - Installing collected packages: blessings 10:20:14 INFO - Running setup.py install for blessings 10:20:14 INFO - Successfully installed blessings 10:20:14 INFO - Cleaning up... 10:20:14 INFO - Return code: 0 10:20:14 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:20:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:20:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:20:14 INFO - Reading from file tmpfile_stdout 10:20:14 INFO - Current package versions: 10:20:14 INFO - argparse == 1.2.1 10:20:14 INFO - blessings == 1.5.1 10:20:14 INFO - blobuploader == 1.2.4 10:20:14 INFO - docopt == 0.6.1 10:20:14 INFO - manifestparser == 1.1 10:20:14 INFO - mozInstall == 1.12 10:20:14 INFO - mozcrash == 0.16 10:20:14 INFO - mozdebug == 0.1 10:20:14 INFO - mozdevice == 0.47 10:20:14 INFO - mozfile == 1.2 10:20:14 INFO - mozhttpd == 0.7 10:20:14 INFO - mozinfo == 0.9 10:20:14 INFO - mozleak == 0.1 10:20:14 INFO - mozlog == 3.1 10:20:14 INFO - moznetwork == 0.27 10:20:14 INFO - mozprocess == 0.22 10:20:14 INFO - mozprofile == 0.27 10:20:14 INFO - mozrunner == 6.11 10:20:14 INFO - mozscreenshot == 0.1 10:20:14 INFO - mozsystemmonitor == 0.0 10:20:14 INFO - moztest == 0.7 10:20:14 INFO - mozversion == 1.4 10:20:14 INFO - psutil == 3.1.1 10:20:14 INFO - requests == 1.2.3 10:20:14 INFO - wsgiref == 0.1.2 10:20:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:20:14 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')]} 10:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:14 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')]} 10:20:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:14 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 0x7f03cc36af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c350>, '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 0x290d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d6e0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467', '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 10:20:14 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 10:20:14 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 10:20:14 INFO - Using env: {'DISPLAY': ':0', 10:20:14 INFO - 'HOME': '/home/cltbld', 10:20:14 INFO - 'LANG': 'en_US.UTF-8', 10:20:14 INFO - 'LANGUAGE': 'en_US:en', 10:20:14 INFO - 'LOGNAME': 'cltbld', 10:20:14 INFO - 'MAIL': '/var/mail/cltbld', 10:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:14 INFO - 'MOZ_NO_REMOTE': '1', 10:20:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:14 INFO - 'NO_EM_RESTART': '1', 10:20:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:20:14 INFO - 'PWD': '/builds/slave/test-pgo', 10:20:14 INFO - 'SHELL': '/bin/bash', 10:20:14 INFO - 'SHLVL': '1', 10:20:14 INFO - 'TERM': 'linux', 10:20:14 INFO - 'TMOUT': '86400', 10:20:14 INFO - 'USER': 'cltbld', 10:20:14 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467', 10:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:14 INFO - '_': '/tools/buildbot/bin/python'} 10:20:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:14 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 1)) 10:20:14 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 2)) 10:20:14 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 3)) 10:20:14 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 4)) 10:20:14 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 5)) 10:20:14 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 6)) 10:20:14 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 7)) 10:20:14 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 8)) 10:20:14 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:20:14 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 3)) 10:20:14 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:20:14 INFO - Cleaning up... 10:20:14 INFO - Return code: 0 10:20:14 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:20:14 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')]} 10:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:14 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')]} 10:20:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:14 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 0x7f03cc36af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c350>, '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 0x290d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d6e0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467', '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 10:20:14 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 10:20:14 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 10:20:14 INFO - Using env: {'DISPLAY': ':0', 10:20:14 INFO - 'HOME': '/home/cltbld', 10:20:14 INFO - 'LANG': 'en_US.UTF-8', 10:20:14 INFO - 'LANGUAGE': 'en_US:en', 10:20:14 INFO - 'LOGNAME': 'cltbld', 10:20:14 INFO - 'MAIL': '/var/mail/cltbld', 10:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:14 INFO - 'MOZ_NO_REMOTE': '1', 10:20:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:14 INFO - 'NO_EM_RESTART': '1', 10:20:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:20:14 INFO - 'PWD': '/builds/slave/test-pgo', 10:20:14 INFO - 'SHELL': '/bin/bash', 10:20:14 INFO - 'SHLVL': '1', 10:20:14 INFO - 'TERM': 'linux', 10:20:14 INFO - 'TMOUT': '86400', 10:20:14 INFO - 'USER': 'cltbld', 10:20:14 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467', 10:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:14 INFO - '_': '/tools/buildbot/bin/python'} 10:20:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:14 INFO - Downloading/unpacking jsonschema 10:20:14 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 10:20:14 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 10:20:14 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 10:20:14 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 10:20:14 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 10:20:14 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 10:20:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:20:16 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 10:20:16 INFO - Downloading/unpacking functools32 (from jsonschema) 10:20:16 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 10:20:16 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 10:20:16 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 10:20:16 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 10:20:16 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 10:20:16 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 10:20:16 INFO - Downloading functools32-3.2.3-2.tar.gz 10:20:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:20:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:20:16 INFO - warning: no files found matching '*.txt' 10:20:16 INFO - no previously-included directories found matching 'build' 10:20:16 INFO - no previously-included directories found matching 'dist' 10:20:16 INFO - no previously-included directories found matching '.git*' 10:20:16 INFO - Installing collected packages: jsonschema, functools32 10:20:16 INFO - Running setup.py install for functools32 10:20:16 INFO - warning: no files found matching '*.txt' 10:20:16 INFO - no previously-included directories found matching 'build' 10:20:16 INFO - no previously-included directories found matching 'dist' 10:20:16 INFO - no previously-included directories found matching '.git*' 10:20:16 INFO - Successfully installed jsonschema functools32 10:20:16 INFO - Cleaning up... 10:20:16 INFO - Return code: 0 10:20:16 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:20:16 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')]} 10:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:16 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')]} 10:20:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:16 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 0x7f03cc36af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c350>, '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 0x290d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d6e0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467', '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 10:20:16 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 10:20:16 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 10:20:16 INFO - Using env: {'DISPLAY': ':0', 10:20:16 INFO - 'HOME': '/home/cltbld', 10:20:16 INFO - 'LANG': 'en_US.UTF-8', 10:20:17 INFO - 'LANGUAGE': 'en_US:en', 10:20:17 INFO - 'LOGNAME': 'cltbld', 10:20:17 INFO - 'MAIL': '/var/mail/cltbld', 10:20:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:17 INFO - 'MOZ_NO_REMOTE': '1', 10:20:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:17 INFO - 'NO_EM_RESTART': '1', 10:20:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:20:17 INFO - 'PWD': '/builds/slave/test-pgo', 10:20:17 INFO - 'SHELL': '/bin/bash', 10:20:17 INFO - 'SHLVL': '1', 10:20:17 INFO - 'TERM': 'linux', 10:20:17 INFO - 'TMOUT': '86400', 10:20:17 INFO - 'USER': 'cltbld', 10:20:17 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467', 10:20:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:17 INFO - '_': '/tools/buildbot/bin/python'} 10:20:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:17 INFO - Downloading/unpacking flake8 10:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:20:18 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 10:20:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:20:19 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 10:20:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:20:19 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 10:20:19 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 10:20:19 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 10:20:19 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 10:20:19 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 10:20:19 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 10:20:19 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 10:20:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:20:19 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 10:20:19 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 10:20:19 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 10:20:19 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 10:20:19 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 10:20:19 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 10:20:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:20:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:20:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:20:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:20:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:20:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:20:19 INFO - no previously-included directories found matching 'docs/_build' 10:20:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:20:19 INFO - Running setup.py install for pep8 10:20:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:20:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:20:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:20:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:20:19 INFO - no previously-included directories found matching 'docs/_build' 10:20:19 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:20:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:20:19 INFO - Cleaning up... 10:20:19 INFO - Return code: 0 10:20:19 INFO - Running post-action listener: _resource_record_post_action 10:20:19 INFO - Running post-action listener: _start_resource_monitoring 10:20:19 INFO - Starting resource monitoring. 10:20:19 INFO - ##### 10:20:19 INFO - ##### Running install step. 10:20:19 INFO - ##### 10:20:19 INFO - Running pre-action listener: _resource_record_pre_action 10:20:19 INFO - Running main action method: install 10:20:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:20:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:20:19 INFO - Reading from file tmpfile_stdout 10:20:19 INFO - Detecting whether we're running mozinstall >=1.0... 10:20:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:20:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:20:20 INFO - Reading from file tmpfile_stdout 10:20:20 INFO - Output received: 10:20:20 INFO - Usage: mozinstall [options] installer 10:20:20 INFO - Options: 10:20:20 INFO - -h, --help show this help message and exit 10:20:20 INFO - -d DEST, --destination=DEST 10:20:20 INFO - Directory to install application into. [default: 10:20:20 INFO - "/builds/slave/test-pgo"] 10:20:20 INFO - --app=APP Application being installed. [default: firefox] 10:20:20 INFO - mkdir: /builds/slave/test-pgo/build/application 10:20:20 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'] 10:20:20 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 10:20:35 INFO - Reading from file tmpfile_stdout 10:20:35 INFO - Output received: 10:20:35 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:20:35 INFO - Running post-action listener: _resource_record_post_action 10:20:35 INFO - ##### 10:20:35 INFO - ##### Running run-tests step. 10:20:35 INFO - ##### 10:20:35 INFO - Running pre-action listener: _resource_record_pre_action 10:20:35 INFO - Running main action method: run_tests 10:20:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:20:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:20:35 INFO - Python 2.7.3 10:20:35 INFO - Return code: 0 10:20:35 INFO - grabbing minidump binary from tooltool 10:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:20:35 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 0x290c350>, '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 0x290d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:20:35 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 10:20:35 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 10:20:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:20:35 INFO - Return code: 0 10:20:35 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:20:35 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:20:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:20:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:20:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:20:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:20:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:20:36 INFO - Return code: 0 10:20:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 10:20:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost 10:20:36 INFO - Using env: {'DISPLAY': ':0', 10:20:36 INFO - 'HOME': '/home/cltbld', 10:20:36 INFO - 'LANG': 'en_US.UTF-8', 10:20:36 INFO - 'LANGUAGE': 'en_US:en', 10:20:36 INFO - 'LOGNAME': 'cltbld', 10:20:36 INFO - 'MAIL': '/var/mail/cltbld', 10:20:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:20:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:36 INFO - 'MOZ_NO_REMOTE': '1', 10:20:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:20:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:36 INFO - 'NO_EM_RESTART': '1', 10:20:36 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:20:36 INFO - 'PWD': '/builds/slave/test-pgo', 10:20:36 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:20:36 INFO - 'SHELL': '/bin/bash', 10:20:36 INFO - 'SHLVL': '1', 10:20:36 INFO - 'TERM': 'linux', 10:20:36 INFO - 'TMOUT': '86400', 10:20:36 INFO - 'USER': 'cltbld', 10:20:36 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467', 10:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:36 INFO - '_': '/tools/buildbot/bin/python'} 10:20:36 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost'] with output_timeout 3600 10:20:36 INFO - mozversion INFO | application_buildid: 20151218073244 10:20:36 INFO - mozversion INFO | application_changeset: c5cb194cc9cb56d742fb3a7a826f0080b0404edc 10:20:36 INFO - mozversion INFO | application_display_name: Nightly 10:20:36 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:20:36 INFO - mozversion INFO | application_name: Firefox 10:20:36 INFO - mozversion INFO | application_remotingname: firefox 10:20:36 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 10:20:37 INFO - mozversion INFO | application_vendor: Mozilla 10:20:37 INFO - mozversion INFO | application_version: 46.0a1 10:20:37 INFO - mozversion INFO | platform_buildid: 20151218073244 10:20:37 INFO - mozversion INFO | platform_changeset: c5cb194cc9cb56d742fb3a7a826f0080b0404edc 10:20:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 10:20:37 INFO - mozversion INFO | platform_version: 46.0a1 10:20:37 INFO - 2015-12-18 10:20:36,998 DEBUG : using testdate: 1450462836 10:20:37 INFO - 2015-12-18 10:20:36,998 DEBUG : actual date: 1450462836 10:20:37 INFO - 2015-12-18 10:20:37,009 INFO : starting webserver on 'localhost:43839' 10:20:37 INFO - 2015-12-18 10:20:37,010 INFO : Starting test suite talos-linux64-ix-020 10:20:37 INFO - 2015-12-18 10:20:37,011 INFO : Starting test dromaeo_css 10:20:37 INFO - 2015-12-18 10:20:37,011 DEBUG : operating with platform_type : linux_ 10:20:37 INFO - 2015-12-18 10:20:37,011 INFO : Initialising browser for dromaeo_css test... 10:20:37 INFO - 2015-12-18 10:20:37,025 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpixWVoy/profile http://localhost:43839/getInfo.html 10:20:42 INFO - 2015-12-18 10:20:42,240 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:20:42 INFO - 2015-12-18 10:20:42,241 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:20:42 INFO - 2015-12-18 10:20:42,241 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:20:42 INFO - 2015-12-18 10:20:42,241 DEBUG : BROWSER_OUTPUT: __metrics 10:20:42 INFO - 2015-12-18 10:20:42,402 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:20:42 INFO - 2015-12-18 10:20:42,458 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:20:43 INFO - 2015-12-18 10:20:43,445 INFO : Browser initialized. 10:20:43 INFO - 2015-12-18 10:20:43,446 INFO : Running cycle 1/1 for dromaeo_css test... 10:20:43 INFO - 2015-12-18 10:20:43,446 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpixWVoy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:20:55 INFO - 2015-12-18 10:20:55,249 DEBUG : BROWSER_OUTPUT: RSS: Main: 149454848 10:20:55 INFO - 2015-12-18 10:20:55,250 DEBUG : BROWSER_OUTPUT: 10:21:46 INFO - 2015-12-18 10:21:46,716 DEBUG : BROWSER_OUTPUT: 1450462906715 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] 10:23:55 INFO - 2015-12-18 10:23:55,802 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43839/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43839/tests/dromaeo/cssquery-ext.html) 10:23:56 INFO - 2015-12-18 10:23:56,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 270090240 10:23:56 INFO - 2015-12-18 10:23:56,934 DEBUG : BROWSER_OUTPUT: 10:26:59 INFO - 2015-12-18 10:26:59,430 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43839/tests/dromaeo/cssquery-ext.html (next: http://localhost:43839/tests/dromaeo/cssquery-jquery.html) 10:26:59 INFO - 2015-12-18 10:26:59,991 DEBUG : BROWSER_OUTPUT: RSS: Main: 234168320 10:26:59 INFO - 2015-12-18 10:26:59,991 DEBUG : BROWSER_OUTPUT: 10:30:01 INFO - 2015-12-18 10:30:01,869 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43839/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43839/tests/dromaeo/cssquery-mootools.html) 10:30:02 INFO - 2015-12-18 10:30:02,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 225685504 10:30:02 INFO - 2015-12-18 10:30:02,435 DEBUG : BROWSER_OUTPUT: 10:33:04 INFO - 2015-12-18 10:33:04,301 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43839/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43839/tests/dromaeo/cssquery-prototype.html) 10:33:04 INFO - 2015-12-18 10:33:04,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 215597056 10:33:04 INFO - 2015-12-18 10:33:04,874 DEBUG : BROWSER_OUTPUT: 10:36:07 INFO - 2015-12-18 10:36:07,272 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43839/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43839/tests/dromaeo/cssquery-yui.html) 10:36:07 INFO - 2015-12-18 10:36:07,857 DEBUG : BROWSER_OUTPUT: RSS: Main: 218263552 10:36:07 INFO - 2015-12-18 10:36:07,858 DEBUG : BROWSER_OUTPUT: 10:39:10 INFO - 2015-12-18 10:39:10,497 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43839/tests/dromaeo/cssquery-yui.html (next: http://localhost:43839/tests/dromaeo/cssquery-dojo.html) 10:39:10 INFO - 2015-12-18 10:39:10,742 DEBUG : BROWSER_OUTPUT: RSS: Main: 260100096 10:39:10 INFO - 2015-12-18 10:39:10,743 DEBUG : BROWSER_OUTPUT: 10:39:10 INFO - 2015-12-18 10:39:10,743 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:39:10 INFO - 2015-12-18 10:39:10,743 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:39:10 INFO - 2015-12-18 10:39:10,743 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:39:10 INFO - 2015-12-18 10:39:10,743 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:39:10 INFO - 2015-12-18 10:39:10,746 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3104.115327131767;3145.622525296965;3170.540271660609;3176.2694580246543;3205.1666566692666;5132.3327967364285;5255.76349064292;5327.147656374981;5329.92005119923;5397.892042159159;5170.922436163461;5260.868478288045;5265.842024739254;5306.283651707018;5317.707526086064;4811.951880481203;4819.108464933981;4829.975850120744;4874.731889746063;4958.826441074545;4713.387259656257;4861.100696371165;4872.585830204437;4901.460839307673;4948.87627809304;4820.758962051901;4832.1543729847135;4926.3595732554895;4935.2350385689915;4970.329005584236;4934.950650493521;4940.061388336205;4951.702897826142;4978.751062446863;4992.725400102993;4665.370175026362;4785.019071090418;4902.338184345103;4923.409190897115;4972.477889821553;5139.280500729901;5202.375714914235;5209.557187639018;5210.374755029383;5243.659162154448;5731.168980497804;5742.28221472316;5745.626534275259;5748.338941021752;5748.482636562688;5558.86102847428;5656.8020119295625;5658.43415658435;5756.194132821408;5770.076787713946;5383.057964856134;5416.485433883775;5474.808381706661;5483.259759932398;5501.202325662796;5856.912146317809;5893.116032595145;5899.380565040695;5909.202257695242;5966.075258334965;5529.419410961871;5744.827655170351;5749.338826034976;5754.05058165398;5754.74103665336;5638.097904335286;5641.492265696025;5714.428557144252;5744.741486633112;5758.568107391962;5778.27771528559;5780.6820624865195;5783.479486846204;5797.797077102281;5801.651900885876;5754.942450575524;5797.8550536236935;5800.53595712342;5803.071508558611;5805.622634528827;4354.129174165117;4393.275109606879;4423.402840616475;4489.1021795641;4496.572825581565;3945.664618507459;3952.4268980997595;3957.584453632327;3961.485006949078;3991.7604943703473;5428.8099916503525;5431.646942948696;5432.619716619799;5440.537554307849;5448.7548060336585;5602.187682786055;5684.8010319638615;5690.061139911868;5765.913511297334;5843.766249349978;5401.108817045222;5412.161115027177;5420.728963551806;5428.2671839301975;5434.728263586805;4871.074495845778;4877.219644856806;4879.756012199376;4883.169861123618;4921.5078492151215;5646.774129034875;5663.093904975184;5745.511631511285;5831;5833.854153646108;5586.217929489956;5627.88744225105;5637.295338082739;5640.661560306395;5683.488486036276;5880.206172166874;5910.261217347832;5925.911111333247;5932.970335148297;5934.703264836655;5425.403205647297;5515.558755299647;5538.47384498472;5755.568332375173;5761.193432919478;5718.857028574319;5740.282464691913;5776.249087618583;5778.191053252464;5820.76716931318;5687.3459552152035;5687.573431992534;5692.658440493584;5698;5707.029804933089;5463.344398672185;5543.750531226024;5580.86047848807;5601.607887448003;5681.715914204191;5537.1140617502615;5558.861028474159;5566.693831839288;5576.414476480073;5679.5172410345585;5636.830895073154;5642.5485961122195;5645.858853528694;5647.774089036557;5663.943360566342;5274.12976858814;5377.247185394126;5388.892222155613;5388.973055134699;5536.501714845684 10:39:10 INFO - 2015-12-18 10:39:10,747 DEBUG : BROWSER_OUTPUT: |1;ext.html;559.3707079535523;565.8161097643265;572.8711040015994;573.9368669446362;583.0816464069093;29767;30770.076897693078;34978.3004339913;35310.2937941241;35317.2936541269;38493.23013539727;38858.805705971434;38987.22025559487;39015.804920975424;39040;7610.733624323149;8676.392652514327;8851.46891186531;8867.911320886806;8868.645254189856;7759;10509.106725928266;10693.572257109745;10718.249722519427;10777.191710621695;10322.380657160595;10467.371957682526;10480.528376223088;10489.947550262237;10497.947510262438;7817.179196184433;8004.51972881629;10378.117859981872;10494.1080008199;10523.684289471328;10244;10343.89656103437;10374.688759337232;10382.377057376581;10382.584696612126;39327.80336098301;39533.80233098845;39635.80182099071;39738.60261397407;39767.20465590672;3140.733037691776;3200.7919485233383;3297.3075654112426;3368.696817286456;3674.3202507536193;30006.399872002658;30096.084254660534;30214.244643884078;30403.543946840815;31406.685933140834;3873.4189871519216;3939.527256729182;3972.8609498667406;4078.57174996627;4083.387491876242;263133;263348;265046;265233;266344;52791.73604132031;54382.289859564175;54926.45073549214;55459.16811247834;56245;54747.726261368436;54895.45104548983;55071.72464137654;55110.72444637751;55110.72444637831;13938.651533711738;14038.1577105374;14049.297535123203;14065.367058482392;14067.085639433404;10272.280940334254;10281.74295642615;10289.897101029044;10298.433586152834;10328.122109620766;18381.724274135897;18391;18404.631907361778;18431.72352414715;18459.907700461412;7090.92909070913;7162.606056666933;7215.242399548077;7331.8900216496795;7341.375983041501;900.6532484993324;972.2027937091517;1008.7478130467383;1019.3221507697447;1055.5250137438184;27998.860005700248;28131.71868281291;28526.572101418496;28542.571861422097;28589.285267868054;983.0660872171466;988.7182153086336;1067.1942683274078;1114.1031469666996;1118.692359601116;12132.514699411924;13127.69796724067;13256.270905100118;13315.866841331657;13351;254352;257637;258660;259159;259311;45661.77169114133;45710;45847;45894;45946.77026614846;1129.8022846002082;1291.8256035435095;1300.6878349196313;1303.7979113237463;1316.1839659411035;22041.889790551588;27261.59107613427;27468.450630987667;27607.723922760517;27692.169234922985;40158;40301.596984030955;40339.596604033584;40389.172757906665;40438.59561404349;220255;221323;268014;271474;286156;28479.43041139207;28483.857580711963;28517.42965140644;28839.42321153523;28862.711372886002;37849.432258516696;38827;39169.804150979064;39200;42185.36721949235;35055.20130625542;35729;35874.820625896704;36537;36930.26139477142;35162.824185878904;35273.47089793604;36224.637753622126;37709.245815083;39959.00102497345;32262.838685806422;32759.67240327566;32796.67203327936;32927.176820579676;32981.83509082535;29046.854765726883;29586.556201657422;30063.549046763877;30118.247043824078;30156.547651784804;24203;24831.87584062068;24896;25183.622245665963;25286.873565632053 10:39:10 INFO - 2015-12-18 10:39:10,751 DEBUG : BROWSER_OUTPUT: |2;jquery.html;345.7268757681432;354.6878746702901;360.23270433975625;360.85205065922975;361.0378341719318;14235.288235588205;14250.643733906658;16332.346706131755;16674.416395426146;17357.82642173578;13835.23906185162;14348.354324055417;15513.379464821423;15850.128242946634;16549.25528351224;5269.736513174335;5398.676079435227;5399.163129714881;5403.2705584745945;5411.161270003136;3620.1311685195496;3726.6646001859826;5088.287639730423;5243.554297884684;5408.378036525791;5263.34208223972;5415.593830462712;5438.3473983122085;5451.100568406208;5453.890922181554;5393.1370980643105;5397.946020539784;5420.268263784378;5555.555555555587;5870.853228669274;5141.074606570815;5151.150060240094;5151.2530683050745;5158.277841102249;5158.871028224287;12220.877791222152;12257.754844903142;12667.239965602;12905.419256133497;13221.405036773273;2073.1085633177727;2088.363049269972;2114.3339847947846;2164.599549083409;2189.6606026065983;9277.953610231905;9507.904920950841;9537.14165725088;9584.904150958471;9749.561269742879;1813.4922221777924;1814.1201517264117;1817.1822679794145;1848.3161230344724;1887.7451544041517;61134.69432652853;62298;62339.68830155866;63783.681081594295;64171.67914160446;9666.371685840399;9956.651517196864;9967.750806229757;9996.900030999743;9998.250131240186;12679.746405071846;12723.872761272454;12760.93619531915;12835.486580536674;12848.036397270242;7135.643217839087;7169.641517924083;7172.031775710317;7173.46199035064;7258.0927384076995;6832.521723479309;6838.589684618939;6847;6886.552374095668;6902.447804175654;4225.619694227535;4247.893802654959;4270.935935960963;4279.572042795696;4323.156984388077;1645.7202275613174;1714.6142118023345;1726.18869131508;1732.0387185112384;1740.7379649753827;873.5195642396657;1007.4861820471613;1013.4527355228095;1036.9992956796727;1042.8331466965249;16140;16485.83514164843;16800;17302;18000.819991800177;829.340674164041;902.6299217320867;902.7743064233941;904.972855808662;905.6830109461636;9526.380785248937;10007.49962501872;10012.499375031219;10079.395236285847;10360.792784144274;540282;547734;550315;559793;560147;80161;80860.59569702114;81593;81972.59013704893;83989.58005209935;1111.2499063132354;1117.2737720481753;1118.3513562133942;1162.2503485252134;1179.5753528729651;15362.769558456408;15852.44516441919;15902.681946360777;15919.044857308598;16113;33067.17332066718;35090.824545877105;35471;35941;37024.07439814026;38944;40022.799886000386;40509.59490405058;46089.308660369454;46624.30063549117;9162.862557061782;9172.862407063765;9339.299552533452;9340.859887101835;9445.574949127169;11297.26567773092;11307;11386.715332116763;11402.942985285352;13035;10351.741206469898;14083.31000279973;14319.856801431852;14375.568732938029;14999.925000374928;2622.6459427977743;12984.805227921777;13745.24401157946;14353.497627582985;14474.046003789354;11341;14165.787513187517;14188.432462701789;14409.927950360601;14468;9362.297827662816;9374.625014999323;9485.715428537154;9616.95191524066;9629.133377996013;10051.145652619316;10130.746731331776;11075.446227688744;11842.822357664814;13779.379927903068 10:39:10 INFO - 2015-12-18 10:39:10,751 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1139.6751925701176;1359.5309618181727;1365.9112157709749;1493.4623535527207;1719.7764290642215;6364.809055728324;6917.792466226015;7293.817654558626;7296.978423020775;7333.230010848864;7210.891836622455;7231.52995055321;7243.782686519413;7277.963610181955;7316.451266155046;1858.646857097154;1900.2683966672862;2172.391730315514;2210.7457642371173;2214.0258286354033;2208.392692009702;2235.519363336882;2246.696695946051;2247.83141264405;2252;2143.7566211597314;2161.643328850738;2206.856554323964;2207.2054060538194;2207.3377986603955;2145.592337455894;2159.730033745782;2187.0377034104945;2187.059564387313;2197.263916587945;2210.5689390568846;2212.623853944833;2226.365485836529;2234.128689810959;2238.832087593437;7132.9643351783425;7150.749723759695;7168.139823221195;7179.353858152791;7200.171980222237;4334.068175342317;4400.3399490076745;4414.955850441486;4425.358323043173;4444.2444784386735;2804.5372513535244;2815.802893797435;2821.2664707176077;2833.6457942757156;2972.539256415259;953.547065144051;979.990200097997;1004.678502879079;1013.4324778124274;1015.7562185075602;10047.397156170653;10079.294449388546;10204.183665306831;10280.845787313196;10296.897031029668;3919.412088186795;3937.940930886039;3978.264021156095;4068.9186216276103;4071.9389209161886;8852.557372131369;8888.022317545065;8892.33307501927;8899.911000890037;8918.955405223061;4478.596926276651;4480.036792089716;4489.887752806206;4517.503074661785;4529.818807247673;4087.2847251730827;4115.650169735546;4118.567550407164;4123.567025462343;4129.15352352767;3136.106209730216;3177.269228077555;3369.79781213128;3462.532558104674;3547.237343971007;1078.1805827570945;1085.847981282621;1088.840384989983;1107.070061148623;1122.7586068995042;984.6898227058454;985.605757696927;1057.043375744952;1090.4493230918335;1277.399622177575;7145.821354466076;7153.606551639606;7157.606331651809;7163.212046674862;7242.6740796663225;1106.4854842498278;1150.2408410449063;1183.828344889986;1193.9701507462382;1209.57060243614;5599.664020158803;5675.659460432387;5690.430956904359;5691.601587888891;5697.943020569741;8040.15578364275;8209.507429554245;8306.169383061646;8316.62575184106;8317.542535160503;8144.592770361458;8195.34437245019;8207.671693132328;8209.8358032839;8218.958905205436;6845.794626161223;6856.828579285558;7047.859042819115;7104.11198600175;7113.679884405111;6921.307869213038;6976.127984002;6990.196127445409;7001;7004.579725216503;7820.804479887821;7968.203179681986;8026.919730802617;8028.718994835152;8033.35733141359;8207.466514676527;8298.336133109458;8322.750317490485;8326.958365208135;8360.916390836013;6762.154730658668;6782.660866956731;6851.177858656993;6865.141857267841;6878.071460352789;6360.522960778053;6511.186101737283;6977.546459480118;7220.169680486812;7244.89132663;6813.659317034029;6839.110915581142;6903.309669033057;6942.993265976304;6971.79084627462;6394.392532709385;6452.322506136976;6456.386643268882;6522.804315870531;6564.4748420125325;6847.691853866489;6895;6895.689693963884;6910.516263861481;6920.446364290744;6047.274327080779;6091.02543593023;6110.480609148272;6124.877502449837;6148.569600127948;6193.907091393723;6246.312905580292;6248.218972628421;6257.2804127525915;6260.467860231931 10:39:10 INFO - 2015-12-18 10:39:10,755 DEBUG : BROWSER_OUTPUT: |4;prototype.html;310.8181713697487;318.25210754726396;318.30768079427247;321.55785794532517;322.28774408557086;5865.090910908811;6026.36723144069;6048.334683184846;6061.151438798561;6062.363451837559;5862.384449632791;5909.4090590941;5915.290165180174;5918.763249470016;5929.525637948965;4288.206681763883;4367.890802729941;4386.780660966939;4552.453705555338;4558.111168322179;4386.276264416368;4427.667924905629;4558.769132334268;4569.885752856172;4573.496915339327;4481.46222453306;4494.595486406222;4497.572730590588;4510.097980403916;4511.3233015047845;4309.892252693677;4406.25093734066;4507.053518761064;4511.909761804778;4514.210013247685;3908;3948.091938854051;3968.3452230381954;3978.7214894957365;3979.0848104936026;5597.076482380402;5602.691851948141;5608.747606357723;5624.15637654351;5639.718014099279;5256.6057545684225;5259.053370393328;5260.053190425722;5260.736963151827;5266.420693723688;6080.270367555878;6239.812805615838;6251.187345645082;6268.09112678659;6282.434580887696;4394.1870753910625;4403.251447253974;4404.317330813697;4407.030453300269;4412.40432541606;6405.455536279422;6470.352964703539;6479.546431749779;6481.319461456526;6496.18797650289;4408.6913916026215;4411.051623900877;4415.161119387306;4415.271480205794;4417.977910110493;4385.6710746694125;4548.158590660738;4552.408186935677;4552.476465206478;4570.7257564546235;5230.555402790806;5238.449962753933;5249.790008399697;5250.422453530108;5250.4749525047955;6289.654069026247;6291.937080629226;6294;6303.2751233607805;6310.274318453345;1577.8501042400953;1586.761985702131;1589.213339397006;1591.3157342342672;1592.0925072708444;1040.8646875906084;1072.6567498400593;1080.978380432387;1081.6214324986192;1082.9025387714985;6007.969960150172;6022.5784195105925;6035.758569657252;6044.365341639064;6050.818475445656;6440.935590644127;6443.613383197023;6446.033095035782;6464.838379040561;6478.967605162038;6037.034074548052;6037.9396206038255;6039.879202416015;6040.124181993587;6045.697715114226;3396.6093899201414;3397.2695870387984;3460.2041530448137;3491.354099491602;3491.5984661763714;6617.073609694647;6641.767538136239;6642.202935647753;6650.567713098633;6663.800085997428;6675.365840245169;6678.866422671519;6686.531942764057;6688.498362622823;6690.230623478362;6490.675466226669;6599.8020059398295;6642;6675.165604299463;6686.197656281374;6579.605223686594;6584.341565843377;6587.670616469253;6588.341165883373;6590.308017658269;6470.6441145737435;6515.315891831289;6516.5112616553;6517.283098859027;6525.967370163119;6560.245571759118;6615.636140012345;6657.700403481952;6662.900056499253;6679.465642748665;4418.690691651554;4450.354698568754;4453.643708503248;4457.665675074318;4464.9107017860115;6552.803415897531;6563.278039415756;6563.310852360433;6564.409203171737;6569.737210511526;6265.624062556261;6332.683365831782;6375.1712277405495;6383.744650213939;6389.105525226379;6332.683365831782;6338.429541341301;6353.491720662243;6360.618362898241;6363.61818290904;6195.907061393992;6205.844853878689;6222.719977601109;6223.502119830493;6232.189815323979;6258.874822503433;6373.7131829066875;6386.648734319657;6388.36116388376;6393.6483493408305;6218.19163508741;6224.813255602339;6225.968870155802;6243.094751260951;6253.1245625613365 10:39:10 INFO - 2015-12-18 10:39:10,756 DEBUG : BROWSER_OUTPUT: |5;yui.html;726.9527480713756;730.926907309269;753.3257734327773;764.3044829205422;802.6709049289792;13658.521951731691;13721.176729396244;13764.242966636832;13902.374393152308;13989.160650360986;11790.587329443471;11790.941045294761;11799.646010619696;11826.172167948247;11932.16474846761;671.5198632977421;680.9080774095484;785.8153333966527;789.5933594198992;808.2321794295443;789.9447038707293;797.5453991225004;798.2416704131069;799.5003123048095;805.2913436176186;825.7976795685065;831.7005877883956;832.4048305461594;832.429785596865;832.7085520067958;677.5629718831351;686.9107016087902;821.1501096365263;837.6691206973272;838.2623291503498;610.3042531514078;611.2054329371844;615.8614311779859;615.9661218632973;616.4852348289184;12703;12796.552120675731;12821;12845.293508857008;12976.740465190738;11109.888901110966;11147.832782508269;11664.708382290426;11666;12135;10153.746156346077;10184.287099902936;10210.693679189637;10390.428526431044;10442.738931526697;3536.4341705327024;3575.606683264839;3592.8203589820664;3621.257642183346;3705.2959937611768;43899.56100438986;44365.55634443647;44520.3321950171;44824.87937801548;44840;9677.274204434696;10033.397996120257;10103.696889093339;10113.003643831633;10377;17739.11304434773;17800.46598602044;17873.19570619325;17900.194491247927;17920.462386128438;7327.853442931111;7365.7790266292095;7395.593242371614;7527.585982771;7895.565743884026;4528.682992190515;4550.795214215368;4553;4568.065369045289;4618.214903466352;2950.51316532774;2995.82025078496;2996.6703662597097;2997.2207226121363;2998.7750918681186;551.8565173055034;558.6899270904687;559.376295430592;559.5607448153262;569.6866723302168;587.9029960056629;601.6540489218717;606.9666168360694;628.3496581038603;631.3560168627973;8528.701495447629;8711.47731136134;8754.430961987451;8805.987311459136;8989.05614910438;595.3986473661633;618.7215752911118;631.797824696102;638.6710843915388;640.7469049725426;3830.138218900725;3975.2248311578965;4213.431186789805;4241.3637954307105;4369.388285640013;55966;57438.7128064357;57725.42274577284;58351.54121147005;58475.41524584785;44490.77754611271;45449.772751136035;45735;45805.31292030622;46285.5371446288;44652.55347446484;44776.3283550747;45532.77233613811;45751.313730294074;45764.5423545767;8256.463329883538;8276.58617069132;8308.29379502749;8320.958395207985;8534.530600817016;33901.3219735599;34139.65860341365;34229.315413692086;34288.657113429545;35003;40046.199076017736;41443;43936.34095488506;44050.55949440593;44291.33562996493;10358.896411035794;10698.135877991894;10748.570057197625;10864.891351086704;11143;12002.75994480088;12173.39133043362;12419;12461.439235234255;12607.180533265308;10930.234883558074;11101.944490277498;11187.440627968732;11233.045191158842;11519.654410367702;10357.792844142925;10494.527746251284;11092.722681933015;11170.49732762044;11193.552257909592;8066.475679080841;9752.43960966242;11189;11226.101911846868;11690.824637630272;9343.626254949997;9666.468344241135;9748.391515399879;9922.950385248028;10386.896131038593;8886.37795354319;9329.906700933176;9335.393199442015;9881.357711748713;9896.455694936847 10:39:10 INFO - 2015-12-18 10:39:10,756 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:39:10 INFO - 2015-12-18 10:39:10,756 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:39:10 INFO - 2015-12-18 10:39:10,756 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,904 10:39:10 INFO - 2015-12-18 10:39:10,756 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:39:10 INFO - 2015-12-18 10:39:10,756 DEBUG : BROWSER_OUTPUT: __startTimestamp1450463950742__endTimestamp 10:39:10 INFO - 2015-12-18 10:39:10,756 DEBUG : BROWSER_OUTPUT: 10:39:10 INFO - 2015-12-18 10:39:10,757 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:39:10 INFO - 2015-12-18 10:39:10,757 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:39:10 INFO - 2015-12-18 10:39:10,757 DEBUG : BROWSER_OUTPUT: 10:39:10 INFO - 2015-12-18 10:39:10,757 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5318.60 Median:5529.42 stddev:590.99 (10.7%) stddev-sans-first:566.69 10:39:10 INFO - 2015-12-18 10:39:10,758 DEBUG : BROWSER_OUTPUT: Values: 3104.1 3145.6 3170.5 3176.3 3205.2 5132.3 5255.8 5327.1 5329.9 5397.9 5170.9 5260.9 5265.8 5306.3 5317.7 4812.0 4819.1 4830.0 4874.7 4958.8 4713.4 4861.1 4872.6 4901.5 4948.9 4820.8 4832.2 4926.4 4935.2 4970.3 4935.0 4940.1 4951.7 4978.8 4992.7 4665.4 4785.0 4902.3 4923.4 4972.5 5139.3 5202.4 5209.6 5210.4 5243.7 5731.2 5742.3 5745.6 5748.3 5748.5 5558.9 5656.8 5658.4 5756.2 5770.1 5383.1 5416.5 5474.8 5483.3 5501.2 5856.9 5893.1 5899.4 5909.2 5966.1 5529.4 5744.8 5749.3 5754.1 5754.7 5638.1 5641.5 5714.4 5744.7 5758.6 5778.3 5780.7 5783.5 5797.8 5801.7 5754.9 5797.9 5800.5 5803.1 5805.6 4354.1 4393.3 4423.4 4489.1 4496.6 3945.7 3952.4 3957.6 3961.5 3991.8 5428.8 5431.6 5432.6 5440.5 5448.8 5602.2 5684.8 5690.1 5765.9 5843.8 5401.1 5412.2 5420.7 5428.3 5434.7 4871.1 4877.2 4879.8 4883.2 4921.5 5646.8 5663.1 5745.5 5831.0 5833.9 5586.2 5627.9 5637.3 5640.7 5683.5 5880.2 5910.3 5925.9 5933.0 5934.7 5425.4 5515.6 5538.5 5755.6 5761.2 5718.9 5740.3 5776.2 5778.2 5820.8 5687.3 5687.6 5692.7 5698.0 5707.0 5463.3 5543.8 5580.9 5601.6 5681.7 5537.1 5558.9 5566.7 5576.4 5679.5 5636.8 5642.5 5645.9 5647.8 5663.9 5274.1 5377.2 5388.9 5389.0 5536.5 10:39:10 INFO - 2015-12-18 10:39:10,758 DEBUG : BROWSER_OUTPUT: 10:39:10 INFO - 2015-12-18 10:39:10,758 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42227.71 Median:30185.40 stddev:67405.80 (223.3%) stddev-sans-first:67522.28 10:39:10 INFO - 2015-12-18 10:39:10,759 DEBUG : BROWSER_OUTPUT: Values: 559.4 565.8 572.9 573.9 583.1 29767.0 30770.1 34978.3 35310.3 35317.3 38493.2 38858.8 38987.2 39015.8 39040.0 7610.7 8676.4 8851.5 8867.9 8868.6 7759.0 10509.1 10693.6 10718.2 10777.2 10322.4 10467.4 10480.5 10489.9 10497.9 7817.2 8004.5 10378.1 10494.1 10523.7 10244.0 10343.9 10374.7 10382.4 10382.6 39327.8 39533.8 39635.8 39738.6 39767.2 3140.7 3200.8 3297.3 3368.7 3674.3 30006.4 30096.1 30214.2 30403.5 31406.7 3873.4 3939.5 3972.9 4078.6 4083.4 263133.0 263348.0 265046.0 265233.0 266344.0 52791.7 54382.3 54926.5 55459.2 56245.0 54747.7 54895.5 55071.7 55110.7 55110.7 13938.7 14038.2 14049.3 14065.4 14067.1 10272.3 10281.7 10289.9 10298.4 10328.1 18381.7 18391.0 18404.6 18431.7 18459.9 7090.9 7162.6 7215.2 7331.9 7341.4 900.7 972.2 1008.7 1019.3 1055.5 27998.9 28131.7 28526.6 28542.6 28589.3 983.1 988.7 1067.2 1114.1 1118.7 12132.5 13127.7 13256.3 13315.9 13351.0 254352.0 257637.0 258660.0 259159.0 259311.0 45661.8 45710.0 45847.0 45894.0 45946.8 1129.8 1291.8 1300.7 1303.8 1316.2 22041.9 27261.6 27468.5 27607.7 27692.2 40158.0 40301.6 40339.6 40389.2 40438.6 220255.0 221323.0 268014.0 271474.0 286156.0 28479.4 28483.9 28517.4 28839.4 28862.7 37849.4 38827.0 39169.8 39200.0 42185.4 35055.2 35729.0 35874.8 36537.0 36930.3 35162.8 35273.5 36224.6 37709.2 39959.0 32262.8 32759.7 32796.7 32927.2 32981.8 29046.9 29586.6 30063.5 30118.2 30156.5 24203.0 24831.9 24896.0 25183.6 25286.9 10:39:10 INFO - 2015-12-18 10:39:10,759 DEBUG : BROWSER_OUTPUT: 10:39:10 INFO - 2015-12-18 10:39:10,760 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28521.51 Median:360.94 stddev:90259.21 (25006.4%) stddev-sans-first:90487.61 10:39:10 INFO - 2015-12-18 10:39:10,760 DEBUG : BROWSER_OUTPUT: Values: 345.7 354.7 360.2 360.9 361.0 14235.3 14250.6 16332.3 16674.4 17357.8 13835.2 14348.4 15513.4 15850.1 16549.3 5269.7 5398.7 5399.2 5403.3 5411.2 3620.1 3726.7 5088.3 5243.6 5408.4 5263.3 5415.6 5438.3 5451.1 5453.9 5393.1 5397.9 5420.3 5555.6 5870.9 5141.1 5151.2 5151.3 5158.3 5158.9 12220.9 12257.8 12667.2 12905.4 13221.4 2073.1 2088.4 2114.3 2164.6 2189.7 9278.0 9507.9 9537.1 9584.9 9749.6 1813.5 1814.1 1817.2 1848.3 1887.7 61134.7 62298.0 62339.7 63783.7 64171.7 9666.4 9956.7 9967.8 9996.9 9998.3 12679.7 12723.9 12760.9 12835.5 12848.0 7135.6 7169.6 7172.0 7173.5 7258.1 6832.5 6838.6 6847.0 6886.6 6902.4 4225.6 4247.9 4270.9 4279.6 4323.2 1645.7 1714.6 1726.2 1732.0 1740.7 873.5 1007.5 1013.5 1037.0 1042.8 16140.0 16485.8 16800.0 17302.0 18000.8 829.3 902.6 902.8 905.0 905.7 9526.4 10007.5 10012.5 10079.4 10360.8 540282.0 547734.0 550315.0 559793.0 560147.0 80161.0 80860.6 81593.0 81972.6 83989.6 1111.2 1117.3 1118.4 1162.3 1179.6 15362.8 15852.4 15902.7 15919.0 16113.0 33067.2 35090.8 35471.0 35941.0 37024.1 38944.0 40022.8 40509.6 46089.3 46624.3 9162.9 9172.9 9339.3 9340.9 9445.6 11297.3 11307.0 11386.7 11402.9 13035.0 10351.7 14083.3 14319.9 14375.6 14999.9 2622.6 12984.8 13745.2 14353.5 14474.0 11341.0 14165.8 14188.4 14409.9 14468.0 9362.3 9374.6 9485.7 9617.0 9629.1 10051.1 10130.7 11075.4 11842.8 13779.4 10:39:10 INFO - 2015-12-18 10:39:10,760 DEBUG : BROWSER_OUTPUT: 10:39:10 INFO - 2015-12-18 10:39:10,761 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5172.66 Median:6171.24 stddev:2650.71 (43.0%) stddev-sans-first:2640.81 10:39:10 INFO - 2015-12-18 10:39:10,762 DEBUG : BROWSER_OUTPUT: Values: 1139.7 1359.5 1365.9 1493.5 1719.8 6364.8 6917.8 7293.8 7297.0 7333.2 7210.9 7231.5 7243.8 7278.0 7316.5 1858.6 1900.3 2172.4 2210.7 2214.0 2208.4 2235.5 2246.7 2247.8 2252.0 2143.8 2161.6 2206.9 2207.2 2207.3 2145.6 2159.7 2187.0 2187.1 2197.3 2210.6 2212.6 2226.4 2234.1 2238.8 7133.0 7150.7 7168.1 7179.4 7200.2 4334.1 4400.3 4415.0 4425.4 4444.2 2804.5 2815.8 2821.3 2833.6 2972.5 953.5 980.0 1004.7 1013.4 1015.8 10047.4 10079.3 10204.2 10280.8 10296.9 3919.4 3937.9 3978.3 4068.9 4071.9 8852.6 8888.0 8892.3 8899.9 8919.0 4478.6 4480.0 4489.9 4517.5 4529.8 4087.3 4115.7 4118.6 4123.6 4129.2 3136.1 3177.3 3369.8 3462.5 3547.2 1078.2 1085.8 1088.8 1107.1 1122.8 984.7 985.6 1057.0 1090.4 1277.4 7145.8 7153.6 7157.6 7163.2 7242.7 1106.5 1150.2 1183.8 1194.0 1209.6 5599.7 5675.7 5690.4 5691.6 5697.9 8040.2 8209.5 8306.2 8316.6 8317.5 8144.6 8195.3 8207.7 8209.8 8219.0 6845.8 6856.8 7047.9 7104.1 7113.7 6921.3 6976.1 6990.2 7001.0 7004.6 7820.8 7968.2 8026.9 8028.7 8033.4 8207.5 8298.3 8322.8 8327.0 8360.9 6762.2 6782.7 6851.2 6865.1 6878.1 6360.5 6511.2 6977.5 7220.2 7244.9 6813.7 6839.1 6903.3 6943.0 6971.8 6394.4 6452.3 6456.4 6522.8 6564.5 6847.7 6895.0 6895.7 6910.5 6920.4 6047.3 6091.0 6110.5 6124.9 6148.6 6193.9 6246.3 6248.2 6257.3 6260.5 10:39:10 INFO - 2015-12-18 10:39:10,762 DEBUG : BROWSER_OUTPUT: 10:39:10 INFO - 2015-12-18 10:39:10,762 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5259.86 Median:6037.49 stddev:1594.21 (26.4%) stddev-sans-first:1554.80 10:39:10 INFO - 2015-12-18 10:39:10,764 DEBUG : BROWSER_OUTPUT: Values: 310.8 318.3 318.3 321.6 322.3 5865.1 6026.4 6048.3 6061.2 6062.4 5862.4 5909.4 5915.3 5918.8 5929.5 4288.2 4367.9 4386.8 4552.5 4558.1 4386.3 4427.7 4558.8 4569.9 4573.5 4481.5 4494.6 4497.6 4510.1 4511.3 4309.9 4406.3 4507.1 4511.9 4514.2 3908.0 3948.1 3968.3 3978.7 3979.1 5597.1 5602.7 5608.7 5624.2 5639.7 5256.6 5259.1 5260.1 5260.7 5266.4 6080.3 6239.8 6251.2 6268.1 6282.4 4394.2 4403.3 4404.3 4407.0 4412.4 6405.5 6470.4 6479.5 6481.3 6496.2 4408.7 4411.1 4415.2 4415.3 4418.0 4385.7 4548.2 4552.4 4552.5 4570.7 5230.6 5238.4 5249.8 5250.4 5250.5 6289.7 6291.9 6294.0 6303.3 6310.3 1577.9 1586.8 1589.2 1591.3 1592.1 1040.9 1072.7 1081.0 1081.6 1082.9 6008.0 6022.6 6035.8 6044.4 6050.8 6440.9 6443.6 6446.0 6464.8 6479.0 6037.0 6037.9 6039.9 6040.1 6045.7 3396.6 3397.3 3460.2 3491.4 3491.6 6617.1 6641.8 6642.2 6650.6 6663.8 6675.4 6678.9 6686.5 6688.5 6690.2 6490.7 6599.8 6642.0 6675.2 6686.2 6579.6 6584.3 6587.7 6588.3 6590.3 6470.6 6515.3 6516.5 6517.3 6526.0 6560.2 6615.6 6657.7 6662.9 6679.5 4418.7 4450.4 4453.6 4457.7 4464.9 6552.8 6563.3 6563.3 6564.4 6569.7 6265.6 6332.7 6375.2 6383.7 6389.1 6332.7 6338.4 6353.5 6360.6 6363.6 6195.9 6205.8 6222.7 6223.5 6232.2 6258.9 6373.7 6386.6 6388.4 6393.6 6218.2 6224.8 6226.0 6243.1 6253.1 10:39:10 INFO - 2015-12-18 10:39:10,764 DEBUG : BROWSER_OUTPUT: 10:39:10 INFO - 2015-12-18 10:39:10,764 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13311.18 Median:24684.34 stddev:15210.01 (61.6%) stddev-sans-first:15223.32 10:39:10 INFO - 2015-12-18 10:39:10,765 DEBUG : BROWSER_OUTPUT: Values: 727.0 730.9 753.3 764.3 802.7 13658.5 13721.2 13764.2 13902.4 13989.2 11790.6 11790.9 11799.6 11826.2 11932.2 671.5 680.9 785.8 789.6 808.2 789.9 797.5 798.2 799.5 805.3 825.8 831.7 832.4 832.4 832.7 677.6 686.9 821.2 837.7 838.3 610.3 611.2 615.9 616.0 616.5 12703.0 12796.6 12821.0 12845.3 12976.7 11109.9 11147.8 11664.7 11666.0 12135.0 10153.7 10184.3 10210.7 10390.4 10442.7 3536.4 3575.6 3592.8 3621.3 3705.3 43899.6 44365.6 44520.3 44824.9 44840.0 9677.3 10033.4 10103.7 10113.0 10377.0 17739.1 17800.5 17873.2 17900.2 17920.5 7327.9 7365.8 7395.6 7527.6 7895.6 4528.7 4550.8 4553.0 4568.1 4618.2 2950.5 2995.8 2996.7 2997.2 2998.8 551.9 558.7 559.4 559.6 569.7 587.9 601.7 607.0 628.3 631.4 8528.7 8711.5 8754.4 8806.0 8989.1 595.4 618.7 631.8 638.7 640.7 3830.1 3975.2 4213.4 4241.4 4369.4 55966.0 57438.7 57725.4 58351.5 58475.4 44490.8 45449.8 45735.0 45805.3 46285.5 44652.6 44776.3 45532.8 45751.3 45764.5 8256.5 8276.6 8308.3 8321.0 8534.5 33901.3 34139.7 34229.3 34288.7 35003.0 40046.2 41443.0 43936.3 44050.6 44291.3 10358.9 10698.1 10748.6 10864.9 11143.0 12002.8 12173.4 12419.0 12461.4 12607.2 10930.2 11101.9 11187.4 11233.0 11519.7 10357.8 10494.5 11092.7 11170.5 11193.6 8066.5 9752.4 11189.0 11226.1 11690.8 9343.6 9666.5 9748.4 9923.0 10386.9 8886.4 9329.9 9335.4 9881.4 9896.5 10:39:10 INFO - 2015-12-18 10:39:10,766 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:39:10 INFO - 2015-12-18 10:39:10,766 DEBUG : BROWSER_OUTPUT: 10:39:11 INFO - 2015-12-18 10:39:11,500 INFO : Browser exited with error code: 0 10:39:11 INFO - 2015-12-18 10:39:11,519 INFO : Completed test dromaeo_css (00:18:34) 10:39:11 INFO - 2015-12-18 10:39:11,519 INFO : Starting test kraken 10:39:11 INFO - 2015-12-18 10:39:11,519 DEBUG : operating with platform_type : linux_ 10:39:11 INFO - 2015-12-18 10:39:11,519 INFO : Initialising browser for kraken test... 10:39:11 INFO - 2015-12-18 10:39:11,525 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2GZBmJ/profile http://localhost:43839/getInfo.html 10:39:16 INFO - 2015-12-18 10:39:16,152 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:39:16 INFO - 2015-12-18 10:39:16,152 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:39:16 INFO - 2015-12-18 10:39:16,152 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:39:16 INFO - 2015-12-18 10:39:16,152 DEBUG : BROWSER_OUTPUT: __metrics 10:39:16 INFO - 2015-12-18 10:39:16,289 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:39:16 INFO - 2015-12-18 10:39:16,365 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:39:17 INFO - 2015-12-18 10:39:17,245 INFO : Browser initialized. 10:39:17 INFO - 2015-12-18 10:39:17,246 INFO : Running cycle 1/1 for kraken test... 10:39:17 INFO - 2015-12-18 10:39:17,246 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2GZBmJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:39:29 INFO - 2015-12-18 10:39:29,133 DEBUG : BROWSER_OUTPUT: RSS: Main: 149184512 10:39:29 INFO - 2015-12-18 10:39:29,133 DEBUG : BROWSER_OUTPUT: 10:39:31 INFO - 2015-12-18 10:39:31,592 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43839/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43839/tests/kraken/driver.html?testName=audio-beat-detection) 10:39:32 INFO - 2015-12-18 10:39:32,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 187375616 10:39:32 INFO - 2015-12-18 10:39:32,166 DEBUG : BROWSER_OUTPUT: 10:39:34 INFO - 2015-12-18 10:39:34,767 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43839/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43839/tests/kraken/driver.html?testName=audio-dft) 10:39:35 INFO - 2015-12-18 10:39:35,340 DEBUG : BROWSER_OUTPUT: RSS: Main: 174800896 10:39:35 INFO - 2015-12-18 10:39:35,340 DEBUG : BROWSER_OUTPUT: 10:39:38 INFO - 2015-12-18 10:39:38,262 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43839/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43839/tests/kraken/driver.html?testName=audio-fft) 10:39:38 INFO - 2015-12-18 10:39:38,815 DEBUG : BROWSER_OUTPUT: RSS: Main: 161492992 10:39:38 INFO - 2015-12-18 10:39:38,815 DEBUG : BROWSER_OUTPUT: 10:39:40 INFO - 2015-12-18 10:39:40,816 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43839/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43839/tests/kraken/driver.html?testName=audio-oscillator) 10:39:41 INFO - 2015-12-18 10:39:41,382 DEBUG : BROWSER_OUTPUT: RSS: Main: 163139584 10:39:41 INFO - 2015-12-18 10:39:41,382 DEBUG : BROWSER_OUTPUT: 10:39:43 INFO - 2015-12-18 10:39:43,584 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43839/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43839/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:39:44 INFO - 2015-12-18 10:39:44,145 DEBUG : BROWSER_OUTPUT: RSS: Main: 165220352 10:39:44 INFO - 2015-12-18 10:39:44,145 DEBUG : BROWSER_OUTPUT: 10:39:47 INFO - 2015-12-18 10:39:47,055 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43839/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43839/tests/kraken/driver.html?testName=imaging-darkroom) 10:39:47 INFO - 2015-12-18 10:39:47,637 DEBUG : BROWSER_OUTPUT: RSS: Main: 165011456 10:39:47 INFO - 2015-12-18 10:39:47,637 DEBUG : BROWSER_OUTPUT: 10:39:51 INFO - 2015-12-18 10:39:51,003 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43839/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43839/tests/kraken/driver.html?testName=imaging-desaturate) 10:39:51 INFO - 2015-12-18 10:39:51,569 DEBUG : BROWSER_OUTPUT: RSS: Main: 166477824 10:39:51 INFO - 2015-12-18 10:39:51,569 DEBUG : BROWSER_OUTPUT: 10:39:54 INFO - 2015-12-18 10:39:54,327 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43839/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43839/tests/kraken/driver.html?testName=json-parse-financial) 10:39:54 INFO - 2015-12-18 10:39:54,901 DEBUG : BROWSER_OUTPUT: RSS: Main: 165814272 10:39:54 INFO - 2015-12-18 10:39:54,901 DEBUG : BROWSER_OUTPUT: 10:39:56 INFO - 2015-12-18 10:39:56,441 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43839/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43839/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:39:57 INFO - 2015-12-18 10:39:57,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 177283072 10:39:57 INFO - 2015-12-18 10:39:57,002 DEBUG : BROWSER_OUTPUT: 10:39:58 INFO - 2015-12-18 10:39:58,805 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43839/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43839/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:39:59 INFO - 2015-12-18 10:39:59,412 DEBUG : BROWSER_OUTPUT: RSS: Main: 175816704 10:39:59 INFO - 2015-12-18 10:39:59,412 DEBUG : BROWSER_OUTPUT: 10:40:01 INFO - 2015-12-18 10:40:01,467 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43839/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43839/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:40:02 INFO - 2015-12-18 10:40:02,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 187011072 10:40:02 INFO - 2015-12-18 10:40:02,036 DEBUG : BROWSER_OUTPUT: 10:40:04 INFO - 2015-12-18 10:40:04,456 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43839/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43839/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:40:05 INFO - 2015-12-18 10:40:05,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 195411968 10:40:05 INFO - 2015-12-18 10:40:05,038 DEBUG : BROWSER_OUTPUT: 10:40:07 INFO - 2015-12-18 10:40:07,592 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43839/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43839/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:40:08 INFO - 2015-12-18 10:40:08,161 DEBUG : BROWSER_OUTPUT: RSS: Main: 193658880 10:40:08 INFO - 2015-12-18 10:40:08,161 DEBUG : BROWSER_OUTPUT: 10:40:09 INFO - 2015-12-18 10:40:09,829 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43839/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43839/tests/kraken/driver.html?testName=ai-astar) 10:40:10 INFO - 2015-12-18 10:40:10,075 DEBUG : BROWSER_OUTPUT: RSS: Main: 251408384 10:40:10 INFO - 2015-12-18 10:40:10,076 DEBUG : BROWSER_OUTPUT: 10:40:10 INFO - 2015-12-18 10:40:10,077 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:40:10 INFO - 2015-12-18 10:40:10,077 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:40:10 INFO - 2015-12-18 10:40:10,077 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:40:10 INFO - 2015-12-18 10:40:10,077 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:40:10 INFO - 2015-12-18 10:40:10,077 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;110;104;111;110;110;99;110;110;110 10:40:10 INFO - 2015-12-18 10:40:10,078 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;127;146;164;124;149;152;126;166;125 10:40:10 INFO - 2015-12-18 10:40:10,078 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;162;161;161;162;160;160;160;162;161 10:40:10 INFO - 2015-12-18 10:40:10,078 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;88;98;70;72;71;112;90;71 10:40:10 INFO - 2015-12-18 10:40:10,078 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;93;135;92;92;93;139;92;94;136 10:40:10 INFO - 2015-12-18 10:40:10,078 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;109;109;110;109;109;109 10:40:10 INFO - 2015-12-18 10:40:10,078 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;145;145;145;144;144;145;144;145 10:40:10 INFO - 2015-12-18 10:40:10,078 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;95;95;95;95;98;96 10:40:10 INFO - 2015-12-18 10:40:10,079 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;59;58;57;58;58;57;66;55;55 10:40:10 INFO - 2015-12-18 10:40:10,079 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;68;66;69;68;67;67;67;68 10:40:10 INFO - 2015-12-18 10:40:10,079 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;86;85;89;85;86;85;86;87 10:40:10 INFO - 2015-12-18 10:40:10,079 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;128;117;114;115;122;122;121;135;122 10:40:10 INFO - 2015-12-18 10:40:10,079 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;150;151;148;151;142;152;149;150;139 10:40:10 INFO - 2015-12-18 10:40:10,079 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;67;68;67;66;67;65;68;67;65 10:40:10 INFO - 2015-12-18 10:40:10,079 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:40:10 INFO - 2015-12-18 10:40:10,079 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:40:10 INFO - 2015-12-18 10:40:10,080 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,922 10:40:10 INFO - 2015-12-18 10:40:10,080 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:40:10 INFO - 2015-12-18 10:40:10,080 DEBUG : BROWSER_OUTPUT: __startTimestamp1450464010076__endTimestamp 10:40:10 INFO - 2015-12-18 10:40:10,080 DEBUG : BROWSER_OUTPUT: 10:40:10 INFO - 2015-12-18 10:40:10,083 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:40:10 INFO - 2015-12-18 10:40:10,084 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:40:10 INFO - 2015-12-18 10:40:10,084 DEBUG : BROWSER_OUTPUT: 10:40:10 INFO - 2015-12-18 10:40:10,084 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.10 Median:110.00 stddev:3.81 (3.5%) stddev-sans-first:4.02 10:40:10 INFO - 2015-12-18 10:40:10,084 DEBUG : BROWSER_OUTPUT: Values: 107.0 110.0 104.0 111.0 110.0 110.0 99.0 110.0 110.0 110.0 10:40:10 INFO - 2015-12-18 10:40:10,084 DEBUG : BROWSER_OUTPUT: 10:40:10 INFO - 2015-12-18 10:40:10,084 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.30 Median:150.50 stddev:16.49 (11.0%) stddev-sans-first:17.03 10:40:10 INFO - 2015-12-18 10:40:10,084 DEBUG : BROWSER_OUTPUT: Values: 154.0 127.0 146.0 164.0 124.0 149.0 152.0 126.0 166.0 125.0 10:40:10 INFO - 2015-12-18 10:40:10,084 DEBUG : BROWSER_OUTPUT: 10:40:10 INFO - 2015-12-18 10:40:10,085 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.87 10:40:10 INFO - 2015-12-18 10:40:10,085 DEBUG : BROWSER_OUTPUT: Values: 160.0 162.0 161.0 161.0 162.0 160.0 160.0 160.0 162.0 161.0 10:40:10 INFO - 2015-12-18 10:40:10,085 DEBUG : BROWSER_OUTPUT: 10:40:10 INFO - 2015-12-18 10:40:10,085 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.60 Median:72.50 stddev:14.69 (20.3%) stddev-sans-first:15.07 10:40:10 INFO - 2015-12-18 10:40:10,085 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 88.0 98.0 70.0 72.0 71.0 112.0 90.0 71.0 10:40:10 INFO - 2015-12-18 10:40:10,085 DEBUG : BROWSER_OUTPUT: 10:40:10 INFO - 2015-12-18 10:40:10,085 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:92.50 stddev:21.20 (22.9%) stddev-sans-first:22.03 10:40:10 INFO - 2015-12-18 10:40:10,085 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 135.0 92.0 92.0 93.0 139.0 92.0 94.0 136.0 10:40:10 INFO - 2015-12-18 10:40:10,085 DEBUG : BROWSER_OUTPUT: 10:40:10 INFO - 2015-12-18 10:40:10,086 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:40:10 INFO - 2015-12-18 10:40:10,086 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 10:40:10 INFO - 2015-12-18 10:40:10,086 DEBUG : BROWSER_OUTPUT: 10:40:10 INFO - 2015-12-18 10:40:10,086 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:144.80 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 10:40:10 INFO - 2015-12-18 10:40:10,086 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 145.0 145.0 145.0 144.0 144.0 145.0 144.0 145.0 10:40:10 INFO - 2015-12-18 10:40:10,086 DEBUG : BROWSER_OUTPUT: 10:40:10 INFO - 2015-12-18 10:40:10,087 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 10:40:10 INFO - 2015-12-18 10:40:10,087 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 98.0 96.0 10:40:10 INFO - 2015-12-18 10:40:10,087 DEBUG : BROWSER_OUTPUT: 10:40:10 INFO - 2015-12-18 10:40:10,087 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.00 stddev:3.07 (5.3%) stddev-sans-first:3.26 10:40:10 INFO - 2015-12-18 10:40:10,087 DEBUG : BROWSER_OUTPUT: Values: 58.0 59.0 58.0 57.0 58.0 58.0 57.0 66.0 55.0 55.0 10:40:10 INFO - 2015-12-18 10:40:10,087 DEBUG : BROWSER_OUTPUT: 10:40:10 INFO - 2015-12-18 10:40:10,088 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:68.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 10:40:10 INFO - 2015-12-18 10:40:10,088 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 66.0 69.0 68.0 67.0 67.0 67.0 68.0 10:40:10 INFO - 2015-12-18 10:40:10,088 DEBUG : BROWSER_OUTPUT: 10:40:10 INFO - 2015-12-18 10:40:10,088 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:86.00 stddev:1.40 (1.6%) stddev-sans-first:1.32 10:40:10 INFO - 2015-12-18 10:40:10,088 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 86.0 85.0 89.0 85.0 86.0 85.0 86.0 87.0 10:40:10 INFO - 2015-12-18 10:40:10,089 DEBUG : BROWSER_OUTPUT: 10:40:10 INFO - 2015-12-18 10:40:10,089 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:122.00 stddev:6.18 (5.1%) stddev-sans-first:6.55 10:40:10 INFO - 2015-12-18 10:40:10,090 DEBUG : BROWSER_OUTPUT: Values: 121.0 128.0 117.0 114.0 115.0 122.0 122.0 121.0 135.0 122.0 10:40:10 INFO - 2015-12-18 10:40:10,090 DEBUG : BROWSER_OUTPUT: 10:40:10 INFO - 2015-12-18 10:40:10,091 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.40 Median:150.00 stddev:4.62 (3.1%) stddev-sans-first:4.47 10:40:10 INFO - 2015-12-18 10:40:10,091 DEBUG : BROWSER_OUTPUT: Values: 142.0 150.0 151.0 148.0 151.0 142.0 152.0 149.0 150.0 139.0 10:40:10 INFO - 2015-12-18 10:40:10,091 DEBUG : BROWSER_OUTPUT: 10:40:10 INFO - 2015-12-18 10:40:10,091 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.07 (1.6%) stddev-sans-first:1.12 10:40:10 INFO - 2015-12-18 10:40:10,091 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 68.0 67.0 66.0 67.0 65.0 68.0 67.0 65.0 10:40:10 INFO - 2015-12-18 10:40:10,091 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:40:10 INFO - 2015-12-18 10:40:10,091 DEBUG : BROWSER_OUTPUT: 10:40:10 INFO - 2015-12-18 10:40:10,964 INFO : Browser exited with error code: 0 10:40:11 INFO - 2015-12-18 10:40:11,020 INFO : Completed test kraken (00:00:59) 10:40:11 INFO - 2015-12-18 10:40:11,020 INFO : Starting test v8_7 10:40:11 INFO - 2015-12-18 10:40:11,020 DEBUG : operating with platform_type : linux_ 10:40:11 INFO - 2015-12-18 10:40:11,021 INFO : Initialising browser for v8_7 test... 10:40:11 INFO - 2015-12-18 10:40:11,027 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUsrFty/profile http://localhost:43839/getInfo.html 10:40:15 INFO - 2015-12-18 10:40:15,224 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:40:15 INFO - 2015-12-18 10:40:15,224 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:40:15 INFO - 2015-12-18 10:40:15,224 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:40:15 INFO - 2015-12-18 10:40:15,224 DEBUG : BROWSER_OUTPUT: __metrics 10:40:15 INFO - 2015-12-18 10:40:15,393 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:40:15 INFO - 2015-12-18 10:40:15,449 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:40:16 INFO - 2015-12-18 10:40:16,749 INFO : Browser initialized. 10:40:16 INFO - 2015-12-18 10:40:16,749 INFO : Running cycle 1/1 for v8_7 test... 10:40:16 INFO - 2015-12-18 10:40:16,749 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUsrFty/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:40:28 INFO - 2015-12-18 10:40:28,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 149823488 10:40:28 INFO - 2015-12-18 10:40:28,506 DEBUG : BROWSER_OUTPUT: 10:40:49 INFO - 2015-12-18 10:40:49,917 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43839/tests/v8_7/run.html (next: http://localhost:43839/tests/v8_7/run.html) 10:40:50 INFO - 2015-12-18 10:40:50,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 559333376 10:40:50 INFO - 2015-12-18 10:40:50,164 DEBUG : BROWSER_OUTPUT: 10:40:50 INFO - 2015-12-18 10:40:50,164 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:40:50 INFO - 2015-12-18 10:40:50,164 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:40:50 INFO - 2015-12-18 10:40:50,164 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:40:50 INFO - 2015-12-18 10:40:50,164 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:40:50 INFO - 2015-12-18 10:40:50,164 DEBUG : BROWSER_OUTPUT: |0;Richards;169.664065151001 10:40:50 INFO - 2015-12-18 10:40:50,165 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;189.6813353566009 10:40:50 INFO - 2015-12-18 10:40:50,165 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.1120448179272 10:40:50 INFO - 2015-12-18 10:40:50,165 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5112.244897959184 10:40:50 INFO - 2015-12-18 10:40:50,165 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1107.4197120708748 10:40:50 INFO - 2015-12-18 10:40:50,165 DEBUG : BROWSER_OUTPUT: |5;Earley;788.8100866824271 10:40:50 INFO - 2015-12-18 10:40:50,165 DEBUG : BROWSER_OUTPUT: |6;Boyer;12207.317073170732 10:40:50 INFO - 2015-12-18 10:40:50,166 DEBUG : BROWSER_OUTPUT: |7;RegExp;25692.30769230769 10:40:50 INFO - 2015-12-18 10:40:50,166 DEBUG : BROWSER_OUTPUT: |8;Splay;580.7200929152149 10:40:50 INFO - 2015-12-18 10:40:50,166 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 10:40:50 INFO - 2015-12-18 10:40:50,166 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:40:50 INFO - 2015-12-18 10:40:50,166 DEBUG : BROWSER_OUTPUT: __startTimestamp1450464050162__endTimestamp 10:40:50 INFO - 2015-12-18 10:40:50,166 DEBUG : BROWSER_OUTPUT: 10:40:50 INFO - 2015-12-18 10:40:50,167 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:40:50 INFO - 2015-12-18 10:40:50,167 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:40:50 INFO - 2015-12-18 10:40:50,167 DEBUG : BROWSER_OUTPUT: 10:40:50 INFO - 2015-12-18 10:40:50,167 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:169.66 Median:169.66 stddev:0.00 (0.0%) 10:40:50 INFO - 2015-12-18 10:40:50,167 DEBUG : BROWSER_OUTPUT: Values: 169.7 10:40:50 INFO - 2015-12-18 10:40:50,167 DEBUG : BROWSER_OUTPUT: 10:40:50 INFO - 2015-12-18 10:40:50,168 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:189.68 Median:189.68 stddev:0.00 (0.0%) 10:40:50 INFO - 2015-12-18 10:40:50,168 DEBUG : BROWSER_OUTPUT: Values: 189.7 10:40:50 INFO - 2015-12-18 10:40:50,168 DEBUG : BROWSER_OUTPUT: 10:40:50 INFO - 2015-12-18 10:40:50,168 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.11 Median:280.11 stddev:0.00 (0.0%) 10:40:50 INFO - 2015-12-18 10:40:50,169 DEBUG : BROWSER_OUTPUT: Values: 280.1 10:40:50 INFO - 2015-12-18 10:40:50,170 DEBUG : BROWSER_OUTPUT: 10:40:50 INFO - 2015-12-18 10:40:50,170 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5112.24 Median:5112.24 stddev:0.00 (0.0%) 10:40:50 INFO - 2015-12-18 10:40:50,170 DEBUG : BROWSER_OUTPUT: Values: 5112.2 10:40:50 INFO - 2015-12-18 10:40:50,170 DEBUG : BROWSER_OUTPUT: 10:40:50 INFO - 2015-12-18 10:40:50,170 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1107.42 Median:1107.42 stddev:0.00 (0.0%) 10:40:50 INFO - 2015-12-18 10:40:50,170 DEBUG : BROWSER_OUTPUT: Values: 1107.4 10:40:50 INFO - 2015-12-18 10:40:50,170 DEBUG : BROWSER_OUTPUT: 10:40:50 INFO - 2015-12-18 10:40:50,171 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:788.81 Median:788.81 stddev:0.00 (0.0%) 10:40:50 INFO - 2015-12-18 10:40:50,171 DEBUG : BROWSER_OUTPUT: Values: 788.8 10:40:50 INFO - 2015-12-18 10:40:50,171 DEBUG : BROWSER_OUTPUT: 10:40:50 INFO - 2015-12-18 10:40:50,171 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 10:40:50 INFO - 2015-12-18 10:40:50,171 DEBUG : BROWSER_OUTPUT: Values: 12207.3 10:40:50 INFO - 2015-12-18 10:40:50,171 DEBUG : BROWSER_OUTPUT: 10:40:50 INFO - 2015-12-18 10:40:50,171 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25692.31 Median:25692.31 stddev:0.00 (0.0%) 10:40:50 INFO - 2015-12-18 10:40:50,171 DEBUG : BROWSER_OUTPUT: Values: 25692.3 10:40:50 INFO - 2015-12-18 10:40:50,172 DEBUG : BROWSER_OUTPUT: 10:40:50 INFO - 2015-12-18 10:40:50,172 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:580.72 Median:580.72 stddev:0.00 (0.0%) 10:40:50 INFO - 2015-12-18 10:40:50,172 DEBUG : BROWSER_OUTPUT: Values: 580.7 10:40:50 INFO - 2015-12-18 10:40:50,172 DEBUG : BROWSER_OUTPUT: 10:40:50 INFO - 2015-12-18 10:40:50,172 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 10:40:50 INFO - 2015-12-18 10:40:50,172 DEBUG : BROWSER_OUTPUT: Values: 4845.4 10:40:50 INFO - 2015-12-18 10:40:50,172 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:40:50 INFO - 2015-12-18 10:40:50,173 DEBUG : BROWSER_OUTPUT: 10:40:50 INFO - 2015-12-18 10:40:50,992 INFO : Browser exited with error code: 0 10:40:51 INFO - 2015-12-18 10:40:51,007 INFO : Completed test v8_7 (00:00:39) 10:40:51 INFO - 2015-12-18 10:40:51,187 INFO : Completed test suite (00:20:14) 10:40:51 INFO - 2015-12-18 10:40:51,187 DEBUG : Working with test: dromaeo_css 10:40:51 INFO - 2015-12-18 10:40:51,187 DEBUG : Generating results file: dromaeo_css 10:40:51 INFO - 2015-12-18 10:40:51,189 DEBUG : Working with test: kraken 10:40:51 INFO - 2015-12-18 10:40:51,189 DEBUG : Generating results file: kraken 10:40:51 INFO - 2015-12-18 10:40:51,189 INFO : javascript benchmark 10:40:51 INFO - 2015-12-18 10:40:51,189 DEBUG : Working with test: v8_7 10:40:51 INFO - 2015-12-18 10:40:51,189 DEBUG : Generating results file: v8_7 10:40:51 INFO - 2015-12-18 10:40:51,190 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:40:51 INFO - 2015-12-18 10:40:51,315 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 10:40:51 INFO - 2015-12-18 10:40:51,315 DEBUG : process_Request line: dromaeo_css 6787.52 graph.html#tests=[[72,1,35]] 10:40:51 INFO - 2015-12-18 10:40:51,315 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:40:51 INFO - 2015-12-18 10:40:51,343 DEBUG : process_Request line: kraken 1496.50 graph.html#tests=[[232,1,35]] 10:40:51 INFO - 2015-12-18 10:40:51,343 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:40:51 INFO - 2015-12-18 10:40:51,476 DEBUG : process_Request line: v8_7 21105.14 graph.html#tests=[[230,1,35]] 10:40:51 INFO - 2015-12-18 10:40:51,477 INFO : javascript benchmark 10:40:51 INFO - 2015-12-18 10:40:51,481 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3104.115327131767, 3145.622525296965, 3170.540271660609, 3176.2694580246543, 3205.1666566692666, 5132.3327967364285, 5255.76349064292, 5327.147656374981, 5329.92005119923, 5397.892042159159, 5170.922436163461, 5260.868478288045, 5265.842024739254, 5306.283651707018, 5317.707526086064, 4811.951880481203, 4819.108464933981, 4829.975850120744, 4874.731889746063, 4958.826441074545, 4713.387259656257, 4861.100696371165, 4872.585830204437, 4901.460839307673, 4948.87627809304, 4820.758962051901, 4832.1543729847135, 4926.3595732554895, 4935.2350385689915, 4970.329005584236, 4934.950650493521, 4940.061388336205, 4951.702897826142, 4978.751062446863, 4992.725400102993, 4665.370175026362, 4785.019071090418, 4902.338184345103, 4923.409190897115, 4972.477889821553, 5139.280500729901, 5202.375714914235, 5209.557187639018, 5210.374755029383, 5243.659162154448, 5731.168980497804, 5742.28221472316, 5745.626534275259, 5748.338941021752, 5748.482636562688, 5558.86102847428, 5656.8020119295625, 5658.43415658435, 5756.194132821408, 5770.076787713946, 5383.057964856134, 5416.485433883775, 5474.808381706661, 5483.259759932398, 5501.202325662796, 5856.912146317809, 5893.116032595145, 5899.380565040695, 5909.202257695242, 5966.075258334965, 5529.419410961871, 5744.827655170351, 5749.338826034976, 5754.05058165398, 5754.74103665336, 5638.097904335286, 5641.492265696025, 5714.428557144252, 5744.741486633112, 5758.568107391962, 5778.27771528559, 5780.6820624865195, 5783.479486846204, 5797.797077102281, 5801.651900885876, 5754.942450575524, 5797.8550536236935, 5800.53595712342, 5803.071508558611, 5805.622634528827, 4354.129174165117, 4393.275109606879, 4423.402840616475, 4489.1021795641, 4496.572825581565, 3945.664618507459, 3952.4268980997595, 3957.584453632327, 3961.485006949078, 3991.7604943703473, 5428.8099916503525, 5431.646942948696, 5432.619716619799, 5440.537554307849, 5448.7548060336585, 5602.187682786055, 5684.8010319638615, 5690.061139911868, 5765.913511297334, 5843.766249349978, 5401.108817045222, 5412.161115027177, 5420.728963551806, 5428.2671839301975, 5434.728263586805, 4871.074495845778, 4877.219644856806, 4879.756012199376, 4883.169861123618, 4921.5078492151215, 5646.774129034875, 5663.093904975184, 5745.511631511285, 5831.0, 5833.854153646108, 5586.217929489956, 5627.88744225105, 5637.295338082739, 5640.661560306395, 5683.488486036276, 5880.206172166874, 5910.261217347832, 5925.911111333247, 5932.970335148297, 5934.703264836655, 5425.403205647297, 5515.558755299647, 5538.47384498472, 5755.568332375173, 5761.193432919478, 5718.857028574319, 5740.282464691913, 5776.249087618583, 5778.191053252464, 5820.76716931318, 5687.3459552152035, 5687.573431992534, 5692.658440493584, 5698.0, 5707.029804933089, 5463.344398672185, 5543.750531226024, 5580.86047848807, 5601.607887448003, 5681.715914204191, 5537.1140617502615, 5558.861028474159, 5566.693831839288, 5576.414476480073, 5679.5172410345585, 5636.830895073154, 5642.5485961122195, 5645.858853528694, 5647.774089036557, 5663.943360566342, 5274.12976858814, 5377.247185394126, 5388.892222155613, 5388.973055134699, 5536.501714845684], "unit": "score", "name": "dojo.html", "value": 5280.050203746554}, {"lowerIsBetter": false, "replicates": [559.3707079535523, 565.8161097643265, 572.8711040015994, 573.9368669446362, 583.0816464069093, 29767.0, 30770.076897693078, 34978.3004339913, 35310.2937941241, 35317.2936541269, 38493.23013539727, 38858.805705971434, 38987.22025559487, 39015.804920975424, 39040.0, 7610.733624323149, 8676.392652514327, 8851.46891186531, 8867.911320886806, 8868.645254189856, 7759.0, 10509.106725928266, 10693.572257109745, 10718.249722519427, 10777.191710621695, 10322.380657160595, 10467.371957682526, 10480.528376223088, 10489.947550262237, 10497.947510262438, 7817.179196184433, 8004.51972881629, 10378.117859981872, 10494.1080008199, 10523.684289471328, 10244.0, 10343.89656103437, 10374.688759337232, 10382.377057376581, 10382.584696612126, 39327.80336098301, 39533.80233098845, 39635.80182099071, 39738.60261397407, 39767.20465590672, 3140.733037691776, 3200.7919485233383, 3297.3075654112426, 3368.696817286456, 3674.3202507536193, 30006.399872002658, 30096.084254660534, 30214.244643884078, 30403.543946840815, 31406.685933140834, 3873.4189871519216, 3939.527256729182, 3972.8609498667406, 4078.57174996627, 4083.387491876242, 263133.0, 263348.0, 265046.0, 265233.0, 266344.0, 52791.73604132031, 54382.289859564175, 54926.45073549214, 55459.16811247834, 56245.0, 54747.726261368436, 54895.45104548983, 55071.72464137654, 55110.72444637751, 55110.72444637831, 13938.651533711738, 14038.1577105374, 14049.297535123203, 14065.367058482392, 14067.085639433404, 10272.280940334254, 10281.74295642615, 10289.897101029044, 10298.433586152834, 10328.122109620766, 18381.724274135897, 18391.0, 18404.631907361778, 18431.72352414715, 18459.907700461412, 7090.92909070913, 7162.606056666933, 7215.242399548077, 7331.8900216496795, 7341.375983041501, 900.6532484993324, 972.2027937091517, 1008.7478130467383, 1019.3221507697447, 1055.5250137438184, 27998.860005700248, 28131.71868281291, 28526.572101418496, 28542.571861422097, 28589.285267868054, 983.0660872171466, 988.7182153086336, 1067.1942683274078, 1114.1031469666996, 1118.692359601116, 12132.514699411924, 13127.69796724067, 13256.270905100118, 13315.866841331657, 13351.0, 254352.0, 257637.0, 258660.0, 259159.0, 259311.0, 45661.77169114133, 45710.0, 45847.0, 45894.0, 45946.77026614846, 1129.8022846002082, 1291.8256035435095, 1300.6878349196313, 1303.7979113237463, 1316.1839659411035, 22041.889790551588, 27261.59107613427, 27468.450630987667, 27607.723922760517, 27692.169234922985, 40158.0, 40301.596984030955, 40339.596604033584, 40389.172757906665, 40438.59561404349, 220255.0, 221323.0, 268014.0, 271474.0, 286156.0, 28479.43041139207, 28483.857580711963, 28517.42965140644, 28839.42321153523, 28862.711372886002, 37849.432258516696, 38827.0, 39169.804150979064, 39200.0, 42185.36721949235, 35055.20130625542, 35729.0, 35874.820625896704, 36537.0, 36930.26139477142, 35162.824185878904, 35273.47089793604, 36224.637753622126, 37709.245815083, 39959.00102497345, 32262.838685806422, 32759.67240327566, 32796.67203327936, 32927.176820579676, 32981.83509082535, 29046.854765726883, 29586.556201657422, 30063.549046763877, 30118.247043824078, 30156.547651784804, 24203.0, 24831.87584062068, 24896.0, 25183.622245665963, 25286.873565632053], "unit": "score", "name": "ext.html", "value": 17739.239383456443}, {"lowerIsBetter": false, "replicates": [345.7268757681432, 354.6878746702901, 360.23270433975625, 360.85205065922975, 361.0378341719318, 14235.288235588205, 14250.643733906658, 16332.346706131755, 16674.416395426146, 17357.82642173578, 13835.23906185162, 14348.354324055417, 15513.379464821423, 15850.128242946634, 16549.25528351224, 5269.736513174335, 5398.676079435227, 5399.163129714881, 5403.2705584745945, 5411.161270003136, 3620.1311685195496, 3726.6646001859826, 5088.287639730423, 5243.554297884684, 5408.378036525791, 5263.34208223972, 5415.593830462712, 5438.3473983122085, 5451.100568406208, 5453.890922181554, 5393.1370980643105, 5397.946020539784, 5420.268263784378, 5555.555555555587, 5870.853228669274, 5141.074606570815, 5151.150060240094, 5151.2530683050745, 5158.277841102249, 5158.871028224287, 12220.877791222152, 12257.754844903142, 12667.239965602, 12905.419256133497, 13221.405036773273, 2073.1085633177727, 2088.363049269972, 2114.3339847947846, 2164.599549083409, 2189.6606026065983, 9277.953610231905, 9507.904920950841, 9537.14165725088, 9584.904150958471, 9749.561269742879, 1813.4922221777924, 1814.1201517264117, 1817.1822679794145, 1848.3161230344724, 1887.7451544041517, 61134.69432652853, 62298.0, 62339.68830155866, 63783.681081594295, 64171.67914160446, 9666.371685840399, 9956.651517196864, 9967.750806229757, 9996.900030999743, 9998.250131240186, 12679.746405071846, 12723.872761272454, 12760.93619531915, 12835.486580536674, 12848.036397270242, 7135.643217839087, 7169.641517924083, 7172.031775710317, 7173.46199035064, 7258.0927384076995, 6832.521723479309, 6838.589684618939, 6847.0, 6886.552374095668, 6902.447804175654, 4225.619694227535, 4247.893802654959, 4270.935935960963, 4279.572042795696, 4323.156984388077, 1645.7202275613174, 1714.6142118023345, 1726.18869131508, 1732.0387185112384, 1740.7379649753827, 873.5195642396657, 1007.4861820471613, 1013.4527355228095, 1036.9992956796727, 1042.8331466965249, 16140.0, 16485.83514164843, 16800.0, 17302.0, 18000.819991800177, 829.340674164041, 902.6299217320867, 902.7743064233941, 904.972855808662, 905.6830109461636, 9526.380785248937, 10007.49962501872, 10012.499375031219, 10079.395236285847, 10360.792784144274, 540282.0, 547734.0, 550315.0, 559793.0, 560147.0, 80161.0, 80860.59569702114, 81593.0, 81972.59013704893, 83989.58005209935, 1111.2499063132354, 1117.2737720481753, 1118.3513562133942, 1162.2503485252134, 1179.5753528729651, 15362.769558456408, 15852.44516441919, 15902.681946360777, 15919.044857308598, 16113.0, 33067.17332066718, 35090.824545877105, 35471.0, 35941.0, 37024.07439814026, 38944.0, 40022.799886000386, 40509.59490405058, 46089.308660369454, 46624.30063549117, 9162.862557061782, 9172.862407063765, 9339.299552533452, 9340.859887101835, 9445.574949127169, 11297.26567773092, 11307.0, 11386.715332116763, 11402.942985285352, 13035.0, 10351.741206469898, 14083.31000279973, 14319.856801431852, 14375.568732938029, 14999.925000374928, 2622.6459427977743, 12984.805227921777, 13745.24401157946, 14353.497627582985, 14474.046003789354, 11341.0, 14165.787513187517, 14188.432462701789, 14409.927950360601, 14468.0, 9362.297827662816, 9374.625014999323, 9485.715428537154, 9616.95191524066, 9629.133377996013, 10051.145652619316, 10130.746731331776, 11075.446227688744, 11842.822357664814, 13779.379927903068], "unit": "score", "name": "jquery.html", "value": 8421.522561360804}, {"lowerIsBetter": false, "replicates": [1139.6751925701176, 1359.5309618181727, 1365.9112157709749, 1493.4623535527207, 1719.7764290642215, 6364.809055728324, 6917.792466226015, 7293.817654558626, 7296.978423020775, 7333.230010848864, 7210.891836622455, 7231.52995055321, 7243.782686519413, 7277.963610181955, 7316.451266155046, 1858.646857097154, 1900.2683966672862, 2172.391730315514, 2210.7457642371173, 2214.0258286354033, 2208.392692009702, 2235.519363336882, 2246.696695946051, 2247.83141264405, 2252.0, 2143.7566211597314, 2161.643328850738, 2206.856554323964, 2207.2054060538194, 2207.3377986603955, 2145.592337455894, 2159.730033745782, 2187.0377034104945, 2187.059564387313, 2197.263916587945, 2210.5689390568846, 2212.623853944833, 2226.365485836529, 2234.128689810959, 2238.832087593437, 7132.9643351783425, 7150.749723759695, 7168.139823221195, 7179.353858152791, 7200.171980222237, 4334.068175342317, 4400.3399490076745, 4414.955850441486, 4425.358323043173, 4444.2444784386735, 2804.5372513535244, 2815.802893797435, 2821.2664707176077, 2833.6457942757156, 2972.539256415259, 953.547065144051, 979.990200097997, 1004.678502879079, 1013.4324778124274, 1015.7562185075602, 10047.397156170653, 10079.294449388546, 10204.183665306831, 10280.845787313196, 10296.897031029668, 3919.412088186795, 3937.940930886039, 3978.264021156095, 4068.9186216276103, 4071.9389209161886, 8852.557372131369, 8888.022317545065, 8892.33307501927, 8899.911000890037, 8918.955405223061, 4478.596926276651, 4480.036792089716, 4489.887752806206, 4517.503074661785, 4529.818807247673, 4087.2847251730827, 4115.650169735546, 4118.567550407164, 4123.567025462343, 4129.15352352767, 3136.106209730216, 3177.269228077555, 3369.79781213128, 3462.532558104674, 3547.237343971007, 1078.1805827570945, 1085.847981282621, 1088.840384989983, 1107.070061148623, 1122.7586068995042, 984.6898227058454, 985.605757696927, 1057.043375744952, 1090.4493230918335, 1277.399622177575, 7145.821354466076, 7153.606551639606, 7157.606331651809, 7163.212046674862, 7242.6740796663225, 1106.4854842498278, 1150.2408410449063, 1183.828344889986, 1193.9701507462382, 1209.57060243614, 5599.664020158803, 5675.659460432387, 5690.430956904359, 5691.601587888891, 5697.943020569741, 8040.15578364275, 8209.507429554245, 8306.169383061646, 8316.62575184106, 8317.542535160503, 8144.592770361458, 8195.34437245019, 8207.671693132328, 8209.8358032839, 8218.958905205436, 6845.794626161223, 6856.828579285558, 7047.859042819115, 7104.11198600175, 7113.679884405111, 6921.307869213038, 6976.127984002, 6990.196127445409, 7001.0, 7004.579725216503, 7820.804479887821, 7968.203179681986, 8026.919730802617, 8028.718994835152, 8033.35733141359, 8207.466514676527, 8298.336133109458, 8322.750317490485, 8326.958365208135, 8360.916390836013, 6762.154730658668, 6782.660866956731, 6851.177858656993, 6865.141857267841, 6878.071460352789, 6360.522960778053, 6511.186101737283, 6977.546459480118, 7220.169680486812, 7244.89132663, 6813.659317034029, 6839.110915581142, 6903.309669033057, 6942.993265976304, 6971.79084627462, 6394.392532709385, 6452.322506136976, 6456.386643268882, 6522.804315870531, 6564.4748420125325, 6847.691853866489, 6895.0, 6895.689693963884, 6910.516263861481, 6920.446364290744, 6047.274327080779, 6091.02543593023, 6110.480609148272, 6124.877502449837, 6148.569600127948, 6193.907091393723, 6246.312905580292, 6248.218972628421, 6257.2804127525915, 6260.467860231931], "unit": "score", "name": "mootools.html", "value": 4265.895263928678}, {"lowerIsBetter": false, "replicates": [310.8181713697487, 318.25210754726396, 318.30768079427247, 321.55785794532517, 322.28774408557086, 5865.090910908811, 6026.36723144069, 6048.334683184846, 6061.151438798561, 6062.363451837559, 5862.384449632791, 5909.4090590941, 5915.290165180174, 5918.763249470016, 5929.525637948965, 4288.206681763883, 4367.890802729941, 4386.780660966939, 4552.453705555338, 4558.111168322179, 4386.276264416368, 4427.667924905629, 4558.769132334268, 4569.885752856172, 4573.496915339327, 4481.46222453306, 4494.595486406222, 4497.572730590588, 4510.097980403916, 4511.3233015047845, 4309.892252693677, 4406.25093734066, 4507.053518761064, 4511.909761804778, 4514.210013247685, 3908.0, 3948.091938854051, 3968.3452230381954, 3978.7214894957365, 3979.0848104936026, 5597.076482380402, 5602.691851948141, 5608.747606357723, 5624.15637654351, 5639.718014099279, 5256.6057545684225, 5259.053370393328, 5260.053190425722, 5260.736963151827, 5266.420693723688, 6080.270367555878, 6239.812805615838, 6251.187345645082, 6268.09112678659, 6282.434580887696, 4394.1870753910625, 4403.251447253974, 4404.317330813697, 4407.030453300269, 4412.40432541606, 6405.455536279422, 6470.352964703539, 6479.546431749779, 6481.319461456526, 6496.18797650289, 4408.6913916026215, 4411.051623900877, 4415.161119387306, 4415.271480205794, 4417.977910110493, 4385.6710746694125, 4548.158590660738, 4552.408186935677, 4552.476465206478, 4570.7257564546235, 5230.555402790806, 5238.449962753933, 5249.790008399697, 5250.422453530108, 5250.4749525047955, 6289.654069026247, 6291.937080629226, 6294.0, 6303.2751233607805, 6310.274318453345, 1577.8501042400953, 1586.761985702131, 1589.213339397006, 1591.3157342342672, 1592.0925072708444, 1040.8646875906084, 1072.6567498400593, 1080.978380432387, 1081.6214324986192, 1082.9025387714985, 6007.969960150172, 6022.5784195105925, 6035.758569657252, 6044.365341639064, 6050.818475445656, 6440.935590644127, 6443.613383197023, 6446.033095035782, 6464.838379040561, 6478.967605162038, 6037.034074548052, 6037.9396206038255, 6039.879202416015, 6040.124181993587, 6045.697715114226, 3396.6093899201414, 3397.2695870387984, 3460.2041530448137, 3491.354099491602, 3491.5984661763714, 6617.073609694647, 6641.767538136239, 6642.202935647753, 6650.567713098633, 6663.800085997428, 6675.365840245169, 6678.866422671519, 6686.531942764057, 6688.498362622823, 6690.230623478362, 6490.675466226669, 6599.8020059398295, 6642.0, 6675.165604299463, 6686.197656281374, 6579.605223686594, 6584.341565843377, 6587.670616469253, 6588.341165883373, 6590.308017658269, 6470.6441145737435, 6515.315891831289, 6516.5112616553, 6517.283098859027, 6525.967370163119, 6560.245571759118, 6615.636140012345, 6657.700403481952, 6662.900056499253, 6679.465642748665, 4418.690691651554, 4450.354698568754, 4453.643708503248, 4457.665675074318, 4464.9107017860115, 6552.803415897531, 6563.278039415756, 6563.310852360433, 6564.409203171737, 6569.737210511526, 6265.624062556261, 6332.683365831782, 6375.1712277405495, 6383.744650213939, 6389.105525226379, 6332.683365831782, 6338.429541341301, 6353.491720662243, 6360.618362898241, 6363.61818290904, 6195.907061393992, 6205.844853878689, 6222.719977601109, 6223.502119830493, 6232.189815323979, 6258.874822503433, 6373.7131829066875, 6386.648734319657, 6388.36116388376, 6393.6483493408305, 6218.19163508741, 6224.813255602339, 6225.968870155802, 6243.094751260951, 6253.1245625613365], "unit": "score", "name": "prototype.html", "value": 4736.2659861969705}, {"lowerIsBetter": false, "replicates": [726.9527480713756, 730.926907309269, 753.3257734327773, 764.3044829205422, 802.6709049289792, 13658.521951731691, 13721.176729396244, 13764.242966636832, 13902.374393152308, 13989.160650360986, 11790.587329443471, 11790.941045294761, 11799.646010619696, 11826.172167948247, 11932.16474846761, 671.5198632977421, 680.9080774095484, 785.8153333966527, 789.5933594198992, 808.2321794295443, 789.9447038707293, 797.5453991225004, 798.2416704131069, 799.5003123048095, 805.2913436176186, 825.7976795685065, 831.7005877883956, 832.4048305461594, 832.429785596865, 832.7085520067958, 677.5629718831351, 686.9107016087902, 821.1501096365263, 837.6691206973272, 838.2623291503498, 610.3042531514078, 611.2054329371844, 615.8614311779859, 615.9661218632973, 616.4852348289184, 12703.0, 12796.552120675731, 12821.0, 12845.293508857008, 12976.740465190738, 11109.888901110966, 11147.832782508269, 11664.708382290426, 11666.0, 12135.0, 10153.746156346077, 10184.287099902936, 10210.693679189637, 10390.428526431044, 10442.738931526697, 3536.4341705327024, 3575.606683264839, 3592.8203589820664, 3621.257642183346, 3705.2959937611768, 43899.56100438986, 44365.55634443647, 44520.3321950171, 44824.87937801548, 44840.0, 9677.274204434696, 10033.397996120257, 10103.696889093339, 10113.003643831633, 10377.0, 17739.11304434773, 17800.46598602044, 17873.19570619325, 17900.194491247927, 17920.462386128438, 7327.853442931111, 7365.7790266292095, 7395.593242371614, 7527.585982771, 7895.565743884026, 4528.682992190515, 4550.795214215368, 4553.0, 4568.065369045289, 4618.214903466352, 2950.51316532774, 2995.82025078496, 2996.6703662597097, 2997.2207226121363, 2998.7750918681186, 551.8565173055034, 558.6899270904687, 559.376295430592, 559.5607448153262, 569.6866723302168, 587.9029960056629, 601.6540489218717, 606.9666168360694, 628.3496581038603, 631.3560168627973, 8528.701495447629, 8711.47731136134, 8754.430961987451, 8805.987311459136, 8989.05614910438, 595.3986473661633, 618.7215752911118, 631.797824696102, 638.6710843915388, 640.7469049725426, 3830.138218900725, 3975.2248311578965, 4213.431186789805, 4241.3637954307105, 4369.388285640013, 55966.0, 57438.7128064357, 57725.42274577284, 58351.54121147005, 58475.41524584785, 44490.77754611271, 45449.772751136035, 45735.0, 45805.31292030622, 46285.5371446288, 44652.55347446484, 44776.3283550747, 45532.77233613811, 45751.313730294074, 45764.5423545767, 8256.463329883538, 8276.58617069132, 8308.29379502749, 8320.958395207985, 8534.530600817016, 33901.3219735599, 34139.65860341365, 34229.315413692086, 34288.657113429545, 35003.0, 40046.199076017736, 41443.0, 43936.34095488506, 44050.55949440593, 44291.33562996493, 10358.896411035794, 10698.135877991894, 10748.570057197625, 10864.891351086704, 11143.0, 12002.75994480088, 12173.39133043362, 12419.0, 12461.439235234255, 12607.180533265308, 10930.234883558074, 11101.944490277498, 11187.440627968732, 11233.045191158842, 11519.654410367702, 10357.792844142925, 10494.527746251284, 11092.722681933015, 11170.49732762044, 11193.552257909592, 8066.475679080841, 9752.43960966242, 11189.0, 11226.101911846868, 11690.824637630272, 9343.626254949997, 9666.468344241135, 9748.391515399879, 9922.950385248028, 10386.896131038593, 8886.37795354319, 9329.906700933176, 9335.393199442015, 9881.357711748713, 9896.455694936847], "unit": "score", "name": "yui.html", "value": 6135.0295191831165}], "name": "dromaeo_css", "value": 6787.516188225621}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 110.0, 104.0, 111.0, 110.0, 110.0, 99.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [154.0, 127.0, 146.0, 164.0, 124.0, 149.0, 152.0, 126.0, 166.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 143.3}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 161.0, 161.0, 162.0, 160.0, 160.0, 160.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 88.0, 98.0, 70.0, 72.0, 71.0, 112.0, 90.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.6}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 135.0, 92.0, 92.0, 93.0, 139.0, 92.0, 94.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 144.0, 144.0, 145.0, 144.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 144.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 98.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 58.0, 57.0, 58.0, 58.0, 57.0, 66.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.1}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 66.0, 69.0, 68.0, 67.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 86.0, 85.0, 89.0, 85.0, 86.0, 85.0, 86.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.8}, {"lowerIsBetter": true, "replicates": [121.0, 128.0, 117.0, 114.0, 115.0, 122.0, 122.0, 121.0, 135.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.7}, {"lowerIsBetter": true, "replicates": [142.0, 150.0, 151.0, 148.0, 151.0, 142.0, 152.0, 149.0, 150.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.4}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 68.0, 67.0, 66.0, 67.0, 65.0, 68.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1496.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.664065151001], "unit": "score", "name": "Richards", "value": 208.0699880000001}, {"lowerIsBetter": false, "replicates": [189.6813353566009], "unit": "score", "name": "DeltaBlue", "value": 348.57409599999994}, {"lowerIsBetter": false, "replicates": [280.1120448179272], "unit": "score", "name": "Encrypt", "value": 950.2661699999999}, {"lowerIsBetter": false, "replicates": [5112.244897959184], "unit": "score", "name": "Decrypt", "value": 52.067341317365305}, {"lowerIsBetter": false, "replicates": [1107.4197120708748], "unit": "score", "name": "RayTrace", "value": 668.2100670000003}, {"lowerIsBetter": false, "replicates": [788.8100866824271], "unit": "score", "name": "Earley", "value": 844.8966503496501}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [25692.30769230769], "unit": "score", "name": "RegExp", "value": 35.4575}, {"lowerIsBetter": false, "replicates": [580.7200929152149], "unit": "score", "name": "Splay", "value": 140.327502}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21105.139343038503}]} 10:40:51 INFO - RETURN: dromaeo_css: 6787.52 10:40:51 INFO - RETURN: kraken: 1496.50 10:40:51 INFO - RETURN: v8_7: 21105.14 10:40:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "21105.14"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1496.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6787.52"}}} 10:40:51 INFO - Return code: 0 10:40:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:40:51 INFO - # TBPL SUCCESS # 10:40:51 INFO - Running post-action listener: _resource_record_post_action 10:40:51 INFO - Running post-run listener: _resource_record_post_run 10:40:52 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 4096; Write bytes: 555577344; Read time: 28; Write time: 910660 10:40:52 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234323968; Read time: 0; Write time: 491196 10:40:52 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 4096; Write bytes: 321253376; Read time: 28; Write time: 419464 10:40:52 INFO - Running post-run listener: _upload_blobber_files 10:40:52 INFO - Blob upload gear active. 10:40:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:40:52 INFO - Copying logs to upload dir... 10:40:52 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1277.541201 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-18 10:40:52.087510) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 10:40:52.090825) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010049 build_url: 'https://queue.taskcluster.net/v1/task/CZ6PqVy0SCS6CRKEQVFM8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 10:40:52.141260) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:40:52.141594) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1450462772.904801-1459865467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:40:52.191278) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 10:40:52.191602) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 10:40:52.191882) ========= ========= Total master_lag: 0.21 =========