builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1450464877.61 results: success (0) buildid: 20151218083043 builduid: 0c295df85c874bbf8c83762f1b7fd370 revision: 7f7cfa4a5383938abc471c22895bf96ceecba4cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 10:54:37.606527) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 10:54:37.609517) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 10:54:37.609852) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006316 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 10:54:37.639397) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 10:54:37.639701) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 10:54:37.686646) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:54:37.686907) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004615 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:54:37.739283) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 10:54:37.739585) ========= 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:54:37.739933) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:54:37.742533) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 10:54:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.6M=0s 2015-12-18 10:54:39 (43.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161799 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:54:37.918212) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:54:37.918552) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017348 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:54:37.968472) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:54:37.968824) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 7f7cfa4a5383938abc471c22895bf96ceecba4cd --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 7f7cfa4a5383938abc471c22895bf96ceecba4cd --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=d7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 10:54:40,073 truncating revision to first 12 chars 2015-12-18 10:54:40,073 Setting DEBUG logging. 2015-12-18 10:54:40,073 attempt 1/10 2015-12-18 10:54:40,073 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/7f7cfa4a5383?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 10:54:40,353 unpacking tar archive at: b2g-inbound-7f7cfa4a5383/testing/mozharness/ program finished with exit code 0 elapsedTime=0.614249 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:54:38.596839) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 10:54:38.597322) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 10:54:38.606510) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 10:54:38.606881) ========= 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:54:38.607350) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-12-18 10:54:38.607653) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:54:40 INFO - MultiFileLogger online at 20151218 10:54:40 in /builds/slave/test-pgo 10:54:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 10:54:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:54:40 INFO - {'append_to_log': False, 10:54:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:54:40 INFO - 'blob_upload_branch': 'B2G-Inbound', 10:54:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:54:40 INFO - 'branch': 'B2G-Inbound', 10:54:40 INFO - 'buildbot_json_path': 'buildprops.json', 10:54:40 INFO - 'config_files': ('talos/linux_config.py',), 10:54:40 INFO - 'default_actions': ('clobber', 10:54:40 INFO - 'read-buildbot-config', 10:54:40 INFO - 'download-and-extract', 10:54:40 INFO - 'populate-webroot', 10:54:40 INFO - 'create-virtualenv', 10:54:40 INFO - 'install', 10:54:40 INFO - 'run-tests'), 10:54:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:54:40 INFO - 'download_minidump_stackwalk': True, 10:54:40 INFO - 'download_symbols': 'ondemand', 10:54:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:54:40 INFO - 'tooltool.py': '/tools/tooltool.py', 10:54:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:54:40 INFO - '/tools/misc-python/virtualenv.py')}, 10:54:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:54:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:54:40 INFO - 'installer_path': 'installer.exe', 10:54:40 INFO - 'log_level': 'info', 10:54:40 INFO - 'log_name': 'talos', 10:54:40 INFO - 'log_to_console': True, 10:54:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:54:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:54:40 INFO - 'opt_config_files': (), 10:54:40 INFO - 'pip_index': False, 10:54:40 INFO - 'sps_profile': False, 10:54:40 INFO - 'sps_profile_interval': 0, 10:54:40 INFO - 'suite': 'dromaeojs', 10:54:40 INFO - 'system_bits': '64', 10:54:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:54:40 INFO - 'title': 'talos-linux64-ix-068', 10:54:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:54:40 INFO - 'use_talos_json': True, 10:54:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:54:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:54:40 INFO - 'work_dir': 'build'} 10:54:40 INFO - ##### 10:54:40 INFO - ##### Running clobber step. 10:54:40 INFO - ##### 10:54:40 INFO - Running pre-action listener: _resource_record_pre_action 10:54:40 INFO - Running main action method: clobber 10:54:40 INFO - rmtree: /builds/slave/test-pgo/build 10:54:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:54:41 INFO - Running post-action listener: _resource_record_post_action 10:54:41 INFO - ##### 10:54:41 INFO - ##### Running read-buildbot-config step. 10:54:41 INFO - ##### 10:54:41 INFO - Running pre-action listener: _resource_record_pre_action 10:54:41 INFO - Running main action method: read_buildbot_config 10:54:41 INFO - Using buildbot properties: 10:54:41 INFO - { 10:54:41 INFO - "project": "", 10:54:41 INFO - "product": "firefox", 10:54:41 INFO - "script_repo_revision": "production", 10:54:41 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 10:54:41 INFO - "repository": "", 10:54:41 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 10:54:41 INFO - "buildid": "20151218083043", 10:54:41 INFO - "pgo_build": "True", 10:54:41 INFO - "basedir": "/builds/slave/test-pgo", 10:54:41 INFO - "buildnumber": 1067, 10:54:41 INFO - "slavename": "talos-linux64-ix-068", 10:54:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:54:41 INFO - "platform": "ubuntu64_hw", 10:54:41 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 10:54:41 INFO - "branch": "b2g-inbound", 10:54:41 INFO - "repo_path": "integration/b2g-inbound", 10:54:41 INFO - "revision": "7f7cfa4a5383938abc471c22895bf96ceecba4cd", 10:54:41 INFO - "stage_platform": "linux64-pgo", 10:54:41 INFO - "builduid": "0c295df85c874bbf8c83762f1b7fd370", 10:54:41 INFO - "slavebuilddir": "test" 10:54:41 INFO - } 10:54:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:54:41 INFO - Running post-action listener: _resource_record_post_action 10:54:41 INFO - ##### 10:54:41 INFO - ##### Running download-and-extract step. 10:54:41 INFO - ##### 10:54:41 INFO - Running pre-action listener: _resource_record_pre_action 10:54:41 INFO - Running main action method: download_and_extract 10:54:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:54:41 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:54:41 INFO - https://queue.taskcluster.net/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:54:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/artifacts/public/build/test_packages.json 10:54:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/artifacts/public/build/test_packages.json 10:54:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:54:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:54:42 INFO - Downloaded 1302 bytes. 10:54:42 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:54:42 INFO - Using the following test package requirements: 10:54:42 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:54:42 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:54:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:54:42 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:54:42 INFO - u'jsshell-linux-x86_64.zip'], 10:54:42 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:54:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:54:42 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:54:42 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:54:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:54:42 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:54:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:54:42 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:54:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:54:42 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:54:42 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:54:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:54:42 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:54:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:42 INFO - https://queue.taskcluster.net/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:54:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:54:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:54:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/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:54:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/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:54:44 INFO - Downloaded 23121096 bytes. 10:54:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:54:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:54:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:54:46 INFO - Return code: 0 10:54:46 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:54:46 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:54:46 INFO - https://queue.taskcluster.net/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:54:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:54:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:54:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/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:54:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/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:54:47 INFO - Downloaded 23121096 bytes. 10:54:47 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:54:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:54:47 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:54:48 INFO - Return code: 0 10:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:48 INFO - https://queue.taskcluster.net/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:54:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:54:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:54:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/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:54:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/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:54:49 INFO - Downloaded 11132039 bytes. 10:54:49 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:54:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:54:49 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:54:50 INFO - Return code: 0 10:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:50 INFO - https://queue.taskcluster.net/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:54:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:54:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:54:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/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:54:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/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:54:52 INFO - Downloaded 54636488 bytes. 10:54:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:54:52 INFO - mkdir: /builds/slave/test-pgo/properties 10:54:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:54:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:54:52 INFO - Contents: 10:54:52 INFO - build_url:https://queue.taskcluster.net/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:54:52 INFO - Running post-action listener: _resource_record_post_action 10:54:52 INFO - Running post-action listener: set_extra_try_arguments 10:54:52 INFO - ##### 10:54:52 INFO - ##### Running populate-webroot step. 10:54:52 INFO - ##### 10:54:52 INFO - Running pre-action listener: _resource_record_pre_action 10:54:52 INFO - Running main action method: populate_webroot 10:54:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:54:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:54:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:54:52 INFO - '--tppagecycles', 10:54:52 INFO - '7'], 10:54:52 INFO - 'tests': ['tsvgm']}}, 10:54:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:54:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:54:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:54:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:54:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:54:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:54:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:54:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:52 INFO - 'talos_options': ['--e10s'], 10:54:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:54:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:52 INFO - 'tests': ['damp', 'tps']}, 10:54:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:52 INFO - 'talos_options': ['--e10s'], 10:54:52 INFO - 'tests': ['damp', 'tps']}, 10:54:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:54:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:54:52 INFO - 'other': {'tests': ['a11yr', 10:54:52 INFO - 'ts_paint', 10:54:52 INFO - 'tpaint', 10:54:52 INFO - 'sessionrestore', 10:54:52 INFO - 'sessionrestore_no_auto_restore']}, 10:54:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:54:52 INFO - 'tests': ['a11yr', 10:54:52 INFO - 'ts_paint', 10:54:52 INFO - 'tpaint', 10:54:52 INFO - 'sessionrestore', 10:54:52 INFO - 'sessionrestore_no_auto_restore']}, 10:54:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:54:52 INFO - 'tests': ['a11yr', 10:54:52 INFO - 'ts_paint', 10:54:52 INFO - 'tpaint', 10:54:52 INFO - 'sessionrestore', 10:54:52 INFO - 'sessionrestore_no_auto_restore']}, 10:54:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:54:52 INFO - 'tests': ['a11yr', 10:54:52 INFO - 'ts_paint', 10:54:52 INFO - 'tpaint', 10:54:52 INFO - 'sessionrestore', 10:54:52 INFO - 'sessionrestore_no_auto_restore']}, 10:54:52 INFO - 'other_l64': {'tests': ['a11yr', 10:54:52 INFO - 'ts_paint', 10:54:52 INFO - 'tpaint', 10:54:52 INFO - 'sessionrestore', 10:54:52 INFO - 'sessionrestore_no_auto_restore']}, 10:54:52 INFO - 'other_nol64': {'tests': ['a11yr', 10:54:52 INFO - 'ts_paint', 10:54:52 INFO - 'tpaint', 10:54:52 INFO - 'sessionrestore', 10:54:52 INFO - 'sessionrestore_no_auto_restore']}, 10:54:52 INFO - 'svgr': {'tests': ['tsvgx', 10:54:52 INFO - 'tsvgr_opacity', 10:54:52 INFO - 'tart', 10:54:52 INFO - 'tscrollx', 10:54:52 INFO - 'cart']}, 10:54:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:54:52 INFO - 'tests': ['tsvgx', 10:54:52 INFO - 'tsvgr_opacity', 10:54:52 INFO - 'tart', 10:54:52 INFO - 'tscrollx', 10:54:52 INFO - 'cart']}, 10:54:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:52 INFO - 'tests': ['tp5o']}, 10:54:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:52 INFO - 'talos_options': ['--e10s'], 10:54:52 INFO - 'tests': ['tp5o']}, 10:54:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:52 INFO - 'talos_options': ['--xperf_path', 10:54:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:54:52 INFO - 'tests': ['tp5n']}, 10:54:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:52 INFO - 'talos_options': ['--e10s', 10:54:52 INFO - '--xperf_path', 10:54:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:54:52 INFO - 'tests': ['tp5n']}}, 10:54:52 INFO - 'talos.zip': {'path': '', 10:54:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:54:52 INFO - Running post-action listener: _resource_record_post_action 10:54:52 INFO - ##### 10:54:52 INFO - ##### Running create-virtualenv step. 10:54:52 INFO - ##### 10:54:52 INFO - Running pre-action listener: _resource_record_pre_action 10:54:52 INFO - Running main action method: create_virtualenv 10:54:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:54:52 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:54:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:54:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:54:52 INFO - Using real prefix '/usr' 10:54:52 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:54:52 INFO - Installing distribute.............................................................................................................................................................................................done. 10:54:54 INFO - Installing pip.................done. 10:54:54 INFO - Return code: 0 10:54:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:54:54 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:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:54 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:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:54 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 0x7fc631983f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa350>, '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 0x18ab250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ab6e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954', '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:54:54 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:54:54 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:54:54 INFO - Using env: {'DISPLAY': ':0', 10:54:54 INFO - 'HOME': '/home/cltbld', 10:54:54 INFO - 'LANG': 'en_US.UTF-8', 10:54:54 INFO - 'LANGUAGE': 'en_US:en', 10:54:54 INFO - 'LOGNAME': 'cltbld', 10:54:54 INFO - 'MAIL': '/var/mail/cltbld', 10:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:54 INFO - 'MOZ_NO_REMOTE': '1', 10:54:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:54 INFO - 'NO_EM_RESTART': '1', 10:54:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:54:54 INFO - 'PWD': '/builds/slave/test-pgo', 10:54:54 INFO - 'SHELL': '/bin/bash', 10:54:54 INFO - 'SHLVL': '1', 10:54:54 INFO - 'TERM': 'linux', 10:54:54 INFO - 'TMOUT': '86400', 10:54:54 INFO - 'USER': 'cltbld', 10:54:54 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954', 10:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:54 INFO - '_': '/tools/buildbot/bin/python'} 10:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:55 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:54:55 INFO - Cleaning up... 10:54:55 INFO - Return code: 0 10:54:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc631983f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa350>, '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 0x18ab250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ab6e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954', '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:54:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 10:54:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:54:55 INFO - Using env: {'DISPLAY': ':0', 10:54:55 INFO - 'HOME': '/home/cltbld', 10:54:55 INFO - 'LANG': 'en_US.UTF-8', 10:54:55 INFO - 'LANGUAGE': 'en_US:en', 10:54:55 INFO - 'LOGNAME': 'cltbld', 10:54:55 INFO - 'MAIL': '/var/mail/cltbld', 10:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:55 INFO - 'MOZ_NO_REMOTE': '1', 10:54:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:55 INFO - 'NO_EM_RESTART': '1', 10:54:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:54:55 INFO - 'PWD': '/builds/slave/test-pgo', 10:54:55 INFO - 'SHELL': '/bin/bash', 10:54:55 INFO - 'SHLVL': '1', 10:54:55 INFO - 'TERM': 'linux', 10:54:55 INFO - 'TMOUT': '86400', 10:54:55 INFO - 'USER': 'cltbld', 10:54:55 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954', 10:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:55 INFO - '_': '/tools/buildbot/bin/python'} 10:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:55 INFO - Downloading/unpacking psutil>=0.7.1 10:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:56 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:54:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:54:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:54:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:54:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:54:57 INFO - Installing collected packages: psutil 10:54:57 INFO - Running setup.py install for psutil 10:54:57 INFO - building 'psutil._psutil_linux' extension 10:54:57 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:54:57 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:54:57 INFO - building 'psutil._psutil_posix' extension 10:54:57 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:54:57 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:54:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:54:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:54:57 INFO - Successfully installed psutil 10:54:57 INFO - Cleaning up... 10:54:57 INFO - Return code: 0 10:54:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc631983f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa350>, '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 0x18ab250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ab6e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954', '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:54:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:54:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:54:57 INFO - Using env: {'DISPLAY': ':0', 10:54:57 INFO - 'HOME': '/home/cltbld', 10:54:57 INFO - 'LANG': 'en_US.UTF-8', 10:54:57 INFO - 'LANGUAGE': 'en_US:en', 10:54:57 INFO - 'LOGNAME': 'cltbld', 10:54:57 INFO - 'MAIL': '/var/mail/cltbld', 10:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:57 INFO - 'MOZ_NO_REMOTE': '1', 10:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:57 INFO - 'NO_EM_RESTART': '1', 10:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:54:57 INFO - 'PWD': '/builds/slave/test-pgo', 10:54:57 INFO - 'SHELL': '/bin/bash', 10:54:57 INFO - 'SHLVL': '1', 10:54:57 INFO - 'TERM': 'linux', 10:54:57 INFO - 'TMOUT': '86400', 10:54:57 INFO - 'USER': 'cltbld', 10:54:57 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954', 10:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:57 INFO - '_': '/tools/buildbot/bin/python'} 10:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:54:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:54:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:54:59 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:54:59 INFO - Installing collected packages: mozsystemmonitor 10:54:59 INFO - Running setup.py install for mozsystemmonitor 10:54:59 INFO - Successfully installed mozsystemmonitor 10:54:59 INFO - Cleaning up... 10:54:59 INFO - Return code: 0 10:54:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:54: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:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54: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:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54: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', '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 0x7fc631983f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa350>, '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 0x18ab250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ab6e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954', '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:54: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 10:54: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 blobuploader==1.2.4 10:54:59 INFO - Using env: {'DISPLAY': ':0', 10:54:59 INFO - 'HOME': '/home/cltbld', 10:54:59 INFO - 'LANG': 'en_US.UTF-8', 10:54:59 INFO - 'LANGUAGE': 'en_US:en', 10:54:59 INFO - 'LOGNAME': 'cltbld', 10:54:59 INFO - 'MAIL': '/var/mail/cltbld', 10:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:59 INFO - 'MOZ_NO_REMOTE': '1', 10:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:59 INFO - 'NO_EM_RESTART': '1', 10:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:54:59 INFO - 'PWD': '/builds/slave/test-pgo', 10:54:59 INFO - 'SHELL': '/bin/bash', 10:54:59 INFO - 'SHLVL': '1', 10:54:59 INFO - 'TERM': 'linux', 10:54:59 INFO - 'TMOUT': '86400', 10:54:59 INFO - 'USER': 'cltbld', 10:54:59 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954', 10:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:59 INFO - '_': '/tools/buildbot/bin/python'} 10:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:59 INFO - Downloading/unpacking blobuploader==1.2.4 10:54: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:54: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:54: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:54: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:54: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:54: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:55:01 INFO - Downloading blobuploader-1.2.4.tar.gz 10:55:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:55:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:55:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:55:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:55:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:55: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:55: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:55: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:55: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:55: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:55: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:55:02 INFO - Downloading docopt-0.6.1.tar.gz 10:55:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:55:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:55:02 INFO - Installing collected packages: blobuploader, requests, docopt 10:55:02 INFO - Running setup.py install for blobuploader 10:55:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:55:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:55:02 INFO - Running setup.py install for requests 10:55:02 INFO - Running setup.py install for docopt 10:55:02 INFO - Successfully installed blobuploader requests docopt 10:55:02 INFO - Cleaning up... 10:55:02 INFO - Return code: 0 10:55:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:55: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:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55: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:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:02 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 0x7fc631983f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa350>, '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 0x18ab250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ab6e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954', '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:55:02 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:55:02 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:55:02 INFO - Using env: {'DISPLAY': ':0', 10:55:02 INFO - 'HOME': '/home/cltbld', 10:55:02 INFO - 'LANG': 'en_US.UTF-8', 10:55:02 INFO - 'LANGUAGE': 'en_US:en', 10:55:02 INFO - 'LOGNAME': 'cltbld', 10:55:02 INFO - 'MAIL': '/var/mail/cltbld', 10:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:02 INFO - 'MOZ_NO_REMOTE': '1', 10:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:02 INFO - 'NO_EM_RESTART': '1', 10:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:55:02 INFO - 'PWD': '/builds/slave/test-pgo', 10:55:02 INFO - 'SHELL': '/bin/bash', 10:55:02 INFO - 'SHLVL': '1', 10:55:02 INFO - 'TERM': 'linux', 10:55:02 INFO - 'TMOUT': '86400', 10:55:02 INFO - 'USER': 'cltbld', 10:55:02 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954', 10:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:02 INFO - '_': '/tools/buildbot/bin/python'} 10:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:55:03 INFO - Running setup.py (path:/tmp/pip-Lw2l4R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:55:03 INFO - Running setup.py (path:/tmp/pip-SWN_FA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:55:03 INFO - Running setup.py (path:/tmp/pip-lwTGKX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:55:03 INFO - Running setup.py (path:/tmp/pip-a20gRd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:55:03 INFO - Running setup.py (path:/tmp/pip-VQYN5p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:55:03 INFO - Running setup.py (path:/tmp/pip-MKdoz5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:55:03 INFO - Running setup.py (path:/tmp/pip-kgzbhp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:55:03 INFO - Running setup.py (path:/tmp/pip-UIw4eW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:55:03 INFO - Running setup.py (path:/tmp/pip-kq8hRB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:55:03 INFO - Running setup.py (path:/tmp/pip-OeCFvl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:55:03 INFO - Running setup.py (path:/tmp/pip-8c43Di-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:55:03 INFO - Running setup.py (path:/tmp/pip-Rw4733-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:55:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:55:04 INFO - Running setup.py (path:/tmp/pip-ZFqvrr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:55:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:55:04 INFO - Running setup.py (path:/tmp/pip-NPZqwN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:55:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:55:04 INFO - Running setup.py (path:/tmp/pip-Bo6HPP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:55:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:55:04 INFO - Running setup.py (path:/tmp/pip-aB_52S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:55:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:55:04 INFO - Running setup.py (path:/tmp/pip-nx6KHV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:55:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:55:04 INFO - Running setup.py install for manifestparser 10:55:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:55:04 INFO - Running setup.py install for mozcrash 10:55:04 INFO - Running setup.py install for mozdebug 10:55:04 INFO - Running setup.py install for mozdevice 10:55:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:55:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:55:04 INFO - Running setup.py install for mozfile 10:55:04 INFO - Running setup.py install for mozhttpd 10:55:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:55:04 INFO - Running setup.py install for mozinfo 10:55:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:55:05 INFO - Running setup.py install for mozInstall 10:55:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:55:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:55:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:55:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:55:05 INFO - Running setup.py install for mozleak 10:55:05 INFO - Running setup.py install for mozlog 10:55:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:55:05 INFO - Running setup.py install for moznetwork 10:55:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:55:05 INFO - Running setup.py install for mozprocess 10:55:05 INFO - Running setup.py install for mozprofile 10:55:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:55:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:55:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:55:05 INFO - Running setup.py install for mozrunner 10:55:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:55:05 INFO - Running setup.py install for mozscreenshot 10:55:05 INFO - Running setup.py install for moztest 10:55:06 INFO - Running setup.py install for mozversion 10:55:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:55:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:55:06 INFO - Cleaning up... 10:55:06 INFO - Return code: 0 10:55:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fc631983f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa350>, '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 0x18ab250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ab6e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954', '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:55:06 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:55:06 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:55:06 INFO - Using env: {'DISPLAY': ':0', 10:55:06 INFO - 'HOME': '/home/cltbld', 10:55:06 INFO - 'LANG': 'en_US.UTF-8', 10:55:06 INFO - 'LANGUAGE': 'en_US:en', 10:55:06 INFO - 'LOGNAME': 'cltbld', 10:55:06 INFO - 'MAIL': '/var/mail/cltbld', 10:55:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:06 INFO - 'MOZ_NO_REMOTE': '1', 10:55:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:06 INFO - 'NO_EM_RESTART': '1', 10:55:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:55:06 INFO - 'PWD': '/builds/slave/test-pgo', 10:55:06 INFO - 'SHELL': '/bin/bash', 10:55:06 INFO - 'SHLVL': '1', 10:55:06 INFO - 'TERM': 'linux', 10:55:06 INFO - 'TMOUT': '86400', 10:55:06 INFO - 'USER': 'cltbld', 10:55:06 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954', 10:55:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:06 INFO - '_': '/tools/buildbot/bin/python'} 10:55:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:55:06 INFO - Running setup.py (path:/tmp/pip-bfMb9H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:55:06 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:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:55:06 INFO - Running setup.py (path:/tmp/pip-_RnPxr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:55:06 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:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:55:06 INFO - Running setup.py (path:/tmp/pip-shy9Gz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:55:06 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:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:55:06 INFO - Running setup.py (path:/tmp/pip-2vZazt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:55:06 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:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:55:06 INFO - Running setup.py (path:/tmp/pip-BOgAfg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:55:06 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:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:55:06 INFO - Running setup.py (path:/tmp/pip-7SZ1Xz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:55:06 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:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:55:06 INFO - Running setup.py (path:/tmp/pip-aLnGyk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:55:06 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:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:55:06 INFO - Running setup.py (path:/tmp/pip-eaiMXy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:55:06 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:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:55:06 INFO - Running setup.py (path:/tmp/pip-FyGORO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:55:07 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:55:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:55:07 INFO - Running setup.py (path:/tmp/pip-gngxQW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:55:07 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:55:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:55:07 INFO - Running setup.py (path:/tmp/pip-OQICz1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:55:07 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:55:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:55:07 INFO - Running setup.py (path:/tmp/pip-Or64c8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:55:07 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:55:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:55:07 INFO - Running setup.py (path:/tmp/pip-H5n9a1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:55:07 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:55:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:55:07 INFO - Running setup.py (path:/tmp/pip-TvtkNt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:55:07 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:55:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:55:07 INFO - Running setup.py (path:/tmp/pip-bz1VR5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:55:07 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:55:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:55:07 INFO - Running setup.py (path:/tmp/pip-BfR0wL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:55:07 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:55:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:55:07 INFO - Running setup.py (path:/tmp/pip-e51jW6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:55:07 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:55:07 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:55:07 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:55:07 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:55:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:55:07 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:55:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:09 INFO - Downloading blessings-1.5.1.tar.gz 10:55:09 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:55:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:55:09 INFO - Installing collected packages: blessings 10:55:09 INFO - Running setup.py install for blessings 10:55:09 INFO - Successfully installed blessings 10:55:09 INFO - Cleaning up... 10:55:09 INFO - Return code: 0 10:55:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:55:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:55:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:55:09 INFO - Reading from file tmpfile_stdout 10:55:09 INFO - Current package versions: 10:55:09 INFO - argparse == 1.2.1 10:55:09 INFO - blessings == 1.5.1 10:55:09 INFO - blobuploader == 1.2.4 10:55:09 INFO - docopt == 0.6.1 10:55:09 INFO - manifestparser == 1.1 10:55:09 INFO - mozInstall == 1.12 10:55:09 INFO - mozcrash == 0.16 10:55:09 INFO - mozdebug == 0.1 10:55:09 INFO - mozdevice == 0.47 10:55:09 INFO - mozfile == 1.2 10:55:09 INFO - mozhttpd == 0.7 10:55:09 INFO - mozinfo == 0.9 10:55:09 INFO - mozleak == 0.1 10:55:09 INFO - mozlog == 3.1 10:55:09 INFO - moznetwork == 0.27 10:55:09 INFO - mozprocess == 0.22 10:55:09 INFO - mozprofile == 0.27 10:55:09 INFO - mozrunner == 6.11 10:55:09 INFO - mozscreenshot == 0.1 10:55:09 INFO - mozsystemmonitor == 0.0 10:55:09 INFO - moztest == 0.7 10:55:09 INFO - mozversion == 1.4 10:55:09 INFO - psutil == 3.1.1 10:55:09 INFO - requests == 1.2.3 10:55:09 INFO - wsgiref == 0.1.2 10:55:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:55:09 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:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:09 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:55:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:09 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 0x7fc631983f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa350>, '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 0x18ab250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ab6e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954', '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:55:09 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:55:09 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:55:09 INFO - Using env: {'DISPLAY': ':0', 10:55:09 INFO - 'HOME': '/home/cltbld', 10:55:09 INFO - 'LANG': 'en_US.UTF-8', 10:55:09 INFO - 'LANGUAGE': 'en_US:en', 10:55:09 INFO - 'LOGNAME': 'cltbld', 10:55:09 INFO - 'MAIL': '/var/mail/cltbld', 10:55:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:09 INFO - 'MOZ_NO_REMOTE': '1', 10:55:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:09 INFO - 'NO_EM_RESTART': '1', 10:55:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:55:09 INFO - 'PWD': '/builds/slave/test-pgo', 10:55:09 INFO - 'SHELL': '/bin/bash', 10:55:09 INFO - 'SHLVL': '1', 10:55:09 INFO - 'TERM': 'linux', 10:55:09 INFO - 'TMOUT': '86400', 10:55:09 INFO - 'USER': 'cltbld', 10:55:09 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954', 10:55:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:09 INFO - '_': '/tools/buildbot/bin/python'} 10:55:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:09 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:55:09 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:55:09 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:55:09 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:55:09 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:55:09 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:55:09 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:55:09 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:55:09 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:55:09 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:55:09 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:55:09 INFO - Cleaning up... 10:55:09 INFO - Return code: 0 10:55:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:55:09 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:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:09 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:55:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:09 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 0x7fc631983f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa350>, '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 0x18ab250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ab6e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954', '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:55:09 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:55:09 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:55:09 INFO - Using env: {'DISPLAY': ':0', 10:55:09 INFO - 'HOME': '/home/cltbld', 10:55:09 INFO - 'LANG': 'en_US.UTF-8', 10:55:09 INFO - 'LANGUAGE': 'en_US:en', 10:55:09 INFO - 'LOGNAME': 'cltbld', 10:55:09 INFO - 'MAIL': '/var/mail/cltbld', 10:55:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:09 INFO - 'MOZ_NO_REMOTE': '1', 10:55:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:09 INFO - 'NO_EM_RESTART': '1', 10:55:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:55:09 INFO - 'PWD': '/builds/slave/test-pgo', 10:55:09 INFO - 'SHELL': '/bin/bash', 10:55:09 INFO - 'SHLVL': '1', 10:55:09 INFO - 'TERM': 'linux', 10:55:09 INFO - 'TMOUT': '86400', 10:55:09 INFO - 'USER': 'cltbld', 10:55:09 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954', 10:55:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:09 INFO - '_': '/tools/buildbot/bin/python'} 10:55:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:10 INFO - Downloading/unpacking jsonschema 10:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:55:11 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:55:11 INFO - Downloading/unpacking functools32 (from jsonschema) 10:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:12 INFO - Downloading functools32-3.2.3-2.tar.gz 10:55:12 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:55:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:55:12 INFO - warning: no files found matching '*.txt' 10:55:12 INFO - no previously-included directories found matching 'build' 10:55:12 INFO - no previously-included directories found matching 'dist' 10:55:12 INFO - no previously-included directories found matching '.git*' 10:55:12 INFO - Installing collected packages: jsonschema, functools32 10:55:12 INFO - Running setup.py install for functools32 10:55:12 INFO - warning: no files found matching '*.txt' 10:55:12 INFO - no previously-included directories found matching 'build' 10:55:12 INFO - no previously-included directories found matching 'dist' 10:55:12 INFO - no previously-included directories found matching '.git*' 10:55:12 INFO - Successfully installed jsonschema functools32 10:55:12 INFO - Cleaning up... 10:55:12 INFO - Return code: 0 10:55:12 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:55:12 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:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:12 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:55:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:12 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 0x7fc631983f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa350>, '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 0x18ab250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ab6e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954', '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:55:12 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:55:12 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:55:12 INFO - Using env: {'DISPLAY': ':0', 10:55:12 INFO - 'HOME': '/home/cltbld', 10:55:12 INFO - 'LANG': 'en_US.UTF-8', 10:55:12 INFO - 'LANGUAGE': 'en_US:en', 10:55:12 INFO - 'LOGNAME': 'cltbld', 10:55:12 INFO - 'MAIL': '/var/mail/cltbld', 10:55:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:12 INFO - 'MOZ_NO_REMOTE': '1', 10:55:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:12 INFO - 'NO_EM_RESTART': '1', 10:55:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:55:12 INFO - 'PWD': '/builds/slave/test-pgo', 10:55:12 INFO - 'SHELL': '/bin/bash', 10:55:12 INFO - 'SHLVL': '1', 10:55:12 INFO - 'TERM': 'linux', 10:55:12 INFO - 'TMOUT': '86400', 10:55:12 INFO - 'USER': 'cltbld', 10:55:12 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954', 10:55:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:12 INFO - '_': '/tools/buildbot/bin/python'} 10:55:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:12 INFO - Downloading/unpacking flake8 10:55: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:55: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:55: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:55: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:55: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:55: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:55:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:55:14 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:55:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:55: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:55: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:55: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:55: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:55: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:55: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:55:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:55:14 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:55:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:55: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:55: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:55: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:55: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:55: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:55: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:55:14 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:55:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:55: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:55: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:55: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:55: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:55: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:55: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:55:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:55:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:55:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:55:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:55:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:55:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:55:15 INFO - no previously-included directories found matching 'docs/_build' 10:55:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:55:15 INFO - Running setup.py install for pep8 10:55:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:55:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:55:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:55:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:55:15 INFO - no previously-included directories found matching 'docs/_build' 10:55:15 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:55:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:55:15 INFO - Cleaning up... 10:55:15 INFO - Return code: 0 10:55:15 INFO - Running post-action listener: _resource_record_post_action 10:55:15 INFO - Running post-action listener: _start_resource_monitoring 10:55:15 INFO - Starting resource monitoring. 10:55:15 INFO - ##### 10:55:15 INFO - ##### Running install step. 10:55:15 INFO - ##### 10:55:15 INFO - Running pre-action listener: _resource_record_pre_action 10:55:15 INFO - Running main action method: install 10:55:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:55:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:55:15 INFO - Reading from file tmpfile_stdout 10:55:15 INFO - Detecting whether we're running mozinstall >=1.0... 10:55:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:55:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:55:15 INFO - Reading from file tmpfile_stdout 10:55:15 INFO - Output received: 10:55:15 INFO - Usage: mozinstall [options] installer 10:55:15 INFO - Options: 10:55:15 INFO - -h, --help show this help message and exit 10:55:15 INFO - -d DEST, --destination=DEST 10:55:15 INFO - Directory to install application into. [default: 10:55:15 INFO - "/builds/slave/test-pgo"] 10:55:15 INFO - --app=APP Application being installed. [default: firefox] 10:55:15 INFO - mkdir: /builds/slave/test-pgo/build/application 10:55:15 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:55:15 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:55:31 INFO - Reading from file tmpfile_stdout 10:55:31 INFO - Output received: 10:55:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:55:31 INFO - Running post-action listener: _resource_record_post_action 10:55:31 INFO - ##### 10:55:31 INFO - ##### Running run-tests step. 10:55:31 INFO - ##### 10:55:31 INFO - Running pre-action listener: _resource_record_pre_action 10:55:31 INFO - Running main action method: run_tests 10:55:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:55:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:55:31 INFO - Python 2.7.3 10:55:31 INFO - Return code: 0 10:55:31 INFO - grabbing minidump binary from tooltool 10:55:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:31 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 0x18aa350>, '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 0x18ab250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ab6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:55:31 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:55:31 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:55:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:55:31 INFO - Return code: 0 10:55:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:55:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:55:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:55:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:55:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:55:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:55:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:55:32 INFO - Return code: 0 10:55:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 10:55:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost 10:55:32 INFO - Using env: {'DISPLAY': ':0', 10:55:32 INFO - 'HOME': '/home/cltbld', 10:55:32 INFO - 'LANG': 'en_US.UTF-8', 10:55:32 INFO - 'LANGUAGE': 'en_US:en', 10:55:32 INFO - 'LOGNAME': 'cltbld', 10:55:32 INFO - 'MAIL': '/var/mail/cltbld', 10:55:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:55:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:32 INFO - 'MOZ_NO_REMOTE': '1', 10:55:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:55:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:32 INFO - 'NO_EM_RESTART': '1', 10:55:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:55:32 INFO - 'PWD': '/builds/slave/test-pgo', 10:55:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:55:32 INFO - 'SHELL': '/bin/bash', 10:55:32 INFO - 'SHLVL': '1', 10:55:32 INFO - 'TERM': 'linux', 10:55:32 INFO - 'TMOUT': '86400', 10:55:32 INFO - 'USER': 'cltbld', 10:55:32 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954', 10:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:32 INFO - '_': '/tools/buildbot/bin/python'} 10:55:32 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost'] with output_timeout 3600 10:55:32 INFO - mozversion INFO | application_buildid: 20151218083043 10:55:32 INFO - mozversion INFO | application_changeset: 7f7cfa4a5383938abc471c22895bf96ceecba4cd 10:55:32 INFO - mozversion INFO | application_display_name: Nightly 10:55:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:55:32 INFO - mozversion INFO | application_name: Firefox 10:55:32 INFO - mozversion INFO | application_remotingname: firefox 10:55:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 10:55:32 INFO - mozversion INFO | application_vendor: Mozilla 10:55:32 INFO - mozversion INFO | application_version: 46.0a1 10:55:32 INFO - mozversion INFO | platform_buildid: 20151218083043 10:55:32 INFO - mozversion INFO | platform_changeset: 7f7cfa4a5383938abc471c22895bf96ceecba4cd 10:55:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 10:55:32 INFO - mozversion INFO | platform_version: 46.0a1 10:55:32 INFO - 2015-12-18 10:55:32,550 DEBUG : using testdate: 1450464932 10:55:32 INFO - 2015-12-18 10:55:32,550 DEBUG : actual date: 1450464932 10:55:32 INFO - 2015-12-18 10:55:32,628 INFO : starting webserver on 'localhost:55201' 10:55:32 INFO - 2015-12-18 10:55:32,629 INFO : Starting test suite talos-linux64-ix-068 10:55:32 INFO - 2015-12-18 10:55:32,629 INFO : Starting test dromaeo_css 10:55:32 INFO - 2015-12-18 10:55:32,629 DEBUG : operating with platform_type : linux_ 10:55:32 INFO - 2015-12-18 10:55:32,630 INFO : Initialising browser for dromaeo_css test... 10:55:32 INFO - 2015-12-18 10:55:32,647 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYSLKss/profile http://localhost:55201/getInfo.html 10:55:36 INFO - 2015-12-18 10:55:36,732 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:55:36 INFO - 2015-12-18 10:55:36,732 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:55:36 INFO - 2015-12-18 10:55:36,732 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:55:36 INFO - 2015-12-18 10:55:36,732 DEBUG : BROWSER_OUTPUT: __metrics 10:55:36 INFO - 2015-12-18 10:55:36,841 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:55:36 INFO - 2015-12-18 10:55:36,897 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:55:37 INFO - 2015-12-18 10:55:37,668 INFO : Browser initialized. 10:55:37 INFO - 2015-12-18 10:55:37,668 INFO : Running cycle 1/1 for dromaeo_css test... 10:55:37 INFO - 2015-12-18 10:55:37,668 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYSLKss/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:55:49 INFO - 2015-12-18 10:55:49,514 DEBUG : BROWSER_OUTPUT: RSS: Main: 149671936 10:55:49 INFO - 2015-12-18 10:55:49,515 DEBUG : BROWSER_OUTPUT: 10:56:40 INFO - 2015-12-18 10:56:40,227 DEBUG : BROWSER_OUTPUT: 1450465000224 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:58:49 INFO - 2015-12-18 10:58:49,780 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55201/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55201/tests/dromaeo/cssquery-ext.html) 10:58:50 INFO - 2015-12-18 10:58:50,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 254418944 10:58:50 INFO - 2015-12-18 10:58:50,825 DEBUG : BROWSER_OUTPUT: 11:01:53 INFO - 2015-12-18 11:01:53,265 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55201/tests/dromaeo/cssquery-ext.html (next: http://localhost:55201/tests/dromaeo/cssquery-jquery.html) 11:01:53 INFO - 2015-12-18 11:01:53,830 DEBUG : BROWSER_OUTPUT: RSS: Main: 227192832 11:01:53 INFO - 2015-12-18 11:01:53,830 DEBUG : BROWSER_OUTPUT: 11:04:55 INFO - 2015-12-18 11:04:55,770 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55201/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55201/tests/dromaeo/cssquery-mootools.html) 11:04:56 INFO - 2015-12-18 11:04:56,343 DEBUG : BROWSER_OUTPUT: RSS: Main: 220958720 11:04:56 INFO - 2015-12-18 11:04:56,343 DEBUG : BROWSER_OUTPUT: 11:07:58 INFO - 2015-12-18 11:07:58,140 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55201/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55201/tests/dromaeo/cssquery-prototype.html) 11:07:58 INFO - 2015-12-18 11:07:58,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 207835136 11:07:58 INFO - 2015-12-18 11:07:58,722 DEBUG : BROWSER_OUTPUT: 11:11:01 INFO - 2015-12-18 11:11:01,110 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55201/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55201/tests/dromaeo/cssquery-yui.html) 11:11:01 INFO - 2015-12-18 11:11:01,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 211787776 11:11:01 INFO - 2015-12-18 11:11:01,696 DEBUG : BROWSER_OUTPUT: 11:14:04 INFO - 2015-12-18 11:14:04,200 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55201/tests/dromaeo/cssquery-yui.html (next: http://localhost:55201/tests/dromaeo/cssquery-dojo.html) 11:14:04 INFO - 2015-12-18 11:14:04,450 DEBUG : BROWSER_OUTPUT: RSS: Main: 279568384 11:14:04 INFO - 2015-12-18 11:14:04,450 DEBUG : BROWSER_OUTPUT: 11:14:04 INFO - 2015-12-18 11:14:04,450 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:14:04 INFO - 2015-12-18 11:14:04,450 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:14:04 INFO - 2015-12-18 11:14:04,450 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:14:04 INFO - 2015-12-18 11:14:04,450 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:14:04 INFO - 2015-12-18 11:14:04,450 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3068.846557672116;3167.4298626247264;3216.2763378239883;3218.871245150194;3236.611606607207;5150.1759718445055;5232.843014709565;5267.604929630279;5302.628815982878;5317.202419637051;5127.7692503837325;5131.743412829363;5188.844334669957;5191.377034755825;5195.714235717034;4765.094632019923;4864.100141473821;4872.3422337984275;4877.146499362615;4930.580900623451;4899.534544218312;4916.213405855064;4931.43288521821;4984.975075124619;4988.32657591226;4682.859514214579;4687.906241875144;4796.2326027835725;4803.495632958524;4816.783244753994;4857.6599638025355;4866.7079975201605;4873.147199240118;4893.559579637814;4909.140900342426;4847.2002119650215;4848.442429120661;4848.927266091011;4853.878653033702;4908.43552991407;5023.874403139951;5109.6167787415725;5112.642115051948;5189.7405129743365;5211.322528071364;5645.802396916089;5664.575156863251;5666.575006874501;5672.205891175238;5680.659160450345;5549.1676248562635;5682.488576028178;5704.3154821421695;5704.3154821421695;5706.914396284059;5266.052110620125;5323.121684921984;5329.893402131975;5340.759665815048;5365.168398898177;5803.82588522345;5830.533557315404;5831.3877042910735;5831.708414579254;5840.474357307778;5404.675719456845;5626.071698169838;5638.097904335286;5638.774449021993;5641.407652196543;5546.861328466821;5622.971885140548;5658.405867383948;5677.261955945701;5711.343195532484;5587.1339942309005;5597;5599.32808063035;5635.971820140873;5732.455416735404;5578.386377498472;5582.8325150245555;5583.609147359727;5597.272354593877;5598.188262701967;4237.173751118564;4317.41714868495;4318.719283246579;4334.934975975363;4386.385905973167;3821.4458903458844;3865.8646947356706;3937.92124157521;3947.5262968443394;3982.6415622594104;5347.625666203407;5378.300820893337;5387.568994480433;5391.029614669319;5392.838214853561;5702.51528620072;5716.314042314949;5722.399148089391;5722.799702010493;5730.34101078373;5156.071907056691;5267.9736601316745;5312.73436328182;5312.92030619541;5419.430959749169;4813.663043586916;4817.27740838877;4839.467658557556;4852.441969173519;4907.288443175719;5637.577181711388;5681.659100453986;5703.144528320785;5703.515201207943;5726.856828579235;5547.805826796042;5605.467480589337;5640.5769567281795;5745.023346031101;5749.310082789924;5771.68255745938;5777.959967205943;5783.16144159103;5784;5793.04414771558;5657.971710141423;5666;5666.065099258576;5687.0616348302065;5690.601657883908;5387.380451248;5567.220589117608;5583.385827558884;5703.857403564944;5753.223314852441;5609.971950140223;5622.971885140548;5629.662220266797;5650;5659.773609055592;5556.416576259435;5596.972015139898;5600.4959553640365;5605.131204663284;5626.43735626434;5279.656822306538;5341.225522299323;5368.8389348319615;5382.30030096085;5535.806246781343;5605;5633.0987042073075;5634.070378387521;5634.323881134126;5664.575156863334;5503.091989821634;5505.504504594605;5506.284183056177;5510.752016159363;5513.972430137824 11:14:04 INFO - 2015-12-18 11:14:04,451 DEBUG : BROWSER_OUTPUT: |1;ext.html;541.2125357604683;570.8601392658799;576.7981206577698;582.4495851420406;585.1836687820488;27444.313892152706;28057.158285251426;28091.719082809166;28133.577996330045;28160.718392816067;39463.802680986555;39607.60392396075;39712.20575588487;39850.80074599623;39865.40201896974;8745.256653184488;8877.245434138105;8900.243479304267;8901.688440904569;8908.376413651047;7717.575533345664;7887.8422431551335;8637.870431943526;8814.823703525926;10531.26281160319;10303.690889273334;10351.482425878714;10357.637482688107;10363;10407.739806504822;10378.688639340831;10489.475526223658;10496.370217786956;10499.055085042382;10505;10187.286889917634;10362.533685984148;10363.274570780048;10369.688909332657;10372.94813525935;40044.79977600093;40066.399004014966;40196;40366.79816600928;40403.59596404028;3330.7501937354555;3369.545111409953;3465.497502862096;3857.1357508829474;3970.086880017612;30479.39041219163;31245.687543124506;31436.842815785774;32018.359632807445;34105.488417673754;3887.688984881203;3999.5400528939253;4096.344584866407;4117.279476091702;4197.118605092935;242511;247433;247852;248216;248297;56655.43344566584;57695.42304576901;63269;64045;64068.83552569161;70457.6477117611;71402.64298678473;71636.06001669959;71747.2825271751;71790.2820971794;15691.607709807118;15694.215289235493;15813.209339532978;15824.68350632981;15833.366665333258;10721.892781072089;10758.46207689628;10821.242513024014;11921.70195745096;12366.134370593973;21387.67918481224;21678.674819877713;21771.782282177293;21774.237901673365;21780.891095544423;8477.788055298544;8599.312055035582;8659.307255419677;8662.740117796477;8671.696490622799;867.1805144138729;918.8529835226332;954.8472244440856;957.2103015012642;1075.7310672331917;27352.45295094087;27735.445291094467;30927.381452370828;31357.372852543278;31594.368112637618;988.9862890537257;1041.3855825063097;1053.173258991703;1079.994600026995;1089.3518356577824;15728.449504267295;16139.273732681822;16250.431234906722;16344.264508097163;16520.42178523746;383099;387251;388599;389280;390306;53519.464805352225;53887;53958.460415396126;54139.729301354026;54191.72904135533;1273.3251376770327;1344.099453366247;1355.735631551838;1369.7671395862728;1369.8493165751959;26786;28262.43475130445;28367.57448638231;31174.37651246917;32102.839485802422;48541.51458485511;48973;49159.75420122877;49175.262371065175;49195.508044919094;281287;282717;282968;283030;283652;41018.58981410148;41373.172536549704;41723.7913810429;41960;45052;42368.57631423646;42558;42570;42854.142917142104;43314.133717326105;35095;35485.82257088698;35592.46611300781;35810.462843057896;36168.81915590405;35366;35733.82133089318;36018;36313.273734524635;41261.1747765037;34209;34283.142921426166;34574.82712586421;34684.65315346814;34916.47625285674;31313.68686313199;32622.184445388106;32742.672573274915;32862.17844553905;32900.835495822364;24155.275341739776;24405.489471225792;24604;24622.261332160066;24652.260432187064 11:14:04 INFO - 2015-12-18 11:14:04,453 DEBUG : BROWSER_OUTPUT: |2;jquery.html;354.5249365849761;355.0013424420515;356.3710051758646;357.1090130125336;360.5655185501471;13659.863401365983;13900.304984750748;16422.42521511746;17699.469015929528;19016.144273507707;14664.413423463075;16243.350265989346;16469.83530164698;17282.30870765168;17323;5396.622236443441;5398.73006349681;5528.281323427969;5534.114541673333;5535.25274087997;3991.181807729423;4068.6338229559333;5428.9185662215095;5484.561235101202;5913.083472061816;5935.080062590284;5985.311689155737;5997.61015533991;5999.760009599632;6012.458878700916;5893.764249430018;6078.39216078393;6088.786892458743;6096.878062438771;6098.512119030489;5284.154535274338;5302.44324345942;5304.734763261821;5310.92033619496;5315.335583052119;19813.10841012158;19989.700154497696;20121.893295868722;20158.49603759903;20452.590948180954;1915.8946257955806;1995.7704863940542;2095.738032745907;2137.9037943292587;2223.9555208895895;9053.411528250643;9452.291078169095;9481.573329200133;12007.519699212022;13024.609261722164;1847.261095561786;1851.9074046297767;1861.2275905499203;1877.6244751049844;1892.9905350473298;58821;61059;61213;61435.999999999556;61660.38339616591;9989.100980911608;10076.647317343857;10154.54304556282;10168.440735759605;10220.437875916896;13241;13352.866471335163;13356.398962046536;13358.866411335957;13377;7471.476996610185;7615.200403957505;7632.885506717404;7643.770686879402;7677.884831727529;7455.2172021938;7465.626718664045;7479.813004674927;7537.585432801139;7545.434092443089;4285.5928686774705;4314.676399270067;4348.652107831366;4364.650827933758;4378.10248898975;1709.3419033672126;1718.6304944436756;1752.807191208966;1763.453329467869;1776.5292197567655;837.3259526081563;892.7589550821242;914.6890057380523;919.1543779722671;1014.5688082564881;15593;16364.83635163657;16649.33402663904;16686.415975441043;16760.1619919006;766.8542976834495;816.6447595295947;885.0618344554792;886.6985225023394;889.9199072083544;8517.190866867637;8778.341624378198;8818.338624603051;8836.293096552261;8844.248238899638;542979;543502;544791;551860;552991;72511;74968.62515687387;75950.62024689841;76810.6159469199;76835.23164768392;481.13636023338194;490.02729581780136;490.70312460961316;490.75707524774754;493.4941684773136;10171.542280597243;10215.897841021791;10394.168466522811;10455.902130276516;10523.263371563917;35048.47427288644;35767.64232357747;36266.456003159445;36652;36915.81542092272;46977.76511117422;48532.5146748528;48834.755826220644;49948.250776237655;53220.20169697535;9290.16388525036;9323.580438880132;9339;9385.812283754423;9582.185514231369;10799.892001080203;10830.566777328819;10843.078338341329;10911;11078.667639970814;14162.645933851323;14331;14409.78385324242;14626.341814618156;14664.266786660837;12242.143049986415;12395.62813115608;14324.641883952985;14444.205568693822;14448.205348705502;14250.144991300554;14376.137431754129;14570.41718331255;14798.926005370335;14968.251587420367;9342.673006444742;9583.377080489747;9731.610735570497;9893.060159284856;9899.505024748878;9824.901750982684;9942.353747006422;9942.453165075991;13072.215667060007;14425.42298308056 11:14:04 INFO - 2015-12-18 11:14:04,456 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1417.333853089048;1486;1550.58909389012;1600.4478454933044;1757.648470305939;6979.057827193334;7521.924780752198;7697.307242348187;7699.961500192505;7718.575478348688;7257.3831224345995;7401.8149546261375;7405.259474052592;7407.444441666883;7408.962955185217;2193.2762188477805;2218.5008373116;2229.1974889039934;2231.665250212473;2234.72065991751;2217.966730499044;2255.1994042115057;2279.282026161762;2280.1563421534056;2285.3486756274465;2158.5359147783224;2200.8239340852692;2209.4365936686204;2214.6013717530836;2226.944326391837;2155.148716257085;2196.8132708719777;2197.3298144066134;2201.9559608807813;2227.387468446174;2197.8681279123143;2217.523232505019;2220;2220.8334374921947;2221.711177546925;7554.093508778927;7556.886646700304;7606.277403646644;7624.313811756913;7632.580208088553;4535.705179163344;4606.0097079128145;4610.515895830957;4640.814367425299;4660;3044.558539011853;3152.653208147102;3178.8569514371907;3207.550942868;3212.518122281653;961.2694352292239;961.7691753978995;968.4092703450889;995.4525011243787;996.3324572536418;10659.733506662396;10664.573417063308;10733.302335348177;10789.62236321725;10823.29648572848;4039.3738970459626;4047.777372244496;4074.7555146691293;4099.364598487239;4104.979475102606;9221.861672074925;9229.077092290718;9229.53852307382;9230.076992300716;9236.26109911219;4614.561616646413;4645.883852903637;4651.67438279324;4652.023075154188;4656.254999200111;3762.5861155272896;3768.7361884668358;4069.959300406958;4222.134462435193;4240.1307731914885;3531.9293614127573;3535.045537704805;3541.9291614167573;3555.5555555555557;3582.158192824684;1114.5597488991802;1132.1282612388416;1138.4421633399575;1140.2474366917795;1148.9138314626437;988.2242439684957;1011.2718842433436;1012.089119792193;1120.8654961404684;1326.5688651188402;7372.152202496782;7452.664630091551;7463.14173870001;7484.513506622052;7487.550746955091;473.76311844077964;482.35364611420863;482.55363788495504;483.59136529632406;485.82267472373036;5678.574106941914;5717.942820571741;5751.338596061423;5756.971215143982;5763.682997435098;9006.234470070118;9265.490398028038;9309.115634014757;9323.487208203615;9450.33847630673;9314.580843862042;9331.766705832408;9344.672936447192;9354.345195836226;9370.812583748424;7019.438444924496;7170.067891174114;7391.15001774792;7410.258974102547;7419.888701669479;7318.926810731825;7331.083614548182;7422.1835598085245;7441.1070671519765;7449.180590134973;8220.753377398449;8379.664813407639;8412.284955778583;8413.70552030676;8548.91451085506;8537.829243414973;8567.957160214408;8569.357298202534;8667.609957551798;8687.956560217159;6158.507319414526;6285.842853928689;6288.748450061947;6912.239653637996;7032.4022458089585;7354.080739907512;7564.962175189089;7609.505382150142;7611.65747541373;7614.200508946702;6854.485913556603;7164.355208031302;7213.350798428167;7281.963590182015;7312.890306645511;7077.5399599025895;7088.113985751781;7152.356287934111;7174.031505746658;7178;6860.931390686029;6976.790696279119;6985.79042628722;6990.09128813251;7000.719971201095;6520.021996700533;6566.080748695091;6570;6571.277159512545;6576.638284894186;6425.261094973951;6478.319776423407;6536.379043990813;6561.3438656134;6563.704633291418 11:14:04 INFO - 2015-12-18 11:14:04,456 DEBUG : BROWSER_OUTPUT: |4;prototype.html;323.6278279978025;326.3538194375137;327.2163169209744;333.17206741248003;333.2751265996459;5733.426657334265;5734.225879506271;5750.19497270382;5763.9135412968835;5797.913031304533;5669.603127781057;5670.206171136044;5732.828015159542;5735.627184233022;5744.597878148531;4388.670849686287;4443.511213766483;4450.399196108517;4451.020775429401;4451.688381813275;4314.417553630266;4420.381146639473;4427.867163985085;4447.0661161156195;4464.3303504474425;4300.655947524207;4363.105563359503;4382.561743825608;4399.802008909591;4400.1419723153995;4209.831606735727;4300.763458009808;4308.655307575402;4331.306990881475;4336.132773445323;3742.6257374262354;3767.5478942526797;3853.325668008087;3860;3863.3239183142837;5418.756155972951;5432.483914028161;5476.479734425223;5494.780208791643;5501.339839219279;4874.366332376804;4997.750112494397;5096.464871188546;5099.745012749348;5104.3619547556555;5957.702114894238;6033.577649564532;6037.667928263943;6041.516678665696;6051.969740151315;4240.215560121356;4243.893902652428;4246.723962942398;4248.235317642823;4250.596193361625;6244.219472565929;6302.401271879165;6330.4619107375465;6336.429721325103;6339.904901426482;4165.375193720966;4341.934870976875;4346.521882592912;4348.369486424451;4359.476862776487;4393.626541743924;4397.692161548661;4398.494173170063;4400.383946247528;4400.44994375703;5070.315507406527;5074.847754567369;5080.796768129233;5081.771320290596;5086.160783470686;6039.335673075958;6122.755089796358;6127;6133.785317513865;6136.570440069152;1519.3998370643533;1551.1701239836634;1551.2166355990378;1552.1695892697353;1554.945576904803;1015.4770293298957;1022.2537547590152;1030.7680771826278;1035.2132379391717;1040.1366865501616;5912.556558258148;5920.082387229986;5937.050071988461;5943.167956486095;5944.7027648617395;6324.988001919671;6326;6328.525360597973;6328.8417789554705;6337.588056776295;5912;5924.644521328734;5924.940750592526;5927;5929.4070592941225;3332.5667663204113;3427.2974040321674;3427.9485807712904;3429.4855771634457;3436.037909385376;6350.714217860207;6382.808515744442;6397.168368112116;6400.295967443578;6400.935990640127;6371.458426033839;6379.936200638027;6416.711247993851;6460.741570337228;6477.125588045554;5977.820665380045;6064.605800623033;6283.151774510474;6382.329855365213;6404;6322.399372059647;6373.74505019794;6392.922300252343;6394.904076438764;6396.48828093742;6335.1447554579545;6341.112244285896;6345.714442850175;6346.540295731915;6346.587471814318;6322.146510221061;6434.967825160844;6447.548671592944;6452.161219041494;6464.676766161579;4312.525622181494;4313.590208930146;4372.6501879850175;4374.431323927869;4377.0808130293;6281.968590157203;6283.528735344776;6285.182926219562;6312.747490100344;6389.297177310399;6061.333253342041;6220.533459990428;6220.7511699531515;6221.9377806223165;6225.657588832658;6196.876062478816;6222.16000839899;6226.533010024175;6228.844278892882;6231.719572619334;6119.938800611937;6123.112148738497;6124;6127.816165515042;6130.816075517741;6177.652017333891;6220.782272620437;6265.937340626718;6270.122182894307;6271.184745982993;6081.939180608138;6088.817335479943;6091.725872335667;6096.1465394845645;6097.603655762361 11:14:04 INFO - 2015-12-18 11:14:04,457 DEBUG : BROWSER_OUTPUT: |5;yui.html;743.331002098112;746.9850602987942;755.3768141283442;764.5259938837921;816.3224523645375;13438.798418023725;13794.862051379483;13828.999999999975;13837.51568695096;13858.37637306321;13173.077884548085;13213.801792973112;13224.27266500342;13232.867671323284;13240.205587664746;685.8731134740065;698.0541366448465;803.2971150243537;819.6229734322219;827.4952279109768;823.2056065896409;823.3043078598574;830.0703212402088;830.0703212402088;830.3232865214861;715.3061530315586;863.2144748279068;863.9265662418702;863.9438436501607;868.1405408645459;720.3552820225894;832.3466079127886;837.4305472278847;846.445578146309;850.974470765878;617.8609812792131;618.4835662222005;627.7896904536985;628.6605233174081;629.0878226571444;12668;12749.936250318782;12839.1012629116;12879.935600322033;13004.674883127904;11917.702057448632;11967.222130561486;12069.879301207051;12364.258144511357;12499.250044997329;10109.191264698806;10135.594576216943;10160.390376577356;10166.186705063577;10222.437765922872;3650.142216579102;3686.981565092184;3690.1143725505954;3690.7970061646597;3702.352088384549;45864.3120353195;45995.31007034897;46831.48480494731;46871.29693054607;47174.764126179834;9707.369021013612;9841.753956151011;9949.900500995042;9969.900300997042;10208.2343824212;18670.906645466686;18691.15889784963;18697.25210991545;18714.344997925007;18740.437786866416;7742.806429839186;7802.68789248435;7807.882881756778;7833.529988200727;7950.562719050507;4331.848385306499;4361.869143925687;4395.428594282723;4397.964840038051;4478.507364189936;2988.417258634589;3013.789034767545;3026.969730302713;3027.712367325101;3037.1951432870305;546.4671944853815;551.2668151358683;552.1469329885336;552.3068548971096;553.5709824885665;508.8269988204028;600.3186383454811;653.1280740211776;663.8439966607843;684.3737979748474;7737.651805668758;7891.131975482693;8975.551222438851;9272.768180795534;9410.95294523523;516.3055690096888;535.1945322289929;598.4823127994254;689.6207086102623;706.5901776969346;3689.2990331836863;3756.718246131551;3776.4335349697767;3979.403089536535;4053.5541090480024;53044.734776326644;54241;54377.72811135919;54780.17829732557;56574.43425565774;46527.76736116366;46599.76700116478;46857.06285874263;47323.05353892903;47413;44283.55716442859;44868.26975953568;45562.772186138856;45811.54188458139;46282.537174627825;8083.434159608771;8454.323654107533;8838.204561589231;8904.777380565538;9036.23192028685;34867.65132348644;34942.825285873405;35773.46339804957;35790.494665374215;35876.8206158978;42057.78971105125;44906.326405104606;46217.76891115657;46878.53121468741;48555.757221213666;10819.837702434312;10822.783544328911;10828.675139745821;10857.511411986321;11016.449177541252;12350.505979760708;12587.118901676795;12608.558700445441;12666.43001064936;13050.890674292792;9971.501424928869;10289.43408112561;10296.536655850356;10323.63867264642;10391.428471433841;11348.602798901999;11445.313281203154;11646.359450230319;11752.11859110553;12064.396780160781;10646.20153488507;11024.173187010845;11062.944685276521;11282.379469129277;11283.097352211638;9431.858522122311;9569.665061722806;9646.228301735704;9750.707478775648;9898.10917017472;8441.357253510667;8841.911580884109;8921.197092261727;9309.953450232706;9352.953235234052 11:14:04 INFO - 2015-12-18 11:14:04,457 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:14:04 INFO - 2015-12-18 11:14:04,457 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:14:04 INFO - 2015-12-18 11:14:04,458 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,824 11:14:04 INFO - 2015-12-18 11:14:04,458 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:14:04 INFO - 2015-12-18 11:14:04,458 DEBUG : BROWSER_OUTPUT: __startTimestamp1450466044449__endTimestamp 11:14:04 INFO - 2015-12-18 11:14:04,458 DEBUG : BROWSER_OUTPUT: 11:14:04 INFO - 2015-12-18 11:14:04,458 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:14:04 INFO - 2015-12-18 11:14:04,458 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:14:04 INFO - 2015-12-18 11:14:04,458 DEBUG : BROWSER_OUTPUT: 11:14:04 INFO - 2015-12-18 11:14:04,458 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5260.69 Median:5505.50 stddev:575.96 (10.5%) stddev-sans-first:551.47 11:14:04 INFO - 2015-12-18 11:14:04,458 DEBUG : BROWSER_OUTPUT: Values: 3068.8 3167.4 3216.3 3218.9 3236.6 5150.2 5232.8 5267.6 5302.6 5317.2 5127.8 5131.7 5188.8 5191.4 5195.7 4765.1 4864.1 4872.3 4877.1 4930.6 4899.5 4916.2 4931.4 4985.0 4988.3 4682.9 4687.9 4796.2 4803.5 4816.8 4857.7 4866.7 4873.1 4893.6 4909.1 4847.2 4848.4 4848.9 4853.9 4908.4 5023.9 5109.6 5112.6 5189.7 5211.3 5645.8 5664.6 5666.6 5672.2 5680.7 5549.2 5682.5 5704.3 5704.3 5706.9 5266.1 5323.1 5329.9 5340.8 5365.2 5803.8 5830.5 5831.4 5831.7 5840.5 5404.7 5626.1 5638.1 5638.8 5641.4 5546.9 5623.0 5658.4 5677.3 5711.3 5587.1 5597.0 5599.3 5636.0 5732.5 5578.4 5582.8 5583.6 5597.3 5598.2 4237.2 4317.4 4318.7 4334.9 4386.4 3821.4 3865.9 3937.9 3947.5 3982.6 5347.6 5378.3 5387.6 5391.0 5392.8 5702.5 5716.3 5722.4 5722.8 5730.3 5156.1 5268.0 5312.7 5312.9 5419.4 4813.7 4817.3 4839.5 4852.4 4907.3 5637.6 5681.7 5703.1 5703.5 5726.9 5547.8 5605.5 5640.6 5745.0 5749.3 5771.7 5778.0 5783.2 5784.0 5793.0 5658.0 5666.0 5666.1 5687.1 5690.6 5387.4 5567.2 5583.4 5703.9 5753.2 5610.0 5623.0 5629.7 5650.0 5659.8 5556.4 5597.0 5600.5 5605.1 5626.4 5279.7 5341.2 5368.8 5382.3 5535.8 5605.0 5633.1 5634.1 5634.3 5664.6 5503.1 5505.5 5506.3 5510.8 5514.0 11:14:04 INFO - 2015-12-18 11:14:04,458 DEBUG : BROWSER_OUTPUT: 11:14:04 INFO - 2015-12-18 11:14:04,459 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48183.97 Median:19020.16 stddev:81762.83 (429.9%) stddev-sans-first:81913.95 11:14:04 INFO - 2015-12-18 11:14:04,460 DEBUG : BROWSER_OUTPUT: Values: 541.2 570.9 576.8 582.4 585.2 27444.3 28057.2 28091.7 28133.6 28160.7 39463.8 39607.6 39712.2 39850.8 39865.4 8745.3 8877.2 8900.2 8901.7 8908.4 7717.6 7887.8 8637.9 8814.8 10531.3 10303.7 10351.5 10357.6 10363.0 10407.7 10378.7 10489.5 10496.4 10499.1 10505.0 10187.3 10362.5 10363.3 10369.7 10372.9 40044.8 40066.4 40196.0 40366.8 40403.6 3330.8 3369.5 3465.5 3857.1 3970.1 30479.4 31245.7 31436.8 32018.4 34105.5 3887.7 3999.5 4096.3 4117.3 4197.1 242511.0 247433.0 247852.0 248216.0 248297.0 56655.4 57695.4 63269.0 64045.0 64068.8 70457.6 71402.6 71636.1 71747.3 71790.3 15691.6 15694.2 15813.2 15824.7 15833.4 10721.9 10758.5 10821.2 11921.7 12366.1 21387.7 21678.7 21771.8 21774.2 21780.9 8477.8 8599.3 8659.3 8662.7 8671.7 867.2 918.9 954.8 957.2 1075.7 27352.5 27735.4 30927.4 31357.4 31594.4 989.0 1041.4 1053.2 1080.0 1089.4 15728.4 16139.3 16250.4 16344.3 16520.4 383099.0 387251.0 388599.0 389280.0 390306.0 53519.5 53887.0 53958.5 54139.7 54191.7 1273.3 1344.1 1355.7 1369.8 1369.8 26786.0 28262.4 28367.6 31174.4 32102.8 48541.5 48973.0 49159.8 49175.3 49195.5 281287.0 282717.0 282968.0 283030.0 283652.0 41018.6 41373.2 41723.8 41960.0 45052.0 42368.6 42558.0 42570.0 42854.1 43314.1 35095.0 35485.8 35592.5 35810.5 36168.8 35366.0 35733.8 36018.0 36313.3 41261.2 34209.0 34283.1 34574.8 34684.7 34916.5 31313.7 32622.2 32742.7 32862.2 32900.8 24155.3 24405.5 24604.0 24622.3 24652.3 11:14:04 INFO - 2015-12-18 11:14:04,460 DEBUG : BROWSER_OUTPUT: 11:14:04 INFO - 2015-12-18 11:14:04,460 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28635.68 Median:25677.93 stddev:89417.38 (348.2%) stddev-sans-first:89643.00 11:14:04 INFO - 2015-12-18 11:14:04,460 DEBUG : BROWSER_OUTPUT: Values: 354.5 355.0 356.4 357.1 360.6 13659.9 13900.3 16422.4 17699.5 19016.1 14664.4 16243.4 16469.8 17282.3 17323.0 5396.6 5398.7 5528.3 5534.1 5535.3 3991.2 4068.6 5428.9 5484.6 5913.1 5935.1 5985.3 5997.6 5999.8 6012.5 5893.8 6078.4 6088.8 6096.9 6098.5 5284.2 5302.4 5304.7 5310.9 5315.3 19813.1 19989.7 20121.9 20158.5 20452.6 1915.9 1995.8 2095.7 2137.9 2224.0 9053.4 9452.3 9481.6 12007.5 13024.6 1847.3 1851.9 1861.2 1877.6 1893.0 58821.0 61059.0 61213.0 61436.0 61660.4 9989.1 10076.6 10154.5 10168.4 10220.4 13241.0 13352.9 13356.4 13358.9 13377.0 7471.5 7615.2 7632.9 7643.8 7677.9 7455.2 7465.6 7479.8 7537.6 7545.4 4285.6 4314.7 4348.7 4364.7 4378.1 1709.3 1718.6 1752.8 1763.5 1776.5 837.3 892.8 914.7 919.2 1014.6 15593.0 16364.8 16649.3 16686.4 16760.2 766.9 816.6 885.1 886.7 889.9 8517.2 8778.3 8818.3 8836.3 8844.2 542979.0 543502.0 544791.0 551860.0 552991.0 72511.0 74968.6 75950.6 76810.6 76835.2 481.1 490.0 490.7 490.8 493.5 10171.5 10215.9 10394.2 10455.9 10523.3 35048.5 35767.6 36266.5 36652.0 36915.8 46977.8 48532.5 48834.8 49948.3 53220.2 9290.2 9323.6 9339.0 9385.8 9582.2 10799.9 10830.6 10843.1 10911.0 11078.7 14162.6 14331.0 14409.8 14626.3 14664.3 12242.1 12395.6 14324.6 14444.2 14448.2 14250.1 14376.1 14570.4 14798.9 14968.3 9342.7 9583.4 9731.6 9893.1 9899.5 9824.9 9942.4 9942.5 13072.2 14425.4 11:14:04 INFO - 2015-12-18 11:14:04,460 DEBUG : BROWSER_OUTPUT: 11:14:04 INFO - 2015-12-18 11:14:04,460 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5409.75 Median:6548.86 stddev:2868.54 (43.8%) stddev-sans-first:2860.89 11:14:04 INFO - 2015-12-18 11:14:04,460 DEBUG : BROWSER_OUTPUT: Values: 1417.3 1486.0 1550.6 1600.4 1757.6 6979.1 7521.9 7697.3 7700.0 7718.6 7257.4 7401.8 7405.3 7407.4 7409.0 2193.3 2218.5 2229.2 2231.7 2234.7 2218.0 2255.2 2279.3 2280.2 2285.3 2158.5 2200.8 2209.4 2214.6 2226.9 2155.1 2196.8 2197.3 2202.0 2227.4 2197.9 2217.5 2220.0 2220.8 2221.7 7554.1 7556.9 7606.3 7624.3 7632.6 4535.7 4606.0 4610.5 4640.8 4660.0 3044.6 3152.7 3178.9 3207.6 3212.5 961.3 961.8 968.4 995.5 996.3 10659.7 10664.6 10733.3 10789.6 10823.3 4039.4 4047.8 4074.8 4099.4 4105.0 9221.9 9229.1 9229.5 9230.1 9236.3 4614.6 4645.9 4651.7 4652.0 4656.3 3762.6 3768.7 4070.0 4222.1 4240.1 3531.9 3535.0 3541.9 3555.6 3582.2 1114.6 1132.1 1138.4 1140.2 1148.9 988.2 1011.3 1012.1 1120.9 1326.6 7372.2 7452.7 7463.1 7484.5 7487.6 473.8 482.4 482.6 483.6 485.8 5678.6 5717.9 5751.3 5757.0 5763.7 9006.2 9265.5 9309.1 9323.5 9450.3 9314.6 9331.8 9344.7 9354.3 9370.8 7019.4 7170.1 7391.2 7410.3 7419.9 7318.9 7331.1 7422.2 7441.1 7449.2 8220.8 8379.7 8412.3 8413.7 8548.9 8537.8 8568.0 8569.4 8667.6 8688.0 6158.5 6285.8 6288.7 6912.2 7032.4 7354.1 7565.0 7609.5 7611.7 7614.2 6854.5 7164.4 7213.4 7282.0 7312.9 7077.5 7088.1 7152.4 7174.0 7178.0 6860.9 6976.8 6985.8 6990.1 7000.7 6520.0 6566.1 6570.0 6571.3 6576.6 6425.3 6478.3 6536.4 6561.3 6563.7 11:14:04 INFO - 2015-12-18 11:14:04,460 DEBUG : BROWSER_OUTPUT: 11:14:04 INFO - 2015-12-18 11:14:04,461 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5110.69 Median:5912.28 stddev:1541.18 (26.1%) stddev-sans-first:1503.04 11:14:04 INFO - 2015-12-18 11:14:04,461 DEBUG : BROWSER_OUTPUT: Values: 323.6 326.4 327.2 333.2 333.3 5733.4 5734.2 5750.2 5763.9 5797.9 5669.6 5670.2 5732.8 5735.6 5744.6 4388.7 4443.5 4450.4 4451.0 4451.7 4314.4 4420.4 4427.9 4447.1 4464.3 4300.7 4363.1 4382.6 4399.8 4400.1 4209.8 4300.8 4308.7 4331.3 4336.1 3742.6 3767.5 3853.3 3860.0 3863.3 5418.8 5432.5 5476.5 5494.8 5501.3 4874.4 4997.8 5096.5 5099.7 5104.4 5957.7 6033.6 6037.7 6041.5 6052.0 4240.2 4243.9 4246.7 4248.2 4250.6 6244.2 6302.4 6330.5 6336.4 6339.9 4165.4 4341.9 4346.5 4348.4 4359.5 4393.6 4397.7 4398.5 4400.4 4400.4 5070.3 5074.8 5080.8 5081.8 5086.2 6039.3 6122.8 6127.0 6133.8 6136.6 1519.4 1551.2 1551.2 1552.2 1554.9 1015.5 1022.3 1030.8 1035.2 1040.1 5912.6 5920.1 5937.1 5943.2 5944.7 6325.0 6326.0 6328.5 6328.8 6337.6 5912.0 5924.6 5924.9 5927.0 5929.4 3332.6 3427.3 3427.9 3429.5 3436.0 6350.7 6382.8 6397.2 6400.3 6400.9 6371.5 6379.9 6416.7 6460.7 6477.1 5977.8 6064.6 6283.2 6382.3 6404.0 6322.4 6373.7 6392.9 6394.9 6396.5 6335.1 6341.1 6345.7 6346.5 6346.6 6322.1 6435.0 6447.5 6452.2 6464.7 4312.5 4313.6 4372.7 4374.4 4377.1 6282.0 6283.5 6285.2 6312.7 6389.3 6061.3 6220.5 6220.8 6221.9 6225.7 6196.9 6222.2 6226.5 6228.8 6231.7 6119.9 6123.1 6124.0 6127.8 6130.8 6177.7 6220.8 6265.9 6270.1 6271.2 6081.9 6088.8 6091.7 6096.1 6097.6 11:14:04 INFO - 2015-12-18 11:14:04,461 DEBUG : BROWSER_OUTPUT: 11:14:04 INFO - 2015-12-18 11:14:04,462 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13528.40 Median:46563.77 stddev:15402.14 (33.1%) stddev-sans-first:15415.43 11:14:04 INFO - 2015-12-18 11:14:04,462 DEBUG : BROWSER_OUTPUT: Values: 743.3 747.0 755.4 764.5 816.3 13438.8 13794.9 13829.0 13837.5 13858.4 13173.1 13213.8 13224.3 13232.9 13240.2 685.9 698.1 803.3 819.6 827.5 823.2 823.3 830.1 830.1 830.3 715.3 863.2 863.9 863.9 868.1 720.4 832.3 837.4 846.4 851.0 617.9 618.5 627.8 628.7 629.1 12668.0 12749.9 12839.1 12879.9 13004.7 11917.7 11967.2 12069.9 12364.3 12499.3 10109.2 10135.6 10160.4 10166.2 10222.4 3650.1 3687.0 3690.1 3690.8 3702.4 45864.3 45995.3 46831.5 46871.3 47174.8 9707.4 9841.8 9949.9 9969.9 10208.2 18670.9 18691.2 18697.3 18714.3 18740.4 7742.8 7802.7 7807.9 7833.5 7950.6 4331.8 4361.9 4395.4 4398.0 4478.5 2988.4 3013.8 3027.0 3027.7 3037.2 546.5 551.3 552.1 552.3 553.6 508.8 600.3 653.1 663.8 684.4 7737.7 7891.1 8975.6 9272.8 9411.0 516.3 535.2 598.5 689.6 706.6 3689.3 3756.7 3776.4 3979.4 4053.6 53044.7 54241.0 54377.7 54780.2 56574.4 46527.8 46599.8 46857.1 47323.1 47413.0 44283.6 44868.3 45562.8 45811.5 46282.5 8083.4 8454.3 8838.2 8904.8 9036.2 34867.7 34942.8 35773.5 35790.5 35876.8 42057.8 44906.3 46217.8 46878.5 48555.8 10819.8 10822.8 10828.7 10857.5 11016.4 12350.5 12587.1 12608.6 12666.4 13050.9 9971.5 10289.4 10296.5 10323.6 10391.4 11348.6 11445.3 11646.4 11752.1 12064.4 10646.2 11024.2 11062.9 11282.4 11283.1 9431.9 9569.7 9646.2 9750.7 9898.1 8441.4 8841.9 8921.2 9310.0 9353.0 11:14:04 INFO - 2015-12-18 11:14:04,462 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:14:04 INFO - 2015-12-18 11:14:04,462 DEBUG : BROWSER_OUTPUT: 11:14:05 INFO - 2015-12-18 11:14:05,200 INFO : Browser exited with error code: 0 11:14:05 INFO - 2015-12-18 11:14:05,219 INFO : Completed test dromaeo_css (00:18:32) 11:14:05 INFO - 2015-12-18 11:14:05,219 INFO : Starting test kraken 11:14:05 INFO - 2015-12-18 11:14:05,219 DEBUG : operating with platform_type : linux_ 11:14:05 INFO - 2015-12-18 11:14:05,219 INFO : Initialising browser for kraken test... 11:14:05 INFO - 2015-12-18 11:14:05,225 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKK7kt8/profile http://localhost:55201/getInfo.html 11:14:09 INFO - 2015-12-18 11:14:09,159 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:14:09 INFO - 2015-12-18 11:14:09,160 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:14:09 INFO - 2015-12-18 11:14:09,160 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:14:09 INFO - 2015-12-18 11:14:09,160 DEBUG : BROWSER_OUTPUT: __metrics 11:14:09 INFO - 2015-12-18 11:14:09,261 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] 11:14:09 INFO - 2015-12-18 11:14:09,321 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] 11:14:10 INFO - 2015-12-18 11:14:10,096 INFO : Browser initialized. 11:14:10 INFO - 2015-12-18 11:14:10,096 INFO : Running cycle 1/1 for kraken test... 11:14:10 INFO - 2015-12-18 11:14:10,097 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKK7kt8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:14:21 INFO - 2015-12-18 11:14:21,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 149827584 11:14:21 INFO - 2015-12-18 11:14:21,808 DEBUG : BROWSER_OUTPUT: 11:14:24 INFO - 2015-12-18 11:14:24,269 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55201/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55201/tests/kraken/driver.html?testName=audio-beat-detection) 11:14:24 INFO - 2015-12-18 11:14:24,862 DEBUG : BROWSER_OUTPUT: RSS: Main: 187035648 11:14:24 INFO - 2015-12-18 11:14:24,863 DEBUG : BROWSER_OUTPUT: 11:14:27 INFO - 2015-12-18 11:14:27,448 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55201/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55201/tests/kraken/driver.html?testName=audio-dft) 11:14:28 INFO - 2015-12-18 11:14:28,048 DEBUG : BROWSER_OUTPUT: RSS: Main: 175407104 11:14:28 INFO - 2015-12-18 11:14:28,048 DEBUG : BROWSER_OUTPUT: 11:14:30 INFO - 2015-12-18 11:14:30,947 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55201/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55201/tests/kraken/driver.html?testName=audio-fft) 11:14:31 INFO - 2015-12-18 11:14:31,508 DEBUG : BROWSER_OUTPUT: RSS: Main: 160055296 11:14:31 INFO - 2015-12-18 11:14:31,508 DEBUG : BROWSER_OUTPUT: 11:14:33 INFO - 2015-12-18 11:14:33,485 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55201/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55201/tests/kraken/driver.html?testName=audio-oscillator) 11:14:34 INFO - 2015-12-18 11:14:34,050 DEBUG : BROWSER_OUTPUT: RSS: Main: 162496512 11:14:34 INFO - 2015-12-18 11:14:34,050 DEBUG : BROWSER_OUTPUT: 11:14:36 INFO - 2015-12-18 11:14:36,242 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55201/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55201/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:14:36 INFO - 2015-12-18 11:14:36,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 165445632 11:14:36 INFO - 2015-12-18 11:14:36,808 DEBUG : BROWSER_OUTPUT: 11:14:39 INFO - 2015-12-18 11:14:39,692 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55201/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55201/tests/kraken/driver.html?testName=imaging-darkroom) 11:14:40 INFO - 2015-12-18 11:14:40,265 DEBUG : BROWSER_OUTPUT: RSS: Main: 165761024 11:14:40 INFO - 2015-12-18 11:14:40,266 DEBUG : BROWSER_OUTPUT: 11:14:43 INFO - 2015-12-18 11:14:43,617 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55201/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55201/tests/kraken/driver.html?testName=imaging-desaturate) 11:14:44 INFO - 2015-12-18 11:14:44,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 164757504 11:14:44 INFO - 2015-12-18 11:14:44,187 DEBUG : BROWSER_OUTPUT: 11:14:46 INFO - 2015-12-18 11:14:46,909 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55201/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55201/tests/kraken/driver.html?testName=json-parse-financial) 11:14:47 INFO - 2015-12-18 11:14:47,491 DEBUG : BROWSER_OUTPUT: RSS: Main: 164904960 11:14:47 INFO - 2015-12-18 11:14:47,491 DEBUG : BROWSER_OUTPUT: 11:14:49 INFO - 2015-12-18 11:14:49,060 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55201/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55201/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:14:49 INFO - 2015-12-18 11:14:49,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 173408256 11:14:49 INFO - 2015-12-18 11:14:49,621 DEBUG : BROWSER_OUTPUT: 11:14:51 INFO - 2015-12-18 11:14:51,437 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55201/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55201/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:14:52 INFO - 2015-12-18 11:14:52,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 173219840 11:14:52 INFO - 2015-12-18 11:14:52,026 DEBUG : BROWSER_OUTPUT: 11:14:54 INFO - 2015-12-18 11:14:54,083 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55201/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55201/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:14:54 INFO - 2015-12-18 11:14:54,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 186032128 11:14:54 INFO - 2015-12-18 11:14:54,653 DEBUG : BROWSER_OUTPUT: 11:14:57 INFO - 2015-12-18 11:14:57,100 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55201/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55201/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:14:57 INFO - 2015-12-18 11:14:57,681 DEBUG : BROWSER_OUTPUT: RSS: Main: 191848448 11:14:57 INFO - 2015-12-18 11:14:57,682 DEBUG : BROWSER_OUTPUT: 11:15:00 INFO - 2015-12-18 11:15:00,285 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55201/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55201/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:15:00 INFO - 2015-12-18 11:15:00,854 DEBUG : BROWSER_OUTPUT: RSS: Main: 191148032 11:15:00 INFO - 2015-12-18 11:15:00,854 DEBUG : BROWSER_OUTPUT: 11:15:02 INFO - 2015-12-18 11:15:02,527 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55201/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55201/tests/kraken/driver.html?testName=ai-astar) 11:15:02 INFO - 2015-12-18 11:15:02,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 250658816 11:15:02 INFO - 2015-12-18 11:15:02,786 DEBUG : BROWSER_OUTPUT: 11:15:02 INFO - 2015-12-18 11:15:02,786 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:15:02 INFO - 2015-12-18 11:15:02,786 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:15:02 INFO - 2015-12-18 11:15:02,786 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:15:02 INFO - 2015-12-18 11:15:02,786 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:15:02 INFO - 2015-12-18 11:15:02,786 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;105;111;109;110;99;110;109;111 11:15:02 INFO - 2015-12-18 11:15:02,786 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;160;121;145;166;124;147;147;128;166;128 11:15:02 INFO - 2015-12-18 11:15:02,786 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;164;161;161;163;161;160;163;161;162 11:15:02 INFO - 2015-12-18 11:15:02,787 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;84;92;72;77;71;107;91;71 11:15:02 INFO - 2015-12-18 11:15:02,787 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;95;136;93;93;93;141;93;93;132 11:15:02 INFO - 2015-12-18 11:15:02,787 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;110;110;110;109;109 11:15:02 INFO - 2015-12-18 11:15:02,787 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;144;145;145;145;144;145;146;145 11:15:02 INFO - 2015-12-18 11:15:02,787 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;96;95;96;96;95;95 11:15:02 INFO - 2015-12-18 11:15:02,787 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;57;61;57;58;59;60;69;55;56 11:15:02 INFO - 2015-12-18 11:15:02,787 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;66;66;67;66;67;67;66;68 11:15:02 INFO - 2015-12-18 11:15:02,787 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;83;85;83;84;83;84;84;84;85 11:15:02 INFO - 2015-12-18 11:15:02,787 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;125;129;124;120;113;116;123;119;123;119 11:15:02 INFO - 2015-12-18 11:15:02,787 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;155;157;159;152;139;151;150;163;143 11:15:02 INFO - 2015-12-18 11:15:02,788 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;67;66;67;67;68;72;66;68;66 11:15:02 INFO - 2015-12-18 11:15:02,788 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:15:02 INFO - 2015-12-18 11:15:02,788 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:15:02 INFO - 2015-12-18 11:15:02,788 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,953 11:15:02 INFO - 2015-12-18 11:15:02,788 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:15:02 INFO - 2015-12-18 11:15:02,788 DEBUG : BROWSER_OUTPUT: __startTimestamp1450466102780__endTimestamp 11:15:02 INFO - 2015-12-18 11:15:02,788 DEBUG : BROWSER_OUTPUT: 11:15:02 INFO - 2015-12-18 11:15:02,788 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:15:02 INFO - 2015-12-18 11:15:02,788 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:15:02 INFO - 2015-12-18 11:15:02,788 DEBUG : BROWSER_OUTPUT: 11:15:02 INFO - 2015-12-18 11:15:02,788 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:3.68 (3.3%) stddev-sans-first:3.90 11:15:02 INFO - 2015-12-18 11:15:02,788 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 105.0 111.0 109.0 110.0 99.0 110.0 109.0 111.0 11:15:02 INFO - 2015-12-18 11:15:02,789 DEBUG : BROWSER_OUTPUT: 11:15:02 INFO - 2015-12-18 11:15:02,789 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.20 Median:147.00 stddev:17.25 (11.7%) stddev-sans-first:17.19 11:15:02 INFO - 2015-12-18 11:15:02,789 DEBUG : BROWSER_OUTPUT: Values: 160.0 121.0 145.0 166.0 124.0 147.0 147.0 128.0 166.0 128.0 11:15:02 INFO - 2015-12-18 11:15:02,789 DEBUG : BROWSER_OUTPUT: 11:15:02 INFO - 2015-12-18 11:15:02,789 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.35 (0.8%) stddev-sans-first:1.30 11:15:02 INFO - 2015-12-18 11:15:02,789 DEBUG : BROWSER_OUTPUT: Values: 160.0 164.0 161.0 161.0 163.0 161.0 160.0 163.0 161.0 162.0 11:15:02 INFO - 2015-12-18 11:15:02,789 DEBUG : BROWSER_OUTPUT: 11:15:02 INFO - 2015-12-18 11:15:02,789 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.20 Median:75.50 stddev:12.09 (16.0%) stddev-sans-first:12.45 11:15:02 INFO - 2015-12-18 11:15:02,789 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 84.0 92.0 72.0 77.0 71.0 107.0 91.0 71.0 11:15:02 INFO - 2015-12-18 11:15:02,790 DEBUG : BROWSER_OUTPUT: 11:15:02 INFO - 2015-12-18 11:15:02,790 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.10 Median:93.00 stddev:20.98 (22.6%) stddev-sans-first:21.63 11:15:02 INFO - 2015-12-18 11:15:02,790 DEBUG : BROWSER_OUTPUT: Values: 92.0 95.0 136.0 93.0 93.0 93.0 141.0 93.0 93.0 132.0 11:15:02 INFO - 2015-12-18 11:15:02,790 DEBUG : BROWSER_OUTPUT: 11:15:02 INFO - 2015-12-18 11:15:02,790 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 11:15:02 INFO - 2015-12-18 11:15:02,790 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 110.0 110.0 110.0 109.0 109.0 11:15:02 INFO - 2015-12-18 11:15:02,790 DEBUG : BROWSER_OUTPUT: 11:15:02 INFO - 2015-12-18 11:15:02,791 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.92 (0.6%) stddev-sans-first:0.71 11:15:02 INFO - 2015-12-18 11:15:02,791 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 144.0 145.0 145.0 145.0 144.0 145.0 146.0 145.0 11:15:02 INFO - 2015-12-18 11:15:02,791 DEBUG : BROWSER_OUTPUT: 11:15:02 INFO - 2015-12-18 11:15:02,791 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 11:15:02 INFO - 2015-12-18 11:15:02,791 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 11:15:02 INFO - 2015-12-18 11:15:02,791 DEBUG : BROWSER_OUTPUT: 11:15:02 INFO - 2015-12-18 11:15:02,791 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.10 Median:59.00 stddev:3.93 (6.7%) stddev-sans-first:4.17 11:15:02 INFO - 2015-12-18 11:15:02,791 DEBUG : BROWSER_OUTPUT: Values: 59.0 57.0 61.0 57.0 58.0 59.0 60.0 69.0 55.0 56.0 11:15:02 INFO - 2015-12-18 11:15:02,791 DEBUG : BROWSER_OUTPUT: 11:15:02 INFO - 2015-12-18 11:15:02,791 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 11:15:02 INFO - 2015-12-18 11:15:02,791 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 66.0 66.0 67.0 66.0 67.0 67.0 66.0 68.0 11:15:02 INFO - 2015-12-18 11:15:02,791 DEBUG : BROWSER_OUTPUT: 11:15:02 INFO - 2015-12-18 11:15:02,791 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:0.79 (0.9%) stddev-sans-first:0.78 11:15:02 INFO - 2015-12-18 11:15:02,791 DEBUG : BROWSER_OUTPUT: Values: 83.0 83.0 85.0 83.0 84.0 83.0 84.0 84.0 84.0 85.0 11:15:02 INFO - 2015-12-18 11:15:02,791 DEBUG : BROWSER_OUTPUT: 11:15:02 INFO - 2015-12-18 11:15:02,792 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.10 Median:123.00 stddev:4.65 (3.8%) stddev-sans-first:4.72 11:15:02 INFO - 2015-12-18 11:15:02,792 DEBUG : BROWSER_OUTPUT: Values: 125.0 129.0 124.0 120.0 113.0 116.0 123.0 119.0 123.0 119.0 11:15:02 INFO - 2015-12-18 11:15:02,792 DEBUG : BROWSER_OUTPUT: 11:15:02 INFO - 2015-12-18 11:15:02,792 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.50 Median:153.50 stddev:7.40 (4.8%) stddev-sans-first:7.57 11:15:02 INFO - 2015-12-18 11:15:02,792 DEBUG : BROWSER_OUTPUT: Values: 146.0 155.0 157.0 159.0 152.0 139.0 151.0 150.0 163.0 143.0 11:15:02 INFO - 2015-12-18 11:15:02,792 DEBUG : BROWSER_OUTPUT: 11:15:02 INFO - 2015-12-18 11:15:02,792 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:1.84 (2.7%) stddev-sans-first:1.88 11:15:02 INFO - 2015-12-18 11:15:02,792 DEBUG : BROWSER_OUTPUT: Values: 69.0 67.0 66.0 67.0 67.0 68.0 72.0 66.0 68.0 66.0 11:15:02 INFO - 2015-12-18 11:15:02,792 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:15:02 INFO - 2015-12-18 11:15:02,792 DEBUG : BROWSER_OUTPUT: 11:15:03 INFO - 2015-12-18 11:15:03,596 INFO : Browser exited with error code: 0 11:15:03 INFO - 2015-12-18 11:15:03,645 INFO : Completed test kraken (00:00:58) 11:15:03 INFO - 2015-12-18 11:15:03,645 INFO : Starting test v8_7 11:15:03 INFO - 2015-12-18 11:15:03,646 DEBUG : operating with platform_type : linux_ 11:15:03 INFO - 2015-12-18 11:15:03,646 INFO : Initialising browser for v8_7 test... 11:15:03 INFO - 2015-12-18 11:15:03,652 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpen_km_/profile http://localhost:55201/getInfo.html 11:15:07 INFO - 2015-12-18 11:15:07,257 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:15:07 INFO - 2015-12-18 11:15:07,257 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:15:07 INFO - 2015-12-18 11:15:07,257 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:15:07 INFO - 2015-12-18 11:15:07,257 DEBUG : BROWSER_OUTPUT: __metrics 11:15:07 INFO - 2015-12-18 11:15:07,333 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] 11:15:07 INFO - 2015-12-18 11:15:07,389 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] 11:15:08 INFO - 2015-12-18 11:15:08,472 INFO : Browser initialized. 11:15:08 INFO - 2015-12-18 11:15:08,473 INFO : Running cycle 1/1 for v8_7 test... 11:15:08 INFO - 2015-12-18 11:15:08,473 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpen_km_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:15:20 INFO - 2015-12-18 11:15:20,256 DEBUG : BROWSER_OUTPUT: RSS: Main: 150306816 11:15:20 INFO - 2015-12-18 11:15:20,256 DEBUG : BROWSER_OUTPUT: 11:15:41 INFO - 2015-12-18 11:15:41,622 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55201/tests/v8_7/run.html (next: http://localhost:55201/tests/v8_7/run.html) 11:15:41 INFO - 2015-12-18 11:15:41,866 DEBUG : BROWSER_OUTPUT: RSS: Main: 552218624 11:15:41 INFO - 2015-12-18 11:15:41,866 DEBUG : BROWSER_OUTPUT: 11:15:41 INFO - 2015-12-18 11:15:41,868 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:15:41 INFO - 2015-12-18 11:15:41,868 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:15:41 INFO - 2015-12-18 11:15:41,868 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:15:41 INFO - 2015-12-18 11:15:41,868 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:15:41 INFO - 2015-12-18 11:15:41,868 DEBUG : BROWSER_OUTPUT: |0;Richards;165.80998176090202 11:15:41 INFO - 2015-12-18 11:15:41,868 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.43037497644622 11:15:41 INFO - 2015-12-18 11:15:41,868 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.0336040324839 11:15:41 INFO - 2015-12-18 11:15:41,869 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 11:15:41 INFO - 2015-12-18 11:15:41,869 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1109.8779134295228 11:15:41 INFO - 2015-12-18 11:15:41,869 DEBUG : BROWSER_OUTPUT: |5;Earley;785.5459544383347 11:15:41 INFO - 2015-12-18 11:15:41,869 DEBUG : BROWSER_OUTPUT: |6;Boyer;12280.487804878048 11:15:41 INFO - 2015-12-18 11:15:41,869 DEBUG : BROWSER_OUTPUT: |7;RegExp;25974.358974358973 11:15:41 INFO - 2015-12-18 11:15:41,869 DEBUG : BROWSER_OUTPUT: |8;Splay;590.318772136954 11:15:41 INFO - 2015-12-18 11:15:41,870 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 11:15:41 INFO - 2015-12-18 11:15:41,870 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:15:41 INFO - 2015-12-18 11:15:41,870 DEBUG : BROWSER_OUTPUT: __startTimestamp1450466141867__endTimestamp 11:15:41 INFO - 2015-12-18 11:15:41,870 DEBUG : BROWSER_OUTPUT: 11:15:41 INFO - 2015-12-18 11:15:41,871 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:15:41 INFO - 2015-12-18 11:15:41,871 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:15:41 INFO - 2015-12-18 11:15:41,871 DEBUG : BROWSER_OUTPUT: 11:15:41 INFO - 2015-12-18 11:15:41,871 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.81 Median:165.81 stddev:0.00 (0.0%) 11:15:41 INFO - 2015-12-18 11:15:41,871 DEBUG : BROWSER_OUTPUT: Values: 165.8 11:15:41 INFO - 2015-12-18 11:15:41,872 DEBUG : BROWSER_OUTPUT: 11:15:41 INFO - 2015-12-18 11:15:41,872 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.43 Median:188.43 stddev:0.00 (0.0%) 11:15:41 INFO - 2015-12-18 11:15:41,872 DEBUG : BROWSER_OUTPUT: Values: 188.4 11:15:41 INFO - 2015-12-18 11:15:41,872 DEBUG : BROWSER_OUTPUT: 11:15:41 INFO - 2015-12-18 11:15:41,872 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 11:15:41 INFO - 2015-12-18 11:15:41,872 DEBUG : BROWSER_OUTPUT: Values: 280.0 11:15:41 INFO - 2015-12-18 11:15:41,872 DEBUG : BROWSER_OUTPUT: 11:15:41 INFO - 2015-12-18 11:15:41,873 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 11:15:41 INFO - 2015-12-18 11:15:41,873 DEBUG : BROWSER_OUTPUT: Values: 5181.3 11:15:41 INFO - 2015-12-18 11:15:41,873 DEBUG : BROWSER_OUTPUT: 11:15:41 INFO - 2015-12-18 11:15:41,874 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1109.88 Median:1109.88 stddev:0.00 (0.0%) 11:15:41 INFO - 2015-12-18 11:15:41,874 DEBUG : BROWSER_OUTPUT: Values: 1109.9 11:15:41 INFO - 2015-12-18 11:15:41,874 DEBUG : BROWSER_OUTPUT: 11:15:41 INFO - 2015-12-18 11:15:41,874 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:785.55 Median:785.55 stddev:0.00 (0.0%) 11:15:41 INFO - 2015-12-18 11:15:41,874 DEBUG : BROWSER_OUTPUT: Values: 785.5 11:15:41 INFO - 2015-12-18 11:15:41,874 DEBUG : BROWSER_OUTPUT: 11:15:41 INFO - 2015-12-18 11:15:41,874 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12280.49 Median:12280.49 stddev:0.00 (0.0%) 11:15:41 INFO - 2015-12-18 11:15:41,874 DEBUG : BROWSER_OUTPUT: Values: 12280.5 11:15:41 INFO - 2015-12-18 11:15:41,874 DEBUG : BROWSER_OUTPUT: 11:15:41 INFO - 2015-12-18 11:15:41,874 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25974.36 Median:25974.36 stddev:0.00 (0.0%) 11:15:41 INFO - 2015-12-18 11:15:41,874 DEBUG : BROWSER_OUTPUT: Values: 25974.4 11:15:41 INFO - 2015-12-18 11:15:41,875 DEBUG : BROWSER_OUTPUT: 11:15:41 INFO - 2015-12-18 11:15:41,875 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:590.32 Median:590.32 stddev:0.00 (0.0%) 11:15:41 INFO - 2015-12-18 11:15:41,875 DEBUG : BROWSER_OUTPUT: Values: 590.3 11:15:41 INFO - 2015-12-18 11:15:41,875 DEBUG : BROWSER_OUTPUT: 11:15:41 INFO - 2015-12-18 11:15:41,875 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 11:15:41 INFO - 2015-12-18 11:15:41,875 DEBUG : BROWSER_OUTPUT: Values: 4830.9 11:15:41 INFO - 2015-12-18 11:15:41,875 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:15:41 INFO - 2015-12-18 11:15:41,875 DEBUG : BROWSER_OUTPUT: 11:15:42 INFO - 2015-12-18 11:15:42,760 INFO : Browser exited with error code: 0 11:15:42 INFO - 2015-12-18 11:15:42,775 INFO : Completed test v8_7 (00:00:39) 11:15:42 INFO - 2015-12-18 11:15:42,898 INFO : Completed test suite (00:20:10) 11:15:42 INFO - 2015-12-18 11:15:42,899 DEBUG : Working with test: dromaeo_css 11:15:42 INFO - 2015-12-18 11:15:42,899 DEBUG : Generating results file: dromaeo_css 11:15:42 INFO - 2015-12-18 11:15:42,900 DEBUG : Working with test: kraken 11:15:42 INFO - 2015-12-18 11:15:42,900 DEBUG : Generating results file: kraken 11:15:42 INFO - 2015-12-18 11:15:42,900 INFO : javascript benchmark 11:15:42 INFO - 2015-12-18 11:15:42,900 DEBUG : Working with test: v8_7 11:15:42 INFO - 2015-12-18 11:15:42,900 DEBUG : Generating results file: v8_7 11:15:42 INFO - 2015-12-18 11:15:42,901 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:15:42 INFO - 2015-12-18 11:15:42,967 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 11:15:42 INFO - 2015-12-18 11:15:42,968 DEBUG : process_Request line: dromaeo_css 6860.81 graph.html#tests=[[72,201,35]] 11:15:42 INFO - 2015-12-18 11:15:42,968 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:15:42 INFO - 2015-12-18 11:15:42,997 DEBUG : process_Request line: kraken 1500.10 graph.html#tests=[[232,201,35]] 11:15:42 INFO - 2015-12-18 11:15:42,997 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:15:43 INFO - 2015-12-18 11:15:43,038 DEBUG : process_Request line: v8_7 21081.25 graph.html#tests=[[230,201,35]] 11:15:43 INFO - 2015-12-18 11:15:43,039 INFO : javascript benchmark 11:15:43 INFO - 2015-12-18 11:15:43,043 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3068.846557672116, 3167.4298626247264, 3216.2763378239883, 3218.871245150194, 3236.611606607207, 5150.1759718445055, 5232.843014709565, 5267.604929630279, 5302.628815982878, 5317.202419637051, 5127.7692503837325, 5131.743412829363, 5188.844334669957, 5191.377034755825, 5195.714235717034, 4765.094632019923, 4864.100141473821, 4872.3422337984275, 4877.146499362615, 4930.580900623451, 4899.534544218312, 4916.213405855064, 4931.43288521821, 4984.975075124619, 4988.32657591226, 4682.859514214579, 4687.906241875144, 4796.2326027835725, 4803.495632958524, 4816.783244753994, 4857.6599638025355, 4866.7079975201605, 4873.147199240118, 4893.559579637814, 4909.140900342426, 4847.2002119650215, 4848.442429120661, 4848.927266091011, 4853.878653033702, 4908.43552991407, 5023.874403139951, 5109.6167787415725, 5112.642115051948, 5189.7405129743365, 5211.322528071364, 5645.802396916089, 5664.575156863251, 5666.575006874501, 5672.205891175238, 5680.659160450345, 5549.1676248562635, 5682.488576028178, 5704.3154821421695, 5704.3154821421695, 5706.914396284059, 5266.052110620125, 5323.121684921984, 5329.893402131975, 5340.759665815048, 5365.168398898177, 5803.82588522345, 5830.533557315404, 5831.3877042910735, 5831.708414579254, 5840.474357307778, 5404.675719456845, 5626.071698169838, 5638.097904335286, 5638.774449021993, 5641.407652196543, 5546.861328466821, 5622.971885140548, 5658.405867383948, 5677.261955945701, 5711.343195532484, 5587.1339942309005, 5597.0, 5599.32808063035, 5635.971820140873, 5732.455416735404, 5578.386377498472, 5582.8325150245555, 5583.609147359727, 5597.272354593877, 5598.188262701967, 4237.173751118564, 4317.41714868495, 4318.719283246579, 4334.934975975363, 4386.385905973167, 3821.4458903458844, 3865.8646947356706, 3937.92124157521, 3947.5262968443394, 3982.6415622594104, 5347.625666203407, 5378.300820893337, 5387.568994480433, 5391.029614669319, 5392.838214853561, 5702.51528620072, 5716.314042314949, 5722.399148089391, 5722.799702010493, 5730.34101078373, 5156.071907056691, 5267.9736601316745, 5312.73436328182, 5312.92030619541, 5419.430959749169, 4813.663043586916, 4817.27740838877, 4839.467658557556, 4852.441969173519, 4907.288443175719, 5637.577181711388, 5681.659100453986, 5703.144528320785, 5703.515201207943, 5726.856828579235, 5547.805826796042, 5605.467480589337, 5640.5769567281795, 5745.023346031101, 5749.310082789924, 5771.68255745938, 5777.959967205943, 5783.16144159103, 5784.0, 5793.04414771558, 5657.971710141423, 5666.0, 5666.065099258576, 5687.0616348302065, 5690.601657883908, 5387.380451248, 5567.220589117608, 5583.385827558884, 5703.857403564944, 5753.223314852441, 5609.971950140223, 5622.971885140548, 5629.662220266797, 5650.0, 5659.773609055592, 5556.416576259435, 5596.972015139898, 5600.4959553640365, 5605.131204663284, 5626.43735626434, 5279.656822306538, 5341.225522299323, 5368.8389348319615, 5382.30030096085, 5535.806246781343, 5605.0, 5633.0987042073075, 5634.070378387521, 5634.323881134126, 5664.575156863334, 5503.091989821634, 5505.504504594605, 5506.284183056177, 5510.752016159363, 5513.972430137824], "unit": "score", "name": "dojo.html", "value": 5223.794316726404}, {"lowerIsBetter": false, "replicates": [541.2125357604683, 570.8601392658799, 576.7981206577698, 582.4495851420406, 585.1836687820488, 27444.313892152706, 28057.158285251426, 28091.719082809166, 28133.577996330045, 28160.718392816067, 39463.802680986555, 39607.60392396075, 39712.20575588487, 39850.80074599623, 39865.40201896974, 8745.256653184488, 8877.245434138105, 8900.243479304267, 8901.688440904569, 8908.376413651047, 7717.575533345664, 7887.8422431551335, 8637.870431943526, 8814.823703525926, 10531.26281160319, 10303.690889273334, 10351.482425878714, 10357.637482688107, 10363.0, 10407.739806504822, 10378.688639340831, 10489.475526223658, 10496.370217786956, 10499.055085042382, 10505.0, 10187.286889917634, 10362.533685984148, 10363.274570780048, 10369.688909332657, 10372.94813525935, 40044.79977600093, 40066.399004014966, 40196.0, 40366.79816600928, 40403.59596404028, 3330.7501937354555, 3369.545111409953, 3465.497502862096, 3857.1357508829474, 3970.086880017612, 30479.39041219163, 31245.687543124506, 31436.842815785774, 32018.359632807445, 34105.488417673754, 3887.688984881203, 3999.5400528939253, 4096.344584866407, 4117.279476091702, 4197.118605092935, 242511.0, 247433.0, 247852.0, 248216.0, 248297.0, 56655.43344566584, 57695.42304576901, 63269.0, 64045.0, 64068.83552569161, 70457.6477117611, 71402.64298678473, 71636.06001669959, 71747.2825271751, 71790.2820971794, 15691.607709807118, 15694.215289235493, 15813.209339532978, 15824.68350632981, 15833.366665333258, 10721.892781072089, 10758.46207689628, 10821.242513024014, 11921.70195745096, 12366.134370593973, 21387.67918481224, 21678.674819877713, 21771.782282177293, 21774.237901673365, 21780.891095544423, 8477.788055298544, 8599.312055035582, 8659.307255419677, 8662.740117796477, 8671.696490622799, 867.1805144138729, 918.8529835226332, 954.8472244440856, 957.2103015012642, 1075.7310672331917, 27352.45295094087, 27735.445291094467, 30927.381452370828, 31357.372852543278, 31594.368112637618, 988.9862890537257, 1041.3855825063097, 1053.173258991703, 1079.994600026995, 1089.3518356577824, 15728.449504267295, 16139.273732681822, 16250.431234906722, 16344.264508097163, 16520.42178523746, 383099.0, 387251.0, 388599.0, 389280.0, 390306.0, 53519.464805352225, 53887.0, 53958.460415396126, 54139.729301354026, 54191.72904135533, 1273.3251376770327, 1344.099453366247, 1355.735631551838, 1369.7671395862728, 1369.8493165751959, 26786.0, 28262.43475130445, 28367.57448638231, 31174.37651246917, 32102.839485802422, 48541.51458485511, 48973.0, 49159.75420122877, 49175.262371065175, 49195.508044919094, 281287.0, 282717.0, 282968.0, 283030.0, 283652.0, 41018.58981410148, 41373.172536549704, 41723.7913810429, 41960.0, 45052.0, 42368.57631423646, 42558.0, 42570.0, 42854.142917142104, 43314.133717326105, 35095.0, 35485.82257088698, 35592.46611300781, 35810.462843057896, 36168.81915590405, 35366.0, 35733.82133089318, 36018.0, 36313.273734524635, 41261.1747765037, 34209.0, 34283.142921426166, 34574.82712586421, 34684.65315346814, 34916.47625285674, 31313.68686313199, 32622.184445388106, 32742.672573274915, 32862.17844553905, 32900.835495822364, 24155.275341739776, 24405.489471225792, 24604.0, 24622.261332160066, 24652.260432187064], "unit": "score", "name": "ext.html", "value": 19111.453326118877}, {"lowerIsBetter": false, "replicates": [354.5249365849761, 355.0013424420515, 356.3710051758646, 357.1090130125336, 360.5655185501471, 13659.863401365983, 13900.304984750748, 16422.42521511746, 17699.469015929528, 19016.144273507707, 14664.413423463075, 16243.350265989346, 16469.83530164698, 17282.30870765168, 17323.0, 5396.622236443441, 5398.73006349681, 5528.281323427969, 5534.114541673333, 5535.25274087997, 3991.181807729423, 4068.6338229559333, 5428.9185662215095, 5484.561235101202, 5913.083472061816, 5935.080062590284, 5985.311689155737, 5997.61015533991, 5999.760009599632, 6012.458878700916, 5893.764249430018, 6078.39216078393, 6088.786892458743, 6096.878062438771, 6098.512119030489, 5284.154535274338, 5302.44324345942, 5304.734763261821, 5310.92033619496, 5315.335583052119, 19813.10841012158, 19989.700154497696, 20121.893295868722, 20158.49603759903, 20452.590948180954, 1915.8946257955806, 1995.7704863940542, 2095.738032745907, 2137.9037943292587, 2223.9555208895895, 9053.411528250643, 9452.291078169095, 9481.573329200133, 12007.519699212022, 13024.609261722164, 1847.261095561786, 1851.9074046297767, 1861.2275905499203, 1877.6244751049844, 1892.9905350473298, 58821.0, 61059.0, 61213.0, 61435.999999999556, 61660.38339616591, 9989.100980911608, 10076.647317343857, 10154.54304556282, 10168.440735759605, 10220.437875916896, 13241.0, 13352.866471335163, 13356.398962046536, 13358.866411335957, 13377.0, 7471.476996610185, 7615.200403957505, 7632.885506717404, 7643.770686879402, 7677.884831727529, 7455.2172021938, 7465.626718664045, 7479.813004674927, 7537.585432801139, 7545.434092443089, 4285.5928686774705, 4314.676399270067, 4348.652107831366, 4364.650827933758, 4378.10248898975, 1709.3419033672126, 1718.6304944436756, 1752.807191208966, 1763.453329467869, 1776.5292197567655, 837.3259526081563, 892.7589550821242, 914.6890057380523, 919.1543779722671, 1014.5688082564881, 15593.0, 16364.83635163657, 16649.33402663904, 16686.415975441043, 16760.1619919006, 766.8542976834495, 816.6447595295947, 885.0618344554792, 886.6985225023394, 889.9199072083544, 8517.190866867637, 8778.341624378198, 8818.338624603051, 8836.293096552261, 8844.248238899638, 542979.0, 543502.0, 544791.0, 551860.0, 552991.0, 72511.0, 74968.62515687387, 75950.62024689841, 76810.6159469199, 76835.23164768392, 481.13636023338194, 490.02729581780136, 490.70312460961316, 490.75707524774754, 493.4941684773136, 10171.542280597243, 10215.897841021791, 10394.168466522811, 10455.902130276516, 10523.263371563917, 35048.47427288644, 35767.64232357747, 36266.456003159445, 36652.0, 36915.81542092272, 46977.76511117422, 48532.5146748528, 48834.755826220644, 49948.250776237655, 53220.20169697535, 9290.16388525036, 9323.580438880132, 9339.0, 9385.812283754423, 9582.185514231369, 10799.892001080203, 10830.566777328819, 10843.078338341329, 10911.0, 11078.667639970814, 14162.645933851323, 14331.0, 14409.78385324242, 14626.341814618156, 14664.266786660837, 12242.143049986415, 12395.62813115608, 14324.641883952985, 14444.205568693822, 14448.205348705502, 14250.144991300554, 14376.137431754129, 14570.41718331255, 14798.926005370335, 14968.251587420367, 9342.673006444742, 9583.377080489747, 9731.610735570497, 9893.060159284856, 9899.505024748878, 9824.901750982684, 9942.353747006422, 9942.453165075991, 13072.215667060007, 14425.42298308056], "unit": "score", "name": "jquery.html", "value": 8411.239041094486}, {"lowerIsBetter": false, "replicates": [1417.333853089048, 1486.0, 1550.58909389012, 1600.4478454933044, 1757.648470305939, 6979.057827193334, 7521.924780752198, 7697.307242348187, 7699.961500192505, 7718.575478348688, 7257.3831224345995, 7401.8149546261375, 7405.259474052592, 7407.444441666883, 7408.962955185217, 2193.2762188477805, 2218.5008373116, 2229.1974889039934, 2231.665250212473, 2234.72065991751, 2217.966730499044, 2255.1994042115057, 2279.282026161762, 2280.1563421534056, 2285.3486756274465, 2158.5359147783224, 2200.8239340852692, 2209.4365936686204, 2214.6013717530836, 2226.944326391837, 2155.148716257085, 2196.8132708719777, 2197.3298144066134, 2201.9559608807813, 2227.387468446174, 2197.8681279123143, 2217.523232505019, 2220.0, 2220.8334374921947, 2221.711177546925, 7554.093508778927, 7556.886646700304, 7606.277403646644, 7624.313811756913, 7632.580208088553, 4535.705179163344, 4606.0097079128145, 4610.515895830957, 4640.814367425299, 4660.0, 3044.558539011853, 3152.653208147102, 3178.8569514371907, 3207.550942868, 3212.518122281653, 961.2694352292239, 961.7691753978995, 968.4092703450889, 995.4525011243787, 996.3324572536418, 10659.733506662396, 10664.573417063308, 10733.302335348177, 10789.62236321725, 10823.29648572848, 4039.3738970459626, 4047.777372244496, 4074.7555146691293, 4099.364598487239, 4104.979475102606, 9221.861672074925, 9229.077092290718, 9229.53852307382, 9230.076992300716, 9236.26109911219, 4614.561616646413, 4645.883852903637, 4651.67438279324, 4652.023075154188, 4656.254999200111, 3762.5861155272896, 3768.7361884668358, 4069.959300406958, 4222.134462435193, 4240.1307731914885, 3531.9293614127573, 3535.045537704805, 3541.9291614167573, 3555.5555555555557, 3582.158192824684, 1114.5597488991802, 1132.1282612388416, 1138.4421633399575, 1140.2474366917795, 1148.9138314626437, 988.2242439684957, 1011.2718842433436, 1012.089119792193, 1120.8654961404684, 1326.5688651188402, 7372.152202496782, 7452.664630091551, 7463.14173870001, 7484.513506622052, 7487.550746955091, 473.76311844077964, 482.35364611420863, 482.55363788495504, 483.59136529632406, 485.82267472373036, 5678.574106941914, 5717.942820571741, 5751.338596061423, 5756.971215143982, 5763.682997435098, 9006.234470070118, 9265.490398028038, 9309.115634014757, 9323.487208203615, 9450.33847630673, 9314.580843862042, 9331.766705832408, 9344.672936447192, 9354.345195836226, 9370.812583748424, 7019.438444924496, 7170.067891174114, 7391.15001774792, 7410.258974102547, 7419.888701669479, 7318.926810731825, 7331.083614548182, 7422.1835598085245, 7441.1070671519765, 7449.180590134973, 8220.753377398449, 8379.664813407639, 8412.284955778583, 8413.70552030676, 8548.91451085506, 8537.829243414973, 8567.957160214408, 8569.357298202534, 8667.609957551798, 8687.956560217159, 6158.507319414526, 6285.842853928689, 6288.748450061947, 6912.239653637996, 7032.4022458089585, 7354.080739907512, 7564.962175189089, 7609.505382150142, 7611.65747541373, 7614.200508946702, 6854.485913556603, 7164.355208031302, 7213.350798428167, 7281.963590182015, 7312.890306645511, 7077.5399599025895, 7088.113985751781, 7152.356287934111, 7174.031505746658, 7178.0, 6860.931390686029, 6976.790696279119, 6985.79042628722, 6990.09128813251, 7000.719971201095, 6520.021996700533, 6566.080748695091, 6570.0, 6571.277159512545, 6576.638284894186, 6425.261094973951, 6478.319776423407, 6536.379043990813, 6561.3438656134, 6563.704633291418], "unit": "score", "name": "mootools.html", "value": 4337.410904854543}, {"lowerIsBetter": false, "replicates": [323.6278279978025, 326.3538194375137, 327.2163169209744, 333.17206741248003, 333.2751265996459, 5733.426657334265, 5734.225879506271, 5750.19497270382, 5763.9135412968835, 5797.913031304533, 5669.603127781057, 5670.206171136044, 5732.828015159542, 5735.627184233022, 5744.597878148531, 4388.670849686287, 4443.511213766483, 4450.399196108517, 4451.020775429401, 4451.688381813275, 4314.417553630266, 4420.381146639473, 4427.867163985085, 4447.0661161156195, 4464.3303504474425, 4300.655947524207, 4363.105563359503, 4382.561743825608, 4399.802008909591, 4400.1419723153995, 4209.831606735727, 4300.763458009808, 4308.655307575402, 4331.306990881475, 4336.132773445323, 3742.6257374262354, 3767.5478942526797, 3853.325668008087, 3860.0, 3863.3239183142837, 5418.756155972951, 5432.483914028161, 5476.479734425223, 5494.780208791643, 5501.339839219279, 4874.366332376804, 4997.750112494397, 5096.464871188546, 5099.745012749348, 5104.3619547556555, 5957.702114894238, 6033.577649564532, 6037.667928263943, 6041.516678665696, 6051.969740151315, 4240.215560121356, 4243.893902652428, 4246.723962942398, 4248.235317642823, 4250.596193361625, 6244.219472565929, 6302.401271879165, 6330.4619107375465, 6336.429721325103, 6339.904901426482, 4165.375193720966, 4341.934870976875, 4346.521882592912, 4348.369486424451, 4359.476862776487, 4393.626541743924, 4397.692161548661, 4398.494173170063, 4400.383946247528, 4400.44994375703, 5070.315507406527, 5074.847754567369, 5080.796768129233, 5081.771320290596, 5086.160783470686, 6039.335673075958, 6122.755089796358, 6127.0, 6133.785317513865, 6136.570440069152, 1519.3998370643533, 1551.1701239836634, 1551.2166355990378, 1552.1695892697353, 1554.945576904803, 1015.4770293298957, 1022.2537547590152, 1030.7680771826278, 1035.2132379391717, 1040.1366865501616, 5912.556558258148, 5920.082387229986, 5937.050071988461, 5943.167956486095, 5944.7027648617395, 6324.988001919671, 6326.0, 6328.525360597973, 6328.8417789554705, 6337.588056776295, 5912.0, 5924.644521328734, 5924.940750592526, 5927.0, 5929.4070592941225, 3332.5667663204113, 3427.2974040321674, 3427.9485807712904, 3429.4855771634457, 3436.037909385376, 6350.714217860207, 6382.808515744442, 6397.168368112116, 6400.295967443578, 6400.935990640127, 6371.458426033839, 6379.936200638027, 6416.711247993851, 6460.741570337228, 6477.125588045554, 5977.820665380045, 6064.605800623033, 6283.151774510474, 6382.329855365213, 6404.0, 6322.399372059647, 6373.74505019794, 6392.922300252343, 6394.904076438764, 6396.48828093742, 6335.1447554579545, 6341.112244285896, 6345.714442850175, 6346.540295731915, 6346.587471814318, 6322.146510221061, 6434.967825160844, 6447.548671592944, 6452.161219041494, 6464.676766161579, 4312.525622181494, 4313.590208930146, 4372.6501879850175, 4374.431323927869, 4377.0808130293, 6281.968590157203, 6283.528735344776, 6285.182926219562, 6312.747490100344, 6389.297177310399, 6061.333253342041, 6220.533459990428, 6220.7511699531515, 6221.9377806223165, 6225.657588832658, 6196.876062478816, 6222.16000839899, 6226.533010024175, 6228.844278892882, 6231.719572619334, 6119.938800611937, 6123.112148738497, 6124.0, 6127.816165515042, 6130.816075517741, 6177.652017333891, 6220.782272620437, 6265.937340626718, 6270.122182894307, 6271.184745982993, 6081.939180608138, 6088.817335479943, 6091.725872335667, 6096.1465394845645, 6097.603655762361], "unit": "score", "name": "prototype.html", "value": 4610.191583343389}, {"lowerIsBetter": false, "replicates": [743.331002098112, 746.9850602987942, 755.3768141283442, 764.5259938837921, 816.3224523645375, 13438.798418023725, 13794.862051379483, 13828.999999999975, 13837.51568695096, 13858.37637306321, 13173.077884548085, 13213.801792973112, 13224.27266500342, 13232.867671323284, 13240.205587664746, 685.8731134740065, 698.0541366448465, 803.2971150243537, 819.6229734322219, 827.4952279109768, 823.2056065896409, 823.3043078598574, 830.0703212402088, 830.0703212402088, 830.3232865214861, 715.3061530315586, 863.2144748279068, 863.9265662418702, 863.9438436501607, 868.1405408645459, 720.3552820225894, 832.3466079127886, 837.4305472278847, 846.445578146309, 850.974470765878, 617.8609812792131, 618.4835662222005, 627.7896904536985, 628.6605233174081, 629.0878226571444, 12668.0, 12749.936250318782, 12839.1012629116, 12879.935600322033, 13004.674883127904, 11917.702057448632, 11967.222130561486, 12069.879301207051, 12364.258144511357, 12499.250044997329, 10109.191264698806, 10135.594576216943, 10160.390376577356, 10166.186705063577, 10222.437765922872, 3650.142216579102, 3686.981565092184, 3690.1143725505954, 3690.7970061646597, 3702.352088384549, 45864.3120353195, 45995.31007034897, 46831.48480494731, 46871.29693054607, 47174.764126179834, 9707.369021013612, 9841.753956151011, 9949.900500995042, 9969.900300997042, 10208.2343824212, 18670.906645466686, 18691.15889784963, 18697.25210991545, 18714.344997925007, 18740.437786866416, 7742.806429839186, 7802.68789248435, 7807.882881756778, 7833.529988200727, 7950.562719050507, 4331.848385306499, 4361.869143925687, 4395.428594282723, 4397.964840038051, 4478.507364189936, 2988.417258634589, 3013.789034767545, 3026.969730302713, 3027.712367325101, 3037.1951432870305, 546.4671944853815, 551.2668151358683, 552.1469329885336, 552.3068548971096, 553.5709824885665, 508.8269988204028, 600.3186383454811, 653.1280740211776, 663.8439966607843, 684.3737979748474, 7737.651805668758, 7891.131975482693, 8975.551222438851, 9272.768180795534, 9410.95294523523, 516.3055690096888, 535.1945322289929, 598.4823127994254, 689.6207086102623, 706.5901776969346, 3689.2990331836863, 3756.718246131551, 3776.4335349697767, 3979.403089536535, 4053.5541090480024, 53044.734776326644, 54241.0, 54377.72811135919, 54780.17829732557, 56574.43425565774, 46527.76736116366, 46599.76700116478, 46857.06285874263, 47323.05353892903, 47413.0, 44283.55716442859, 44868.26975953568, 45562.772186138856, 45811.54188458139, 46282.537174627825, 8083.434159608771, 8454.323654107533, 8838.204561589231, 8904.777380565538, 9036.23192028685, 34867.65132348644, 34942.825285873405, 35773.46339804957, 35790.494665374215, 35876.8206158978, 42057.78971105125, 44906.326405104606, 46217.76891115657, 46878.53121468741, 48555.757221213666, 10819.837702434312, 10822.783544328911, 10828.675139745821, 10857.511411986321, 11016.449177541252, 12350.505979760708, 12587.118901676795, 12608.558700445441, 12666.43001064936, 13050.890674292792, 9971.501424928869, 10289.43408112561, 10296.536655850356, 10323.63867264642, 10391.428471433841, 11348.602798901999, 11445.313281203154, 11646.359450230319, 11752.11859110553, 12064.396780160781, 10646.20153488507, 11024.173187010845, 11062.944685276521, 11282.379469129277, 11283.097352211638, 9431.858522122311, 9569.665061722806, 9646.228301735704, 9750.707478775648, 9898.10917017472, 8441.357253510667, 8841.911580884109, 8921.197092261727, 9309.953450232706, 9352.953235234052], "unit": "score", "name": "yui.html", "value": 6210.443055607332}], "name": "dromaeo_css", "value": 6860.813865358753}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 105.0, 111.0, 109.0, 110.0, 99.0, 110.0, 109.0, 111.0], "unit": "score", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [160.0, 121.0, 145.0, 166.0, 124.0, 147.0, 147.0, 128.0, 166.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 143.2}, {"lowerIsBetter": true, "replicates": [160.0, 164.0, 161.0, 161.0, 163.0, 161.0, 160.0, 163.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 84.0, 92.0, 72.0, 77.0, 71.0, 107.0, 91.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.2}, {"lowerIsBetter": true, "replicates": [92.0, 95.0, 136.0, 93.0, 93.0, 93.0, 141.0, 93.0, 93.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 106.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 144.0, 145.0, 145.0, 145.0, 144.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 61.0, 57.0, 58.0, 59.0, 60.0, 69.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 59.1}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 66.0, 66.0, 67.0, 66.0, 67.0, 67.0, 66.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.8}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 85.0, 83.0, 84.0, 83.0, 84.0, 84.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [125.0, 129.0, 124.0, 120.0, 113.0, 116.0, 123.0, 119.0, 123.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.1}, {"lowerIsBetter": true, "replicates": [146.0, 155.0, 157.0, 159.0, 152.0, 139.0, 151.0, 150.0, 163.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.5}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 66.0, 67.0, 67.0, 68.0, 72.0, 66.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1500.0999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.80998176090202], "unit": "score", "name": "Richards", "value": 212.90636200000006}, {"lowerIsBetter": false, "replicates": [188.43037497644622], "unit": "score", "name": "DeltaBlue", "value": 350.8882260000001}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1109.8779134295228], "unit": "score", "name": "RayTrace", "value": 666.7300889999998}, {"lowerIsBetter": false, "replicates": [785.5459544383347], "unit": "score", "name": "Earley", "value": 848.4073989999999}, {"lowerIsBetter": false, "replicates": [12280.487804878048], "unit": "score", "name": "Boyer", "value": 54.27007547169812}, {"lowerIsBetter": false, "replicates": [25974.358974358973], "unit": "score", "name": "RegExp", "value": 35.072472852912156}, {"lowerIsBetter": false, "replicates": [590.318772136954], "unit": "score", "name": "Splay", "value": 138.04575399999996}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21081.247293981316}]} 11:15:43 INFO - RETURN: dromaeo_css: 6860.81 11:15:43 INFO - RETURN: kraken: 1500.10 11:15:43 INFO - RETURN: v8_7: 21081.25 11:15:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "21081.25"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1500.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6860.81"}}} 11:15:43 INFO - Return code: 0 11:15:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:15:43 INFO - # TBPL SUCCESS # 11:15:43 INFO - Running post-action listener: _resource_record_post_action 11:15:43 INFO - Running post-run listener: _resource_record_post_run 11:15:44 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553967616; Read time: 8; Write time: 645708 11:15:44 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 241496064; Read time: 0; Write time: 342048 11:15:44 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 312471552; Read time: 8; Write time: 303660 11:15:44 INFO - Running post-run listener: _upload_blobber_files 11:15:44 INFO - Blob upload gear active. 11:15:44 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:15:44 INFO - Copying logs to upload dir... 11:15:44 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1263.600065 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-12-18 11:15:42.222586) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 11:15:42.226696) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009995 build_url: 'https://queue.taskcluster.net/v1/task/osjSgiMYQ5aJ8rgiNvfkxg/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 11:15:42.278999) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 11:15:42.279349) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1450464741.223470-1253595954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004645 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 11:15:42.328583) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 11:15:42.328934) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 11:15:42.329252) ========= ========= Total master_lag: 0.23 =========