builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1450399597.68 results: success (0) buildid: 20151217143003 builduid: abb4941c611a47bf9ff7ce176cc831ca revision: 66fb852962c0d5f6f5fe0604204da4f5d17763c9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 16:46:37.681327) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 16:46:37.682330) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 16:46:37.682670) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006367 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 16:46:37.714143) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 16:46:37.714454) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 16:46:37.751263) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 16:46:37.751590) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 16:46:37.800571) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 16:46:37.800841) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 16:46:37.801195) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 16:46:37.801473) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 16:46:38-- 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% 221M=0s 2015-12-17 16:46:38 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177357 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 16:46:37.991858) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 16:46:37.992303) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022124 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 16:46:38.046304) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 16:46:38.046727) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 66fb852962c0d5f6f5fe0604204da4f5d17763c9 --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 66fb852962c0d5f6f5fe0604204da4f5d17763c9 --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=b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 16:46:38,299 truncating revision to first 12 chars 2015-12-17 16:46:38,299 Setting DEBUG logging. 2015-12-17 16:46:38,299 attempt 1/10 2015-12-17 16:46:38,299 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/66fb852962c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 16:46:39,564 unpacking tar archive at: b2g-inbound-66fb852962c0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.533575 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 16:46:39.593294) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 16:46:39.593638) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 16:46:39.601519) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 16:46:39.601923) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 16:46:39.602442) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-12-17 16:46:39.602763) ========= /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=b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:46:39 INFO - MultiFileLogger online at 20151217 16:46:39 in /builds/slave/test-pgo 16:46:39 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 16:46:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:46:39 INFO - {'append_to_log': False, 16:46:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:46:39 INFO - 'blob_upload_branch': 'B2G-Inbound', 16:46:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:46:39 INFO - 'branch': 'B2G-Inbound', 16:46:39 INFO - 'buildbot_json_path': 'buildprops.json', 16:46:39 INFO - 'config_files': ('talos/linux_config.py',), 16:46:39 INFO - 'default_actions': ('clobber', 16:46:39 INFO - 'read-buildbot-config', 16:46:39 INFO - 'download-and-extract', 16:46:39 INFO - 'populate-webroot', 16:46:39 INFO - 'create-virtualenv', 16:46:39 INFO - 'install', 16:46:39 INFO - 'run-tests'), 16:46:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:46:39 INFO - 'download_minidump_stackwalk': True, 16:46:39 INFO - 'download_symbols': 'ondemand', 16:46:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:46:39 INFO - 'tooltool.py': '/tools/tooltool.py', 16:46:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:46:39 INFO - '/tools/misc-python/virtualenv.py')}, 16:46:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:46:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:46:39 INFO - 'installer_path': 'installer.exe', 16:46:39 INFO - 'log_level': 'info', 16:46:39 INFO - 'log_name': 'talos', 16:46:39 INFO - 'log_to_console': True, 16:46:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:46:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:46:39 INFO - 'opt_config_files': (), 16:46:39 INFO - 'pip_index': False, 16:46:39 INFO - 'sps_profile': False, 16:46:39 INFO - 'sps_profile_interval': 0, 16:46:39 INFO - 'suite': 'dromaeojs', 16:46:39 INFO - 'system_bits': '64', 16:46:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:46:39 INFO - 'title': 'talos-linux64-ix-001', 16:46:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:46:39 INFO - 'use_talos_json': True, 16:46:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:46:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:46:39 INFO - 'work_dir': 'build'} 16:46:39 INFO - ##### 16:46:39 INFO - ##### Running clobber step. 16:46:39 INFO - ##### 16:46:39 INFO - Running pre-action listener: _resource_record_pre_action 16:46:39 INFO - Running main action method: clobber 16:46:39 INFO - rmtree: /builds/slave/test-pgo/build 16:46:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:46:40 INFO - Running post-action listener: _resource_record_post_action 16:46:40 INFO - ##### 16:46:40 INFO - ##### Running read-buildbot-config step. 16:46:40 INFO - ##### 16:46:40 INFO - Running pre-action listener: _resource_record_pre_action 16:46:40 INFO - Running main action method: read_buildbot_config 16:46:40 INFO - Using buildbot properties: 16:46:40 INFO - { 16:46:40 INFO - "project": "", 16:46:40 INFO - "product": "firefox", 16:46:40 INFO - "script_repo_revision": "production", 16:46:40 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 16:46:40 INFO - "repository": "", 16:46:40 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 16:46:40 INFO - "buildid": "20151217143003", 16:46:40 INFO - "pgo_build": "True", 16:46:40 INFO - "basedir": "/builds/slave/test-pgo", 16:46:40 INFO - "buildnumber": 1063, 16:46:40 INFO - "slavename": "talos-linux64-ix-001", 16:46:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:46:40 INFO - "platform": "ubuntu64_hw", 16:46:40 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 16:46:40 INFO - "branch": "b2g-inbound", 16:46:40 INFO - "repo_path": "integration/b2g-inbound", 16:46:40 INFO - "revision": "66fb852962c0d5f6f5fe0604204da4f5d17763c9", 16:46:40 INFO - "stage_platform": "linux64-pgo", 16:46:40 INFO - "builduid": "abb4941c611a47bf9ff7ce176cc831ca", 16:46:40 INFO - "slavebuilddir": "test" 16:46:40 INFO - } 16:46:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/0zR7p5ZfSuiNtfJkqxIwig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:46:40 INFO - Running post-action listener: _resource_record_post_action 16:46:40 INFO - ##### 16:46:40 INFO - ##### Running download-and-extract step. 16:46:40 INFO - ##### 16:46:40 INFO - Running pre-action listener: _resource_record_pre_action 16:46:40 INFO - Running main action method: download_and_extract 16:46:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:40 INFO - https://queue.taskcluster.net/v1/task/0zR7p5ZfSuiNtfJkqxIwig/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:46:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0zR7p5ZfSuiNtfJkqxIwig/artifacts/public/build/test_packages.json 16:46:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0zR7p5ZfSuiNtfJkqxIwig/artifacts/public/build/test_packages.json 16:46:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0zR7p5ZfSuiNtfJkqxIwig/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:46:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0zR7p5ZfSuiNtfJkqxIwig/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:46:41 INFO - Downloaded 1302 bytes. 16:46:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:46:41 INFO - Using the following test package requirements: 16:46:41 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:46:41 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:46:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:46:41 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:46:41 INFO - u'jsshell-linux-x86_64.zip'], 16:46:41 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:46:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:46:41 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:46:41 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:46:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:46:41 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:46:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:46:41 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:46:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:46:41 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:46:41 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:46:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:46:41 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:46: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')]} 16:46:41 INFO - https://queue.taskcluster.net/v1/task/0zR7p5ZfSuiNtfJkqxIwig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:46:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0zR7p5ZfSuiNtfJkqxIwig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:46:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0zR7p5ZfSuiNtfJkqxIwig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:46:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0zR7p5ZfSuiNtfJkqxIwig/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 16:46:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0zR7p5ZfSuiNtfJkqxIwig/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 16:46:42 INFO - Downloaded 23119573 bytes. 16:46:42 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 16:46:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:46:42 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 16:46:43 INFO - Return code: 0 16:46:43 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 16:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:43 INFO - https://queue.taskcluster.net/v1/task/0zR7p5ZfSuiNtfJkqxIwig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:46:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0zR7p5ZfSuiNtfJkqxIwig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:46:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0zR7p5ZfSuiNtfJkqxIwig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:46:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0zR7p5ZfSuiNtfJkqxIwig/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 16:46:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0zR7p5ZfSuiNtfJkqxIwig/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 16:46:46 INFO - Downloaded 23119573 bytes. 16:46:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:46:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:46:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:46:48 INFO - Return code: 0 16:46: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')]} 16:46:48 INFO - https://queue.taskcluster.net/v1/task/0zR7p5ZfSuiNtfJkqxIwig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:46:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0zR7p5ZfSuiNtfJkqxIwig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:46:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0zR7p5ZfSuiNtfJkqxIwig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:46:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0zR7p5ZfSuiNtfJkqxIwig/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 16:46:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0zR7p5ZfSuiNtfJkqxIwig/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 16:46:49 INFO - Downloaded 11132039 bytes. 16:46: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 16:46:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:46: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 16:46:49 INFO - Return code: 0 16:46:49 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')]} 16:46:49 INFO - https://queue.taskcluster.net/v1/task/0zR7p5ZfSuiNtfJkqxIwig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:46:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0zR7p5ZfSuiNtfJkqxIwig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:46:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0zR7p5ZfSuiNtfJkqxIwig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:46:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0zR7p5ZfSuiNtfJkqxIwig/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 16:46:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0zR7p5ZfSuiNtfJkqxIwig/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 16:46:50 INFO - Downloaded 54635157 bytes. 16:46:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/0zR7p5ZfSuiNtfJkqxIwig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:46:50 INFO - mkdir: /builds/slave/test-pgo/properties 16:46:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:46:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:46:50 INFO - Contents: 16:46:50 INFO - build_url:https://queue.taskcluster.net/v1/task/0zR7p5ZfSuiNtfJkqxIwig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:46:50 INFO - Running post-action listener: _resource_record_post_action 16:46:50 INFO - Running post-action listener: set_extra_try_arguments 16:46:50 INFO - ##### 16:46:50 INFO - ##### Running populate-webroot step. 16:46:50 INFO - ##### 16:46:50 INFO - Running pre-action listener: _resource_record_pre_action 16:46:50 INFO - Running main action method: populate_webroot 16:46:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:46:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:46:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:46:50 INFO - '--tppagecycles', 16:46:50 INFO - '7'], 16:46:50 INFO - 'tests': ['tsvgm']}}, 16:46:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:46:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:46:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:46:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:46:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:46:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:46:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:46:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:46:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:46:50 INFO - 'talos_options': ['--e10s'], 16:46:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:46:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:46:50 INFO - 'tests': ['damp', 'tps']}, 16:46:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:46:50 INFO - 'talos_options': ['--e10s'], 16:46:50 INFO - 'tests': ['damp', 'tps']}, 16:46:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:46:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:46:50 INFO - 'other': {'tests': ['a11yr', 16:46:50 INFO - 'ts_paint', 16:46:50 INFO - 'tpaint', 16:46:50 INFO - 'sessionrestore', 16:46:50 INFO - 'sessionrestore_no_auto_restore']}, 16:46:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:46:50 INFO - 'tests': ['a11yr', 16:46:50 INFO - 'ts_paint', 16:46:50 INFO - 'tpaint', 16:46:50 INFO - 'sessionrestore', 16:46:50 INFO - 'sessionrestore_no_auto_restore']}, 16:46:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:46:50 INFO - 'tests': ['a11yr', 16:46:50 INFO - 'ts_paint', 16:46:50 INFO - 'tpaint', 16:46:50 INFO - 'sessionrestore', 16:46:50 INFO - 'sessionrestore_no_auto_restore']}, 16:46:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:46:50 INFO - 'tests': ['a11yr', 16:46:50 INFO - 'ts_paint', 16:46:50 INFO - 'tpaint', 16:46:50 INFO - 'sessionrestore', 16:46:50 INFO - 'sessionrestore_no_auto_restore']}, 16:46:50 INFO - 'other_l64': {'tests': ['a11yr', 16:46:50 INFO - 'ts_paint', 16:46:50 INFO - 'tpaint', 16:46:50 INFO - 'sessionrestore', 16:46:50 INFO - 'sessionrestore_no_auto_restore']}, 16:46:50 INFO - 'other_nol64': {'tests': ['a11yr', 16:46:50 INFO - 'ts_paint', 16:46:50 INFO - 'tpaint', 16:46:50 INFO - 'sessionrestore', 16:46:50 INFO - 'sessionrestore_no_auto_restore']}, 16:46:50 INFO - 'svgr': {'tests': ['tsvgx', 16:46:50 INFO - 'tsvgr_opacity', 16:46:50 INFO - 'tart', 16:46:50 INFO - 'tscrollx', 16:46:50 INFO - 'cart']}, 16:46:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:46:50 INFO - 'tests': ['tsvgx', 16:46:50 INFO - 'tsvgr_opacity', 16:46:50 INFO - 'tart', 16:46:50 INFO - 'tscrollx', 16:46:50 INFO - 'cart']}, 16:46:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:46:50 INFO - 'tests': ['tp5o']}, 16:46:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:46:50 INFO - 'talos_options': ['--e10s'], 16:46:50 INFO - 'tests': ['tp5o']}, 16:46:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:46:50 INFO - 'talos_options': ['--xperf_path', 16:46:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:46:50 INFO - 'tests': ['tp5n']}, 16:46:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:46:50 INFO - 'talos_options': ['--e10s', 16:46:50 INFO - '--xperf_path', 16:46:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:46:50 INFO - 'tests': ['tp5n']}}, 16:46:50 INFO - 'talos.zip': {'path': '', 16:46:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:46:50 INFO - Running post-action listener: _resource_record_post_action 16:46:50 INFO - ##### 16:46:50 INFO - ##### Running create-virtualenv step. 16:46:50 INFO - ##### 16:46:50 INFO - Running pre-action listener: _resource_record_pre_action 16:46:50 INFO - Running main action method: create_virtualenv 16:46:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:46:50 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 16:46:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:46:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:46:50 INFO - Using real prefix '/usr' 16:46:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:46:51 INFO - Installing distribute.............................................................................................................................................................................................done. 16:46:53 INFO - Installing pip.................done. 16:46:53 INFO - Return code: 0 16:46:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc80ec27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ca600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959350>, '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 0x295a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295a6e0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448', '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 16:46:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 16:46:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:46:53 INFO - Using env: {'DISPLAY': ':0', 16:46:53 INFO - 'HOME': '/home/cltbld', 16:46:53 INFO - 'LANG': 'en_US.UTF-8', 16:46:53 INFO - 'LANGUAGE': 'en_US:en', 16:46:53 INFO - 'LOGNAME': 'cltbld', 16:46:53 INFO - 'MAIL': '/var/mail/cltbld', 16:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:53 INFO - 'MOZ_NO_REMOTE': '1', 16:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:53 INFO - 'NO_EM_RESTART': '1', 16:46:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:46:53 INFO - 'PWD': '/builds/slave/test-pgo', 16:46:53 INFO - 'SHELL': '/bin/bash', 16:46:53 INFO - 'SHLVL': '1', 16:46:53 INFO - 'TERM': 'linux', 16:46:53 INFO - 'TMOUT': '86400', 16:46:53 INFO - 'USER': 'cltbld', 16:46:53 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448', 16:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:53 INFO - '_': '/tools/buildbot/bin/python'} 16:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:53 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 16:46:53 INFO - Cleaning up... 16:46:53 INFO - Return code: 0 16:46:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc80ec27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ca600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959350>, '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 0x295a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295a6e0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448', '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 16:46:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 16:46:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:46:53 INFO - Using env: {'DISPLAY': ':0', 16:46:53 INFO - 'HOME': '/home/cltbld', 16:46:53 INFO - 'LANG': 'en_US.UTF-8', 16:46:53 INFO - 'LANGUAGE': 'en_US:en', 16:46:53 INFO - 'LOGNAME': 'cltbld', 16:46:53 INFO - 'MAIL': '/var/mail/cltbld', 16:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:53 INFO - 'MOZ_NO_REMOTE': '1', 16:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:53 INFO - 'NO_EM_RESTART': '1', 16:46:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:46:53 INFO - 'PWD': '/builds/slave/test-pgo', 16:46:53 INFO - 'SHELL': '/bin/bash', 16:46:53 INFO - 'SHLVL': '1', 16:46:53 INFO - 'TERM': 'linux', 16:46:53 INFO - 'TMOUT': '86400', 16:46:53 INFO - 'USER': 'cltbld', 16:46:53 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448', 16:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:53 INFO - '_': '/tools/buildbot/bin/python'} 16:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:53 INFO - Downloading/unpacking psutil>=0.7.1 16:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:55 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 16:46:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:46:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:46:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:46:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:46:55 INFO - Installing collected packages: psutil 16:46:55 INFO - Running setup.py install for psutil 16:46:55 INFO - building 'psutil._psutil_linux' extension 16:46:55 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 16:46:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:46:55 INFO - building 'psutil._psutil_posix' extension 16:46:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:46:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:46:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:46:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:46:55 INFO - Successfully installed psutil 16:46:55 INFO - Cleaning up... 16:46:55 INFO - Return code: 0 16:46:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:46: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')]} 16:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46: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')]} 16:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc80ec27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ca600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959350>, '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 0x295a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295a6e0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448', '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 16:46:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 16:46:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:46:55 INFO - Using env: {'DISPLAY': ':0', 16:46:55 INFO - 'HOME': '/home/cltbld', 16:46:55 INFO - 'LANG': 'en_US.UTF-8', 16:46:55 INFO - 'LANGUAGE': 'en_US:en', 16:46:55 INFO - 'LOGNAME': 'cltbld', 16:46:55 INFO - 'MAIL': '/var/mail/cltbld', 16:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:55 INFO - 'MOZ_NO_REMOTE': '1', 16:46:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:55 INFO - 'NO_EM_RESTART': '1', 16:46:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:46:55 INFO - 'PWD': '/builds/slave/test-pgo', 16:46:55 INFO - 'SHELL': '/bin/bash', 16:46:55 INFO - 'SHLVL': '1', 16:46:55 INFO - 'TERM': 'linux', 16:46:55 INFO - 'TMOUT': '86400', 16:46:55 INFO - 'USER': 'cltbld', 16:46:55 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448', 16:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:55 INFO - '_': '/tools/buildbot/bin/python'} 16:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:46:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:46:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:46:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:46:57 INFO - Installing collected packages: mozsystemmonitor 16:46:57 INFO - Running setup.py install for mozsystemmonitor 16:46:58 INFO - Successfully installed mozsystemmonitor 16:46:58 INFO - Cleaning up... 16:46:58 INFO - Return code: 0 16:46:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:46:58 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')]} 16:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:58 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')]} 16:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:58 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 0x7fc80ec27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ca600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959350>, '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 0x295a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295a6e0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448', '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 16:46:58 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 16:46:58 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 16:46:58 INFO - Using env: {'DISPLAY': ':0', 16:46:58 INFO - 'HOME': '/home/cltbld', 16:46:58 INFO - 'LANG': 'en_US.UTF-8', 16:46:58 INFO - 'LANGUAGE': 'en_US:en', 16:46:58 INFO - 'LOGNAME': 'cltbld', 16:46:58 INFO - 'MAIL': '/var/mail/cltbld', 16:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:58 INFO - 'MOZ_NO_REMOTE': '1', 16:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:58 INFO - 'NO_EM_RESTART': '1', 16:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:46:58 INFO - 'PWD': '/builds/slave/test-pgo', 16:46:58 INFO - 'SHELL': '/bin/bash', 16:46:58 INFO - 'SHLVL': '1', 16:46:58 INFO - 'TERM': 'linux', 16:46:58 INFO - 'TMOUT': '86400', 16:46:58 INFO - 'USER': 'cltbld', 16:46:58 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448', 16:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:58 INFO - '_': '/tools/buildbot/bin/python'} 16:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:58 INFO - Downloading/unpacking blobuploader==1.2.4 16:46:58 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 16:46:58 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 16:46:58 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 16:46:58 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 16:46:58 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 16:46:58 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 16:46:59 INFO - Downloading blobuploader-1.2.4.tar.gz 16:47:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:47:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:47:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:47:00 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 16:47:00 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 16:47:00 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 16:47:00 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 16:47:00 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 16:47:00 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 16:47:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:47:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:47:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:47:00 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 16:47:00 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 16:47:00 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 16:47:00 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 16:47:00 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 16:47:00 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 16:47:00 INFO - Downloading docopt-0.6.1.tar.gz 16:47:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:47:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:47:00 INFO - Installing collected packages: blobuploader, requests, docopt 16:47:00 INFO - Running setup.py install for blobuploader 16:47:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:47:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:47:00 INFO - Running setup.py install for requests 16:47:01 INFO - Running setup.py install for docopt 16:47:01 INFO - Successfully installed blobuploader requests docopt 16:47:01 INFO - Cleaning up... 16:47:01 INFO - Return code: 0 16:47:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:47:01 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')]} 16:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:01 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')]} 16:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:01 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 0x7fc80ec27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ca600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959350>, '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 0x295a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295a6e0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448', '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 16:47:01 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 16:47:01 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 16:47:01 INFO - Using env: {'DISPLAY': ':0', 16:47:01 INFO - 'HOME': '/home/cltbld', 16:47:01 INFO - 'LANG': 'en_US.UTF-8', 16:47:01 INFO - 'LANGUAGE': 'en_US:en', 16:47:01 INFO - 'LOGNAME': 'cltbld', 16:47:01 INFO - 'MAIL': '/var/mail/cltbld', 16:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:01 INFO - 'MOZ_NO_REMOTE': '1', 16:47:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:01 INFO - 'NO_EM_RESTART': '1', 16:47:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:47:01 INFO - 'PWD': '/builds/slave/test-pgo', 16:47:01 INFO - 'SHELL': '/bin/bash', 16:47:01 INFO - 'SHLVL': '1', 16:47:01 INFO - 'TERM': 'linux', 16:47:01 INFO - 'TMOUT': '86400', 16:47:01 INFO - 'USER': 'cltbld', 16:47:01 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448', 16:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:01 INFO - '_': '/tools/buildbot/bin/python'} 16:47:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:47:01 INFO - Running setup.py (path:/tmp/pip-D2H_2X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:47:01 INFO - Running setup.py (path:/tmp/pip-xkmBCz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:47:01 INFO - Running setup.py (path:/tmp/pip-_QpbzP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:47:01 INFO - Running setup.py (path:/tmp/pip-xCtlKN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:47:01 INFO - Running setup.py (path:/tmp/pip-MB6MPS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:47:02 INFO - Running setup.py (path:/tmp/pip-k0p_xL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:47:02 INFO - Running setup.py (path:/tmp/pip-g8wQAj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:47:02 INFO - Running setup.py (path:/tmp/pip-j4Rmuw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:47:02 INFO - Running setup.py (path:/tmp/pip-pm7qei-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:47:02 INFO - Running setup.py (path:/tmp/pip-OGwDFL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:47:02 INFO - Running setup.py (path:/tmp/pip-9Xv0xm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:47:02 INFO - Running setup.py (path:/tmp/pip-b6G2rA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:47:02 INFO - Running setup.py (path:/tmp/pip-xdCBDO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:47:02 INFO - Running setup.py (path:/tmp/pip-Xxd6z5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:47:02 INFO - Running setup.py (path:/tmp/pip-RIYCC6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:47:02 INFO - Running setup.py (path:/tmp/pip-7YAuh2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:47:02 INFO - Running setup.py (path:/tmp/pip-VbF4n5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:47:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:47:02 INFO - Running setup.py install for manifestparser 16:47:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:47:03 INFO - Running setup.py install for mozcrash 16:47:03 INFO - Running setup.py install for mozdebug 16:47:03 INFO - Running setup.py install for mozdevice 16:47:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:47:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:47:03 INFO - Running setup.py install for mozfile 16:47:03 INFO - Running setup.py install for mozhttpd 16:47:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:47:03 INFO - Running setup.py install for mozinfo 16:47:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:47:03 INFO - Running setup.py install for mozInstall 16:47:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:47:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:47:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:47:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:47:03 INFO - Running setup.py install for mozleak 16:47:03 INFO - Running setup.py install for mozlog 16:47:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:47:03 INFO - Running setup.py install for moznetwork 16:47:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:47:04 INFO - Running setup.py install for mozprocess 16:47:04 INFO - Running setup.py install for mozprofile 16:47:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:47:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:47:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:47:04 INFO - Running setup.py install for mozrunner 16:47:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:47:04 INFO - Running setup.py install for mozscreenshot 16:47:04 INFO - Running setup.py install for moztest 16:47:04 INFO - Running setup.py install for mozversion 16:47:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:47:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:47:04 INFO - Cleaning up... 16:47:04 INFO - Return code: 0 16:47:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fc80ec27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ca600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959350>, '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 0x295a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295a6e0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448', '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 16:47:04 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 16:47:04 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 16:47:04 INFO - Using env: {'DISPLAY': ':0', 16:47:04 INFO - 'HOME': '/home/cltbld', 16:47:04 INFO - 'LANG': 'en_US.UTF-8', 16:47:04 INFO - 'LANGUAGE': 'en_US:en', 16:47:04 INFO - 'LOGNAME': 'cltbld', 16:47:04 INFO - 'MAIL': '/var/mail/cltbld', 16:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:04 INFO - 'MOZ_NO_REMOTE': '1', 16:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:04 INFO - 'NO_EM_RESTART': '1', 16:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:47:04 INFO - 'PWD': '/builds/slave/test-pgo', 16:47:04 INFO - 'SHELL': '/bin/bash', 16:47:04 INFO - 'SHLVL': '1', 16:47:04 INFO - 'TERM': 'linux', 16:47:04 INFO - 'TMOUT': '86400', 16:47:04 INFO - 'USER': 'cltbld', 16:47:04 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448', 16:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:04 INFO - '_': '/tools/buildbot/bin/python'} 16:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:47:04 INFO - Running setup.py (path:/tmp/pip-FzH_AC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 16:47:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:47:04 INFO - Running setup.py (path:/tmp/pip-RIGXpi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:47:05 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)) 16:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:47:05 INFO - Running setup.py (path:/tmp/pip-SLh7fv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:47:05 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)) 16:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:47:05 INFO - Running setup.py (path:/tmp/pip-YoDOAh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:47:05 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)) 16:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:47:05 INFO - Running setup.py (path:/tmp/pip-lT6skl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:47:05 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)) 16:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:47:05 INFO - Running setup.py (path:/tmp/pip-uyDZrx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:47:05 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)) 16:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:47:05 INFO - Running setup.py (path:/tmp/pip-XPF4Z3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:47:05 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)) 16:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:47:05 INFO - Running setup.py (path:/tmp/pip-_e_i_s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:47:05 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)) 16:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:47:05 INFO - Running setup.py (path:/tmp/pip-NmIT4O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:47:05 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)) 16:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:47:05 INFO - Running setup.py (path:/tmp/pip-8xoXDY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:47:05 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)) 16:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:47:05 INFO - Running setup.py (path:/tmp/pip-t20Ovc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:47:05 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)) 16:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:47:05 INFO - Running setup.py (path:/tmp/pip-5xsCCO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 16:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:47:05 INFO - Running setup.py (path:/tmp/pip-EaO6Rx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:47:05 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)) 16:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:47:05 INFO - Running setup.py (path:/tmp/pip-RZZ_w0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 16:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:47:05 INFO - Running setup.py (path:/tmp/pip-0nk5qv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 16:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:47:05 INFO - Running setup.py (path:/tmp/pip-GoOW5B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:47:06 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)) 16:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:47:06 INFO - Running setup.py (path:/tmp/pip-g1QYvJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:47:06 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)) 16:47:06 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)) 16:47:06 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)) 16:47:06 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)) 16:47:06 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)) 16:47:06 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)) 16:47:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:07 INFO - Downloading blessings-1.5.1.tar.gz 16:47:07 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 16:47:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:47:07 INFO - Installing collected packages: blessings 16:47:07 INFO - Running setup.py install for blessings 16:47:07 INFO - Successfully installed blessings 16:47:07 INFO - Cleaning up... 16:47:08 INFO - Return code: 0 16:47:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:47:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:47:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:47:08 INFO - Reading from file tmpfile_stdout 16:47:08 INFO - Current package versions: 16:47:08 INFO - argparse == 1.2.1 16:47:08 INFO - blessings == 1.5.1 16:47:08 INFO - blobuploader == 1.2.4 16:47:08 INFO - docopt == 0.6.1 16:47:08 INFO - manifestparser == 1.1 16:47:08 INFO - mozInstall == 1.12 16:47:08 INFO - mozcrash == 0.16 16:47:08 INFO - mozdebug == 0.1 16:47:08 INFO - mozdevice == 0.47 16:47:08 INFO - mozfile == 1.2 16:47:08 INFO - mozhttpd == 0.7 16:47:08 INFO - mozinfo == 0.9 16:47:08 INFO - mozleak == 0.1 16:47:08 INFO - mozlog == 3.1 16:47:08 INFO - moznetwork == 0.27 16:47:08 INFO - mozprocess == 0.22 16:47:08 INFO - mozprofile == 0.27 16:47:08 INFO - mozrunner == 6.11 16:47:08 INFO - mozscreenshot == 0.1 16:47:08 INFO - mozsystemmonitor == 0.0 16:47:08 INFO - moztest == 0.7 16:47:08 INFO - mozversion == 1.4 16:47:08 INFO - psutil == 3.1.1 16:47:08 INFO - requests == 1.2.3 16:47:08 INFO - wsgiref == 0.1.2 16:47:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:47:08 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')]} 16:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:08 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')]} 16:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:08 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 0x7fc80ec27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ca600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959350>, '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 0x295a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295a6e0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448', '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 16:47:08 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 16:47:08 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 16:47:08 INFO - Using env: {'DISPLAY': ':0', 16:47:08 INFO - 'HOME': '/home/cltbld', 16:47:08 INFO - 'LANG': 'en_US.UTF-8', 16:47:08 INFO - 'LANGUAGE': 'en_US:en', 16:47:08 INFO - 'LOGNAME': 'cltbld', 16:47:08 INFO - 'MAIL': '/var/mail/cltbld', 16:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:08 INFO - 'MOZ_NO_REMOTE': '1', 16:47:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:08 INFO - 'NO_EM_RESTART': '1', 16:47:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:47:08 INFO - 'PWD': '/builds/slave/test-pgo', 16:47:08 INFO - 'SHELL': '/bin/bash', 16:47:08 INFO - 'SHLVL': '1', 16:47:08 INFO - 'TERM': 'linux', 16:47:08 INFO - 'TMOUT': '86400', 16:47:08 INFO - 'USER': 'cltbld', 16:47:08 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448', 16:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:08 INFO - '_': '/tools/buildbot/bin/python'} 16:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:08 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)) 16:47:08 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)) 16:47:08 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)) 16:47:08 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)) 16:47:08 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)) 16:47:08 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)) 16:47:08 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)) 16:47:08 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)) 16:47:08 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)) 16:47:08 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)) 16:47:08 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)) 16:47:08 INFO - Cleaning up... 16:47:08 INFO - Return code: 0 16:47:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:47:08 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')]} 16:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:08 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')]} 16:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:08 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 0x7fc80ec27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ca600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959350>, '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 0x295a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295a6e0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448', '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 16:47:08 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 16:47:08 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 16:47:08 INFO - Using env: {'DISPLAY': ':0', 16:47:08 INFO - 'HOME': '/home/cltbld', 16:47:08 INFO - 'LANG': 'en_US.UTF-8', 16:47:08 INFO - 'LANGUAGE': 'en_US:en', 16:47:08 INFO - 'LOGNAME': 'cltbld', 16:47:08 INFO - 'MAIL': '/var/mail/cltbld', 16:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:08 INFO - 'MOZ_NO_REMOTE': '1', 16:47:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:08 INFO - 'NO_EM_RESTART': '1', 16:47:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:47:08 INFO - 'PWD': '/builds/slave/test-pgo', 16:47:08 INFO - 'SHELL': '/bin/bash', 16:47:08 INFO - 'SHLVL': '1', 16:47:08 INFO - 'TERM': 'linux', 16:47:08 INFO - 'TMOUT': '86400', 16:47:08 INFO - 'USER': 'cltbld', 16:47:08 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448', 16:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:08 INFO - '_': '/tools/buildbot/bin/python'} 16:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:08 INFO - Downloading/unpacking jsonschema 16:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:47:10 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 16:47:10 INFO - Downloading/unpacking functools32 (from jsonschema) 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47:10 INFO - Downloading functools32-3.2.3-2.tar.gz 16:47:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:47:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:47:10 INFO - warning: no files found matching '*.txt' 16:47:10 INFO - no previously-included directories found matching 'build' 16:47:10 INFO - no previously-included directories found matching 'dist' 16:47:10 INFO - no previously-included directories found matching '.git*' 16:47:10 INFO - Installing collected packages: jsonschema, functools32 16:47:10 INFO - Running setup.py install for functools32 16:47:10 INFO - warning: no files found matching '*.txt' 16:47:10 INFO - no previously-included directories found matching 'build' 16:47:10 INFO - no previously-included directories found matching 'dist' 16:47:10 INFO - no previously-included directories found matching '.git*' 16:47:10 INFO - Successfully installed jsonschema functools32 16:47:10 INFO - Cleaning up... 16:47:10 INFO - Return code: 0 16:47:10 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:47:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc80ec27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ca600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959350>, '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 0x295a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295a6e0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448', '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 16:47:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 16:47:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:47:10 INFO - Using env: {'DISPLAY': ':0', 16:47:10 INFO - 'HOME': '/home/cltbld', 16:47:10 INFO - 'LANG': 'en_US.UTF-8', 16:47:10 INFO - 'LANGUAGE': 'en_US:en', 16:47:10 INFO - 'LOGNAME': 'cltbld', 16:47:10 INFO - 'MAIL': '/var/mail/cltbld', 16:47:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:10 INFO - 'MOZ_NO_REMOTE': '1', 16:47:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:10 INFO - 'NO_EM_RESTART': '1', 16:47:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:47:10 INFO - 'PWD': '/builds/slave/test-pgo', 16:47:10 INFO - 'SHELL': '/bin/bash', 16:47:10 INFO - 'SHLVL': '1', 16:47:10 INFO - 'TERM': 'linux', 16:47:10 INFO - 'TMOUT': '86400', 16:47:10 INFO - 'USER': 'cltbld', 16:47:10 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448', 16:47:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:10 INFO - '_': '/tools/buildbot/bin/python'} 16:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:11 INFO - Downloading/unpacking flake8 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:47:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 16:47:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:47:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 16:47:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47:13 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 16:47:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:47:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:47:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:47:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:47:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:47:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:47:13 INFO - no previously-included directories found matching 'docs/_build' 16:47:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:47:13 INFO - Running setup.py install for pep8 16:47:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:47:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:47:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:47:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:47:13 INFO - no previously-included directories found matching 'docs/_build' 16:47:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:47:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:47:13 INFO - Cleaning up... 16:47:13 INFO - Return code: 0 16:47:13 INFO - Running post-action listener: _resource_record_post_action 16:47:13 INFO - Running post-action listener: _start_resource_monitoring 16:47:13 INFO - Starting resource monitoring. 16:47:13 INFO - ##### 16:47:13 INFO - ##### Running install step. 16:47:13 INFO - ##### 16:47:13 INFO - Running pre-action listener: _resource_record_pre_action 16:47:13 INFO - Running main action method: install 16:47:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:47:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:47:13 INFO - Reading from file tmpfile_stdout 16:47:13 INFO - Detecting whether we're running mozinstall >=1.0... 16:47:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:47:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:47:13 INFO - Reading from file tmpfile_stdout 16:47:13 INFO - Output received: 16:47:13 INFO - Usage: mozinstall [options] installer 16:47:13 INFO - Options: 16:47:13 INFO - -h, --help show this help message and exit 16:47:13 INFO - -d DEST, --destination=DEST 16:47:13 INFO - Directory to install application into. [default: 16:47:13 INFO - "/builds/slave/test-pgo"] 16:47:13 INFO - --app=APP Application being installed. [default: firefox] 16:47:13 INFO - mkdir: /builds/slave/test-pgo/build/application 16:47:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 16:47:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 16:47:29 INFO - Reading from file tmpfile_stdout 16:47:29 INFO - Output received: 16:47:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:47:29 INFO - Running post-action listener: _resource_record_post_action 16:47:29 INFO - ##### 16:47:29 INFO - ##### Running run-tests step. 16:47:29 INFO - ##### 16:47:29 INFO - Running pre-action listener: _resource_record_pre_action 16:47:29 INFO - Running main action method: run_tests 16:47:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:47:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:47:29 INFO - Python 2.7.3 16:47:29 INFO - Return code: 0 16:47:29 INFO - grabbing minidump binary from tooltool 16:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959350>, '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 0x295a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295a6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:47:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 16:47:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:47:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:47:29 INFO - Return code: 0 16:47:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:47:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:47:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:47:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:47:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:47:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:47:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:47:30 INFO - Return code: 0 16:47:30 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/0zR7p5ZfSuiNtfJkqxIwig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 16:47:30 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/0zR7p5ZfSuiNtfJkqxIwig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost 16:47:30 INFO - Using env: {'DISPLAY': ':0', 16:47:30 INFO - 'HOME': '/home/cltbld', 16:47:30 INFO - 'LANG': 'en_US.UTF-8', 16:47:30 INFO - 'LANGUAGE': 'en_US:en', 16:47:30 INFO - 'LOGNAME': 'cltbld', 16:47:30 INFO - 'MAIL': '/var/mail/cltbld', 16:47:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:47:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:30 INFO - 'MOZ_NO_REMOTE': '1', 16:47:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:47:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:30 INFO - 'NO_EM_RESTART': '1', 16:47:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:47:30 INFO - 'PWD': '/builds/slave/test-pgo', 16:47:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:47:30 INFO - 'SHELL': '/bin/bash', 16:47:30 INFO - 'SHLVL': '1', 16:47:30 INFO - 'TERM': 'linux', 16:47:30 INFO - 'TMOUT': '86400', 16:47:30 INFO - 'USER': 'cltbld', 16:47:30 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448', 16:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:30 INFO - '_': '/tools/buildbot/bin/python'} 16:47:30 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/0zR7p5ZfSuiNtfJkqxIwig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost'] with output_timeout 3600 16:47:30 INFO - mozversion INFO | application_buildid: 20151217143003 16:47:30 INFO - mozversion INFO | application_changeset: 66fb852962c0d5f6f5fe0604204da4f5d17763c9 16:47:30 INFO - mozversion INFO | application_display_name: Nightly 16:47:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:47:30 INFO - mozversion INFO | application_name: Firefox 16:47:30 INFO - mozversion INFO | application_remotingname: firefox 16:47:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 16:47:30 INFO - mozversion INFO | application_vendor: Mozilla 16:47:30 INFO - mozversion INFO | application_version: 46.0a1 16:47:30 INFO - mozversion INFO | platform_buildid: 20151217143003 16:47:30 INFO - mozversion INFO | platform_changeset: 66fb852962c0d5f6f5fe0604204da4f5d17763c9 16:47:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 16:47:30 INFO - mozversion INFO | platform_version: 46.0a1 16:47:30 INFO - 2015-12-17 16:47:30,882 DEBUG : using testdate: 1450399650 16:47:30 INFO - 2015-12-17 16:47:30,882 DEBUG : actual date: 1450399650 16:47:30 INFO - 2015-12-17 16:47:30,930 INFO : starting webserver on 'localhost:34551' 16:47:30 INFO - 2015-12-17 16:47:30,931 INFO : Starting test suite talos-linux64-ix-001 16:47:30 INFO - 2015-12-17 16:47:30,931 INFO : Starting test dromaeo_css 16:47:30 INFO - 2015-12-17 16:47:30,931 DEBUG : operating with platform_type : linux_ 16:47:30 INFO - 2015-12-17 16:47:30,932 INFO : Initialising browser for dromaeo_css test... 16:47:30 INFO - 2015-12-17 16:47:30,946 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzRdc5w/profile http://localhost:34551/getInfo.html 16:47:35 INFO - 2015-12-17 16:47:35,045 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:47:35 INFO - 2015-12-17 16:47:35,045 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:47:35 INFO - 2015-12-17 16:47:35,045 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:47:35 INFO - 2015-12-17 16:47:35,045 DEBUG : BROWSER_OUTPUT: __metrics 16:47:35 INFO - 2015-12-17 16:47:35,303 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] 16:47:35 INFO - 2015-12-17 16:47:35,343 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] 16:47:36 INFO - 2015-12-17 16:47:36,516 INFO : Browser initialized. 16:47:36 INFO - 2015-12-17 16:47:36,517 INFO : Running cycle 1/1 for dromaeo_css test... 16:47:36 INFO - 2015-12-17 16:47:36,517 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzRdc5w/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:47:48 INFO - 2015-12-17 16:47:48,306 DEBUG : BROWSER_OUTPUT: RSS: Main: 150011904 16:47:48 INFO - 2015-12-17 16:47:48,306 DEBUG : BROWSER_OUTPUT: 16:48:39 INFO - 2015-12-17 16:48:39,527 DEBUG : BROWSER_OUTPUT: 1450399719524 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] 16:50:48 INFO - 2015-12-17 16:50:48,395 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34551/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34551/tests/dromaeo/cssquery-ext.html) 16:50:49 INFO - 2015-12-17 16:50:49,500 DEBUG : BROWSER_OUTPUT: RSS: Main: 269201408 16:50:49 INFO - 2015-12-17 16:50:49,500 DEBUG : BROWSER_OUTPUT: 16:53:51 INFO - 2015-12-17 16:53:51,975 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34551/tests/dromaeo/cssquery-ext.html (next: http://localhost:34551/tests/dromaeo/cssquery-jquery.html) 16:53:52 INFO - 2015-12-17 16:53:52,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 233394176 16:53:52 INFO - 2015-12-17 16:53:52,542 DEBUG : BROWSER_OUTPUT: 16:56:54 INFO - 2015-12-17 16:56:54,384 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34551/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34551/tests/dromaeo/cssquery-mootools.html) 16:56:54 INFO - 2015-12-17 16:56:54,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 232726528 16:56:54 INFO - 2015-12-17 16:56:54,965 DEBUG : BROWSER_OUTPUT: 16:59:56 INFO - 2015-12-17 16:59:56,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34551/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34551/tests/dromaeo/cssquery-prototype.html) 16:59:57 INFO - 2015-12-17 16:59:57,363 DEBUG : BROWSER_OUTPUT: RSS: Main: 213213184 16:59:57 INFO - 2015-12-17 16:59:57,364 DEBUG : BROWSER_OUTPUT: 17:02:59 INFO - 2015-12-17 17:02:59,767 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34551/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34551/tests/dromaeo/cssquery-yui.html) 17:03:00 INFO - 2015-12-17 17:03:00,368 DEBUG : BROWSER_OUTPUT: RSS: Main: 217513984 17:03:00 INFO - 2015-12-17 17:03:00,368 DEBUG : BROWSER_OUTPUT: 17:06:02 INFO - 2015-12-17 17:06:02,920 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34551/tests/dromaeo/cssquery-yui.html (next: http://localhost:34551/tests/dromaeo/cssquery-dojo.html) 17:06:03 INFO - 2015-12-17 17:06:03,179 DEBUG : BROWSER_OUTPUT: RSS: Main: 258977792 17:06:03 INFO - 2015-12-17 17:06:03,179 DEBUG : BROWSER_OUTPUT: 17:06:03 INFO - 2015-12-17 17:06:03,179 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:06:03 INFO - 2015-12-17 17:06:03,180 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:06:03 INFO - 2015-12-17 17:06:03,180 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:06:03 INFO - 2015-12-17 17:06:03,180 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:06:03 INFO - 2015-12-17 17:06:03,180 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3068.125584208501;3095.1797773589988;3144.072498612909;3145.606799150105;3164.272217390001;4880.145974454474;4995.125852975724;5167.534921857032;5187.662801917877;5204.42751297357;5115.923261151086;5131.820386286481;5239.214117882319;5244.921326180101;5247.344081989751;4683.90632187356;4720.740359280238;4729.7635118244125;4743.35964644772;4842.322074909515;4802.759862006886;4845.53967373099;4890.5109489051165;4898.53463920927;4939.110960027194;4582.977085114587;4672.5327467253;4690.929636055462;4820.276958456225;4834.178189707741;4726.172919739032;4743.620510359163;4750.524947505256;4754.191787396151;4762.333273341735;4697.67116301859;4698.248280275139;4705.529447055267;4706.22347312693;4715.339852420664;4925.778339974674;4998.950010499885;5033.993201359743;5035.496450354972;5037.219231019198;5606.131049687305;5614.3824179340645;5614.663120212759;5619.129034999582;5619.887602247973;5307.310049693554;5395.73021348931;5648.858778530528;5655.335835138655;5705.2012718219485;5204.3234379530795;5274.103402421598;5307.946920530784;5312.415634280226;5321.547668448186;5652.3217213934595;5674.829755107354;5698.544116470673;5700.8859822803315;5700.942990570041;5294.92057619136;5543.722813859291;5544.667319960815;5546.750396232179;5547.583931205176;5389.164679474688;5455.645383050089;5462.945370546323;5488.4785945335125;5501.642393244426;5539.418361072029;5539.889202215933;5551.472610102034;5552.555795536347;5554.91667624986;5378.757955891916;5549.472800083986;5551.611387202857;5556.055470570012;5605.80379686709;4212.620864122244;4298.140371925628;4305.547917468621;4340.60934515895;4346.913061738747;3858.9807050964564;3859.3439115350457;3872.8644497442456;3900.395438707005;3904.3752999520507;5209.426963034063;5214.0875346814155;5216.113260745682;5221.399539053057;5223.164293712987;5451;5461.836144915659;5495.725213739377;5545.279113715191;5553.77784888608;5188.636795424284;5190.532852043334;5206.088934436459;5214.895702085937;5256.2115682647145;4895.069936712013;4906.950930490721;4909.754512274372;4913.533214344631;4956.727379994063;5476.780928762805;5554.50009499147;5561.888762224733;5676.460736230051;5705.74324155414;5503.559715222693;5503.642263252876;5503.862403439946;5524.972375138259;5571.303587051619;5676.120201368794;5713.9142912855505;5714.142878568248;5716.228309178207;5727.284089488814;5353.866153346197;5397.163439666858;5451.400345962021;5537.335519737658;5557.944420555743;5542.418046105262;5542.473465020817;5564.054110801255;5565.220869078251;5581.804636837691;5447.237386765935;5451.236826844166;5452.073147565003;5483.287172667528;5508.118701007819;5356.6785992838995;5461.781528738965;5466.180072988925;5468.72656367188;5490.286262785812;5303.2840566524565;5361.946380536145;5366.892662146814;5374.785008599769;5407.702576358338;5471.452854714496;5589;5603.8879222416135;5606.299212598426;5678.488935995781;5281.60387970896;5324.8146946516945;5380.3274590676165;5458.836234912959;5488.286522752017 17:06:03 INFO - 2015-12-17 17:06:03,180 DEBUG : BROWSER_OUTPUT: |1;ext.html;576.4350936082639;584.2346526050874;587.1427715535317;590.3712546138365;604.894143524883;28597.428051438957;37133.514659413624;37633;37664.81167594158;37710.43434348487;41233.793831030875;41454.75635730933;41696;41699.79150104253;41770.37344439828;7495.100587929456;7621.36140729743;8522.829543409143;8683.088275731052;8688.56557172142;9896.851547226797;10004.199664026897;10066.69799906004;10077.647282345119;10096.141827944633;9978.600855965753;10224.312988356913;10224.591016359336;10227.335223210504;10228.386296822215;7721.382289416862;7909.604519773989;10069.949650251738;10270.486475676262;10548.05067543917;9953.800923981553;10073.49632518371;10073.899261007442;10076.748081297952;10078.79842403155;36998.63001370006;37150;37404.812975935216;37449.25101497955;37455.06362340936;3178;3179.5230715392645;3329.9500507492407;3557.3952428087287;3564.4296912494137;29152.562711559345;29257.268568285752;29458.705412946027;29576.55635165474;30304.54543181832;3880.2433525462548;3920.2747491714126;3933.940990885139;3971.5631280559114;3978.3236849735613;270462;271574;272693;273489;274527;52930;54649.45350546444;55603.721981389834;55908;56667.71666141725;49060.75469622629;49199;49260.75369623129;49341.25988110181;49543.50456495389;13045;13055.28195949213;13067.869321306855;13125.343732813511;13159.67100822468;9994.900050999397;10000.599976001024;10013.549390277454;10017;10159.085682288629;18231.63536729258;18315.175817088264;18318.633627327377;18324.26702931868;18332.816671833112;7412.814679633052;7635.847283054308;7678;7724.343430808444;7724.691012359555;885.5483703311357;953.5041778275258;1077.9651534526786;1078.8618008001633;1113.4655365424642;24887.377815554755;25026;26243.212703618923;26681.46637067248;28209.576856347172;1007.385494848142;1014.8680671512656;1045.0907710291942;1104.9558167531604;1127.4137448526885;13360.93319533396;13511.121777084458;13520.86479135196;13679.316034198251;13958;314723;318924;319545;319844;320758;48516.27225591619;48679.756601216766;48744;48803.511964879894;48866.5113348862;1340.1824886819034;1358.7554240236852;1362.50949658123;1369.698666293414;1470.4265336518765;26366.472670546864;26971;27109.855013436;27264.318392039564;27358.17925462239;44377.33433998428;44811.55188448074;44822;44846.10307793891;44853;288888;289250;289295;289751;289787;26778.196654100408;27107.45785084248;29162.854185728935;30378.544321834746;30839.845800770854;35673;35972;36002.09994750152;36030.63969360273;36828.81585592055;33271;33340.33319333648;33649.15877103092;33898.152546186546;34378.65621343755;29272.56091158592;32942.835285823414;33398.833005834815;35394.8230258847;35634.46548301829;31290.21774455566;31520.52719209168;35042.29915401627;36110.638893610725;36292;29465.263368415963;31172;31462;32095.679043210203;32114.19714507156;23823.404414889766;23993.28020159398;24007.63988540208;24113.27660170198;24270 17:06:03 INFO - 2015-12-17 17:06:03,180 DEBUG : BROWSER_OUTPUT: |2;jquery.html;350.35534616306006;351.3079233909198;351.77662184512843;351.9736019798516;354.10411658503983;13888.79166812496;14154.150750954925;15375.692486150285;16004.439844605427;17180.65638687227;14065.226412547307;14137.505187318446;14601.78097328541;14675.706485870276;14693.412263509446;5169.819056333029;5233.65981211222;5289.709066001368;5294.1529355303155;5296.09966305727;3894.844206231747;3950.8222130004074;5279.472052794709;5717.684932465515;5886.793962211324;5439.211314359415;5785.768569257225;5808.157817116516;5832.9708351458185;5842.44496772808;5901.940980590182;5916.230889984317;5918.2306300181135;5927.703614819264;5930.614510056833;5107.591392688576;5206.843794686128;5212.8957420851375;5215.426303106655;5227.372715274153;20304.28934987283;20319;20710.89644551783;20758.58482830335;20778.272760453463;2068.431181425105;2077.5637116205617;2090.4042347930917;2141.7965293297266;2271.897764600597;13107;13228.537001205008;13392;13516.594502164951;13577.728445431136;1781.5100847266976;1830.1764206107173;1861.6928206845855;1881.0782716468832;1886.962260754791;59911.70044149795;62449.37550624526;62662;62824.371756282766;63479.36520634781;9467.66863159786;9677;9908.702738917844;9949.403035817873;10005;13043.086983911035;13054.869451305365;13086.607401777961;13090;13094.738105237842;6986.126734158231;7124.325783440887;7179.174394944544;7252.854942901113;7313.670884810196;6525.151730275129;6543.247526534509;6579.210494740566;6754.425873800782;6789.796306110825;5917.437843404869;5954.523638108941;5979.073243647242;5979.4618484336615;6067.332593414721;1598.1449924290448;1681.7729606502965;1685.1068933465283;1737.9304827806745;1738.2699266308182;942.189716843514;944.4522177137244;1011.6964910526813;1022.805666923297;1078.6440474643348;15615.375384984472;17532.561685957953;17629.471115866545;18008;18500.444986650422;923.6813299411692;946.6828612414918;957.3107362698846;1030.253066526762;1036.404067661098;9918.702438926844;10131.898681013243;10158.13655839247;10555;10650.573977040987;510512;521820;521952;533840;534667;65032.34967650263;66289.6685516579;75560;80415;80987.19012809797;1155.133649762678;1156.7859945910202;1185.5909711149811;1210.6065528703207;1222.5904322052033;15210.239488025332;15275.159866207465;15409.229538523254;15496.302666379814;15685.294161762977;34352.82823585866;34487.827560863036;34622.82688586541;35702.642973569935;36255.27489450143;45604.771976139906;46025.53974460212;47712;49243.50756492389;49604;9065.864012039692;9182.31132665066;9238.861417078884;9276.211522020703;9307.255419566554;11149.554017839195;16359.672806543564;16971.066591337596;17345.56636084108;17475.82524174742;13902.443902243796;14151.363188656329;14191.07757995727;14449.78325325142;14568.344424501134;13703.314834258446;13726.862731372958;13836.930815345859;14203.928980355033;14501.854981450473;14242.71514569682;14328.14031158134;14503.202323872289;14512.492062777752;14773.630659233175;9263.907360926305;9303.395279306824;9386.67146649864;9390.436573805593;9414.15272625467;13015.674608134872;13088.541901033419;13849.446022159002;14194.219317937612;14240.857591423954 17:06:03 INFO - 2015-12-17 17:06:03,180 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1277.1889849945294;1654.6856097341504;1694.788151481065;1731.0911771320054;1731.4978656189705;6575.53971222014;7218.133823941128;7374.115106187265;7393.3345998860095;7395.70417183312;7243.167035790886;7413.592252426128;7413.88879166813;7419.629018549078;7439.628018599075;1876.8217019383137;1909.6371689378973;1910.140436803437;2150.6773983902385;2192.7916847899505;2204.5370472200857;2225.5660146271484;2227.7772222777676;2229.732432108149;2230.130249202812;2081.1779347157863;2099.3701889433187;2179.030331502474;2181.0512427094263;2184.0171922634877;2114.851960362775;2142.2823354176294;2143.303426386415;2162.1675654872906;2164.9891750541224;2184.7159869217057;2206.415299945516;2211.7345918489723;2212.9778702212934;2213.125815302946;6999.755008574675;7069.081019467488;7092.751753688648;7099.006139140524;7105.538140020882;4231.597998190167;4264.488261408651;4282.336237883133;4283.0363168287195;4329.502107257674;2925.166327596646;2925.61966944298;2963.9259018524494;2970.4207679502506;2996.625421822272;966.3235734985539;975.1516180922642;1959.294653924586;1967.4294454608146;1972.2505447929839;9940.204783617293;10071.295009349275;10071.34536255141;10072.748181295527;10081.495925203784;3867.7099217558793;3922.0783115967724;3959.1883663848844;3977.244323578511;3979.064919743858;7953.403494737918;7961.243681850215;7972.481788683833;7985.161558036439;7995.960020199978;4320.719153255029;4344.587264209895;4345.261305578059;4347.891302717394;4352.760598167131;3964.266610676976;3985.4021896715726;3986.461827653288;3996.8601098961976;4001.779902105354;3020.6526249481153;3038;3038.9544156837665;3244.7890887092262;3311.453610154346;1061.7345663584103;1073.683263437288;1077.978440431187;1082.626493859617;1087.3095584304024;1043.8642976413018;1072.3297938788257;1077.8059949209219;1230.7476967221698;1363.1344096498597;6950.652467376611;6985.79042628722;7030.437564994788;7039.507234493536;7072.08062951813;1100.4332768624165;1126.9661910142709;1135.2053562506278;1143.2168964259508;1160.6692092753524;5530.640508366943;5600.327960644749;5660.433956604389;5662.037453632893;5662.801801936913;8259.21537453941;8375.581220938928;8375.623096960651;8376.288015518749;8408.075111737704;7993.120756716757;8186.754397368089;8212.219839115274;8232.300254478316;8252.83494330122;6846.041554182419;6847.21257055435;6858.074159988438;6869.965650171717;6935.7225710971;6698.464122870256;6901.378875901193;6902.344277293649;6902.896456553055;6912.827179320558;7639.961800190964;7720.53676779395;7734.690612375667;7816.570088644951;7832;7850.921490785247;7962.163972782774;7963.442559020813;8027.59862006909;8035.879461807961;6230.283517395557;6319.747210111728;6349.682515874096;6363.87272254543;6367.426931575995;5998.0103282957825;6082.543809214415;7065.0815393998455;7075.752348667772;7230.276972302728;5799.217105690678;6008.098785182083;6049.939500604937;6342.175517182736;6419.871602567829;6024.156618073561;6246.968765156145;6262.3111457738705;6312.368763123651;6336.429721325103;6279.560430769802;6290.748370065329;6307.621542707268;6342.7145778441;6343.5876668016435;5567.8608034797835;5581.023320918905;5598.272224610774;5646;5921.1414344918885;5745.368009519033;5764.077747560538;5792.333881603669;5809.186713860147;5818.679972601548 17:06:03 INFO - 2015-12-17 17:06:03,180 DEBUG : BROWSER_OUTPUT: |4;prototype.html;328.464602697603;328.533482454914;335.74818885835623;338.8983305008497;341.53380635432643;5977.551683623724;6022.87954240916;6052.667103309316;6074.149619053331;6076.969615151918;5667.5749318801045;5755.366909639947;5807.099899515571;5882.264716910387;5887.764489420418;4492.707973981697;4513.074819661978;4521.751303678297;4526.0042790586185;4555.931661025087;4318.244307246219;4553.225951588238;4556.3621093047;4564.42944631921;4576.107659006495;4345.760983145941;4377.978110109445;4471.396361491205;4496.033352829141;4519.887002824939;4469.217886869801;4495.348174514677;4495.662825288116;4501.257292546742;4501.594856462902;3953.743006704584;3969.4442778011103;3971.8808435746973;3978.562358140602;3986.2824691555506;5455.972720136374;5602.243697100921;5606.187102870061;5606.635568688022;5614.129809879475;5252.9737351313;5266.262723218752;5267.3152490176035;5271.604629652753;5275.788968441258;6225.844353891189;6233.96883015582;6239.937600623981;6241.126242326078;6244.656543890084;4395.384646149541;4395.582419670126;4395.780210989437;4397.208502469554;4399.340098985146;6383.489320854367;6455.774047908348;6515.446187074104;6541.6075035498025;6548.214214294268;4546.681732278775;4550.317452382103;4550.49944506104;4556.248219043887;4564.634829213722;4588.541145885385;4618.445786505641;4620.4686461056735;4620.745858977789;4629.189891768927;5299.682019078868;5300.549453296513;5303.204519322133;5308;5314.043472175045;6169.722362493609;6346.873062538816;6350.7459701611415;6357.14178585885;6359.427651511386;1619.9514014579581;1635.6728654269193;1637.516932504914;1639.9262033208533;1640.1799100449775;1100.7303210713426;1116.6315116011697;1121.8613107695696;1131.8754936956927;1133.920625556203;6078.635281883101;6091.299500557404;6096.664683442365;6102.115193297036;6102.389761023862;6458;6511.739530418825;6511.902321465182;6521.347865213441;6524.804255872332;5865.149553314745;5964.612300200473;6016.338202797689;6146.631202127797;6152.292486364126;3523;3540;3542.9017004728103;3545.6808887200277;3549.6450354964813;6681.064650948871;6694.665266736643;6701.195856497252;6706.932930670729;6720.764773232913;6633.568818026813;6735.528513004141;6735.629540375228;6758.256591774901;6763.966180169067;6671.566348187449;6672.5996440212775;6678.465722742072;6679.79960601173;6686.598804071771;6568.47452203813;6570.638614876228;6571.704273307808;6574.342565743387;6576.901346479903;6334.9366506334345;6491.058796474579;6493.480521558169;6494.765994461038;6517.576357536745;6620.8344791380605;6680.465562754871;6684.799456016327;6685;6702.262751097473;4603.079384123122;4606.88482787933;4610.054938737618;4610.585047345755;4612.907741845212;6451.387118223761;6575.178102737158;6580.703868325841;6582.506312026521;6583.572067815577;6377.553571249968;6404.455621272244;6406.167198264196;6407.423331900151;6410.166678331973;6334.1765570475545;6363.1091647168505;6386.584871983307;6394.936050639434;6395.42441180296;6154.261488621394;6242.063690446469;6253.530985176221;6254.312025677081;6268.310485846644;6397.912354899771;6408.551401401857;6412.422881940648;6413.583117097373;6417.839554011187;6253.78111766086;6258.904691679029;6259.812205633838;6260.311365749672;6265.624062556261 17:06:03 INFO - 2015-12-17 17:06:03,182 DEBUG : BROWSER_OUTPUT: |5;yui.html;769.7756554733825;776.6431756076514;797.8045378882175;834.4909605140865;875.3347455933491;12758.425870835812;13020.54428095017;13050.543230986905;13061.477540898377;13075.869241307571;12532.624021279353;12589.496420143207;12606.93696531516;14261.643458913532;14466.421343146261;831.226958928195;841.6170642357744;842.5871323051691;842.7092653034724;844.0167205205959;688.102026854954;695.7286658203304;823.3454403749034;843.780617039568;845.5729856422498;877.1404024056396;877.6664867350398;884.4914174349742;885.1635204731531;885.2608072259671;705.414505960057;713.8465229975528;870.2950610005915;874.0865795243985;874.1215078845751;627.0061951806392;635.0315768453099;635.4598591197491;635.4820821030892;635.8728254349148;13704.314784260747;13815.861841381558;13818.792718109236;13822.37799299034;13824.377902994289;11268.549258029669;11450.599229026944;11645.12661550387;12139.271643701406;12242.265464072185;10082.647107351208;10163.831159416688;10165.695029149138;10288.845667314996;10406.323588966692;3521.2077282611463;3541.929161416783;3559;3572.964270357315;3661.121330880596;46913;47479.287810682865;47598.76200618975;47679.28481072787;48256.7587162062;9509.809803804024;9513.238940884712;9716.6275176171;9808.852867206997;9907.45508997012;17992.37026704059;18033.098345082693;18082;18100.27598896056;18130.09349532518;7460.253974602496;7550.169481357047;7642.312191902755;7654.502457340255;7845.529268243924;4103.302438585448;4116.5060192777055;4246.278132717445;4266.466691663542;4278.080212754273;2947.322115913352;2983.9104826855228;2989.4320079184886;2992.2369795701957;2992.3716019635685;537.0494225221337;553.0846449126702;555.4612026334449;556.3268445181376;567.7445149682659;493.56671608968134;563.0669771645056;639.3510586754448;691.339770519153;701.0430762009921;8161.918380816234;8573.18554737299;8585.31317494599;8738.95630521856;8792.38453308275;530.3556179242162;531.7421050790364;533.5384892068333;543.429399130911;652.9347065293433;3748.475213470116;3877.6122387760997;3975;3989.7007724420782;3999.3601023836627;52391.73804130955;53060.20409693858;53543.464565354625;53880.19179712307;53946;47882;48594.75702621535;49325;49361;49754.50245497499;43546.34680479732;43669.563304367184;43757.78121109438;43851.342229866576;44076.77961610172;7907.920920790949;8087.393445491729;8110.737222437348;8313.542755148525;8394.160583941557;33396.165095871824;33644.66355336415;33790.324193516484;33944;34094.147646309044;41617.58382416137;42813;43129.784351079295;43167.78416107899;43176.56823431851;9967.651132210338;10173;10184.439855807705;10354.637587684394;10537.73655658584;11130.888691112985;11145.164112691742;11202.271852329572;11322.207445478738;11437.942810285895;10201.38791672502;10352.844707329245;10538.367697938149;10593.311434756715;10685.626003090165;10288.382697038202;10416.427096509764;10767.676969690921;11036;11208.719782005515;8752.256058235122;9961.40231586107;10192.28653994243;10277.74305642365;10285.228607854591;9516.524173791144;9528.19010384125;9761.36335240755;9787.217022638315;10212.08091271789;8612;9168.266538677024;9510.393778117332;9708.126268635857;9728.756781080247 17:06:03 INFO - 2015-12-17 17:06:03,182 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:06:03 INFO - 2015-12-17 17:06:03,182 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:06:03 INFO - 2015-12-17 17:06:03,182 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,910 17:06:03 INFO - 2015-12-17 17:06:03,182 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:06:03 INFO - 2015-12-17 17:06:03,182 DEBUG : BROWSER_OUTPUT: __startTimestamp1450400763172__endTimestamp 17:06:03 INFO - 2015-12-17 17:06:03,182 DEBUG : BROWSER_OUTPUT: 17:06:03 INFO - 2015-12-17 17:06:03,182 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:06:03 INFO - 2015-12-17 17:06:03,183 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:06:03 INFO - 2015-12-17 17:06:03,183 DEBUG : BROWSER_OUTPUT: 17:06:03 INFO - 2015-12-17 17:06:03,183 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5166.35 Median:5361.95 stddev:555.98 (10.4%) stddev-sans-first:532.77 17:06:03 INFO - 2015-12-17 17:06:03,183 DEBUG : BROWSER_OUTPUT: Values: 3068.1 3095.2 3144.1 3145.6 3164.3 4880.1 4995.1 5167.5 5187.7 5204.4 5115.9 5131.8 5239.2 5244.9 5247.3 4683.9 4720.7 4729.8 4743.4 4842.3 4802.8 4845.5 4890.5 4898.5 4939.1 4583.0 4672.5 4690.9 4820.3 4834.2 4726.2 4743.6 4750.5 4754.2 4762.3 4697.7 4698.2 4705.5 4706.2 4715.3 4925.8 4999.0 5034.0 5035.5 5037.2 5606.1 5614.4 5614.7 5619.1 5619.9 5307.3 5395.7 5648.9 5655.3 5705.2 5204.3 5274.1 5307.9 5312.4 5321.5 5652.3 5674.8 5698.5 5700.9 5700.9 5294.9 5543.7 5544.7 5546.8 5547.6 5389.2 5455.6 5462.9 5488.5 5501.6 5539.4 5539.9 5551.5 5552.6 5554.9 5378.8 5549.5 5551.6 5556.1 5605.8 4212.6 4298.1 4305.5 4340.6 4346.9 3859.0 3859.3 3872.9 3900.4 3904.4 5209.4 5214.1 5216.1 5221.4 5223.2 5451.0 5461.8 5495.7 5545.3 5553.8 5188.6 5190.5 5206.1 5214.9 5256.2 4895.1 4907.0 4909.8 4913.5 4956.7 5476.8 5554.5 5561.9 5676.5 5705.7 5503.6 5503.6 5503.9 5525.0 5571.3 5676.1 5713.9 5714.1 5716.2 5727.3 5353.9 5397.2 5451.4 5537.3 5557.9 5542.4 5542.5 5564.1 5565.2 5581.8 5447.2 5451.2 5452.1 5483.3 5508.1 5356.7 5461.8 5466.2 5468.7 5490.3 5303.3 5361.9 5366.9 5374.8 5407.7 5471.5 5589.0 5603.9 5606.3 5678.5 5281.6 5324.8 5380.3 5458.8 5488.3 17:06:03 INFO - 2015-12-17 17:06:03,183 DEBUG : BROWSER_OUTPUT: 17:06:03 INFO - 2015-12-17 17:06:03,183 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44975.37 Median:3178.76 stddev:76922.10 (2419.9%) stddev-sans-first:77065.65 17:06:03 INFO - 2015-12-17 17:06:03,184 DEBUG : BROWSER_OUTPUT: Values: 576.4 584.2 587.1 590.4 604.9 28597.4 37133.5 37633.0 37664.8 37710.4 41233.8 41454.8 41696.0 41699.8 41770.4 7495.1 7621.4 8522.8 8683.1 8688.6 9896.9 10004.2 10066.7 10077.6 10096.1 9978.6 10224.3 10224.6 10227.3 10228.4 7721.4 7909.6 10069.9 10270.5 10548.1 9953.8 10073.5 10073.9 10076.7 10078.8 36998.6 37150.0 37404.8 37449.3 37455.1 3178.0 3179.5 3330.0 3557.4 3564.4 29152.6 29257.3 29458.7 29576.6 30304.5 3880.2 3920.3 3933.9 3971.6 3978.3 270462.0 271574.0 272693.0 273489.0 274527.0 52930.0 54649.5 55603.7 55908.0 56667.7 49060.8 49199.0 49260.8 49341.3 49543.5 13045.0 13055.3 13067.9 13125.3 13159.7 9994.9 10000.6 10013.5 10017.0 10159.1 18231.6 18315.2 18318.6 18324.3 18332.8 7412.8 7635.8 7678.0 7724.3 7724.7 885.5 953.5 1078.0 1078.9 1113.5 24887.4 25026.0 26243.2 26681.5 28209.6 1007.4 1014.9 1045.1 1105.0 1127.4 13360.9 13511.1 13520.9 13679.3 13958.0 314723.0 318924.0 319545.0 319844.0 320758.0 48516.3 48679.8 48744.0 48803.5 48866.5 1340.2 1358.8 1362.5 1369.7 1470.4 26366.5 26971.0 27109.9 27264.3 27358.2 44377.3 44811.6 44822.0 44846.1 44853.0 288888.0 289250.0 289295.0 289751.0 289787.0 26778.2 27107.5 29162.9 30378.5 30839.8 35673.0 35972.0 36002.1 36030.6 36828.8 33271.0 33340.3 33649.2 33898.2 34378.7 29272.6 32942.8 33398.8 35394.8 35634.5 31290.2 31520.5 35042.3 36110.6 36292.0 29465.3 31172.0 31462.0 32095.7 32114.2 23823.4 23993.3 24007.6 24113.3 24270.0 17:06:03 INFO - 2015-12-17 17:06:03,185 DEBUG : BROWSER_OUTPUT: 17:06:03 INFO - 2015-12-17 17:06:03,185 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28327.23 Median:34420.33 stddev:85660.30 (248.9%) stddev-sans-first:85874.84 17:06:03 INFO - 2015-12-17 17:06:03,185 DEBUG : BROWSER_OUTPUT: Values: 350.4 351.3 351.8 352.0 354.1 13888.8 14154.2 15375.7 16004.4 17180.7 14065.2 14137.5 14601.8 14675.7 14693.4 5169.8 5233.7 5289.7 5294.2 5296.1 3894.8 3950.8 5279.5 5717.7 5886.8 5439.2 5785.8 5808.2 5833.0 5842.4 5901.9 5916.2 5918.2 5927.7 5930.6 5107.6 5206.8 5212.9 5215.4 5227.4 20304.3 20319.0 20710.9 20758.6 20778.3 2068.4 2077.6 2090.4 2141.8 2271.9 13107.0 13228.5 13392.0 13516.6 13577.7 1781.5 1830.2 1861.7 1881.1 1887.0 59911.7 62449.4 62662.0 62824.4 63479.4 9467.7 9677.0 9908.7 9949.4 10005.0 13043.1 13054.9 13086.6 13090.0 13094.7 6986.1 7124.3 7179.2 7252.9 7313.7 6525.2 6543.2 6579.2 6754.4 6789.8 5917.4 5954.5 5979.1 5979.5 6067.3 1598.1 1681.8 1685.1 1737.9 1738.3 942.2 944.5 1011.7 1022.8 1078.6 15615.4 17532.6 17629.5 18008.0 18500.4 923.7 946.7 957.3 1030.3 1036.4 9918.7 10131.9 10158.1 10555.0 10650.6 510512.0 521820.0 521952.0 533840.0 534667.0 65032.3 66289.7 75560.0 80415.0 80987.2 1155.1 1156.8 1185.6 1210.6 1222.6 15210.2 15275.2 15409.2 15496.3 15685.3 34352.8 34487.8 34622.8 35702.6 36255.3 45604.8 46025.5 47712.0 49243.5 49604.0 9065.9 9182.3 9238.9 9276.2 9307.3 11149.6 16359.7 16971.1 17345.6 17475.8 13902.4 14151.4 14191.1 14449.8 14568.3 13703.3 13726.9 13836.9 14203.9 14501.9 14242.7 14328.1 14503.2 14512.5 14773.6 9263.9 9303.4 9386.7 9390.4 9414.2 13015.7 13088.5 13849.4 14194.2 14240.9 17:06:03 INFO - 2015-12-17 17:06:03,185 DEBUG : BROWSER_OUTPUT: 17:06:03 INFO - 2015-12-17 17:06:03,185 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5037.56 Median:5704.08 stddev:2529.76 (44.3%) stddev-sans-first:2521.06 17:06:03 INFO - 2015-12-17 17:06:03,185 DEBUG : BROWSER_OUTPUT: Values: 1277.2 1654.7 1694.8 1731.1 1731.5 6575.5 7218.1 7374.1 7393.3 7395.7 7243.2 7413.6 7413.9 7419.6 7439.6 1876.8 1909.6 1910.1 2150.7 2192.8 2204.5 2225.6 2227.8 2229.7 2230.1 2081.2 2099.4 2179.0 2181.1 2184.0 2114.9 2142.3 2143.3 2162.2 2165.0 2184.7 2206.4 2211.7 2213.0 2213.1 6999.8 7069.1 7092.8 7099.0 7105.5 4231.6 4264.5 4282.3 4283.0 4329.5 2925.2 2925.6 2963.9 2970.4 2996.6 966.3 975.2 1959.3 1967.4 1972.3 9940.2 10071.3 10071.3 10072.7 10081.5 3867.7 3922.1 3959.2 3977.2 3979.1 7953.4 7961.2 7972.5 7985.2 7996.0 4320.7 4344.6 4345.3 4347.9 4352.8 3964.3 3985.4 3986.5 3996.9 4001.8 3020.7 3038.0 3039.0 3244.8 3311.5 1061.7 1073.7 1078.0 1082.6 1087.3 1043.9 1072.3 1077.8 1230.7 1363.1 6950.7 6985.8 7030.4 7039.5 7072.1 1100.4 1127.0 1135.2 1143.2 1160.7 5530.6 5600.3 5660.4 5662.0 5662.8 8259.2 8375.6 8375.6 8376.3 8408.1 7993.1 8186.8 8212.2 8232.3 8252.8 6846.0 6847.2 6858.1 6870.0 6935.7 6698.5 6901.4 6902.3 6902.9 6912.8 7640.0 7720.5 7734.7 7816.6 7832.0 7850.9 7962.2 7963.4 8027.6 8035.9 6230.3 6319.7 6349.7 6363.9 6367.4 5998.0 6082.5 7065.1 7075.8 7230.3 5799.2 6008.1 6049.9 6342.2 6419.9 6024.2 6247.0 6262.3 6312.4 6336.4 6279.6 6290.7 6307.6 6342.7 6343.6 5567.9 5581.0 5598.3 5646.0 5921.1 5745.4 5764.1 5792.3 5809.2 5818.7 17:06:03 INFO - 2015-12-17 17:06:03,185 DEBUG : BROWSER_OUTPUT: 17:06:03 INFO - 2015-12-17 17:06:03,185 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5290.59 Median:6063.41 stddev:1585.13 (26.1%) stddev-sans-first:1545.20 17:06:03 INFO - 2015-12-17 17:06:03,187 DEBUG : BROWSER_OUTPUT: Values: 328.5 328.5 335.7 338.9 341.5 5977.6 6022.9 6052.7 6074.1 6077.0 5667.6 5755.4 5807.1 5882.3 5887.8 4492.7 4513.1 4521.8 4526.0 4555.9 4318.2 4553.2 4556.4 4564.4 4576.1 4345.8 4378.0 4471.4 4496.0 4519.9 4469.2 4495.3 4495.7 4501.3 4501.6 3953.7 3969.4 3971.9 3978.6 3986.3 5456.0 5602.2 5606.2 5606.6 5614.1 5253.0 5266.3 5267.3 5271.6 5275.8 6225.8 6234.0 6239.9 6241.1 6244.7 4395.4 4395.6 4395.8 4397.2 4399.3 6383.5 6455.8 6515.4 6541.6 6548.2 4546.7 4550.3 4550.5 4556.2 4564.6 4588.5 4618.4 4620.5 4620.7 4629.2 5299.7 5300.5 5303.2 5308.0 5314.0 6169.7 6346.9 6350.7 6357.1 6359.4 1620.0 1635.7 1637.5 1639.9 1640.2 1100.7 1116.6 1121.9 1131.9 1133.9 6078.6 6091.3 6096.7 6102.1 6102.4 6458.0 6511.7 6511.9 6521.3 6524.8 5865.1 5964.6 6016.3 6146.6 6152.3 3523.0 3540.0 3542.9 3545.7 3549.6 6681.1 6694.7 6701.2 6706.9 6720.8 6633.6 6735.5 6735.6 6758.3 6764.0 6671.6 6672.6 6678.5 6679.8 6686.6 6568.5 6570.6 6571.7 6574.3 6576.9 6334.9 6491.1 6493.5 6494.8 6517.6 6620.8 6680.5 6684.8 6685.0 6702.3 4603.1 4606.9 4610.1 4610.6 4612.9 6451.4 6575.2 6580.7 6582.5 6583.6 6377.6 6404.5 6406.2 6407.4 6410.2 6334.2 6363.1 6386.6 6394.9 6395.4 6154.3 6242.1 6253.5 6254.3 6268.3 6397.9 6408.6 6412.4 6413.6 6417.8 6253.8 6258.9 6259.8 6260.3 6265.6 17:06:03 INFO - 2015-12-17 17:06:03,187 DEBUG : BROWSER_OUTPUT: 17:06:03 INFO - 2015-12-17 17:06:03,187 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13258.58 Median:47639.02 stddev:15196.60 (31.9%) stddev-sans-first:15210.29 17:06:03 INFO - 2015-12-17 17:06:03,187 DEBUG : BROWSER_OUTPUT: Values: 769.8 776.6 797.8 834.5 875.3 12758.4 13020.5 13050.5 13061.5 13075.9 12532.6 12589.5 12606.9 14261.6 14466.4 831.2 841.6 842.6 842.7 844.0 688.1 695.7 823.3 843.8 845.6 877.1 877.7 884.5 885.2 885.3 705.4 713.8 870.3 874.1 874.1 627.0 635.0 635.5 635.5 635.9 13704.3 13815.9 13818.8 13822.4 13824.4 11268.5 11450.6 11645.1 12139.3 12242.3 10082.6 10163.8 10165.7 10288.8 10406.3 3521.2 3541.9 3559.0 3573.0 3661.1 46913.0 47479.3 47598.8 47679.3 48256.8 9509.8 9513.2 9716.6 9808.9 9907.5 17992.4 18033.1 18082.0 18100.3 18130.1 7460.3 7550.2 7642.3 7654.5 7845.5 4103.3 4116.5 4246.3 4266.5 4278.1 2947.3 2983.9 2989.4 2992.2 2992.4 537.0 553.1 555.5 556.3 567.7 493.6 563.1 639.4 691.3 701.0 8161.9 8573.2 8585.3 8739.0 8792.4 530.4 531.7 533.5 543.4 652.9 3748.5 3877.6 3975.0 3989.7 3999.4 52391.7 53060.2 53543.5 53880.2 53946.0 47882.0 48594.8 49325.0 49361.0 49754.5 43546.3 43669.6 43757.8 43851.3 44076.8 7907.9 8087.4 8110.7 8313.5 8394.2 33396.2 33644.7 33790.3 33944.0 34094.1 41617.6 42813.0 43129.8 43167.8 43176.6 9967.7 10173.0 10184.4 10354.6 10537.7 11130.9 11145.2 11202.3 11322.2 11437.9 10201.4 10352.8 10538.4 10593.3 10685.6 10288.4 10416.4 10767.7 11036.0 11208.7 8752.3 9961.4 10192.3 10277.7 10285.2 9516.5 9528.2 9761.4 9787.2 10212.1 8612.0 9168.3 9510.4 9708.1 9728.8 17:06:03 INFO - 2015-12-17 17:06:03,187 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:06:03 INFO - 2015-12-17 17:06:03,187 DEBUG : BROWSER_OUTPUT: 17:06:03 INFO - 2015-12-17 17:06:03,889 INFO : Browser exited with error code: 0 17:06:03 INFO - 2015-12-17 17:06:03,905 INFO : Completed test dromaeo_css (00:18:32) 17:06:03 INFO - 2015-12-17 17:06:03,906 INFO : Starting test kraken 17:06:03 INFO - 2015-12-17 17:06:03,906 DEBUG : operating with platform_type : linux_ 17:06:03 INFO - 2015-12-17 17:06:03,906 INFO : Initialising browser for kraken test... 17:06:03 INFO - 2015-12-17 17:06:03,912 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgLF_Cd/profile http://localhost:34551/getInfo.html 17:06:07 INFO - 2015-12-17 17:06:07,967 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:06:07 INFO - 2015-12-17 17:06:07,967 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:06:07 INFO - 2015-12-17 17:06:07,967 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:06:07 INFO - 2015-12-17 17:06:07,967 DEBUG : BROWSER_OUTPUT: __metrics 17:06:08 INFO - 2015-12-17 17:06:08,069 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] 17:06:08 INFO - 2015-12-17 17:06:08,125 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] 17:06:09 INFO - 2015-12-17 17:06:09,331 INFO : Browser initialized. 17:06:09 INFO - 2015-12-17 17:06:09,332 INFO : Running cycle 1/1 for kraken test... 17:06:09 INFO - 2015-12-17 17:06:09,332 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgLF_Cd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:06:21 INFO - 2015-12-17 17:06:21,175 DEBUG : BROWSER_OUTPUT: RSS: Main: 149749760 17:06:21 INFO - 2015-12-17 17:06:21,175 DEBUG : BROWSER_OUTPUT: 17:06:23 INFO - 2015-12-17 17:06:23,676 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34551/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34551/tests/kraken/driver.html?testName=audio-beat-detection) 17:06:24 INFO - 2015-12-17 17:06:24,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 186499072 17:06:24 INFO - 2015-12-17 17:06:24,258 DEBUG : BROWSER_OUTPUT: 17:06:26 INFO - 2015-12-17 17:06:26,838 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34551/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34551/tests/kraken/driver.html?testName=audio-dft) 17:06:27 INFO - 2015-12-17 17:06:27,419 DEBUG : BROWSER_OUTPUT: RSS: Main: 175603712 17:06:27 INFO - 2015-12-17 17:06:27,420 DEBUG : BROWSER_OUTPUT: 17:06:30 INFO - 2015-12-17 17:06:30,385 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34551/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34551/tests/kraken/driver.html?testName=audio-fft) 17:06:30 INFO - 2015-12-17 17:06:30,946 DEBUG : BROWSER_OUTPUT: RSS: Main: 160645120 17:06:30 INFO - 2015-12-17 17:06:30,946 DEBUG : BROWSER_OUTPUT: 17:06:32 INFO - 2015-12-17 17:06:32,902 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34551/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34551/tests/kraken/driver.html?testName=audio-oscillator) 17:06:33 INFO - 2015-12-17 17:06:33,469 DEBUG : BROWSER_OUTPUT: RSS: Main: 163536896 17:06:33 INFO - 2015-12-17 17:06:33,469 DEBUG : BROWSER_OUTPUT: 17:06:35 INFO - 2015-12-17 17:06:35,723 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34551/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34551/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:06:36 INFO - 2015-12-17 17:06:36,284 DEBUG : BROWSER_OUTPUT: RSS: Main: 165179392 17:06:36 INFO - 2015-12-17 17:06:36,285 DEBUG : BROWSER_OUTPUT: 17:06:39 INFO - 2015-12-17 17:06:39,150 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34551/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34551/tests/kraken/driver.html?testName=imaging-darkroom) 17:06:39 INFO - 2015-12-17 17:06:39,724 DEBUG : BROWSER_OUTPUT: RSS: Main: 165998592 17:06:39 INFO - 2015-12-17 17:06:39,724 DEBUG : BROWSER_OUTPUT: 17:06:43 INFO - 2015-12-17 17:06:43,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34551/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34551/tests/kraken/driver.html?testName=imaging-desaturate) 17:06:43 INFO - 2015-12-17 17:06:43,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 165273600 17:06:43 INFO - 2015-12-17 17:06:43,635 DEBUG : BROWSER_OUTPUT: 17:06:46 INFO - 2015-12-17 17:06:46,344 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34551/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34551/tests/kraken/driver.html?testName=json-parse-financial) 17:06:46 INFO - 2015-12-17 17:06:46,917 DEBUG : BROWSER_OUTPUT: RSS: Main: 165285888 17:06:46 INFO - 2015-12-17 17:06:46,918 DEBUG : BROWSER_OUTPUT: 17:06:48 INFO - 2015-12-17 17:06:48,471 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34551/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34551/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:06:49 INFO - 2015-12-17 17:06:49,045 DEBUG : BROWSER_OUTPUT: RSS: Main: 175878144 17:06:49 INFO - 2015-12-17 17:06:49,045 DEBUG : BROWSER_OUTPUT: 17:06:50 INFO - 2015-12-17 17:06:50,847 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34551/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34551/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:06:51 INFO - 2015-12-17 17:06:51,440 DEBUG : BROWSER_OUTPUT: RSS: Main: 173092864 17:06:51 INFO - 2015-12-17 17:06:51,441 DEBUG : BROWSER_OUTPUT: 17:06:53 INFO - 2015-12-17 17:06:53,472 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34551/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34551/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:06:54 INFO - 2015-12-17 17:06:54,045 DEBUG : BROWSER_OUTPUT: RSS: Main: 186789888 17:06:54 INFO - 2015-12-17 17:06:54,045 DEBUG : BROWSER_OUTPUT: 17:06:56 INFO - 2015-12-17 17:06:56,431 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34551/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34551/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:06:57 INFO - 2015-12-17 17:06:57,013 DEBUG : BROWSER_OUTPUT: RSS: Main: 194093056 17:06:57 INFO - 2015-12-17 17:06:57,013 DEBUG : BROWSER_OUTPUT: 17:06:59 INFO - 2015-12-17 17:06:59,549 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34551/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34551/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:07:00 INFO - 2015-12-17 17:07:00,118 DEBUG : BROWSER_OUTPUT: RSS: Main: 191426560 17:07:00 INFO - 2015-12-17 17:07:00,118 DEBUG : BROWSER_OUTPUT: 17:07:01 INFO - 2015-12-17 17:07:01,787 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34551/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34551/tests/kraken/driver.html?testName=ai-astar) 17:07:02 INFO - 2015-12-17 17:07:02,045 DEBUG : BROWSER_OUTPUT: RSS: Main: 249286656 17:07:02 INFO - 2015-12-17 17:07:02,045 DEBUG : BROWSER_OUTPUT: 17:07:02 INFO - 2015-12-17 17:07:02,045 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:07:02 INFO - 2015-12-17 17:07:02,045 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:07:02 INFO - 2015-12-17 17:07:02,045 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:07:02 INFO - 2015-12-17 17:07:02,045 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:07:02 INFO - 2015-12-17 17:07:02,046 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;112;107;113;112;112;101;112;111;119 17:07:02 INFO - 2015-12-17 17:07:02,046 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;127;148;161;129;159;152;124;165;122 17:07:02 INFO - 2015-12-17 17:07:02,046 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;161;158;164;163;159;162;163;161 17:07:02 INFO - 2015-12-17 17:07:02,046 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;84;92;72;71;72;96;92;72 17:07:02 INFO - 2015-12-17 17:07:02,046 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;93;137;94;101;94;148;93;93;139 17:07:02 INFO - 2015-12-17 17:07:02,046 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;110;109;109;109;110;109;109 17:07:02 INFO - 2015-12-17 17:07:02,046 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;144;145;145;145;145;144;145;146 17:07:02 INFO - 2015-12-17 17:07:02,047 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;96;96;95;95;95;95;95 17:07:02 INFO - 2015-12-17 17:07:02,047 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;58;58;58;59;59;60;59;58;57 17:07:02 INFO - 2015-12-17 17:07:02,047 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;69;69;69;69;69;69;68 17:07:02 INFO - 2015-12-17 17:07:02,047 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;83;86;84;85;84;84;83;86;84 17:07:02 INFO - 2015-12-17 17:07:02,047 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;116;118;115;130;114;117;125;123;117 17:07:02 INFO - 2015-12-17 17:07:02,048 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;141;153;153;142;141;155;151;153;139 17:07:02 INFO - 2015-12-17 17:07:02,048 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;68;69;67;69;67;68;66;66;66 17:07:02 INFO - 2015-12-17 17:07:02,048 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:07:02 INFO - 2015-12-17 17:07:02,048 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:07:02 INFO - 2015-12-17 17:07:02,048 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,928 17:07:02 INFO - 2015-12-17 17:07:02,048 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:07:02 INFO - 2015-12-17 17:07:02,048 DEBUG : BROWSER_OUTPUT: __startTimestamp1450400822039__endTimestamp 17:07:02 INFO - 2015-12-17 17:07:02,049 DEBUG : BROWSER_OUTPUT: 17:07:02 INFO - 2015-12-17 17:07:02,049 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:07:02 INFO - 2015-12-17 17:07:02,049 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:07:02 INFO - 2015-12-17 17:07:02,049 DEBUG : BROWSER_OUTPUT: 17:07:02 INFO - 2015-12-17 17:07:02,049 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:4.58 (4.1%) stddev-sans-first:4.85 17:07:02 INFO - 2015-12-17 17:07:02,049 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 107.0 113.0 112.0 112.0 101.0 112.0 111.0 119.0 17:07:02 INFO - 2015-12-17 17:07:02,049 DEBUG : BROWSER_OUTPUT: 17:07:02 INFO - 2015-12-17 17:07:02,051 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.10 Median:153.00 stddev:16.78 (11.0%) stddev-sans-first:17.41 17:07:02 INFO - 2015-12-17 17:07:02,051 DEBUG : BROWSER_OUTPUT: Values: 154.0 127.0 148.0 161.0 129.0 159.0 152.0 124.0 165.0 122.0 17:07:02 INFO - 2015-12-17 17:07:02,051 DEBUG : BROWSER_OUTPUT: 17:07:02 INFO - 2015-12-17 17:07:02,051 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.87 (1.2%) stddev-sans-first:1.94 17:07:02 INFO - 2015-12-17 17:07:02,051 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 161.0 158.0 164.0 163.0 159.0 162.0 163.0 161.0 17:07:02 INFO - 2015-12-17 17:07:02,051 DEBUG : BROWSER_OUTPUT: 17:07:02 INFO - 2015-12-17 17:07:02,051 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.60 Median:78.50 stddev:10.24 (13.0%) stddev-sans-first:10.49 17:07:02 INFO - 2015-12-17 17:07:02,051 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 84.0 92.0 72.0 71.0 72.0 96.0 92.0 72.0 17:07:02 INFO - 2015-12-17 17:07:02,051 DEBUG : BROWSER_OUTPUT: 17:07:02 INFO - 2015-12-17 17:07:02,051 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:108.60 Median:93.00 stddev:22.88 (24.6%) stddev-sans-first:23.65 17:07:02 INFO - 2015-12-17 17:07:02,051 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 137.0 94.0 101.0 94.0 148.0 93.0 93.0 139.0 17:07:02 INFO - 2015-12-17 17:07:02,052 DEBUG : BROWSER_OUTPUT: 17:07:02 INFO - 2015-12-17 17:07:02,052 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:07:02 INFO - 2015-12-17 17:07:02,052 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 110.0 109.0 109.0 109.0 110.0 109.0 109.0 17:07:02 INFO - 2015-12-17 17:07:02,052 DEBUG : BROWSER_OUTPUT: 17:07:02 INFO - 2015-12-17 17:07:02,052 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 17:07:02 INFO - 2015-12-17 17:07:02,052 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 144.0 145.0 145.0 145.0 145.0 144.0 145.0 146.0 17:07:02 INFO - 2015-12-17 17:07:02,052 DEBUG : BROWSER_OUTPUT: 17:07:02 INFO - 2015-12-17 17:07:02,052 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:07:02 INFO - 2015-12-17 17:07:02,053 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 17:07:02 INFO - 2015-12-17 17:07:02,053 DEBUG : BROWSER_OUTPUT: 17:07:02 INFO - 2015-12-17 17:07:02,053 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.60 Median:59.00 stddev:0.97 (1.6%) stddev-sans-first:0.88 17:07:02 INFO - 2015-12-17 17:07:02,053 DEBUG : BROWSER_OUTPUT: Values: 60.0 58.0 58.0 58.0 59.0 59.0 60.0 59.0 58.0 57.0 17:07:02 INFO - 2015-12-17 17:07:02,053 DEBUG : BROWSER_OUTPUT: 17:07:02 INFO - 2015-12-17 17:07:02,053 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 17:07:02 INFO - 2015-12-17 17:07:02,054 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 69.0 69.0 69.0 69.0 69.0 68.0 17:07:02 INFO - 2015-12-17 17:07:02,054 DEBUG : BROWSER_OUTPUT: 17:07:02 INFO - 2015-12-17 17:07:02,054 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:1.14 (1.4%) stddev-sans-first:1.12 17:07:02 INFO - 2015-12-17 17:07:02,054 DEBUG : BROWSER_OUTPUT: Values: 83.0 83.0 86.0 84.0 85.0 84.0 84.0 83.0 86.0 84.0 17:07:02 INFO - 2015-12-17 17:07:02,054 DEBUG : BROWSER_OUTPUT: 17:07:02 INFO - 2015-12-17 17:07:02,054 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.20 Median:117.50 stddev:5.12 (4.4%) stddev-sans-first:5.36 17:07:02 INFO - 2015-12-17 17:07:02,054 DEBUG : BROWSER_OUTPUT: Values: 117.0 116.0 118.0 115.0 130.0 114.0 117.0 125.0 123.0 117.0 17:07:02 INFO - 2015-12-17 17:07:02,055 DEBUG : BROWSER_OUTPUT: 17:07:02 INFO - 2015-12-17 17:07:02,055 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.00 Median:152.00 stddev:6.45 (4.2%) stddev-sans-first:6.58 17:07:02 INFO - 2015-12-17 17:07:02,055 DEBUG : BROWSER_OUTPUT: Values: 142.0 141.0 153.0 153.0 142.0 141.0 155.0 151.0 153.0 139.0 17:07:02 INFO - 2015-12-17 17:07:02,055 DEBUG : BROWSER_OUTPUT: 17:07:02 INFO - 2015-12-17 17:07:02,055 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:1.17 (1.7%) stddev-sans-first:1.22 17:07:02 INFO - 2015-12-17 17:07:02,055 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 69.0 67.0 69.0 67.0 68.0 66.0 66.0 66.0 17:07:02 INFO - 2015-12-17 17:07:02,056 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:07:02 INFO - 2015-12-17 17:07:02,056 DEBUG : BROWSER_OUTPUT: 17:07:02 INFO - 2015-12-17 17:07:02,857 INFO : Browser exited with error code: 0 17:07:02 INFO - 2015-12-17 17:07:02,906 INFO : Completed test kraken (00:00:59) 17:07:02 INFO - 2015-12-17 17:07:02,906 INFO : Starting test v8_7 17:07:02 INFO - 2015-12-17 17:07:02,906 DEBUG : operating with platform_type : linux_ 17:07:02 INFO - 2015-12-17 17:07:02,906 INFO : Initialising browser for v8_7 test... 17:07:02 INFO - 2015-12-17 17:07:02,912 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCsjVPC/profile http://localhost:34551/getInfo.html 17:07:06 INFO - 2015-12-17 17:07:06,962 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:07:06 INFO - 2015-12-17 17:07:06,962 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:07:06 INFO - 2015-12-17 17:07:06,962 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:07:06 INFO - 2015-12-17 17:07:06,962 DEBUG : BROWSER_OUTPUT: __metrics 17:07:07 INFO - 2015-12-17 17:07:07,139 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] 17:07:07 INFO - 2015-12-17 17:07:07,195 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] 17:07:08 INFO - 2015-12-17 17:07:08,231 INFO : Browser initialized. 17:07:08 INFO - 2015-12-17 17:07:08,232 INFO : Running cycle 1/1 for v8_7 test... 17:07:08 INFO - 2015-12-17 17:07:08,232 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCsjVPC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:07:19 INFO - 2015-12-17 17:07:19,932 DEBUG : BROWSER_OUTPUT: RSS: Main: 149954560 17:07:19 INFO - 2015-12-17 17:07:19,932 DEBUG : BROWSER_OUTPUT: 17:07:41 INFO - 2015-12-17 17:07:41,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34551/tests/v8_7/run.html (next: http://localhost:34551/tests/v8_7/run.html) 17:07:41 INFO - 2015-12-17 17:07:41,553 DEBUG : BROWSER_OUTPUT: RSS: Main: 574930944 17:07:41 INFO - 2015-12-17 17:07:41,553 DEBUG : BROWSER_OUTPUT: 17:07:41 INFO - 2015-12-17 17:07:41,554 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:07:41 INFO - 2015-12-17 17:07:41,554 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:07:41 INFO - 2015-12-17 17:07:41,555 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:07:41 INFO - 2015-12-17 17:07:41,555 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:07:41 INFO - 2015-12-17 17:07:41,555 DEBUG : BROWSER_OUTPUT: |0;Richards;166.333998669328 17:07:41 INFO - 2015-12-17 17:07:41,555 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.64365214110546 17:07:41 INFO - 2015-12-17 17:07:41,555 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.0336040324839 17:07:41 INFO - 2015-12-17 17:07:41,555 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5143.589743589743 17:07:41 INFO - 2015-12-17 17:07:41,555 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1119.8208286674133 17:07:41 INFO - 2015-12-17 17:07:41,555 DEBUG : BROWSER_OUTPUT: |5;Earley;782.4726134585289 17:07:41 INFO - 2015-12-17 17:07:41,556 DEBUG : BROWSER_OUTPUT: |6;Boyer;12096.385542168675 17:07:41 INFO - 2015-12-17 17:07:41,556 DEBUG : BROWSER_OUTPUT: |7;RegExp;26657.894736842107 17:07:41 INFO - 2015-12-17 17:07:41,556 DEBUG : BROWSER_OUTPUT: |8;Splay;652.9680365296804 17:07:41 INFO - 2015-12-17 17:07:41,556 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 17:07:41 INFO - 2015-12-17 17:07:41,556 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:07:41 INFO - 2015-12-17 17:07:41,556 DEBUG : BROWSER_OUTPUT: __startTimestamp1450400861553__endTimestamp 17:07:41 INFO - 2015-12-17 17:07:41,556 DEBUG : BROWSER_OUTPUT: 17:07:41 INFO - 2015-12-17 17:07:41,556 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:07:41 INFO - 2015-12-17 17:07:41,556 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:07:41 INFO - 2015-12-17 17:07:41,556 DEBUG : BROWSER_OUTPUT: 17:07:41 INFO - 2015-12-17 17:07:41,556 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.33 Median:166.33 stddev:0.00 (0.0%) 17:07:41 INFO - 2015-12-17 17:07:41,557 DEBUG : BROWSER_OUTPUT: Values: 166.3 17:07:41 INFO - 2015-12-17 17:07:41,557 DEBUG : BROWSER_OUTPUT: 17:07:41 INFO - 2015-12-17 17:07:41,557 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.64 Median:188.64 stddev:0.00 (0.0%) 17:07:41 INFO - 2015-12-17 17:07:41,557 DEBUG : BROWSER_OUTPUT: Values: 188.6 17:07:41 INFO - 2015-12-17 17:07:41,557 DEBUG : BROWSER_OUTPUT: 17:07:41 INFO - 2015-12-17 17:07:41,557 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 17:07:41 INFO - 2015-12-17 17:07:41,557 DEBUG : BROWSER_OUTPUT: Values: 280.0 17:07:41 INFO - 2015-12-17 17:07:41,558 DEBUG : BROWSER_OUTPUT: 17:07:41 INFO - 2015-12-17 17:07:41,558 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5143.59 Median:5143.59 stddev:0.00 (0.0%) 17:07:41 INFO - 2015-12-17 17:07:41,558 DEBUG : BROWSER_OUTPUT: Values: 5143.6 17:07:41 INFO - 2015-12-17 17:07:41,558 DEBUG : BROWSER_OUTPUT: 17:07:41 INFO - 2015-12-17 17:07:41,558 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1119.82 Median:1119.82 stddev:0.00 (0.0%) 17:07:41 INFO - 2015-12-17 17:07:41,558 DEBUG : BROWSER_OUTPUT: Values: 1119.8 17:07:41 INFO - 2015-12-17 17:07:41,558 DEBUG : BROWSER_OUTPUT: 17:07:41 INFO - 2015-12-17 17:07:41,559 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:782.47 Median:782.47 stddev:0.00 (0.0%) 17:07:41 INFO - 2015-12-17 17:07:41,559 DEBUG : BROWSER_OUTPUT: Values: 782.5 17:07:41 INFO - 2015-12-17 17:07:41,559 DEBUG : BROWSER_OUTPUT: 17:07:41 INFO - 2015-12-17 17:07:41,559 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12096.39 Median:12096.39 stddev:0.00 (0.0%) 17:07:41 INFO - 2015-12-17 17:07:41,559 DEBUG : BROWSER_OUTPUT: Values: 12096.4 17:07:41 INFO - 2015-12-17 17:07:41,560 DEBUG : BROWSER_OUTPUT: 17:07:41 INFO - 2015-12-17 17:07:41,560 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26657.89 Median:26657.89 stddev:0.00 (0.0%) 17:07:41 INFO - 2015-12-17 17:07:41,560 DEBUG : BROWSER_OUTPUT: Values: 26657.9 17:07:41 INFO - 2015-12-17 17:07:41,560 DEBUG : BROWSER_OUTPUT: 17:07:41 INFO - 2015-12-17 17:07:41,560 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:652.97 Median:652.97 stddev:0.00 (0.0%) 17:07:41 INFO - 2015-12-17 17:07:41,560 DEBUG : BROWSER_OUTPUT: Values: 653.0 17:07:41 INFO - 2015-12-17 17:07:41,561 DEBUG : BROWSER_OUTPUT: 17:07:41 INFO - 2015-12-17 17:07:41,561 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 17:07:41 INFO - 2015-12-17 17:07:41,562 DEBUG : BROWSER_OUTPUT: Values: 4830.9 17:07:41 INFO - 2015-12-17 17:07:41,562 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:07:41 INFO - 2015-12-17 17:07:41,562 DEBUG : BROWSER_OUTPUT: 17:07:42 INFO - 2015-12-17 17:07:42,381 INFO : Browser exited with error code: 0 17:07:42 INFO - 2015-12-17 17:07:42,396 INFO : Completed test v8_7 (00:00:39) 17:07:42 INFO - 2015-12-17 17:07:42,597 INFO : Completed test suite (00:20:11) 17:07:42 INFO - 2015-12-17 17:07:42,597 DEBUG : Working with test: dromaeo_css 17:07:42 INFO - 2015-12-17 17:07:42,597 DEBUG : Generating results file: dromaeo_css 17:07:42 INFO - 2015-12-17 17:07:42,598 DEBUG : Working with test: kraken 17:07:42 INFO - 2015-12-17 17:07:42,598 DEBUG : Generating results file: kraken 17:07:42 INFO - 2015-12-17 17:07:42,599 INFO : javascript benchmark 17:07:42 INFO - 2015-12-17 17:07:42,599 DEBUG : Working with test: v8_7 17:07:42 INFO - 2015-12-17 17:07:42,599 DEBUG : Generating results file: v8_7 17:07:42 INFO - 2015-12-17 17:07:42,599 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:07:42 INFO - 2015-12-17 17:07:42,663 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 17:07:42 INFO - 2015-12-17 17:07:42,663 DEBUG : process_Request line: dromaeo_css 6824.76 graph.html#tests=[[72,201,35]] 17:07:42 INFO - 2015-12-17 17:07:42,664 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:07:42 INFO - 2015-12-17 17:07:42,697 DEBUG : process_Request line: kraken 1499.10 graph.html#tests=[[232,201,35]] 17:07:42 INFO - 2015-12-17 17:07:42,697 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:07:42 INFO - 2015-12-17 17:07:42,735 DEBUG : process_Request line: v8_7 20844.09 graph.html#tests=[[230,201,35]] 17:07:42 INFO - 2015-12-17 17:07:42,737 INFO : javascript benchmark 17:07:42 INFO - 2015-12-17 17:07:42,741 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3068.125584208501, 3095.1797773589988, 3144.072498612909, 3145.606799150105, 3164.272217390001, 4880.145974454474, 4995.125852975724, 5167.534921857032, 5187.662801917877, 5204.42751297357, 5115.923261151086, 5131.820386286481, 5239.214117882319, 5244.921326180101, 5247.344081989751, 4683.90632187356, 4720.740359280238, 4729.7635118244125, 4743.35964644772, 4842.322074909515, 4802.759862006886, 4845.53967373099, 4890.5109489051165, 4898.53463920927, 4939.110960027194, 4582.977085114587, 4672.5327467253, 4690.929636055462, 4820.276958456225, 4834.178189707741, 4726.172919739032, 4743.620510359163, 4750.524947505256, 4754.191787396151, 4762.333273341735, 4697.67116301859, 4698.248280275139, 4705.529447055267, 4706.22347312693, 4715.339852420664, 4925.778339974674, 4998.950010499885, 5033.993201359743, 5035.496450354972, 5037.219231019198, 5606.131049687305, 5614.3824179340645, 5614.663120212759, 5619.129034999582, 5619.887602247973, 5307.310049693554, 5395.73021348931, 5648.858778530528, 5655.335835138655, 5705.2012718219485, 5204.3234379530795, 5274.103402421598, 5307.946920530784, 5312.415634280226, 5321.547668448186, 5652.3217213934595, 5674.829755107354, 5698.544116470673, 5700.8859822803315, 5700.942990570041, 5294.92057619136, 5543.722813859291, 5544.667319960815, 5546.750396232179, 5547.583931205176, 5389.164679474688, 5455.645383050089, 5462.945370546323, 5488.4785945335125, 5501.642393244426, 5539.418361072029, 5539.889202215933, 5551.472610102034, 5552.555795536347, 5554.91667624986, 5378.757955891916, 5549.472800083986, 5551.611387202857, 5556.055470570012, 5605.80379686709, 4212.620864122244, 4298.140371925628, 4305.547917468621, 4340.60934515895, 4346.913061738747, 3858.9807050964564, 3859.3439115350457, 3872.8644497442456, 3900.395438707005, 3904.3752999520507, 5209.426963034063, 5214.0875346814155, 5216.113260745682, 5221.399539053057, 5223.164293712987, 5451.0, 5461.836144915659, 5495.725213739377, 5545.279113715191, 5553.77784888608, 5188.636795424284, 5190.532852043334, 5206.088934436459, 5214.895702085937, 5256.2115682647145, 4895.069936712013, 4906.950930490721, 4909.754512274372, 4913.533214344631, 4956.727379994063, 5476.780928762805, 5554.50009499147, 5561.888762224733, 5676.460736230051, 5705.74324155414, 5503.559715222693, 5503.642263252876, 5503.862403439946, 5524.972375138259, 5571.303587051619, 5676.120201368794, 5713.9142912855505, 5714.142878568248, 5716.228309178207, 5727.284089488814, 5353.866153346197, 5397.163439666858, 5451.400345962021, 5537.335519737658, 5557.944420555743, 5542.418046105262, 5542.473465020817, 5564.054110801255, 5565.220869078251, 5581.804636837691, 5447.237386765935, 5451.236826844166, 5452.073147565003, 5483.287172667528, 5508.118701007819, 5356.6785992838995, 5461.781528738965, 5466.180072988925, 5468.72656367188, 5490.286262785812, 5303.2840566524565, 5361.946380536145, 5366.892662146814, 5374.785008599769, 5407.702576358338, 5471.452854714496, 5589.0, 5603.8879222416135, 5606.299212598426, 5678.488935995781, 5281.60387970896, 5324.8146946516945, 5380.3274590676165, 5458.836234912959, 5488.286522752017], "unit": "score", "name": "dojo.html", "value": 5131.371709073422}, {"lowerIsBetter": false, "replicates": [576.4350936082639, 584.2346526050874, 587.1427715535317, 590.3712546138365, 604.894143524883, 28597.428051438957, 37133.514659413624, 37633.0, 37664.81167594158, 37710.43434348487, 41233.793831030875, 41454.75635730933, 41696.0, 41699.79150104253, 41770.37344439828, 7495.100587929456, 7621.36140729743, 8522.829543409143, 8683.088275731052, 8688.56557172142, 9896.851547226797, 10004.199664026897, 10066.69799906004, 10077.647282345119, 10096.141827944633, 9978.600855965753, 10224.312988356913, 10224.591016359336, 10227.335223210504, 10228.386296822215, 7721.382289416862, 7909.604519773989, 10069.949650251738, 10270.486475676262, 10548.05067543917, 9953.800923981553, 10073.49632518371, 10073.899261007442, 10076.748081297952, 10078.79842403155, 36998.63001370006, 37150.0, 37404.812975935216, 37449.25101497955, 37455.06362340936, 3178.0, 3179.5230715392645, 3329.9500507492407, 3557.3952428087287, 3564.4296912494137, 29152.562711559345, 29257.268568285752, 29458.705412946027, 29576.55635165474, 30304.54543181832, 3880.2433525462548, 3920.2747491714126, 3933.940990885139, 3971.5631280559114, 3978.3236849735613, 270462.0, 271574.0, 272693.0, 273489.0, 274527.0, 52930.0, 54649.45350546444, 55603.721981389834, 55908.0, 56667.71666141725, 49060.75469622629, 49199.0, 49260.75369623129, 49341.25988110181, 49543.50456495389, 13045.0, 13055.28195949213, 13067.869321306855, 13125.343732813511, 13159.67100822468, 9994.900050999397, 10000.599976001024, 10013.549390277454, 10017.0, 10159.085682288629, 18231.63536729258, 18315.175817088264, 18318.633627327377, 18324.26702931868, 18332.816671833112, 7412.814679633052, 7635.847283054308, 7678.0, 7724.343430808444, 7724.691012359555, 885.5483703311357, 953.5041778275258, 1077.9651534526786, 1078.8618008001633, 1113.4655365424642, 24887.377815554755, 25026.0, 26243.212703618923, 26681.46637067248, 28209.576856347172, 1007.385494848142, 1014.8680671512656, 1045.0907710291942, 1104.9558167531604, 1127.4137448526885, 13360.93319533396, 13511.121777084458, 13520.86479135196, 13679.316034198251, 13958.0, 314723.0, 318924.0, 319545.0, 319844.0, 320758.0, 48516.27225591619, 48679.756601216766, 48744.0, 48803.511964879894, 48866.5113348862, 1340.1824886819034, 1358.7554240236852, 1362.50949658123, 1369.698666293414, 1470.4265336518765, 26366.472670546864, 26971.0, 27109.855013436, 27264.318392039564, 27358.17925462239, 44377.33433998428, 44811.55188448074, 44822.0, 44846.10307793891, 44853.0, 288888.0, 289250.0, 289295.0, 289751.0, 289787.0, 26778.196654100408, 27107.45785084248, 29162.854185728935, 30378.544321834746, 30839.845800770854, 35673.0, 35972.0, 36002.09994750152, 36030.63969360273, 36828.81585592055, 33271.0, 33340.33319333648, 33649.15877103092, 33898.152546186546, 34378.65621343755, 29272.56091158592, 32942.835285823414, 33398.833005834815, 35394.8230258847, 35634.46548301829, 31290.21774455566, 31520.52719209168, 35042.29915401627, 36110.638893610725, 36292.0, 29465.263368415963, 31172.0, 31462.0, 32095.679043210203, 32114.19714507156, 23823.404414889766, 23993.28020159398, 24007.63988540208, 24113.27660170198, 24270.0], "unit": "score", "name": "ext.html", "value": 17866.1691737631}, {"lowerIsBetter": false, "replicates": [350.35534616306006, 351.3079233909198, 351.77662184512843, 351.9736019798516, 354.10411658503983, 13888.79166812496, 14154.150750954925, 15375.692486150285, 16004.439844605427, 17180.65638687227, 14065.226412547307, 14137.505187318446, 14601.78097328541, 14675.706485870276, 14693.412263509446, 5169.819056333029, 5233.65981211222, 5289.709066001368, 5294.1529355303155, 5296.09966305727, 3894.844206231747, 3950.8222130004074, 5279.472052794709, 5717.684932465515, 5886.793962211324, 5439.211314359415, 5785.768569257225, 5808.157817116516, 5832.9708351458185, 5842.44496772808, 5901.940980590182, 5916.230889984317, 5918.2306300181135, 5927.703614819264, 5930.614510056833, 5107.591392688576, 5206.843794686128, 5212.8957420851375, 5215.426303106655, 5227.372715274153, 20304.28934987283, 20319.0, 20710.89644551783, 20758.58482830335, 20778.272760453463, 2068.431181425105, 2077.5637116205617, 2090.4042347930917, 2141.7965293297266, 2271.897764600597, 13107.0, 13228.537001205008, 13392.0, 13516.594502164951, 13577.728445431136, 1781.5100847266976, 1830.1764206107173, 1861.6928206845855, 1881.0782716468832, 1886.962260754791, 59911.70044149795, 62449.37550624526, 62662.0, 62824.371756282766, 63479.36520634781, 9467.66863159786, 9677.0, 9908.702738917844, 9949.403035817873, 10005.0, 13043.086983911035, 13054.869451305365, 13086.607401777961, 13090.0, 13094.738105237842, 6986.126734158231, 7124.325783440887, 7179.174394944544, 7252.854942901113, 7313.670884810196, 6525.151730275129, 6543.247526534509, 6579.210494740566, 6754.425873800782, 6789.796306110825, 5917.437843404869, 5954.523638108941, 5979.073243647242, 5979.4618484336615, 6067.332593414721, 1598.1449924290448, 1681.7729606502965, 1685.1068933465283, 1737.9304827806745, 1738.2699266308182, 942.189716843514, 944.4522177137244, 1011.6964910526813, 1022.805666923297, 1078.6440474643348, 15615.375384984472, 17532.561685957953, 17629.471115866545, 18008.0, 18500.444986650422, 923.6813299411692, 946.6828612414918, 957.3107362698846, 1030.253066526762, 1036.404067661098, 9918.702438926844, 10131.898681013243, 10158.13655839247, 10555.0, 10650.573977040987, 510512.0, 521820.0, 521952.0, 533840.0, 534667.0, 65032.34967650263, 66289.6685516579, 75560.0, 80415.0, 80987.19012809797, 1155.133649762678, 1156.7859945910202, 1185.5909711149811, 1210.6065528703207, 1222.5904322052033, 15210.239488025332, 15275.159866207465, 15409.229538523254, 15496.302666379814, 15685.294161762977, 34352.82823585866, 34487.827560863036, 34622.82688586541, 35702.642973569935, 36255.27489450143, 45604.771976139906, 46025.53974460212, 47712.0, 49243.50756492389, 49604.0, 9065.864012039692, 9182.31132665066, 9238.861417078884, 9276.211522020703, 9307.255419566554, 11149.554017839195, 16359.672806543564, 16971.066591337596, 17345.56636084108, 17475.82524174742, 13902.443902243796, 14151.363188656329, 14191.07757995727, 14449.78325325142, 14568.344424501134, 13703.314834258446, 13726.862731372958, 13836.930815345859, 14203.928980355033, 14501.854981450473, 14242.71514569682, 14328.14031158134, 14503.202323872289, 14512.492062777752, 14773.630659233175, 9263.907360926305, 9303.395279306824, 9386.67146649864, 9390.436573805593, 9414.15272625467, 13015.674608134872, 13088.541901033419, 13849.446022159002, 14194.219317937612, 14240.857591423954], "unit": "score", "name": "jquery.html", "value": 8925.392559127547}, {"lowerIsBetter": false, "replicates": [1277.1889849945294, 1654.6856097341504, 1694.788151481065, 1731.0911771320054, 1731.4978656189705, 6575.53971222014, 7218.133823941128, 7374.115106187265, 7393.3345998860095, 7395.70417183312, 7243.167035790886, 7413.592252426128, 7413.88879166813, 7419.629018549078, 7439.628018599075, 1876.8217019383137, 1909.6371689378973, 1910.140436803437, 2150.6773983902385, 2192.7916847899505, 2204.5370472200857, 2225.5660146271484, 2227.7772222777676, 2229.732432108149, 2230.130249202812, 2081.1779347157863, 2099.3701889433187, 2179.030331502474, 2181.0512427094263, 2184.0171922634877, 2114.851960362775, 2142.2823354176294, 2143.303426386415, 2162.1675654872906, 2164.9891750541224, 2184.7159869217057, 2206.415299945516, 2211.7345918489723, 2212.9778702212934, 2213.125815302946, 6999.755008574675, 7069.081019467488, 7092.751753688648, 7099.006139140524, 7105.538140020882, 4231.597998190167, 4264.488261408651, 4282.336237883133, 4283.0363168287195, 4329.502107257674, 2925.166327596646, 2925.61966944298, 2963.9259018524494, 2970.4207679502506, 2996.625421822272, 966.3235734985539, 975.1516180922642, 1959.294653924586, 1967.4294454608146, 1972.2505447929839, 9940.204783617293, 10071.295009349275, 10071.34536255141, 10072.748181295527, 10081.495925203784, 3867.7099217558793, 3922.0783115967724, 3959.1883663848844, 3977.244323578511, 3979.064919743858, 7953.403494737918, 7961.243681850215, 7972.481788683833, 7985.161558036439, 7995.960020199978, 4320.719153255029, 4344.587264209895, 4345.261305578059, 4347.891302717394, 4352.760598167131, 3964.266610676976, 3985.4021896715726, 3986.461827653288, 3996.8601098961976, 4001.779902105354, 3020.6526249481153, 3038.0, 3038.9544156837665, 3244.7890887092262, 3311.453610154346, 1061.7345663584103, 1073.683263437288, 1077.978440431187, 1082.626493859617, 1087.3095584304024, 1043.8642976413018, 1072.3297938788257, 1077.8059949209219, 1230.7476967221698, 1363.1344096498597, 6950.652467376611, 6985.79042628722, 7030.437564994788, 7039.507234493536, 7072.08062951813, 1100.4332768624165, 1126.9661910142709, 1135.2053562506278, 1143.2168964259508, 1160.6692092753524, 5530.640508366943, 5600.327960644749, 5660.433956604389, 5662.037453632893, 5662.801801936913, 8259.21537453941, 8375.581220938928, 8375.623096960651, 8376.288015518749, 8408.075111737704, 7993.120756716757, 8186.754397368089, 8212.219839115274, 8232.300254478316, 8252.83494330122, 6846.041554182419, 6847.21257055435, 6858.074159988438, 6869.965650171717, 6935.7225710971, 6698.464122870256, 6901.378875901193, 6902.344277293649, 6902.896456553055, 6912.827179320558, 7639.961800190964, 7720.53676779395, 7734.690612375667, 7816.570088644951, 7832.0, 7850.921490785247, 7962.163972782774, 7963.442559020813, 8027.59862006909, 8035.879461807961, 6230.283517395557, 6319.747210111728, 6349.682515874096, 6363.87272254543, 6367.426931575995, 5998.0103282957825, 6082.543809214415, 7065.0815393998455, 7075.752348667772, 7230.276972302728, 5799.217105690678, 6008.098785182083, 6049.939500604937, 6342.175517182736, 6419.871602567829, 6024.156618073561, 6246.968765156145, 6262.3111457738705, 6312.368763123651, 6336.429721325103, 6279.560430769802, 6290.748370065329, 6307.621542707268, 6342.7145778441, 6343.5876668016435, 5567.8608034797835, 5581.023320918905, 5598.272224610774, 5646.0, 5921.1414344918885, 5745.368009519033, 5764.077747560538, 5792.333881603669, 5809.186713860147, 5818.679972601548], "unit": "score", "name": "mootools.html", "value": 4228.000531493272}, {"lowerIsBetter": false, "replicates": [328.464602697603, 328.533482454914, 335.74818885835623, 338.8983305008497, 341.53380635432643, 5977.551683623724, 6022.87954240916, 6052.667103309316, 6074.149619053331, 6076.969615151918, 5667.5749318801045, 5755.366909639947, 5807.099899515571, 5882.264716910387, 5887.764489420418, 4492.707973981697, 4513.074819661978, 4521.751303678297, 4526.0042790586185, 4555.931661025087, 4318.244307246219, 4553.225951588238, 4556.3621093047, 4564.42944631921, 4576.107659006495, 4345.760983145941, 4377.978110109445, 4471.396361491205, 4496.033352829141, 4519.887002824939, 4469.217886869801, 4495.348174514677, 4495.662825288116, 4501.257292546742, 4501.594856462902, 3953.743006704584, 3969.4442778011103, 3971.8808435746973, 3978.562358140602, 3986.2824691555506, 5455.972720136374, 5602.243697100921, 5606.187102870061, 5606.635568688022, 5614.129809879475, 5252.9737351313, 5266.262723218752, 5267.3152490176035, 5271.604629652753, 5275.788968441258, 6225.844353891189, 6233.96883015582, 6239.937600623981, 6241.126242326078, 6244.656543890084, 4395.384646149541, 4395.582419670126, 4395.780210989437, 4397.208502469554, 4399.340098985146, 6383.489320854367, 6455.774047908348, 6515.446187074104, 6541.6075035498025, 6548.214214294268, 4546.681732278775, 4550.317452382103, 4550.49944506104, 4556.248219043887, 4564.634829213722, 4588.541145885385, 4618.445786505641, 4620.4686461056735, 4620.745858977789, 4629.189891768927, 5299.682019078868, 5300.549453296513, 5303.204519322133, 5308.0, 5314.043472175045, 6169.722362493609, 6346.873062538816, 6350.7459701611415, 6357.14178585885, 6359.427651511386, 1619.9514014579581, 1635.6728654269193, 1637.516932504914, 1639.9262033208533, 1640.1799100449775, 1100.7303210713426, 1116.6315116011697, 1121.8613107695696, 1131.8754936956927, 1133.920625556203, 6078.635281883101, 6091.299500557404, 6096.664683442365, 6102.115193297036, 6102.389761023862, 6458.0, 6511.739530418825, 6511.902321465182, 6521.347865213441, 6524.804255872332, 5865.149553314745, 5964.612300200473, 6016.338202797689, 6146.631202127797, 6152.292486364126, 3523.0, 3540.0, 3542.9017004728103, 3545.6808887200277, 3549.6450354964813, 6681.064650948871, 6694.665266736643, 6701.195856497252, 6706.932930670729, 6720.764773232913, 6633.568818026813, 6735.528513004141, 6735.629540375228, 6758.256591774901, 6763.966180169067, 6671.566348187449, 6672.5996440212775, 6678.465722742072, 6679.79960601173, 6686.598804071771, 6568.47452203813, 6570.638614876228, 6571.704273307808, 6574.342565743387, 6576.901346479903, 6334.9366506334345, 6491.058796474579, 6493.480521558169, 6494.765994461038, 6517.576357536745, 6620.8344791380605, 6680.465562754871, 6684.799456016327, 6685.0, 6702.262751097473, 4603.079384123122, 4606.88482787933, 4610.054938737618, 4610.585047345755, 4612.907741845212, 6451.387118223761, 6575.178102737158, 6580.703868325841, 6582.506312026521, 6583.572067815577, 6377.553571249968, 6404.455621272244, 6406.167198264196, 6407.423331900151, 6410.166678331973, 6334.1765570475545, 6363.1091647168505, 6386.584871983307, 6394.936050639434, 6395.42441180296, 6154.261488621394, 6242.063690446469, 6253.530985176221, 6254.312025677081, 6268.310485846644, 6397.912354899771, 6408.551401401857, 6412.422881940648, 6413.583117097373, 6417.839554011187, 6253.78111766086, 6258.904691679029, 6259.812205633838, 6260.311365749672, 6265.624062556261], "unit": "score", "name": "prototype.html", "value": 4779.027343010986}, {"lowerIsBetter": false, "replicates": [769.7756554733825, 776.6431756076514, 797.8045378882175, 834.4909605140865, 875.3347455933491, 12758.425870835812, 13020.54428095017, 13050.543230986905, 13061.477540898377, 13075.869241307571, 12532.624021279353, 12589.496420143207, 12606.93696531516, 14261.643458913532, 14466.421343146261, 831.226958928195, 841.6170642357744, 842.5871323051691, 842.7092653034724, 844.0167205205959, 688.102026854954, 695.7286658203304, 823.3454403749034, 843.780617039568, 845.5729856422498, 877.1404024056396, 877.6664867350398, 884.4914174349742, 885.1635204731531, 885.2608072259671, 705.414505960057, 713.8465229975528, 870.2950610005915, 874.0865795243985, 874.1215078845751, 627.0061951806392, 635.0315768453099, 635.4598591197491, 635.4820821030892, 635.8728254349148, 13704.314784260747, 13815.861841381558, 13818.792718109236, 13822.37799299034, 13824.377902994289, 11268.549258029669, 11450.599229026944, 11645.12661550387, 12139.271643701406, 12242.265464072185, 10082.647107351208, 10163.831159416688, 10165.695029149138, 10288.845667314996, 10406.323588966692, 3521.2077282611463, 3541.929161416783, 3559.0, 3572.964270357315, 3661.121330880596, 46913.0, 47479.287810682865, 47598.76200618975, 47679.28481072787, 48256.7587162062, 9509.809803804024, 9513.238940884712, 9716.6275176171, 9808.852867206997, 9907.45508997012, 17992.37026704059, 18033.098345082693, 18082.0, 18100.27598896056, 18130.09349532518, 7460.253974602496, 7550.169481357047, 7642.312191902755, 7654.502457340255, 7845.529268243924, 4103.302438585448, 4116.5060192777055, 4246.278132717445, 4266.466691663542, 4278.080212754273, 2947.322115913352, 2983.9104826855228, 2989.4320079184886, 2992.2369795701957, 2992.3716019635685, 537.0494225221337, 553.0846449126702, 555.4612026334449, 556.3268445181376, 567.7445149682659, 493.56671608968134, 563.0669771645056, 639.3510586754448, 691.339770519153, 701.0430762009921, 8161.918380816234, 8573.18554737299, 8585.31317494599, 8738.95630521856, 8792.38453308275, 530.3556179242162, 531.7421050790364, 533.5384892068333, 543.429399130911, 652.9347065293433, 3748.475213470116, 3877.6122387760997, 3975.0, 3989.7007724420782, 3999.3601023836627, 52391.73804130955, 53060.20409693858, 53543.464565354625, 53880.19179712307, 53946.0, 47882.0, 48594.75702621535, 49325.0, 49361.0, 49754.50245497499, 43546.34680479732, 43669.563304367184, 43757.78121109438, 43851.342229866576, 44076.77961610172, 7907.920920790949, 8087.393445491729, 8110.737222437348, 8313.542755148525, 8394.160583941557, 33396.165095871824, 33644.66355336415, 33790.324193516484, 33944.0, 34094.147646309044, 41617.58382416137, 42813.0, 43129.784351079295, 43167.78416107899, 43176.56823431851, 9967.651132210338, 10173.0, 10184.439855807705, 10354.637587684394, 10537.73655658584, 11130.888691112985, 11145.164112691742, 11202.271852329572, 11322.207445478738, 11437.942810285895, 10201.38791672502, 10352.844707329245, 10538.367697938149, 10593.311434756715, 10685.626003090165, 10288.382697038202, 10416.427096509764, 10767.676969690921, 11036.0, 11208.719782005515, 8752.256058235122, 9961.40231586107, 10192.28653994243, 10277.74305642365, 10285.228607854591, 9516.524173791144, 9528.19010384125, 9761.36335240755, 9787.217022638315, 10212.08091271789, 8612.0, 9168.266538677024, 9510.393778117332, 9708.126268635857, 9728.756781080247], "unit": "score", "name": "yui.html", "value": 6111.074805549264}], "name": "dromaeo_css", "value": 6824.761391899356}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 107.0, 113.0, 112.0, 112.0, 101.0, 112.0, 111.0, 119.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [154.0, 127.0, 148.0, 161.0, 129.0, 159.0, 152.0, 124.0, 165.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 144.1}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 158.0, 164.0, 163.0, 159.0, 162.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 84.0, 92.0, 72.0, 71.0, 72.0, 96.0, 92.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.6}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 137.0, 94.0, 101.0, 94.0, 148.0, 93.0, 93.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 108.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 144.0, 145.0, 145.0, 145.0, 145.0, 144.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [60.0, 58.0, 58.0, 58.0, 59.0, 59.0, 60.0, 59.0, 58.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.6}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 86.0, 84.0, 85.0, 84.0, 84.0, 83.0, 86.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 118.0, 115.0, 130.0, 114.0, 117.0, 125.0, 123.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.2}, {"lowerIsBetter": true, "replicates": [142.0, 141.0, 153.0, 153.0, 142.0, 141.0, 155.0, 151.0, 153.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 67.0, 69.0, 67.0, 68.0, 66.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1499.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.333998669328], "unit": "score", "name": "Richards", "value": 212.23562399999997}, {"lowerIsBetter": false, "replicates": [188.64365214110546], "unit": "score", "name": "DeltaBlue", "value": 350.49151800000004}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5143.589743589743], "unit": "score", "name": "Decrypt", "value": 51.75004486540379}, {"lowerIsBetter": false, "replicates": [1119.8208286674133], "unit": "score", "name": "RayTrace", "value": 660.8101769999998}, {"lowerIsBetter": false, "replicates": [782.4726134585289], "unit": "score", "name": "Earley", "value": 851.7397139999999}, {"lowerIsBetter": false, "replicates": [12096.385542168675], "unit": "score", "name": "Boyer", "value": 55.096044820717125}, {"lowerIsBetter": false, "replicates": [26657.894736842107], "unit": "score", "name": "RegExp", "value": 34.173178677196454}, {"lowerIsBetter": false, "replicates": [652.9680365296804], "unit": "score", "name": "Splay", "value": 124.80090209790214}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20844.08671250055}]} 17:07:42 INFO - RETURN: dromaeo_css: 6824.76 17:07:42 INFO - RETURN: kraken: 1499.10 17:07:42 INFO - RETURN: v8_7: 20844.09 17:07:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20844.09"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1499.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6824.76"}}} 17:07:42 INFO - Return code: 0 17:07:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:07:42 INFO - # TBPL SUCCESS # 17:07:42 INFO - Running post-action listener: _resource_record_post_action 17:07:42 INFO - Running post-run listener: _resource_record_post_run 17:07:43 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551641088; Read time: 8; Write time: 667892 17:07:43 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 242278400; Read time: 0; Write time: 370228 17:07:43 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 308498432; Read time: 8; Write time: 297628 17:07:43 INFO - Running post-run listener: _upload_blobber_files 17:07:43 INFO - Blob upload gear active. 17:07:43 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:07:43 INFO - Copying logs to upload dir... 17:07:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.188285 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-12-17 17:07:43.815424) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 17:07:43.819565) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/0zR7p5ZfSuiNtfJkqxIwig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009131 build_url: 'https://queue.taskcluster.net/v1/task/0zR7p5ZfSuiNtfJkqxIwig/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-17 17:07:43.872260) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:07:43.872660) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450397622.176168-1590530448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:07:43.922258) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 17:07:43.922623) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 17:07:43.922980) ========= ========= Total master_lag: 0.24 =========