builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1454462705.75 results: success (0) buildid: 20160202143019 builduid: 369b64dfcd8c4d3899df613c8ca34e7a revision: dedc2cf5ef02f5f1cb8f235a21b8b81a59b2d242 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-02 17:25:05.750005) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-02 17:25:05.750577) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-02 17:25:05.750934) ========= 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=ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005622 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-02 17:25:05.772246) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-02 17:25:05.772598) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-02 17:25:05.786270) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 17:25:05.786670) ========= 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=ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004542 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 17:25:05.836592) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-02 17:25:05.836935) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-02 17:25:05.837365) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 17:25:05.837676) ========= 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=ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-02 17:25:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-02-02 17:25:06 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155427 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 17:25:06.006802) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 17:25:06.007302) ========= 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=ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022422 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 17:25:06.060501) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 17:25:06.061307) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev dedc2cf5ef02f5f1cb8f235a21b8b81a59b2d242 --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 dedc2cf5ef02f5f1cb8f235a21b8b81a59b2d242 --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=ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-02 17:25:06,178 truncating revision to first 12 chars 2016-02-02 17:25:06,178 Setting DEBUG logging. 2016-02-02 17:25:06,178 attempt 1/10 2016-02-02 17:25:06,178 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/dedc2cf5ef02?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-02 17:25:06,413 unpacking tar archive at: b2g-inbound-dedc2cf5ef02/testing/mozharness/ program finished with exit code 0 elapsedTime=0.489876 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 17:25:06.565755) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-02 17:25:06.566159) ========= echo dedc2cf5ef02f5f1cb8f235a21b8b81a59b2d242 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'dedc2cf5ef02f5f1cb8f235a21b8b81a59b2d242'] 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=ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False dedc2cf5ef02f5f1cb8f235a21b8b81a59b2d242 program finished with exit code 0 elapsedTime=0.004652 script_repo_revision: 'dedc2cf5ef02f5f1cb8f235a21b8b81a59b2d242' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-02 17:25:06.618545) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-02 17:25:06.619028) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-02 17:25:06.631096) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-02-02 17:25:06.631756) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:25:06 INFO - MultiFileLogger online at 20160202 17:25:06 in /builds/slave/test-pgo 17:25:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 17:25:06 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:25:06 INFO - {'append_to_log': False, 17:25:06 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:25:06 INFO - 'blob_upload_branch': 'B2G-Inbound', 17:25:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:25:06 INFO - 'branch': 'B2G-Inbound', 17:25:06 INFO - 'buildbot_json_path': 'buildprops.json', 17:25:06 INFO - 'config_files': ('talos/linux_config.py',), 17:25:06 INFO - 'default_actions': ('clobber', 17:25:06 INFO - 'read-buildbot-config', 17:25:06 INFO - 'download-and-extract', 17:25:06 INFO - 'populate-webroot', 17:25:06 INFO - 'create-virtualenv', 17:25:06 INFO - 'install', 17:25:06 INFO - 'run-tests'), 17:25:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:25:06 INFO - 'download_minidump_stackwalk': True, 17:25:06 INFO - 'download_symbols': 'ondemand', 17:25:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:25:06 INFO - 'tooltool.py': '/tools/tooltool.py', 17:25:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:25:06 INFO - '/tools/misc-python/virtualenv.py')}, 17:25:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:25:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:25:06 INFO - 'installer_path': 'installer.exe', 17:25:06 INFO - 'log_level': 'info', 17:25:06 INFO - 'log_name': 'talos', 17:25:06 INFO - 'log_to_console': True, 17:25:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:25:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:25:06 INFO - 'opt_config_files': (), 17:25:06 INFO - 'pip_index': False, 17:25:06 INFO - 'sps_profile': False, 17:25:06 INFO - 'sps_profile_interval': 0, 17:25:06 INFO - 'suite': 'dromaeojs', 17:25:06 INFO - 'system_bits': '32', 17:25:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:25:06 INFO - 'title': 'talos-linux64-ix-035', 17:25:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:25:06 INFO - 'use_talos_json': True, 17:25:06 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:25:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:25:06 INFO - 'work_dir': 'build'} 17:25:06 INFO - ##### 17:25:06 INFO - ##### Running clobber step. 17:25:06 INFO - ##### 17:25:06 INFO - Running pre-action listener: _resource_record_pre_action 17:25:06 INFO - Running main action method: clobber 17:25:06 INFO - rmtree: /builds/slave/test-pgo/build 17:25:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:25:07 INFO - Running post-action listener: _resource_record_post_action 17:25:07 INFO - ##### 17:25:07 INFO - ##### Running read-buildbot-config step. 17:25:07 INFO - ##### 17:25:07 INFO - Running pre-action listener: _resource_record_pre_action 17:25:07 INFO - Running main action method: read_buildbot_config 17:25:07 INFO - Using buildbot properties: 17:25:07 INFO - { 17:25:07 INFO - "project": "", 17:25:07 INFO - "product": "firefox", 17:25:07 INFO - "script_repo_revision": "production", 17:25:07 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 17:25:07 INFO - "repository": "", 17:25:07 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 17:25:07 INFO - "buildid": "20160202143019", 17:25:07 INFO - "pgo_build": "True", 17:25:07 INFO - "basedir": "/builds/slave/test-pgo", 17:25:07 INFO - "buildnumber": 35, 17:25:07 INFO - "slavename": "talos-linux64-ix-035", 17:25:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:25:07 INFO - "platform": "ubuntu64_hw", 17:25:07 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 17:25:07 INFO - "branch": "b2g-inbound", 17:25:07 INFO - "repo_path": "integration/b2g-inbound", 17:25:07 INFO - "revision": "dedc2cf5ef02f5f1cb8f235a21b8b81a59b2d242", 17:25:07 INFO - "stage_platform": "linux64-pgo", 17:25:07 INFO - "builduid": "369b64dfcd8c4d3899df613c8ca34e7a", 17:25:07 INFO - "slavebuilddir": "test" 17:25:07 INFO - } 17:25:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 17:25:07 INFO - Running post-action listener: _resource_record_post_action 17:25:07 INFO - ##### 17:25:07 INFO - ##### Running download-and-extract step. 17:25:07 INFO - ##### 17:25:07 INFO - Running pre-action listener: _resource_record_pre_action 17:25:07 INFO - Running main action method: download_and_extract 17:25:07 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:07 INFO - https://queue.taskcluster.net/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:25:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/test_packages.json 17:25:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/test_packages.json 17:25:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:25:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:25:07 INFO - Downloaded 1448 bytes. 17:25:07 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:25:07 INFO - Using the following test package requirements: 17:25:07 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:25:07 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:07 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:25:07 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:07 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:25:07 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:07 INFO - u'jsshell-linux-x86_64.zip'], 17:25:07 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:07 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:25:07 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:25:07 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:07 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:25:07 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:07 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:25:07 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:07 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:25:07 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:25:07 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:07 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:25:07 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:07 INFO - https://queue.taskcluster.net/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:25:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:25:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:25:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:25:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:25:09 INFO - Downloaded 22499123 bytes. 17:25:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:25:09 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 17:25:10 INFO - Return code: 0 17:25:10 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:25: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')]} 17:25:10 INFO - https://queue.taskcluster.net/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:25:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:25:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:25:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:25:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:25:11 INFO - Downloaded 22499123 bytes. 17:25:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:25:11 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 17:25:12 INFO - Return code: 0 17:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:12 INFO - https://queue.taskcluster.net/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:25:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:25:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:25:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:25:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:25:13 INFO - Downloaded 10706572 bytes. 17:25:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:25:13 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 17:25:13 INFO - Return code: 0 17:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:13 INFO - https://queue.taskcluster.net/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:25:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:25:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:25:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:25:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:25:15 INFO - Downloaded 55984647 bytes. 17:25:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:25:15 INFO - mkdir: /builds/slave/test-pgo/properties 17:25:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:25:15 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:25:15 INFO - Contents: 17:25:15 INFO - build_url:https://queue.taskcluster.net/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:25:15 INFO - Running post-action listener: _resource_record_post_action 17:25:15 INFO - Running post-action listener: set_extra_try_arguments 17:25:15 INFO - ##### 17:25:15 INFO - ##### Running populate-webroot step. 17:25:15 INFO - ##### 17:25:15 INFO - Running pre-action listener: _resource_record_pre_action 17:25:15 INFO - Running main action method: populate_webroot 17:25:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:25:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:25:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:25:15 INFO - '--tppagecycles', 17:25:15 INFO - '7'], 17:25:15 INFO - 'tests': ['tsvgm']}}, 17:25:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:25:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:25:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:25:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:25:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:25:15 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:25:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:25:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:15 INFO - 'talos_options': ['--e10s'], 17:25:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:25:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:15 INFO - 'tests': ['damp', 'tps']}, 17:25:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:15 INFO - 'talos_options': ['--e10s'], 17:25:15 INFO - 'tests': ['damp', 'tps']}, 17:25:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:25:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:25:15 INFO - 'other': {'tests': ['a11yr', 17:25:15 INFO - 'ts_paint', 17:25:15 INFO - 'tpaint', 17:25:15 INFO - 'sessionrestore', 17:25:15 INFO - 'sessionrestore_no_auto_restore']}, 17:25:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:25:15 INFO - 'tests': ['a11yr', 17:25:15 INFO - 'ts_paint', 17:25:15 INFO - 'tpaint', 17:25:15 INFO - 'sessionrestore', 17:25:15 INFO - 'sessionrestore_no_auto_restore']}, 17:25:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:25:15 INFO - 'tests': ['a11yr', 17:25:15 INFO - 'ts_paint', 17:25:15 INFO - 'tpaint', 17:25:15 INFO - 'sessionrestore', 17:25:15 INFO - 'sessionrestore_no_auto_restore']}, 17:25:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:25:15 INFO - 'tests': ['a11yr', 17:25:15 INFO - 'ts_paint', 17:25:15 INFO - 'tpaint', 17:25:15 INFO - 'sessionrestore', 17:25:15 INFO - 'sessionrestore_no_auto_restore']}, 17:25:15 INFO - 'other_l64': {'tests': ['a11yr', 17:25:15 INFO - 'ts_paint', 17:25:15 INFO - 'tpaint', 17:25:15 INFO - 'sessionrestore', 17:25:15 INFO - 'sessionrestore_no_auto_restore']}, 17:25:15 INFO - 'other_nol64': {'tests': ['a11yr', 17:25:15 INFO - 'ts_paint', 17:25:15 INFO - 'tpaint', 17:25:15 INFO - 'sessionrestore', 17:25:15 INFO - 'sessionrestore_no_auto_restore']}, 17:25:15 INFO - 'svgr': {'tests': ['tsvgx', 17:25:15 INFO - 'tsvgr_opacity', 17:25:15 INFO - 'tart', 17:25:15 INFO - 'tscrollx', 17:25:15 INFO - 'cart']}, 17:25:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:25:15 INFO - 'tests': ['tsvgx', 17:25:15 INFO - 'tsvgr_opacity', 17:25:15 INFO - 'tart', 17:25:15 INFO - 'tscrollx', 17:25:15 INFO - 'cart']}, 17:25:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:15 INFO - 'tests': ['tp5o']}, 17:25:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:15 INFO - 'talos_options': ['--e10s'], 17:25:15 INFO - 'tests': ['tp5o']}, 17:25:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:15 INFO - 'talos_options': ['--xperf_path', 17:25:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:25:15 INFO - 'tests': ['tp5n']}, 17:25:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:15 INFO - 'talos_options': ['--e10s', 17:25:15 INFO - '--xperf_path', 17:25:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:25:15 INFO - 'tests': ['tp5n']}}, 17:25:15 INFO - 'talos.zip': {'path': '', 17:25:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:25:15 INFO - Running post-action listener: _resource_record_post_action 17:25:15 INFO - ##### 17:25:15 INFO - ##### Running create-virtualenv step. 17:25:15 INFO - ##### 17:25:15 INFO - Running pre-action listener: _resource_record_pre_action 17:25:15 INFO - Running main action method: create_virtualenv 17:25:15 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:25:15 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 17:25:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:25:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:25:16 INFO - Using real prefix '/usr' 17:25:16 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:25:16 INFO - Installing distribute.............................................................................................................................................................................................done. 17:25:18 INFO - Installing pip.................done. 17:25:18 INFO - Return code: 0 17:25:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:25:18 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')]} 17:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:18 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')]} 17:25:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fed11fb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf39630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfca840>, '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 0xf376b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061', '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 17:25:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 17:25:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 17:25:18 INFO - Using env: {'DISPLAY': ':0', 17:25:18 INFO - 'HOME': '/home/cltbld', 17:25:18 INFO - 'LANG': 'en_US.UTF-8', 17:25:18 INFO - 'LANGUAGE': 'en_US:en', 17:25:18 INFO - 'LOGNAME': 'cltbld', 17:25:18 INFO - 'MAIL': '/var/mail/cltbld', 17:25:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:18 INFO - 'MOZ_NO_REMOTE': '1', 17:25:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:18 INFO - 'NO_EM_RESTART': '1', 17:25:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:18 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:18 INFO - 'SHELL': '/bin/bash', 17:25:18 INFO - 'SHLVL': '1', 17:25:18 INFO - 'TERM': 'linux', 17:25:18 INFO - 'TMOUT': '86400', 17:25:18 INFO - 'USER': 'cltbld', 17:25:18 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061', 17:25:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:18 INFO - '_': '/tools/buildbot/bin/python'} 17:25:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:18 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 17:25:18 INFO - Cleaning up... 17:25:18 INFO - Return code: 0 17:25:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:25:18 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')]} 17:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:18 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')]} 17:25:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fed11fb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf39630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfca840>, '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 0xf376b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061', '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 17:25:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 17:25:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 17:25:18 INFO - Using env: {'DISPLAY': ':0', 17:25:18 INFO - 'HOME': '/home/cltbld', 17:25:18 INFO - 'LANG': 'en_US.UTF-8', 17:25:18 INFO - 'LANGUAGE': 'en_US:en', 17:25:18 INFO - 'LOGNAME': 'cltbld', 17:25:18 INFO - 'MAIL': '/var/mail/cltbld', 17:25:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:18 INFO - 'MOZ_NO_REMOTE': '1', 17:25:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:18 INFO - 'NO_EM_RESTART': '1', 17:25:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:18 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:18 INFO - 'SHELL': '/bin/bash', 17:25:18 INFO - 'SHLVL': '1', 17:25:18 INFO - 'TERM': 'linux', 17:25:18 INFO - 'TMOUT': '86400', 17:25:18 INFO - 'USER': 'cltbld', 17:25:18 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061', 17:25:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:18 INFO - '_': '/tools/buildbot/bin/python'} 17:25:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:18 INFO - Downloading/unpacking psutil>=0.7.1 17:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:25:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:25:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:25:20 INFO - Installing collected packages: psutil 17:25:20 INFO - Running setup.py install for psutil 17:25:21 INFO - building 'psutil._psutil_linux' extension 17:25:21 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 17:25:21 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 17:25:21 INFO - building 'psutil._psutil_posix' extension 17:25:21 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 17:25:21 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 17:25:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:25:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:25:21 INFO - Successfully installed psutil 17:25:21 INFO - Cleaning up... 17:25:21 INFO - Return code: 0 17:25:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:25:21 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')]} 17:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:21 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')]} 17:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fed11fb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf39630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfca840>, '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 0xf376b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061', '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 17:25:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 17:25:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 17:25:21 INFO - Using env: {'DISPLAY': ':0', 17:25:21 INFO - 'HOME': '/home/cltbld', 17:25:21 INFO - 'LANG': 'en_US.UTF-8', 17:25:21 INFO - 'LANGUAGE': 'en_US:en', 17:25:21 INFO - 'LOGNAME': 'cltbld', 17:25:21 INFO - 'MAIL': '/var/mail/cltbld', 17:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:21 INFO - 'MOZ_NO_REMOTE': '1', 17:25:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:21 INFO - 'NO_EM_RESTART': '1', 17:25:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:21 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:21 INFO - 'SHELL': '/bin/bash', 17:25:21 INFO - 'SHLVL': '1', 17:25:21 INFO - 'TERM': 'linux', 17:25:21 INFO - 'TMOUT': '86400', 17:25:21 INFO - 'USER': 'cltbld', 17:25:21 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061', 17:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:21 INFO - '_': '/tools/buildbot/bin/python'} 17:25:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:25:21 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 17:25:21 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 17:25:21 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 17:25:21 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 17:25:21 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 17:25:21 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 17:25:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:25:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:25:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:25:23 INFO - Installing collected packages: mozsystemmonitor 17:25:23 INFO - Running setup.py install for mozsystemmonitor 17:25:23 INFO - Successfully installed mozsystemmonitor 17:25:23 INFO - Cleaning up... 17:25:23 INFO - Return code: 0 17:25:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:25:23 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')]} 17:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:23 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')]} 17:25:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fed11fb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf39630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfca840>, '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 0xf376b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061', '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 17:25:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 17:25:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 17:25:23 INFO - Using env: {'DISPLAY': ':0', 17:25:23 INFO - 'HOME': '/home/cltbld', 17:25:23 INFO - 'LANG': 'en_US.UTF-8', 17:25:23 INFO - 'LANGUAGE': 'en_US:en', 17:25:23 INFO - 'LOGNAME': 'cltbld', 17:25:23 INFO - 'MAIL': '/var/mail/cltbld', 17:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:23 INFO - 'MOZ_NO_REMOTE': '1', 17:25:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:23 INFO - 'NO_EM_RESTART': '1', 17:25:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:23 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:23 INFO - 'SHELL': '/bin/bash', 17:25:23 INFO - 'SHLVL': '1', 17:25:23 INFO - 'TERM': 'linux', 17:25:23 INFO - 'TMOUT': '86400', 17:25:23 INFO - 'USER': 'cltbld', 17:25:23 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061', 17:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:23 INFO - '_': '/tools/buildbot/bin/python'} 17:25:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:23 INFO - Downloading/unpacking blobuploader==1.2.4 17:25:23 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 17:25:23 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 17:25:23 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 17:25:23 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 17:25:23 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 17:25:23 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 17:25:25 INFO - Downloading blobuploader-1.2.4.tar.gz 17:25:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:25:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:25:25 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 17:25:25 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 17:25:25 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 17:25:25 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 17:25:25 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 17:25:25 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 17:25:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:25:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:25:26 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 17:25:26 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 17:25:26 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 17:25:26 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 17:25:26 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 17:25:26 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 17:25:26 INFO - Downloading docopt-0.6.1.tar.gz 17:25:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:25:26 INFO - Installing collected packages: blobuploader, requests, docopt 17:25:26 INFO - Running setup.py install for blobuploader 17:25:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:25:26 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:25:26 INFO - Running setup.py install for requests 17:25:26 INFO - Running setup.py install for docopt 17:25:26 INFO - Successfully installed blobuploader requests docopt 17:25:26 INFO - Cleaning up... 17:25:27 INFO - Return code: 0 17:25:27 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:25:27 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')]} 17:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:27 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')]} 17:25:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:27 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7fed11fb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf39630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfca840>, '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 0xf376b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061', '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 17:25:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 17:25:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 17:25:27 INFO - Using env: {'DISPLAY': ':0', 17:25:27 INFO - 'HOME': '/home/cltbld', 17:25:27 INFO - 'LANG': 'en_US.UTF-8', 17:25:27 INFO - 'LANGUAGE': 'en_US:en', 17:25:27 INFO - 'LOGNAME': 'cltbld', 17:25:27 INFO - 'MAIL': '/var/mail/cltbld', 17:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:27 INFO - 'MOZ_NO_REMOTE': '1', 17:25:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:27 INFO - 'NO_EM_RESTART': '1', 17:25:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:27 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:27 INFO - 'SHELL': '/bin/bash', 17:25:27 INFO - 'SHLVL': '1', 17:25:27 INFO - 'TERM': 'linux', 17:25:27 INFO - 'TMOUT': '86400', 17:25:27 INFO - 'USER': 'cltbld', 17:25:27 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061', 17:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:27 INFO - '_': '/tools/buildbot/bin/python'} 17:25:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:25:27 INFO - Running setup.py (path:/tmp/pip-ugA4uq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:25:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:25:27 INFO - Running setup.py (path:/tmp/pip-h27Rp8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:25:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:25:27 INFO - Running setup.py (path:/tmp/pip-tKGUYQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:25:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:25:27 INFO - Running setup.py (path:/tmp/pip-qjW59A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:25:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:25:27 INFO - Running setup.py (path:/tmp/pip-w7TVLC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:25:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:25:27 INFO - Running setup.py (path:/tmp/pip-oWpm9a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:25:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:25:27 INFO - Running setup.py (path:/tmp/pip-8edQHP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:25:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:25:27 INFO - Running setup.py (path:/tmp/pip-hUybib-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:25:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:25:27 INFO - Running setup.py (path:/tmp/pip-EObFmq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:25:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:25:27 INFO - Running setup.py (path:/tmp/pip-kD5D5K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:25:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:25:27 INFO - Running setup.py (path:/tmp/pip-qpVIuZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:25:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:25:28 INFO - Running setup.py (path:/tmp/pip-WhaACL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:25:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:25:28 INFO - Running setup.py (path:/tmp/pip-rojvhe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:25:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:25:28 INFO - Running setup.py (path:/tmp/pip-3MZCGu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:25:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:25:28 INFO - Running setup.py (path:/tmp/pip-KhBHn1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:25:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:25:28 INFO - Running setup.py (path:/tmp/pip-T2IAfh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:25:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:25:28 INFO - Running setup.py (path:/tmp/pip-WrGHAU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:25:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:25:28 INFO - Running setup.py install for manifestparser 17:25:28 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:25:28 INFO - Running setup.py install for mozcrash 17:25:28 INFO - Running setup.py install for mozdebug 17:25:28 INFO - Running setup.py install for mozdevice 17:25:28 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:25:28 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:25:28 INFO - Running setup.py install for mozfile 17:25:28 INFO - Running setup.py install for mozhttpd 17:25:29 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:25:29 INFO - Running setup.py install for mozinfo 17:25:29 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:25:29 INFO - Running setup.py install for mozInstall 17:25:29 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:25:29 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:25:29 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:25:29 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:25:29 INFO - Running setup.py install for mozleak 17:25:29 INFO - Running setup.py install for mozlog 17:25:29 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:25:29 INFO - Running setup.py install for moznetwork 17:25:29 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:25:29 INFO - Running setup.py install for mozprocess 17:25:29 INFO - Running setup.py install for mozprofile 17:25:29 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:25:29 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:25:29 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:25:29 INFO - Running setup.py install for mozrunner 17:25:29 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:25:29 INFO - Running setup.py install for mozscreenshot 17:25:30 INFO - Running setup.py install for moztest 17:25:30 INFO - Running setup.py install for mozversion 17:25:30 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:25:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:25:30 INFO - Cleaning up... 17:25:30 INFO - Return code: 0 17:25:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:25:30 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')]} 17:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:30 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')]} 17:25:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fed11fb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf39630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfca840>, '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 0xf376b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061', '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 17:25:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 17:25:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 17:25:30 INFO - Using env: {'DISPLAY': ':0', 17:25:30 INFO - 'HOME': '/home/cltbld', 17:25:30 INFO - 'LANG': 'en_US.UTF-8', 17:25:30 INFO - 'LANGUAGE': 'en_US:en', 17:25:30 INFO - 'LOGNAME': 'cltbld', 17:25:30 INFO - 'MAIL': '/var/mail/cltbld', 17:25:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:30 INFO - 'MOZ_NO_REMOTE': '1', 17:25:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:30 INFO - 'NO_EM_RESTART': '1', 17:25:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:30 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:30 INFO - 'SHELL': '/bin/bash', 17:25:30 INFO - 'SHLVL': '1', 17:25:30 INFO - 'TERM': 'linux', 17:25:30 INFO - 'TMOUT': '86400', 17:25:30 INFO - 'USER': 'cltbld', 17:25:30 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061', 17:25:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:30 INFO - '_': '/tools/buildbot/bin/python'} 17:25:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:25:30 INFO - Running setup.py (path:/tmp/pip-mAwS8J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:25:30 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)) 17:25:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:25:30 INFO - Running setup.py (path:/tmp/pip-SmK5w6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:25:30 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)) 17:25:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:25:30 INFO - Running setup.py (path:/tmp/pip-D_7LJh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:25:30 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)) 17:25:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:25:30 INFO - Running setup.py (path:/tmp/pip-CNz3t3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:25:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 17:25:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:25:30 INFO - Running setup.py (path:/tmp/pip-tQZ8cm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:25:30 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)) 17:25:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:25:30 INFO - Running setup.py (path:/tmp/pip-cPd3Ys-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:25:30 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)) 17:25:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:25:30 INFO - Running setup.py (path:/tmp/pip-eOI6jW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:25:30 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)) 17:25:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:25:30 INFO - Running setup.py (path:/tmp/pip-lgo_m4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:25:31 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)) 17:25:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:25:31 INFO - Running setup.py (path:/tmp/pip-VYtjwB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:25:31 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)) 17:25:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:25:31 INFO - Running setup.py (path:/tmp/pip-YbwOjD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:25:31 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)) 17:25:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:25:31 INFO - Running setup.py (path:/tmp/pip-ywfZzp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:25:31 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)) 17:25:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:25:31 INFO - Running setup.py (path:/tmp/pip-XhPXOh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:25:31 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)) 17:25:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:25:31 INFO - Running setup.py (path:/tmp/pip-RBnHqX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:25:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 17:25:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:25:31 INFO - Running setup.py (path:/tmp/pip-KvJPpB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:25:31 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)) 17:25:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:25:31 INFO - Running setup.py (path:/tmp/pip-hNgNBJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:25:31 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)) 17:25:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:25:31 INFO - Running setup.py (path:/tmp/pip-xKv0kw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:25:31 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)) 17:25:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:25:31 INFO - Running setup.py (path:/tmp/pip-NMRetV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:25:31 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)) 17:25:31 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)) 17:25:31 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)) 17:25:31 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)) 17:25:31 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:25:31 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:25:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:33 INFO - Downloading blessings-1.6.tar.gz 17:25:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:25:33 INFO - Installing collected packages: blessings 17:25:33 INFO - Running setup.py install for blessings 17:25:33 INFO - Successfully installed blessings 17:25:33 INFO - Cleaning up... 17:25:33 INFO - Return code: 0 17:25:33 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:25:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:25:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:25:33 INFO - Reading from file tmpfile_stdout 17:25:33 INFO - Current package versions: 17:25:33 INFO - argparse == 1.2.1 17:25:33 INFO - blessings == 1.6 17:25:33 INFO - blobuploader == 1.2.4 17:25:33 INFO - docopt == 0.6.1 17:25:33 INFO - manifestparser == 1.1 17:25:33 INFO - mozInstall == 1.12 17:25:33 INFO - mozcrash == 0.16 17:25:33 INFO - mozdebug == 0.1 17:25:33 INFO - mozdevice == 0.48 17:25:33 INFO - mozfile == 1.2 17:25:33 INFO - mozhttpd == 0.7 17:25:33 INFO - mozinfo == 0.9 17:25:33 INFO - mozleak == 0.1 17:25:33 INFO - mozlog == 3.1 17:25:33 INFO - moznetwork == 0.27 17:25:33 INFO - mozprocess == 0.22 17:25:33 INFO - mozprofile == 0.28 17:25:33 INFO - mozrunner == 6.11 17:25:33 INFO - mozscreenshot == 0.1 17:25:33 INFO - mozsystemmonitor == 0.0 17:25:33 INFO - moztest == 0.7 17:25:33 INFO - mozversion == 1.4 17:25:33 INFO - psutil == 3.1.1 17:25:33 INFO - requests == 1.2.3 17:25:33 INFO - wsgiref == 0.1.2 17:25:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:25:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fed11fb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf39630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfca840>, '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 0xf376b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061', '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 17:25:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 17:25:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 17:25:33 INFO - Using env: {'DISPLAY': ':0', 17:25:33 INFO - 'HOME': '/home/cltbld', 17:25:33 INFO - 'LANG': 'en_US.UTF-8', 17:25:33 INFO - 'LANGUAGE': 'en_US:en', 17:25:33 INFO - 'LOGNAME': 'cltbld', 17:25:33 INFO - 'MAIL': '/var/mail/cltbld', 17:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:33 INFO - 'MOZ_NO_REMOTE': '1', 17:25:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:33 INFO - 'NO_EM_RESTART': '1', 17:25:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:33 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:33 INFO - 'SHELL': '/bin/bash', 17:25:33 INFO - 'SHLVL': '1', 17:25:33 INFO - 'TERM': 'linux', 17:25:33 INFO - 'TMOUT': '86400', 17:25:33 INFO - 'USER': 'cltbld', 17:25:33 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061', 17:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:33 INFO - '_': '/tools/buildbot/bin/python'} 17:25:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 17:25:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 17:25:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 17:25:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 17:25:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 17:25:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 17:25:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 17:25:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 17:25:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 17:25:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 17:25:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 17:25:34 INFO - Cleaning up... 17:25:34 INFO - Return code: 0 17:25:34 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fed11fb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf39630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfca840>, '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 0xf376b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061', '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 17:25:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 17:25:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 17:25:34 INFO - Using env: {'DISPLAY': ':0', 17:25:34 INFO - 'HOME': '/home/cltbld', 17:25:34 INFO - 'LANG': 'en_US.UTF-8', 17:25:34 INFO - 'LANGUAGE': 'en_US:en', 17:25:34 INFO - 'LOGNAME': 'cltbld', 17:25:34 INFO - 'MAIL': '/var/mail/cltbld', 17:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:34 INFO - 'MOZ_NO_REMOTE': '1', 17:25:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:34 INFO - 'NO_EM_RESTART': '1', 17:25:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:34 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:34 INFO - 'SHELL': '/bin/bash', 17:25:34 INFO - 'SHLVL': '1', 17:25:34 INFO - 'TERM': 'linux', 17:25:34 INFO - 'TMOUT': '86400', 17:25:34 INFO - 'USER': 'cltbld', 17:25:34 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061', 17:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:34 INFO - '_': '/tools/buildbot/bin/python'} 17:25:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:34 INFO - Downloading/unpacking jsonschema 17:25:34 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 17:25:34 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 17:25:34 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 17:25:34 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 17:25:34 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 17:25:34 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 17:25:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:25:36 INFO - Downloading/unpacking functools32 (from jsonschema) 17:25:36 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 17:25:36 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 17:25:36 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 17:25:36 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 17:25:36 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 17:25:36 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 17:25:36 INFO - Downloading functools32-3.2.3-2.tar.gz 17:25:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:25:36 INFO - warning: no files found matching '*.txt' 17:25:36 INFO - no previously-included directories found matching 'build' 17:25:36 INFO - no previously-included directories found matching 'dist' 17:25:36 INFO - no previously-included directories found matching '.git*' 17:25:36 INFO - Installing collected packages: jsonschema, functools32 17:25:36 INFO - Running setup.py install for functools32 17:25:36 INFO - warning: no files found matching '*.txt' 17:25:36 INFO - no previously-included directories found matching 'build' 17:25:36 INFO - no previously-included directories found matching 'dist' 17:25:36 INFO - no previously-included directories found matching '.git*' 17:25:36 INFO - Successfully installed jsonschema functools32 17:25:36 INFO - Cleaning up... 17:25:36 INFO - Return code: 0 17:25:36 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fed11fb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf39630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfca840>, '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 0xf376b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061', '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 17:25:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 17:25:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 17:25:36 INFO - Using env: {'DISPLAY': ':0', 17:25:36 INFO - 'HOME': '/home/cltbld', 17:25:36 INFO - 'LANG': 'en_US.UTF-8', 17:25:36 INFO - 'LANGUAGE': 'en_US:en', 17:25:36 INFO - 'LOGNAME': 'cltbld', 17:25:36 INFO - 'MAIL': '/var/mail/cltbld', 17:25:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:36 INFO - 'MOZ_NO_REMOTE': '1', 17:25:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:36 INFO - 'NO_EM_RESTART': '1', 17:25:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:36 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:36 INFO - 'SHELL': '/bin/bash', 17:25:36 INFO - 'SHLVL': '1', 17:25:36 INFO - 'TERM': 'linux', 17:25:36 INFO - 'TMOUT': '86400', 17:25:36 INFO - 'USER': 'cltbld', 17:25:36 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061', 17:25:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:36 INFO - '_': '/tools/buildbot/bin/python'} 17:25:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:36 INFO - Downloading/unpacking flake8 17:25:36 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 17:25:36 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 17:25:36 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 17:25:36 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 17:25:36 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 17:25:36 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 17:25:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:25:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:25:38 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 17:25:38 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 17:25:38 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 17:25:38 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 17:25:38 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 17:25:38 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 17:25:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:25:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:25:38 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 17:25:38 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 17:25:38 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 17:25:38 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 17:25:38 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 17:25:38 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 17:25:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:25:39 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 17:25:39 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 17:25:39 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 17:25:39 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 17:25:39 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 17:25:39 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 17:25:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:25:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:25:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:25:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:25:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:25:39 INFO - no previously-included directories found matching 'docs/_build' 17:25:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:25:39 INFO - Running setup.py install for pep8 17:25:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:25:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:25:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:25:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:25:39 INFO - no previously-included directories found matching 'docs/_build' 17:25:39 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:25:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:25:39 INFO - Cleaning up... 17:25:39 INFO - Return code: 0 17:25:39 INFO - Running post-action listener: _resource_record_post_action 17:25:39 INFO - Running post-action listener: _start_resource_monitoring 17:25:39 INFO - Starting resource monitoring. 17:25:39 INFO - ##### 17:25:39 INFO - ##### Running install step. 17:25:39 INFO - ##### 17:25:39 INFO - Running pre-action listener: _resource_record_pre_action 17:25:39 INFO - Running main action method: install 17:25:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:25:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:25:39 INFO - Reading from file tmpfile_stdout 17:25:39 INFO - Detecting whether we're running mozinstall >=1.0... 17:25:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:25:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:25:39 INFO - Reading from file tmpfile_stdout 17:25:39 INFO - Output received: 17:25:39 INFO - Usage: mozinstall [options] installer 17:25:39 INFO - Options: 17:25:39 INFO - -h, --help show this help message and exit 17:25:39 INFO - -d DEST, --destination=DEST 17:25:39 INFO - Directory to install application into. [default: 17:25:39 INFO - "/builds/slave/test-pgo"] 17:25:39 INFO - --app=APP Application being installed. [default: firefox] 17:25:39 INFO - mkdir: /builds/slave/test-pgo/build/application 17:25:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 17:25:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 17:25:55 INFO - Reading from file tmpfile_stdout 17:25:55 INFO - Output received: 17:25:55 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:25:55 INFO - Running post-action listener: _resource_record_post_action 17:25:55 INFO - ##### 17:25:55 INFO - ##### Running run-tests step. 17:25:55 INFO - ##### 17:25:55 INFO - Running pre-action listener: _resource_record_pre_action 17:25:55 INFO - Running main action method: run_tests 17:25:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:25:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:25:55 INFO - Python 2.7.3 17:25:55 INFO - Return code: 0 17:25:55 INFO - grabbing minidump binary from tooltool 17:25: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')]} 17:25:55 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 0xfca840>, '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 0xf376b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:25:55 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 17:25:55 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 17:25:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:25:55 INFO - Return code: 0 17:25:55 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:25:55 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:25:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:25:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:25:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:25:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:25:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:25:57 INFO - Return code: 0 17:25:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 17:25:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 17:25:57 INFO - Using env: {'DISPLAY': ':0', 17:25:57 INFO - 'HOME': '/home/cltbld', 17:25:57 INFO - 'LANG': 'en_US.UTF-8', 17:25:57 INFO - 'LANGUAGE': 'en_US:en', 17:25:57 INFO - 'LOGNAME': 'cltbld', 17:25:57 INFO - 'MAIL': '/var/mail/cltbld', 17:25:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:25:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:57 INFO - 'MOZ_NO_REMOTE': '1', 17:25:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:25:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:57 INFO - 'NO_EM_RESTART': '1', 17:25:57 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:57 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:57 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:25:57 INFO - 'SHELL': '/bin/bash', 17:25:57 INFO - 'SHLVL': '1', 17:25:57 INFO - 'TERM': 'linux', 17:25:57 INFO - 'TMOUT': '86400', 17:25:57 INFO - 'USER': 'cltbld', 17:25:57 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061', 17:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:57 INFO - '_': '/tools/buildbot/bin/python'} 17:25:57 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:25:57 INFO - mozversion application_buildid: 20160202143019 17:25:57 INFO - mozversion application_changeset: dedc2cf5ef02f5f1cb8f235a21b8b81a59b2d242 17:25:57 INFO - mozversion application_display_name: Nightly 17:25:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:25:57 INFO - mozversion application_name: Firefox 17:25:57 INFO - mozversion application_remotingname: firefox 17:25:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 17:25:57 INFO - mozversion application_vendor: Mozilla 17:25:57 INFO - mozversion application_version: 47.0a1 17:25:57 INFO - mozversion platform_buildid: 20160202143019 17:25:57 INFO - mozversion platform_changeset: dedc2cf5ef02f5f1cb8f235a21b8b81a59b2d242 17:25:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 17:25:57 INFO - mozversion platform_version: 47.0a1 17:25:57 INFO - using testdate: 1454462757 17:25:57 INFO - actual date: 1454462757 17:25:57 INFO - starting webserver on 'localhost:44181' 17:25:57 INFO - SUITE-START | Running 3 tests 17:25:57 INFO - TEST-START | dromaeo_css 17:25:57 INFO - operating with platform_type : linux_ 17:25:57 INFO - Initialising browser for dromaeo_css test... 17:25:57 INFO - TEST-INFO | started process 24561 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6w8O78/profile http://localhost:44181/getInfo.html) 17:26:00 INFO - PROCESS | 24561 | __metrics Screen width/height:1600/1200 17:26:00 INFO - PROCESS | 24561 | colorDepth:24 17:26:00 INFO - PROCESS | 24561 | Browser inner width/height: 1024/697 17:26:00 INFO - PROCESS | 24561 | __metrics 17:26:00 INFO - PROCESS | 24561 | 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:26:00 INFO - PROCESS | 24561 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:26:01 INFO - TEST-INFO | 24561: exit 0 17:26:01 INFO - Browser initialized. 17:26:01 INFO - Running cycle 1/1 for dromaeo_css test... 17:26:01 INFO - TEST-INFO | started process 24654 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6w8O78/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:26:13 INFO - PROCESS | 24654 | RSS: Main: 148082688 17:26:13 INFO - PROCESS | 24654 | 17:27:05 INFO - PROCESS | 24654 | 1454462825156 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] 17:29:13 INFO - PROCESS | 24654 | Cycle 1(1): loaded http://localhost:44181/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44181/tests/dromaeo/cssquery-ext.html) 17:29:14 INFO - PROCESS | 24654 | RSS: Main: 239685632 17:29:14 INFO - PROCESS | 24654 | 17:32:16 INFO - PROCESS | 24654 | Cycle 1(1): loaded http://localhost:44181/tests/dromaeo/cssquery-ext.html (next: http://localhost:44181/tests/dromaeo/cssquery-jquery.html) 17:32:17 INFO - PROCESS | 24654 | RSS: Main: 224751616 17:32:17 INFO - PROCESS | 24654 | 17:35:19 INFO - PROCESS | 24654 | Cycle 1(1): loaded http://localhost:44181/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44181/tests/dromaeo/cssquery-mootools.html) 17:35:19 INFO - PROCESS | 24654 | RSS: Main: 245121024 17:35:19 INFO - PROCESS | 24654 | 17:38:21 INFO - PROCESS | 24654 | Cycle 1(1): loaded http://localhost:44181/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44181/tests/dromaeo/cssquery-prototype.html) 17:38:22 INFO - PROCESS | 24654 | RSS: Main: 214822912 17:38:22 INFO - PROCESS | 24654 | 17:41:25 INFO - PROCESS | 24654 | Cycle 1(1): loaded http://localhost:44181/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44181/tests/dromaeo/cssquery-yui.html) 17:41:25 INFO - PROCESS | 24654 | RSS: Main: 212049920 17:41:25 INFO - PROCESS | 24654 | 17:44:28 INFO - PROCESS | 24654 | Cycle 1(1): loaded http://localhost:44181/tests/dromaeo/cssquery-yui.html (next: http://localhost:44181/tests/dromaeo/cssquery-dojo.html) 17:44:28 INFO - PROCESS | 24654 | RSS: Main: 257740800 17:44:28 INFO - PROCESS | 24654 | 17:44:28 INFO - PROCESS | 24654 | __start_tp_report 17:44:28 INFO - PROCESS | 24654 | _x_x_mozilla_page_load 17:44:28 INFO - PROCESS | 24654 | _x_x_mozilla_page_load_details 17:44:28 INFO - PROCESS | 24654 | |i|pagename|runs| 17:44:28 INFO - PROCESS | 24654 | |0;dojo.html;3139.356431931454;3143.8113713177195;3147.1030756234472;3148.087054754123;3176.317091825257;5103.157978933481;5145.691258524482;5167.638265321429;5185.740712964346;5228.6078544109205;5222.529972302492;5244.187150991593;5252.763625636846;5259.5529380002745;5321.813736519222;4709.246520556711;4726.716397016173;4765.142274390609;4856.854294371175;4859.757012149396;4808.567228949394;4818.975905120487;4886.242632391967;4886.53577910098;4895.755212239374;4672.322513235579;4702.576768090854;4748.620110391161;4750.809967601326;4779.02030083832;4725.385699859031;4728.196206644879;4729;4729.834455794065;4767.308740232646;4665.370175026362;4720.905581888343;4728.527147285278;4731.550502702272;4743.407074115736;4926.45808961014;4965.205567109245;4998;5003.099442100421;5009.12340340439;5434.83695489136;5467.398586155519;5486.945130548684;5487.204355368449;5492.066348720727;5493.7802487900435;5512.641678290898;5514.035043867307;5592.6085174037835;5666.5183459406;5289.47105289468;5300.655457395257;5300.893982120336;5305.867353316159;5306.946930530684;5708.571857110734;5736.42635736423;5762;5762.683052432157;5763.538916886639;5320.654157479751;5405.702686352289;5406.729663516809;5556.777728890799;5616.185653080281;5590.608657394025;5610.354809196913;5615.887682246333;5618.297712785902;5646.181303710939;5573.442655734394;5579.0515612346;5588.385277619459;5591.30108736408;5603.831885043373;5503.807366742145;5569.777208911598;5589.664620122806;5592.412796656374;5636.379998200195;4331.4152589400655;4333.306670932636;4362.629176520031;4386.385905973167;4404.691671582958;3850.7882066486613;3865.690744740414;3868.1103346230525;3894.357431023849;3898.493195884517;5090.669106508065;5134.332536770196;5136.614753893473;5148.021875843578;5173.249878767558;5543.168524721244;5563.805266815642;5564.582656300794;5574.860628484239;5628.690422026828;5157.329547158845;5161.225816127611;5161.81933632321;5168;5210.426853046238;4657.743824089707;4677.158111539888;4729.385179926657;4761.309610106515;4791.425028996473;5786.334571524244;5852.356240813507;5852.502537284378;5856.4143585641095;5857.736401861841;5614.410486898817;5630.662160270397;5639;5639.351474580311;5639.6334238274385;5609.9158512621525;5627.184058311604;5745.511631511368;5795.072788354012;5831.096180092092;5526.253955715927;5535.529479994246;5546.722663866871;5550.5282051026115;5554.416786237549;5427.240186373831;5580.274564306615;5616.831495055155;5628;5639.661620302795;5314.7874085036165;5497.697626630574;5517.172424136412;5528.308961379827;5565.053940829987;5402;5411.594130440154;5415.214793854948;5416.566674666096;5420.783168673209;5282.97358513205;5314.760835762478;5315.813946512008;5348.679079255257;5379.220013098001;5439.755211015435;5468.72656367188;5499.50504454585;5524.806631767869;5544.417836127149;5382.757775900016;5422.8373148805595;5427.674339539641;5428.891422171613;5430.755615997368 17:44:28 INFO - PROCESS | 24654 | |1;ext.html;513.7636687123922;519.3015394294674;565.5645153232011;585.2684144818976;585.9648421094735;27911.302217444547;28421.28946776329;28423.85788071062;28433.715662843366;34305.82847085761;33393;33858.15354616136;33877.32245355097;33911.49132763004;33924.49113263303;8353.37349698772;8580.141985801401;8583.828323433527;8587.871181932276;8589.35579831512;8284.378671599625;8406.83186336273;8415.915840841575;8423.536705481196;8424.073351931283;8416.284615807665;8600.483970961732;8628.09405012474;8631.395802293842;8665.826683466326;8459.492430454162;8541.615627296787;8552.503311920389;8554.35842311826;8555.443896146793;8385.496870187808;8496.490210587323;8508.276796472308;8512.063672995966;8512.65949362031;36067.81966090179;38612.80693596514;38620.420693689615;38631.42052869209;38634.227315453536;3008.864601092956;3072.9846350768103;3162.177833763215;3251.170951407376;3415.9487607685905;28799;28878.42243155125;28996.710032899613;29719.851400743075;29959;3892.4369414298358;3925.7840818754958;3994.940075898864;4039.313316736162;4095.058136628592;254169;256068;258635;258991;259229;51570.484295157316;52549;55625.72187139119;56010.71994640082;57052.42947570554;50429.49570504321;50485.74757126264;50593.24110138351;50641.746791266545;50756.74621626868;14734.63163420923;14917.179555124572;14921.701565968837;14922.70154596902;14940.32768525419;9700.563474643657;9725.56234969428;10376.42929638862;10525.736856578647;11377;18391.81608183901;18481;18637.627247454973;18639.161237744334;18751.81248187528;6817.113775209191;7084.610346430995;7100.68046937889;7110.822229444202;7136.429985403203;851.7104184577149;931.5668214280392;952.8951815300311;1008.2035192198082;1040.8334666453331;27669.723302767117;27872;28002.159935201977;28394.71605283921;28497.430051398856;886.7073865624328;915.2266334946959;974.7855471796194;1008.7679833638305;1053.9039399025082;14852.257387130816;15270.770938435933;15326.15706136151;15533.301001454962;15629.296681649126;310450;318610;318693;318956;318998;50732.492675072775;51149.744251278506;51241.7437912808;51278.84653841488;51330.48669513257;1262.1102123003445;1271.3389037700344;1286.0933042205222;1292.2698675248455;1305.2103477396229;27848.303792404542;28668.28329291701;28794.85602571974;29148.56277155802;29227.85386073056;47379.526204737514;48236.27645585389;48354;48388.5161148384;48470.27294590513;241733;241906;243019;243170;243992;27183.45633087367;27599.31001724973;29930;30308.696913030588;30483.933062342712;34145.48781768325;34266.657333426345;34634.65365346415;35056.298874021864;35163.29673406569;33877.83061084679;34008;34069.65930340764;34070.14824629404;34576;33236.50145247872;34235.828820855735;34319.65680343265;34322.65677343195;34482.310353793284;29964;30946.22634434067;34032;34759;35001;26414.735852641996;30562.68137832657;30776.727026839646;30843.476701794858;30963.225919352197;23619.64570531409;23685.64471532894;23752.893446498827;24147;24264.393390165387 17:44:28 INFO - PROCESS | 24654 | |2;jquery.html;327.8377203284373;343.321939170139;345.7147853021257;347.8452088820474;350.224253278987;13399.196048237089;13855.307234638252;15414.306356213969;15673.843261567381;17437.65124697507;14887.627809304746;15007.92496037521;16044.43844465441;16172;16174.919125404356;5036.546710796028;5355.973220133894;5359.598030147755;5361.383440904287;5366.543843773284;3972.7417717848393;4119.711620186588;5276.234945932837;5674.205611214434;5893.911591326112;5628.859278518029;5795.2176456178295;5802.448767367094;5851.648901065928;5852.76588936442;5712.771489140429;5728.62763920346;5747;5758.078707406816;5762.135679648044;4921.581665558432;5044.142495775727;5056.646034777567;5069.417017043051;5070.645054846163;19213.135408906634;19260.614787704308;19527.90236048825;19585.510362241057;19590.314338998065;2070.6686930091114;2141.550274442369;2235.184157782414;2341.988290058539;2348.0490401387465;12132.757344853053;12280.754384912341;12622.873771262262;12802.74394512114;12935.094543381967;1780.1900135438345;1812.5196822841958;1824.5985883105827;1829.4237315245655;1845.0959030075167;52346.21480677793;54173.1874021886;54187.72906135444;54370;55311.44688553143;8940.748295238673;9153;9357.625694972125;9374.203192728559;9432.811343773086;12094.032477401786;12101.09241806868;12105.515779368727;12112.69718257033;12116.030717542575;7269.745558905519;7416.925830741731;7438.033055702724;7479.289467500687;7531.698732050657;7339.596322202224;7352.70589176427;7390.667419966115;7406.037215162102;7419.962900185573;5090.41460232078;5558.194061861008;5599.300087489064;5637.887242255132;5646.435356464321;1634.4524584264404;1656.7349224124323;1702.7871516060493;1702.8637708983251;1717.544850614588;378.09446375929497;855.6577369052429;903.4850135422878;983.4394395194813;992.3103443107116;8294.668213271401;9389.201917837061;9941.105300522988;10103.545340459697;10413.843792343121;825.640846231891;836.4939211776909;848.8896443462311;857.8455877942031;881.3918396306528;5554.444555544414;8690.608922598498;8874;9003.594838232295;9128.26973842091;158804;159761;510746;523195.4562044717;524577;61303.38696613066;61451;63096.36903630997;65548;70891.64554177196;945.9574319155655;972.1445128287062;1079.794838980591;1095.7151140703475;1143.8398624192453;13904.37430315618;14210.360533776211;14411.711765764416;14639.780403294171;14683.853161468249;29718.851405742833;32004;32235.677643224204;32610.51084233691;33569.83215083909;32962;33380.33239335248;33466.33067338688;34329.65670343264;34340.48489272613;6547.377999090078;7066.081409416743;7106.857862842818;7123.715051397886;7207.891881621885;9776.462294573867;10617.787644247226;10644.467776610983;10865.348079115278;11220.66338009861;9420.858687119562;9440.771486802425;9571.760705982406;9963.25275604347;10202.030807073315;9864.358816676893;10036.749081273027;10265.5450109269;10294.3823370595;10322.380657160595;9985.400875947176;10001.449920254456;10152.289339746147;10347.327423717434;10353.482325883826;6669.83325416849;6897.068895699016;6937.549059311129;7041.295870412918;7112.6088065154845;9747.415155090717;10017.849732254168;10044.849327259952;10138.391696498235;10202.693919182437 17:44:28 INFO - PROCESS | 24654 | |3;mootools.html;1188.9643310700683;1437.5687293811857;1455.1705527849126;1600.4638446120548;1758.6482703459303;6952.478564107693;7561.810954726127;7726.575038372887;7743.303102720754;7751.379889608817;7615.238476152382;7824.843503129934;7829.843403131948;7835.764927052183;7839.882401763978;2028.1076326416403;2080.906359213839;2083.3854013066107;2262.298687406905;2283.54329134173;2020.5756791073893;2030.9796902031012;2308.8268379871492;2356.2695564375013;2363.196513185517;2273.068042102738;2314.2825724025606;2320.779525945041;2321.5472982768365;2323.0475505042937;2271.2731925783755;2274.6465852817546;2275.7155355580553;2276.6015947209253;2277.271273192579;2237.9328620141423;2278.2026290798253;2295.5294164696197;2299.252742858561;2300.5628930503317;7905.486143400661;7937.682492700343;7950.681972721084;7955.960220198862;7968.243016913384;4684.32077348786;4768.2847572864;4801.927971080401;4809.1343558159515;4810.206315957863;3146.3392687535643;3173.825439600821;3262.13553408347;3297.55483009793;3299.9175020624434;966.1739212972877;998.5007496251874;1013.8023085498331;1029.8918613545545;1065.6696424108475;10705.090067344285;10705.46472676363;10713.785724285548;10736.892631073668;10764.300320479144;4233;4277.422547955986;4329.610335069859;4359.782010899442;4368.912621747547;9187.586558604879;9220.953895230616;9221.216196623362;9221.40060896053;9221.677241296522;4736.550027747358;4764.30917516965;4770.546798054249;4775.808967641325;4778.116048531033;4311.655067594585;4324.805383757738;4343.478782546114;4346.65226781863;4356.281213599784;3286.2113092857544;3614.6023937366867;3624.8187590620364;3640.7997560133917;3675.0996005978704;1067.5729708116814;1073.120041565924;1088.151242031217;1139.6239241050434;1150.6202953025481;1289.0589869395394;1298.8960883129516;1308.9214647121203;1316.0261406559268;1335.3523541082568;7109.75115870942;7125.5368401053765;7134.892976605355;7135.964320178366;7193.712251509881;1077.6443773554709;1092.7377429416883;1095.3646884806792;1100.3233011697748;1106.1758989552834;5833.7083145842535;5880.470757631833;5883.794067207627;5899.67551784656;5900.675462849585;9529.475878826592;9589.184919281799;9888.950555247178;9941.155001824782;9960.352577082467;9672.032796720272;9765.121139097515;9785.902140978642;9793.363431376938;9805.754856128511;6964;7105.076340075757;7153.463490238253;7170.533915295489;7273.054502914587;7249.601271930094;7280.344768970818;7304.707811687473;7305.379042781423;7308.196098429275;8180.672773089248;8215.301699355621;8335.24982751531;8501.489910605384;8519.95740021296;8370.4559203654;8459.196376344238;8600.22597966186;8605.139486051345;8613.741587752127;6920.169579650475;7030.3321184487395;7034.859302814018;7035.33164349386;7036.894446583407;7160.140783105852;7208.207097219197;7218.602976836114;7220.519793442227;7356.080489938758;6032.90950635732;7000.789976300719;7209.170945341353;7249.456290778318;7363.926360736538;6087.269527656709;6555.704993275219;6979.127609048869;7076.752313668997;7085.964570177116;6989.231184569591;7013.929860701328;7037.612931288828;7040.331168538981;7054.294570542905;6485.578437401554;6513.609183449008;6517.608943463408;6535.673216339069;6539.869202616016;6617.8014659560295;6636.601803891782;6650.401463868275;6658.1011563438315;6660.100886380276 17:44:28 INFO - PROCESS | 24654 | |4;prototype.html;312.1540624906503;316.2583741127058;319.53188578732136;319.8432767943705;322.4453939224533;5895.85260368491;6059.787907423241;6069.544784141185;6070.605410648316;6078.665673387962;5821.476067153955;5925.762969481227;5927.911081333773;5928.644281343111;5939.940600593993;4278.9786051069705;4367.628751556122;4406.933895991563;4549.704269222499;4563.794629241692;4348.869533913988;4395.824167033331;4410.889727756816;4411.88970275744;4500.774961251941;4444.799984000711;4452.042810795679;4455.710378825383;4471.39636149119;4474.731516109027;4428.645708343325;4438.400815889846;4442.555744425547;4443.2446484097945;4449.154660614506;3653.2328211075705;3704.6110158433244;3771.3211621908044;3862.2854771867296;3862.382018876994;5545.916811247835;5566.415526369713;5589.636673616202;5615.157726341082;5618.747156377932;5150.510701483353;5165.66423182492;5169.431362550116;5170.457102004273;5175.637705360627;6153.969230153821;6188.39101833522;6189.040698691665;6191.4118158774845;6202.286737025254;3969.2458432897656;4013.7190396672245;4267.850625228133;4278.144371125756;4279.529251782302;6284.025975973731;6354.904676429857;6412.487001039905;6413.551051426402;6502.967485162591;4236.322188449833;4291.098869237433;4299.763513006815;4322.546132656089;4339.218940590724;4354.912901742011;4391.165678521071;4399.274119770266;4404.66964977628;4406.845760398371;4959.776810043557;5084.110280700863;5089.618278629117;5119.564836988823;5141.2288156776785;6229.96885015572;6285.685715714288;6289.55973081889;6299.716512756937;6302.558820882494;1518.293993293124;1542.460138951358;1544.050408998458;1545.5363390982661;1546.1418912503668;1018.2464975917768;1021.9795604087876;1023.0587859169582;1024.4672770159475;1041.8489319048695;5859.121131830174;5880.676562789087;5896.882062358729;5898.056310990221;5900.970495147497;6393.328700486382;6423.261324947597;6432.195975503062;6442.61344319333;6446.065320528497;5868.471837534642;5874.353821079678;5874.941250587525;5878.647281163144;5879.941200588025;3354.1279267390164;3493.9126521836647;3496;3503.404421248394;3508.1755787389943;6736.2253340865445;6739.157605299338;6741.089952856301;6744.62904540255;6759.087523184406;6609.933900660932;6610.504212184009;6612.834679132964;6625.4037136657935;6626.900596491057;6509.9023514647315;6694.330566943364;6700.296468870796;6705.2624211336715;6818.28408017151;6515.934840651723;6519.282878883224;6520.413162815369;6528.510361722795;6533;6157.291911430243;6234.817813765328;6274.090256912631;6452.225732911893;6463.030545418225;6731.394174524316;6736.292689267556;6751.493637977073;6781.864362712619;6787.966060169668;4397.8900527485785;4438.223310920641;4442.4669039715445;4445.110977804387;4445.866624001285;6333.65164915934;6491.253505846699;6527.249366322933;6555.4427873629365;6559.901601475886;6296.496280297657;6319.24169099711;6338.619682819046;6358.109864619049;6366.299707032315;6334.049892516159;6336.429721325103;6338.207724034496;6339.524535659752;6347.079673447417;6005.408566729733;6188.226471691039;6197.194364732556;6201.255849298113;6223.937760622517;6341.524385671001;6343.270523889812;6349.841253968688;6356.9046464304;6357.745690172342;6202;6212.254529456313;6217.222847144107;6220.440160385587;6226.3151053385 17:44:28 INFO - PROCESS | 24654 | |5;yui.html;724.6087112959002;805.3758337288605;812.9309008734257;832.1803024021334;834.8872902158208;15430.459933902315;15594.532164035068;15602.063876167438;15630.765538516931;15650.139242341667;13547.525836595722;13582.117162384462;13632.931835340834;13677.931610341935;13689.110207836484;665.3944910131781;771.4291424345986;789.0058526256901;790.0677200902933;790.328221012138;669.3975422120083;792.239450127878;801.4229754576725;801.5471258738824;801.7314199743093;824.6989848705209;827.7020272701823;833.1210572845646;834.8580741273998;835.5989125219899;687.5084314714953;688.8587839492892;822.173715416009;830.2610676497922;832.0431503770652;602.5059451249977;610.4505944649807;613.702354358136;613.7667686279229;614.4899733221415;13139.474421023147;13267.86732132676;13349.933250333783;13407.396667150002;13441.66395840102;10908.727281817939;11404.54381824726;12393.938030309791;12531.43608537618;12572.371381430892;10125.189984801198;10127;10426.635067772591;10427.165826733843;10731;3494.5806503219524;3513.6135025147214;3532.6290739472242;3536.7877927324184;3622.2936527377174;41448.1710365791;42265;42328;42407.36388954168;42408.36387454191;9663.565139568736;9702.75743106428;9740.853887191697;10037.146842518321;10092.091711745978;17474;17485.47543573695;17500.562485937953;17502.91248543749;17508.737368939477;7088.645567721696;7122.180949190806;7214.098237720285;7274.927250727425;7514.211834808889;4228.725132866354;4251.3771154784645;4262.126777339739;4271.765052922057;4274.551172126944;3065.739412149948;3097.6902309768843;3098.2719061020643;3099.9225019374694;3104.456720073978;541.5992165797281;546.592788372657;547.4990383798859;548.1366847215651;554.0968221798443;504.87551353759636;514.3210961530818;514.729766872395;518.8184135552602;535.8955003774226;8034.758957231293;8629;8712.477251364939;8832.725767602415;8927.776805579913;496.6051988669017;572.7995201679379;648.8377905523619;704.9718011279491;737.8413641067197;4027.335489644176;4228.534861165269;4276.828926842892;4313.309870420718;4505.346724724962;54717.179242311395;55016.17475737867;55109.724451378286;55169.72415137979;55186.448135518935;48569;49644;50163.74918125386;50218.74890625597;50245.24632130521;42415.787921060815;42537.36193957093;42801;43598.7820060904;43646.56353436488;8906.777330566787;8907.955460222658;9099.636014559343;9145.451272923647;9270.768230794283;30743.385132296782;31414.842925785226;31875.84062079675;32163.51754723634;35427.468587971714;43230.13539729125;43255.78372108119;44367.33448998203;45111.774441127585;45995.77002114968;11054;11074.11407087415;11116.174474703623;11116.277441966246;11354.943225283821;12034.277943323428;12537.686557836127;12588.748225035264;12600.243985360908;12663.556775512812;11737.47181376823;11914.30064448716;11945.16383853122;12164;12454.25274483534;11800.881991180322;11844.28934263947;11992.74076221984;12375.319357435428;12382.876171238173;11669.76660466769;11991.520339186683;12260.632181034583;12535.93732031334;12566.874331256571;9605.279604029865;9849.26130540198;9934.254930880068;10108.84836727435;10177.49112544355;9610.375325603813;9648.565814538222;9838.557264922953;9895.158911492605;9988.101070903653 17:44:28 INFO - PROCESS | 24654 | __end_tp_report 17:44:28 INFO - PROCESS | 24654 | __start_cc_report 17:44:28 INFO - PROCESS | 24654 | _x_x_mozilla_cycle_collect,769 17:44:28 INFO - PROCESS | 24654 | __end_cc_report 17:44:28 INFO - PROCESS | 24654 | __startTimestamp1454463868682__endTimestamp 17:44:28 INFO - PROCESS | 24654 | 17:44:28 INFO - PROCESS | 24654 | ------- Summary: start ------- 17:44:28 INFO - PROCESS | 24654 | Number of tests: 6 17:44:28 INFO - PROCESS | 24654 | 17:44:28 INFO - PROCESS | 24654 | [#0] dojo.html Cycles:165 Average:5182.05 Median:5382.76 stddev:566.91 (10.5%) stddev-sans-first:545.53 17:44:28 INFO - PROCESS | 24654 | Values: 3139.4 3143.8 3147.1 3148.1 3176.3 5103.2 5145.7 5167.6 5185.7 5228.6 5222.5 5244.2 5252.8 5259.6 5321.8 4709.2 4726.7 4765.1 4856.9 4859.8 4808.6 4819.0 4886.2 4886.5 4895.8 4672.3 4702.6 4748.6 4750.8 4779.0 4725.4 4728.2 4729.0 4729.8 4767.3 4665.4 4720.9 4728.5 4731.6 4743.4 4926.5 4965.2 4998.0 5003.1 5009.1 5434.8 5467.4 5486.9 5487.2 5492.1 5493.8 5512.6 5514.0 5592.6 5666.5 5289.5 5300.7 5300.9 5305.9 5306.9 5708.6 5736.4 5762.0 5762.7 5763.5 5320.7 5405.7 5406.7 5556.8 5616.2 5590.6 5610.4 5615.9 5618.3 5646.2 5573.4 5579.1 5588.4 5591.3 5603.8 5503.8 5569.8 5589.7 5592.4 5636.4 4331.4 4333.3 4362.6 4386.4 4404.7 3850.8 3865.7 3868.1 3894.4 3898.5 5090.7 5134.3 5136.6 5148.0 5173.2 5543.2 5563.8 5564.6 5574.9 5628.7 5157.3 5161.2 5161.8 5168.0 5210.4 4657.7 4677.2 4729.4 4761.3 4791.4 5786.3 5852.4 5852.5 5856.4 5857.7 5614.4 5630.7 5639.0 5639.4 5639.6 5609.9 5627.2 5745.5 5795.1 5831.1 5526.3 5535.5 5546.7 5550.5 5554.4 5427.2 5580.3 5616.8 5628.0 5639.7 5314.8 5497.7 5517.2 5528.3 5565.1 5402.0 5411.6 5415.2 5416.6 5420.8 5283.0 5314.8 5315.8 5348.7 5379.2 5439.8 5468.7 5499.5 5524.8 5544.4 5382.8 5422.8 5427.7 5428.9 5430.8 17:44:28 INFO - PROCESS | 24654 | 17:44:28 INFO - PROCESS | 24654 | [#1] ext.html Cycles:180 Average:42990.82 Median:34050.83 stddev:71684.55 (210.5%) stddev-sans-first:71814.69 17:44:28 INFO - PROCESS | 24654 | Values: 513.8 519.3 565.6 585.3 586.0 27911.3 28421.3 28423.9 28433.7 34305.8 33393.0 33858.2 33877.3 33911.5 33924.5 8353.4 8580.1 8583.8 8587.9 8589.4 8284.4 8406.8 8415.9 8423.5 8424.1 8416.3 8600.5 8628.1 8631.4 8665.8 8459.5 8541.6 8552.5 8554.4 8555.4 8385.5 8496.5 8508.3 8512.1 8512.7 36067.8 38612.8 38620.4 38631.4 38634.2 3008.9 3073.0 3162.2 3251.2 3415.9 28799.0 28878.4 28996.7 29719.9 29959.0 3892.4 3925.8 3994.9 4039.3 4095.1 254169.0 256068.0 258635.0 258991.0 259229.0 51570.5 52549.0 55625.7 56010.7 57052.4 50429.5 50485.7 50593.2 50641.7 50756.7 14734.6 14917.2 14921.7 14922.7 14940.3 9700.6 9725.6 10376.4 10525.7 11377.0 18391.8 18481.0 18637.6 18639.2 18751.8 6817.1 7084.6 7100.7 7110.8 7136.4 851.7 931.6 952.9 1008.2 1040.8 27669.7 27872.0 28002.2 28394.7 28497.4 886.7 915.2 974.8 1008.8 1053.9 14852.3 15270.8 15326.2 15533.3 15629.3 310450.0 318610.0 318693.0 318956.0 318998.0 50732.5 51149.7 51241.7 51278.8 51330.5 1262.1 1271.3 1286.1 1292.3 1305.2 27848.3 28668.3 28794.9 29148.6 29227.9 47379.5 48236.3 48354.0 48388.5 48470.3 241733.0 241906.0 243019.0 243170.0 243992.0 27183.5 27599.3 29930.0 30308.7 30483.9 34145.5 34266.7 34634.7 35056.3 35163.3 33877.8 34008.0 34069.7 34070.1 34576.0 33236.5 34235.8 34319.7 34322.7 34482.3 29964.0 30946.2 34032.0 34759.0 35001.0 26414.7 30562.7 30776.7 30843.5 30963.2 23619.6 23685.6 23752.9 24147.0 24264.4 17:44:28 INFO - PROCESS | 24654 | 17:44:28 INFO - PROCESS | 24654 | [#2] jquery.html Cycles:180 Average:22129.96 Median:5063.03 stddev:68146.89 (1346.0%) stddev-sans-first:68318.40 17:44:28 INFO - PROCESS | 24654 | Values: 327.8 343.3 345.7 347.8 350.2 13399.2 13855.3 15414.3 15673.8 17437.7 14887.6 15007.9 16044.4 16172.0 16174.9 5036.5 5356.0 5359.6 5361.4 5366.5 3972.7 4119.7 5276.2 5674.2 5893.9 5628.9 5795.2 5802.4 5851.6 5852.8 5712.8 5728.6 5747.0 5758.1 5762.1 4921.6 5044.1 5056.6 5069.4 5070.6 19213.1 19260.6 19527.9 19585.5 19590.3 2070.7 2141.6 2235.2 2342.0 2348.0 12132.8 12280.8 12622.9 12802.7 12935.1 1780.2 1812.5 1824.6 1829.4 1845.1 52346.2 54173.2 54187.7 54370.0 55311.4 8940.7 9153.0 9357.6 9374.2 9432.8 12094.0 12101.1 12105.5 12112.7 12116.0 7269.7 7416.9 7438.0 7479.3 7531.7 7339.6 7352.7 7390.7 7406.0 7420.0 5090.4 5558.2 5599.3 5637.9 5646.4 1634.5 1656.7 1702.8 1702.9 1717.5 378.1 855.7 903.5 983.4 992.3 8294.7 9389.2 9941.1 10103.5 10413.8 825.6 836.5 848.9 857.8 881.4 5554.4 8690.6 8874.0 9003.6 9128.3 158804.0 159761.0 510746.0 523195.5 524577.0 61303.4 61451.0 63096.4 65548.0 70891.6 946.0 972.1 1079.8 1095.7 1143.8 13904.4 14210.4 14411.7 14639.8 14683.9 29718.9 32004.0 32235.7 32610.5 33569.8 32962.0 33380.3 33466.3 34329.7 34340.5 6547.4 7066.1 7106.9 7123.7 7207.9 9776.5 10617.8 10644.5 10865.3 11220.7 9420.9 9440.8 9571.8 9963.3 10202.0 9864.4 10036.7 10265.5 10294.4 10322.4 9985.4 10001.4 10152.3 10347.3 10353.5 6669.8 6897.1 6937.5 7041.3 7112.6 9747.4 10017.8 10044.8 10138.4 10202.7 17:44:28 INFO - PROCESS | 24654 | 17:44:28 INFO - PROCESS | 24654 | [#3] mootools.html Cycles:180 Average:5485.78 Median:6499.59 stddev:2853.74 (43.9%) stddev-sans-first:2843.46 17:44:28 INFO - PROCESS | 24654 | Values: 1189.0 1437.6 1455.2 1600.5 1758.6 6952.5 7561.8 7726.6 7743.3 7751.4 7615.2 7824.8 7829.8 7835.8 7839.9 2028.1 2080.9 2083.4 2262.3 2283.5 2020.6 2031.0 2308.8 2356.3 2363.2 2273.1 2314.3 2320.8 2321.5 2323.0 2271.3 2274.6 2275.7 2276.6 2277.3 2237.9 2278.2 2295.5 2299.3 2300.6 7905.5 7937.7 7950.7 7956.0 7968.2 4684.3 4768.3 4801.9 4809.1 4810.2 3146.3 3173.8 3262.1 3297.6 3299.9 966.2 998.5 1013.8 1029.9 1065.7 10705.1 10705.5 10713.8 10736.9 10764.3 4233.0 4277.4 4329.6 4359.8 4368.9 9187.6 9221.0 9221.2 9221.4 9221.7 4736.6 4764.3 4770.5 4775.8 4778.1 4311.7 4324.8 4343.5 4346.7 4356.3 3286.2 3614.6 3624.8 3640.8 3675.1 1067.6 1073.1 1088.2 1139.6 1150.6 1289.1 1298.9 1308.9 1316.0 1335.4 7109.8 7125.5 7134.9 7136.0 7193.7 1077.6 1092.7 1095.4 1100.3 1106.2 5833.7 5880.5 5883.8 5899.7 5900.7 9529.5 9589.2 9889.0 9941.2 9960.4 9672.0 9765.1 9785.9 9793.4 9805.8 6964.0 7105.1 7153.5 7170.5 7273.1 7249.6 7280.3 7304.7 7305.4 7308.2 8180.7 8215.3 8335.2 8501.5 8520.0 8370.5 8459.2 8600.2 8605.1 8613.7 6920.2 7030.3 7034.9 7035.3 7036.9 7160.1 7208.2 7218.6 7220.5 7356.1 6032.9 7000.8 7209.2 7249.5 7363.9 6087.3 6555.7 6979.1 7076.8 7086.0 6989.2 7013.9 7037.6 7040.3 7054.3 6485.6 6513.6 6517.6 6535.7 6539.9 6617.8 6636.6 6650.4 6658.1 6660.1 17:44:28 INFO - PROCESS | 24654 | 17:44:28 INFO - PROCESS | 24654 | [#4] prototype.html Cycles:180 Average:5209.01 Median:5899.51 stddev:1604.68 (27.2%) stddev-sans-first:1566.52 17:44:28 INFO - PROCESS | 24654 | Values: 312.2 316.3 319.5 319.8 322.4 5895.9 6059.8 6069.5 6070.6 6078.7 5821.5 5925.8 5927.9 5928.6 5939.9 4279.0 4367.6 4406.9 4549.7 4563.8 4348.9 4395.8 4410.9 4411.9 4500.8 4444.8 4452.0 4455.7 4471.4 4474.7 4428.6 4438.4 4442.6 4443.2 4449.2 3653.2 3704.6 3771.3 3862.3 3862.4 5545.9 5566.4 5589.6 5615.2 5618.7 5150.5 5165.7 5169.4 5170.5 5175.6 6154.0 6188.4 6189.0 6191.4 6202.3 3969.2 4013.7 4267.9 4278.1 4279.5 6284.0 6354.9 6412.5 6413.6 6503.0 4236.3 4291.1 4299.8 4322.5 4339.2 4354.9 4391.2 4399.3 4404.7 4406.8 4959.8 5084.1 5089.6 5119.6 5141.2 6230.0 6285.7 6289.6 6299.7 6302.6 1518.3 1542.5 1544.1 1545.5 1546.1 1018.2 1022.0 1023.1 1024.5 1041.8 5859.1 5880.7 5896.9 5898.1 5901.0 6393.3 6423.3 6432.2 6442.6 6446.1 5868.5 5874.4 5874.9 5878.6 5879.9 3354.1 3493.9 3496.0 3503.4 3508.2 6736.2 6739.2 6741.1 6744.6 6759.1 6609.9 6610.5 6612.8 6625.4 6626.9 6509.9 6694.3 6700.3 6705.3 6818.3 6515.9 6519.3 6520.4 6528.5 6533.0 6157.3 6234.8 6274.1 6452.2 6463.0 6731.4 6736.3 6751.5 6781.9 6788.0 4397.9 4438.2 4442.5 4445.1 4445.9 6333.7 6491.3 6527.2 6555.4 6559.9 6296.5 6319.2 6338.6 6358.1 6366.3 6334.0 6336.4 6338.2 6339.5 6347.1 6005.4 6188.2 6197.2 6201.3 6223.9 6341.5 6343.3 6349.8 6356.9 6357.7 6202.0 6212.3 6217.2 6220.4 6226.3 17:44:28 INFO - PROCESS | 24654 | 17:44:28 INFO - PROCESS | 24654 | [#5] yui.html Cycles:180 Average:13470.24 Median:23771.72 stddev:15013.03 (63.2%) stddev-sans-first:15024.63 17:44:28 INFO - PROCESS | 24654 | Values: 724.6 805.4 812.9 832.2 834.9 15430.5 15594.5 15602.1 15630.8 15650.1 13547.5 13582.1 13632.9 13677.9 13689.1 665.4 771.4 789.0 790.1 790.3 669.4 792.2 801.4 801.5 801.7 824.7 827.7 833.1 834.9 835.6 687.5 688.9 822.2 830.3 832.0 602.5 610.5 613.7 613.8 614.5 13139.5 13267.9 13349.9 13407.4 13441.7 10908.7 11404.5 12393.9 12531.4 12572.4 10125.2 10127.0 10426.6 10427.2 10731.0 3494.6 3513.6 3532.6 3536.8 3622.3 41448.2 42265.0 42328.0 42407.4 42408.4 9663.6 9702.8 9740.9 10037.1 10092.1 17474.0 17485.5 17500.6 17502.9 17508.7 7088.6 7122.2 7214.1 7274.9 7514.2 4228.7 4251.4 4262.1 4271.8 4274.6 3065.7 3097.7 3098.3 3099.9 3104.5 541.6 546.6 547.5 548.1 554.1 504.9 514.3 514.7 518.8 535.9 8034.8 8629.0 8712.5 8832.7 8927.8 496.6 572.8 648.8 705.0 737.8 4027.3 4228.5 4276.8 4313.3 4505.3 54717.2 55016.2 55109.7 55169.7 55186.4 48569.0 49644.0 50163.7 50218.7 50245.2 42415.8 42537.4 42801.0 43598.8 43646.6 8906.8 8908.0 9099.6 9145.5 9270.8 30743.4 31414.8 31875.8 32163.5 35427.5 43230.1 43255.8 44367.3 45111.8 45995.8 11054.0 11074.1 11116.2 11116.3 11354.9 12034.3 12537.7 12588.7 12600.2 12663.6 11737.5 11914.3 11945.2 12164.0 12454.3 11800.9 11844.3 11992.7 12375.3 12382.9 11669.8 11991.5 12260.6 12535.9 12566.9 9605.3 9849.3 9934.3 10108.8 10177.5 9610.4 9648.6 9838.6 9895.2 9988.1 17:44:28 INFO - PROCESS | 24654 | -------- Summary: end -------- 17:44:28 INFO - PROCESS | 24654 | 17:44:29 INFO - TEST-INFO | 24654: exit 0 17:44:29 INFO - TEST-OK | dromaeo_css | took 1112196ms 17:44:29 INFO - TEST-START | kraken 17:44:29 INFO - operating with platform_type : linux_ 17:44:29 INFO - Initialising browser for kraken test... 17:44:29 INFO - TEST-INFO | started process 24851 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJP29hR/profile http://localhost:44181/getInfo.html) 17:44:33 INFO - PROCESS | 24851 | __metrics Screen width/height:1600/1200 17:44:33 INFO - PROCESS | 24851 | colorDepth:24 17:44:33 INFO - PROCESS | 24851 | Browser inner width/height: 1024/697 17:44:33 INFO - PROCESS | 24851 | __metrics 17:44:33 INFO - PROCESS | 24851 | 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:44:33 INFO - PROCESS | 24851 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:44:34 INFO - TEST-INFO | 24851: exit 0 17:44:34 INFO - Browser initialized. 17:44:34 INFO - Running cycle 1/1 for kraken test... 17:44:34 INFO - TEST-INFO | started process 24930 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJP29hR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:44:45 INFO - PROCESS | 24930 | RSS: Main: 148598784 17:44:45 INFO - PROCESS | 24930 | 17:44:48 INFO - PROCESS | 24930 | Cycle 1(1): loaded http://localhost:44181/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44181/tests/kraken/driver.html?testName=audio-beat-detection) 17:44:48 INFO - PROCESS | 24930 | RSS: Main: 187572224 17:44:48 INFO - PROCESS | 24930 | 17:44:51 INFO - PROCESS | 24930 | Cycle 1(1): loaded http://localhost:44181/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44181/tests/kraken/driver.html?testName=audio-dft) 17:44:52 INFO - PROCESS | 24930 | RSS: Main: 177381376 17:44:52 INFO - PROCESS | 24930 | 17:44:54 INFO - PROCESS | 24930 | Cycle 1(1): loaded http://localhost:44181/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44181/tests/kraken/driver.html?testName=audio-fft) 17:44:55 INFO - PROCESS | 24930 | RSS: Main: 166014976 17:44:55 INFO - PROCESS | 24930 | 17:44:57 INFO - PROCESS | 24930 | Cycle 1(1): loaded http://localhost:44181/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44181/tests/kraken/driver.html?testName=audio-oscillator) 17:44:58 INFO - PROCESS | 24930 | RSS: Main: 165826560 17:44:58 INFO - PROCESS | 24930 | 17:45:00 INFO - PROCESS | 24930 | Cycle 1(1): loaded http://localhost:44181/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44181/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:45:00 INFO - PROCESS | 24930 | RSS: Main: 166555648 17:45:00 INFO - PROCESS | 24930 | 17:45:03 INFO - PROCESS | 24930 | Cycle 1(1): loaded http://localhost:44181/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44181/tests/kraken/driver.html?testName=imaging-darkroom) 17:45:04 INFO - PROCESS | 24930 | RSS: Main: 167841792 17:45:04 INFO - PROCESS | 24930 | 17:45:07 INFO - PROCESS | 24930 | Cycle 1(1): loaded http://localhost:44181/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44181/tests/kraken/driver.html?testName=imaging-desaturate) 17:45:08 INFO - PROCESS | 24930 | RSS: Main: 167309312 17:45:08 INFO - PROCESS | 24930 | 17:45:11 INFO - PROCESS | 24930 | Cycle 1(1): loaded http://localhost:44181/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44181/tests/kraken/driver.html?testName=json-parse-financial) 17:45:11 INFO - PROCESS | 24930 | RSS: Main: 169623552 17:45:11 INFO - PROCESS | 24930 | 17:45:13 INFO - PROCESS | 24930 | Cycle 1(1): loaded http://localhost:44181/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44181/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:45:13 INFO - PROCESS | 24930 | RSS: Main: 179732480 17:45:13 INFO - PROCESS | 24930 | 17:45:15 INFO - PROCESS | 24930 | Cycle 1(1): loaded http://localhost:44181/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44181/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:45:16 INFO - PROCESS | 24930 | RSS: Main: 177270784 17:45:16 INFO - PROCESS | 24930 | 17:45:18 INFO - PROCESS | 24930 | Cycle 1(1): loaded http://localhost:44181/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44181/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:45:18 INFO - PROCESS | 24930 | RSS: Main: 191602688 17:45:18 INFO - PROCESS | 24930 | 17:45:21 INFO - PROCESS | 24930 | Cycle 1(1): loaded http://localhost:44181/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44181/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:45:21 INFO - PROCESS | 24930 | RSS: Main: 196878336 17:45:21 INFO - PROCESS | 24930 | 17:45:24 INFO - PROCESS | 24930 | Cycle 1(1): loaded http://localhost:44181/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44181/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:45:24 INFO - PROCESS | 24930 | RSS: Main: 196517888 17:45:24 INFO - PROCESS | 24930 | 17:45:26 INFO - PROCESS | 24930 | Cycle 1(1): loaded http://localhost:44181/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44181/tests/kraken/driver.html?testName=ai-astar) 17:45:26 INFO - PROCESS | 24930 | RSS: Main: 257081344 17:45:26 INFO - PROCESS | 24930 | 17:45:26 INFO - PROCESS | 24930 | __start_tp_report 17:45:26 INFO - PROCESS | 24930 | _x_x_mozilla_page_load 17:45:26 INFO - PROCESS | 24930 | _x_x_mozilla_page_load_details 17:45:26 INFO - PROCESS | 24930 | |i|pagename|runs| 17:45:26 INFO - PROCESS | 24930 | |0;ai-astar;111;110;107;110;108;111;110;110;102;109 17:45:26 INFO - PROCESS | 24930 | |1;audio-beat-detection;154;124;148;167;128;148;146;126;170;125 17:45:26 INFO - PROCESS | 24930 | |2;audio-dft;160;161;161;161;160;162;162;159;167;162 17:45:26 INFO - PROCESS | 24930 | |3;audio-fft;72;73;77;155;76;73;73;73;149;75 17:45:26 INFO - PROCESS | 24930 | |4;audio-oscillator;97;97;149;95;97;97;139;95;104;134 17:45:26 INFO - PROCESS | 24930 | |5;imaging-gaussian-blur;120;115;114;115;115;117;115;114;116;115 17:45:26 INFO - PROCESS | 24930 | |6;imaging-darkroom;146;145;145;146;145;146;145;146;146;146 17:45:26 INFO - PROCESS | 24930 | |7;imaging-desaturate;95;97;95;95;95;96;95;96;95;96 17:45:26 INFO - PROCESS | 24930 | |8;json-parse-financial;58;55;56;55;56;57;55;55;60;53 17:45:26 INFO - PROCESS | 24930 | |9;json-stringify-tinderbox;67;67;67;68;66;67;67;66;67;67 17:45:26 INFO - PROCESS | 24930 | |10;stanford-crypto-aes;93;84;84;83;83;83;84;83;83;84 17:45:26 INFO - PROCESS | 24930 | |11;stanford-crypto-ccm;123;114;115;125;118;130;116;116;131;124 17:45:26 INFO - PROCESS | 24930 | |12;stanford-crypto-pbkdf2;143;131;143;142;141;133;143;133;142;155 17:45:26 INFO - PROCESS | 24930 | |13;stanford-crypto-sha256-iterative;68;70;71;70;67;69;69;67;68;69 17:45:26 INFO - PROCESS | 24930 | __end_tp_report 17:45:26 INFO - PROCESS | 24930 | __start_cc_report 17:45:26 INFO - PROCESS | 24930 | _x_x_mozilla_cycle_collect,947 17:45:26 INFO - PROCESS | 24930 | __end_cc_report 17:45:26 INFO - PROCESS | 24930 | __startTimestamp1454463926846__endTimestamp 17:45:26 INFO - PROCESS | 24930 | 17:45:26 INFO - PROCESS | 24930 | ------- Summary: start ------- 17:45:26 INFO - PROCESS | 24930 | Number of tests: 14 17:45:26 INFO - PROCESS | 24930 | 17:45:26 INFO - PROCESS | 24930 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:2.70 (2.5%) stddev-sans-first:2.74 17:45:26 INFO - PROCESS | 24930 | Values: 111.0 110.0 107.0 110.0 108.0 111.0 110.0 110.0 102.0 109.0 17:45:26 INFO - PROCESS | 24930 | 17:45:26 INFO - PROCESS | 24930 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:148.00 stddev:17.26 (11.7%) stddev-sans-first:17.89 17:45:26 INFO - PROCESS | 24930 | Values: 154.0 124.0 148.0 167.0 128.0 148.0 146.0 126.0 170.0 125.0 17:45:26 INFO - PROCESS | 24930 | 17:45:26 INFO - PROCESS | 24930 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:2.17 (1.3%) stddev-sans-first:2.24 17:45:26 INFO - PROCESS | 24930 | Values: 160.0 161.0 161.0 161.0 160.0 162.0 162.0 159.0 167.0 162.0 17:45:26 INFO - PROCESS | 24930 | 17:45:26 INFO - PROCESS | 24930 | [#3] audio-fft Cycles:10 Average:89.60 Median:73.00 stddev:32.96 (45.1%) stddev-sans-first:34.33 17:45:26 INFO - PROCESS | 24930 | Values: 72.0 73.0 77.0 155.0 76.0 73.0 73.0 73.0 149.0 75.0 17:45:26 INFO - PROCESS | 24930 | 17:45:26 INFO - PROCESS | 24930 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:96.00 stddev:21.34 (22.2%) stddev-sans-first:22.08 17:45:26 INFO - PROCESS | 24930 | Values: 97.0 97.0 149.0 95.0 97.0 97.0 139.0 95.0 104.0 134.0 17:45:26 INFO - PROCESS | 24930 | 17:45:26 INFO - PROCESS | 24930 | [#5] imaging-gaussian-blur Cycles:10 Average:115.60 Median:115.00 stddev:1.78 (1.5%) stddev-sans-first:0.93 17:45:26 INFO - PROCESS | 24930 | Values: 120.0 115.0 114.0 115.0 115.0 117.0 115.0 114.0 116.0 115.0 17:45:26 INFO - PROCESS | 24930 | 17:45:26 INFO - PROCESS | 24930 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 17:45:26 INFO - PROCESS | 24930 | Values: 146.0 145.0 145.0 146.0 145.0 146.0 145.0 146.0 146.0 146.0 17:45:26 INFO - PROCESS | 24930 | 17:45:26 INFO - PROCESS | 24930 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 17:45:26 INFO - PROCESS | 24930 | Values: 95.0 97.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 96.0 17:45:26 INFO - PROCESS | 24930 | 17:45:26 INFO - PROCESS | 24930 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.94 (3.5%) stddev-sans-first:1.92 17:45:26 INFO - PROCESS | 24930 | Values: 58.0 55.0 56.0 55.0 56.0 57.0 55.0 55.0 60.0 53.0 17:45:26 INFO - PROCESS | 24930 | 17:45:26 INFO - PROCESS | 24930 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 17:45:26 INFO - PROCESS | 24930 | Values: 67.0 67.0 67.0 68.0 66.0 67.0 67.0 66.0 67.0 67.0 17:45:26 INFO - PROCESS | 24930 | 17:45:26 INFO - PROCESS | 24930 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:3.06 (3.6%) stddev-sans-first:0.53 17:45:26 INFO - PROCESS | 24930 | Values: 93.0 84.0 84.0 83.0 83.0 83.0 84.0 83.0 83.0 84.0 17:45:26 INFO - PROCESS | 24930 | 17:45:26 INFO - PROCESS | 24930 | [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:123.50 stddev:6.27 (5.1%) stddev-sans-first:6.61 17:45:26 INFO - PROCESS | 24930 | Values: 123.0 114.0 115.0 125.0 118.0 130.0 116.0 116.0 131.0 124.0 17:45:26 INFO - PROCESS | 24930 | 17:45:26 INFO - PROCESS | 24930 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.60 Median:142.50 stddev:6.96 (4.9%) stddev-sans-first:7.33 17:45:26 INFO - PROCESS | 24930 | Values: 143.0 131.0 143.0 142.0 141.0 133.0 143.0 133.0 142.0 155.0 17:45:26 INFO - PROCESS | 24930 | 17:45:26 INFO - PROCESS | 24930 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.32 (1.9%) stddev-sans-first:1.36 17:45:26 INFO - PROCESS | 24930 | Values: 68.0 70.0 71.0 70.0 67.0 69.0 69.0 67.0 68.0 69.0 17:45:26 INFO - PROCESS | 24930 | -------- Summary: end -------- 17:45:26 INFO - PROCESS | 24930 | 17:45:27 INFO - TEST-INFO | 24930: exit 0 17:45:27 INFO - TEST-OK | kraken | took 58372ms 17:45:27 INFO - TEST-START | v8_7 17:45:27 INFO - operating with platform_type : linux_ 17:45:27 INFO - Initialising browser for v8_7 test... 17:45:27 INFO - TEST-INFO | started process 25177 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAIjAI7/profile http://localhost:44181/getInfo.html) 17:45:31 INFO - PROCESS | 25177 | __metrics Screen width/height:1600/1200 17:45:31 INFO - PROCESS | 25177 | colorDepth:24 17:45:31 INFO - PROCESS | 25177 | Browser inner width/height: 1024/697 17:45:31 INFO - PROCESS | 25177 | __metrics 17:45:31 INFO - PROCESS | 25177 | 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:45:31 INFO - PROCESS | 25177 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:45:32 INFO - TEST-INFO | 25177: exit 0 17:45:32 INFO - Browser initialized. 17:45:32 INFO - Running cycle 1/1 for v8_7 test... 17:45:32 INFO - TEST-INFO | started process 25258 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAIjAI7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:45:44 INFO - PROCESS | 25258 | RSS: Main: 148504576 17:45:44 INFO - PROCESS | 25258 | 17:46:06 INFO - PROCESS | 25258 | Cycle 1(1): loaded http://localhost:44181/tests/v8_7/run.html (next: http://localhost:44181/tests/v8_7/run.html) 17:46:06 INFO - PROCESS | 25258 | RSS: Main: 535236608 17:46:06 INFO - PROCESS | 25258 | 17:46:06 INFO - PROCESS | 25258 | __start_tp_report 17:46:06 INFO - PROCESS | 25258 | _x_x_mozilla_page_load 17:46:06 INFO - PROCESS | 25258 | _x_x_mozilla_page_load_details 17:46:06 INFO - PROCESS | 25258 | |i|pagename|runs| 17:46:06 INFO - PROCESS | 25258 | |0;Richards;167.0843776106934 17:46:06 INFO - PROCESS | 25258 | |1;DeltaBlue;189.000189000189 17:46:06 INFO - PROCESS | 25258 | |2;Encrypt;272.8512960436562 17:46:06 INFO - PROCESS | 25258 | |3;Decrypt;5191.709844559586 17:46:06 INFO - PROCESS | 25258 | |4;RayTrace;1951.2670565302144 17:46:06 INFO - PROCESS | 25258 | |5;Earley;772.2007722007722 17:46:06 INFO - PROCESS | 25258 | |6;Boyer;12268.292682926829 17:46:06 INFO - PROCESS | 25258 | |7;RegExp;42270.833333333336 17:46:06 INFO - PROCESS | 25258 | |8;Splay;596.7837998808815 17:46:06 INFO - PROCESS | 25258 | |9;NavierStokes;4822.115384615385 17:46:06 INFO - PROCESS | 25258 | __end_tp_report 17:46:06 INFO - PROCESS | 25258 | __startTimestamp1454463966862__endTimestamp 17:46:06 INFO - PROCESS | 25258 | 17:46:06 INFO - PROCESS | 25258 | ------- Summary: start ------- 17:46:06 INFO - PROCESS | 25258 | Number of tests: 10 17:46:06 INFO - PROCESS | 25258 | 17:46:06 INFO - PROCESS | 25258 | [#0] Richards Cycles:1 Average:167.08 Median:167.08 stddev:0.00 (0.0%) 17:46:06 INFO - PROCESS | 25258 | Values: 167.1 17:46:06 INFO - PROCESS | 25258 | 17:46:06 INFO - PROCESS | 25258 | [#1] DeltaBlue Cycles:1 Average:189.00 Median:189.00 stddev:0.00 (0.0%) 17:46:06 INFO - PROCESS | 25258 | Values: 189.0 17:46:06 INFO - PROCESS | 25258 | 17:46:06 INFO - PROCESS | 25258 | [#2] Encrypt Cycles:1 Average:272.85 Median:272.85 stddev:0.00 (0.0%) 17:46:06 INFO - PROCESS | 25258 | Values: 272.9 17:46:06 INFO - PROCESS | 25258 | 17:46:06 INFO - PROCESS | 25258 | [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 17:46:06 INFO - PROCESS | 25258 | Values: 5191.7 17:46:06 INFO - PROCESS | 25258 | 17:46:06 INFO - PROCESS | 25258 | [#4] RayTrace Cycles:1 Average:1951.27 Median:1951.27 stddev:0.00 (0.0%) 17:46:06 INFO - PROCESS | 25258 | Values: 1951.3 17:46:06 INFO - PROCESS | 25258 | 17:46:06 INFO - PROCESS | 25258 | [#5] Earley Cycles:1 Average:772.20 Median:772.20 stddev:0.00 (0.0%) 17:46:06 INFO - PROCESS | 25258 | Values: 772.2 17:46:06 INFO - PROCESS | 25258 | 17:46:06 INFO - PROCESS | 25258 | [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 17:46:06 INFO - PROCESS | 25258 | Values: 12268.3 17:46:06 INFO - PROCESS | 25258 | 17:46:06 INFO - PROCESS | 25258 | [#7] RegExp Cycles:1 Average:42270.83 Median:42270.83 stddev:0.00 (0.0%) 17:46:06 INFO - PROCESS | 25258 | Values: 42270.8 17:46:06 INFO - PROCESS | 25258 | 17:46:06 INFO - PROCESS | 25258 | [#8] Splay Cycles:1 Average:596.78 Median:596.78 stddev:0.00 (0.0%) 17:46:06 INFO - PROCESS | 25258 | Values: 596.8 17:46:06 INFO - PROCESS | 25258 | 17:46:06 INFO - PROCESS | 25258 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 17:46:06 INFO - PROCESS | 25258 | Values: 4822.1 17:46:06 INFO - PROCESS | 25258 | -------- Summary: end -------- 17:46:06 INFO - PROCESS | 25258 | 17:46:07 INFO - TEST-INFO | 25258: exit 0 17:46:07 INFO - TEST-OK | v8_7 | took 39948ms 17:46:07 INFO - SUITE-END | took 1210s 17:46:07 INFO - Completed test suite (00:20:10) 17:46:07 INFO - Working with test: dromaeo_css 17:46:07 INFO - Generating results file: dromaeo_css 17:46:07 INFO - Working with test: kraken 17:46:07 INFO - Generating results file: kraken 17:46:07 INFO - javascript benchmark 17:46:07 INFO - Working with test: v8_7 17:46:07 INFO - Generating results file: v8_7 17:46:07 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:46:07 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 17:46:07 INFO - process_Request line: dromaeo_css 6708.22 graph.html#tests=[[72,201,35]] 17:46:07 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:46:07 INFO - process_Request line: kraken 1508.50 graph.html#tests=[[232,201,35]] 17:46:07 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:46:07 INFO - process_Request line: v8_7 19045.70 graph.html#tests=[[230,201,35]] 17:46:07 INFO - RETURN: dromaeo_css: 6708.22 17:46:07 INFO - RETURN: kraken: 1508.50 17:46:07 INFO - RETURN: v8_7: 19045.70 17:46:07 INFO - javascript benchmark 17:46:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3139.356431931454, 3143.8113713177195, 3147.1030756234472, 3148.087054754123, 3176.317091825257, 5103.157978933481, 5145.691258524482, 5167.638265321429, 5185.740712964346, 5228.6078544109205, 5222.529972302492, 5244.187150991593, 5252.763625636846, 5259.5529380002745, 5321.813736519222, 4709.246520556711, 4726.716397016173, 4765.142274390609, 4856.854294371175, 4859.757012149396, 4808.567228949394, 4818.975905120487, 4886.242632391967, 4886.53577910098, 4895.755212239374, 4672.322513235579, 4702.576768090854, 4748.620110391161, 4750.809967601326, 4779.02030083832, 4725.385699859031, 4728.196206644879, 4729.0, 4729.834455794065, 4767.308740232646, 4665.370175026362, 4720.905581888343, 4728.527147285278, 4731.550502702272, 4743.407074115736, 4926.45808961014, 4965.205567109245, 4998.0, 5003.099442100421, 5009.12340340439, 5434.83695489136, 5467.398586155519, 5486.945130548684, 5487.204355368449, 5492.066348720727, 5493.7802487900435, 5512.641678290898, 5514.035043867307, 5592.6085174037835, 5666.5183459406, 5289.47105289468, 5300.655457395257, 5300.893982120336, 5305.867353316159, 5306.946930530684, 5708.571857110734, 5736.42635736423, 5762.0, 5762.683052432157, 5763.538916886639, 5320.654157479751, 5405.702686352289, 5406.729663516809, 5556.777728890799, 5616.185653080281, 5590.608657394025, 5610.354809196913, 5615.887682246333, 5618.297712785902, 5646.181303710939, 5573.442655734394, 5579.0515612346, 5588.385277619459, 5591.30108736408, 5603.831885043373, 5503.807366742145, 5569.777208911598, 5589.664620122806, 5592.412796656374, 5636.379998200195, 4331.4152589400655, 4333.306670932636, 4362.629176520031, 4386.385905973167, 4404.691671582958, 3850.7882066486613, 3865.690744740414, 3868.1103346230525, 3894.357431023849, 3898.493195884517, 5090.669106508065, 5134.332536770196, 5136.614753893473, 5148.021875843578, 5173.249878767558, 5543.168524721244, 5563.805266815642, 5564.582656300794, 5574.860628484239, 5628.690422026828, 5157.329547158845, 5161.225816127611, 5161.81933632321, 5168.0, 5210.426853046238, 4657.743824089707, 4677.158111539888, 4729.385179926657, 4761.309610106515, 4791.425028996473, 5786.334571524244, 5852.356240813507, 5852.502537284378, 5856.4143585641095, 5857.736401861841, 5614.410486898817, 5630.662160270397, 5639.0, 5639.351474580311, 5639.6334238274385, 5609.9158512621525, 5627.184058311604, 5745.511631511368, 5795.072788354012, 5831.096180092092, 5526.253955715927, 5535.529479994246, 5546.722663866871, 5550.5282051026115, 5554.416786237549, 5427.240186373831, 5580.274564306615, 5616.831495055155, 5628.0, 5639.661620302795, 5314.7874085036165, 5497.697626630574, 5517.172424136412, 5528.308961379827, 5565.053940829987, 5402.0, 5411.594130440154, 5415.214793854948, 5416.566674666096, 5420.783168673209, 5282.97358513205, 5314.760835762478, 5315.813946512008, 5348.679079255257, 5379.220013098001, 5439.755211015435, 5468.72656367188, 5499.50504454585, 5524.806631767869, 5544.417836127149, 5382.757775900016, 5422.8373148805595, 5427.674339539641, 5428.891422171613, 5430.755615997368], "unit": "score", "name": "dojo.html", "value": 5146.019086238123}, {"lowerIsBetter": false, "replicates": [513.7636687123922, 519.3015394294674, 565.5645153232011, 585.2684144818976, 585.9648421094735, 27911.302217444547, 28421.28946776329, 28423.85788071062, 28433.715662843366, 34305.82847085761, 33393.0, 33858.15354616136, 33877.32245355097, 33911.49132763004, 33924.49113263303, 8353.37349698772, 8580.141985801401, 8583.828323433527, 8587.871181932276, 8589.35579831512, 8284.378671599625, 8406.83186336273, 8415.915840841575, 8423.536705481196, 8424.073351931283, 8416.284615807665, 8600.483970961732, 8628.09405012474, 8631.395802293842, 8665.826683466326, 8459.492430454162, 8541.615627296787, 8552.503311920389, 8554.35842311826, 8555.443896146793, 8385.496870187808, 8496.490210587323, 8508.276796472308, 8512.063672995966, 8512.65949362031, 36067.81966090179, 38612.80693596514, 38620.420693689615, 38631.42052869209, 38634.227315453536, 3008.864601092956, 3072.9846350768103, 3162.177833763215, 3251.170951407376, 3415.9487607685905, 28799.0, 28878.42243155125, 28996.710032899613, 29719.851400743075, 29959.0, 3892.4369414298358, 3925.7840818754958, 3994.940075898864, 4039.313316736162, 4095.058136628592, 254169.0, 256068.0, 258635.0, 258991.0, 259229.0, 51570.484295157316, 52549.0, 55625.72187139119, 56010.71994640082, 57052.42947570554, 50429.49570504321, 50485.74757126264, 50593.24110138351, 50641.746791266545, 50756.74621626868, 14734.63163420923, 14917.179555124572, 14921.701565968837, 14922.70154596902, 14940.32768525419, 9700.563474643657, 9725.56234969428, 10376.42929638862, 10525.736856578647, 11377.0, 18391.81608183901, 18481.0, 18637.627247454973, 18639.161237744334, 18751.81248187528, 6817.113775209191, 7084.610346430995, 7100.68046937889, 7110.822229444202, 7136.429985403203, 851.7104184577149, 931.5668214280392, 952.8951815300311, 1008.2035192198082, 1040.8334666453331, 27669.723302767117, 27872.0, 28002.159935201977, 28394.71605283921, 28497.430051398856, 886.7073865624328, 915.2266334946959, 974.7855471796194, 1008.7679833638305, 1053.9039399025082, 14852.257387130816, 15270.770938435933, 15326.15706136151, 15533.301001454962, 15629.296681649126, 310450.0, 318610.0, 318693.0, 318956.0, 318998.0, 50732.492675072775, 51149.744251278506, 51241.7437912808, 51278.84653841488, 51330.48669513257, 1262.1102123003445, 1271.3389037700344, 1286.0933042205222, 1292.2698675248455, 1305.2103477396229, 27848.303792404542, 28668.28329291701, 28794.85602571974, 29148.56277155802, 29227.85386073056, 47379.526204737514, 48236.27645585389, 48354.0, 48388.5161148384, 48470.27294590513, 241733.0, 241906.0, 243019.0, 243170.0, 243992.0, 27183.45633087367, 27599.31001724973, 29930.0, 30308.696913030588, 30483.933062342712, 34145.48781768325, 34266.657333426345, 34634.65365346415, 35056.298874021864, 35163.29673406569, 33877.83061084679, 34008.0, 34069.65930340764, 34070.14824629404, 34576.0, 33236.50145247872, 34235.828820855735, 34319.65680343265, 34322.65677343195, 34482.310353793284, 29964.0, 30946.22634434067, 34032.0, 34759.0, 35001.0, 26414.735852641996, 30562.68137832657, 30776.727026839646, 30843.476701794858, 30963.225919352197, 23619.64570531409, 23685.64471532894, 23752.893446498827, 24147.0, 24264.393390165387], "unit": "score", "name": "ext.html", "value": 17319.346232995533}, {"lowerIsBetter": false, "replicates": [327.8377203284373, 343.321939170139, 345.7147853021257, 347.8452088820474, 350.224253278987, 13399.196048237089, 13855.307234638252, 15414.306356213969, 15673.843261567381, 17437.65124697507, 14887.627809304746, 15007.92496037521, 16044.43844465441, 16172.0, 16174.919125404356, 5036.546710796028, 5355.973220133894, 5359.598030147755, 5361.383440904287, 5366.543843773284, 3972.7417717848393, 4119.711620186588, 5276.234945932837, 5674.205611214434, 5893.911591326112, 5628.859278518029, 5795.2176456178295, 5802.448767367094, 5851.648901065928, 5852.76588936442, 5712.771489140429, 5728.62763920346, 5747.0, 5758.078707406816, 5762.135679648044, 4921.581665558432, 5044.142495775727, 5056.646034777567, 5069.417017043051, 5070.645054846163, 19213.135408906634, 19260.614787704308, 19527.90236048825, 19585.510362241057, 19590.314338998065, 2070.6686930091114, 2141.550274442369, 2235.184157782414, 2341.988290058539, 2348.0490401387465, 12132.757344853053, 12280.754384912341, 12622.873771262262, 12802.74394512114, 12935.094543381967, 1780.1900135438345, 1812.5196822841958, 1824.5985883105827, 1829.4237315245655, 1845.0959030075167, 52346.21480677793, 54173.1874021886, 54187.72906135444, 54370.0, 55311.44688553143, 8940.748295238673, 9153.0, 9357.625694972125, 9374.203192728559, 9432.811343773086, 12094.032477401786, 12101.09241806868, 12105.515779368727, 12112.69718257033, 12116.030717542575, 7269.745558905519, 7416.925830741731, 7438.033055702724, 7479.289467500687, 7531.698732050657, 7339.596322202224, 7352.70589176427, 7390.667419966115, 7406.037215162102, 7419.962900185573, 5090.41460232078, 5558.194061861008, 5599.300087489064, 5637.887242255132, 5646.435356464321, 1634.4524584264404, 1656.7349224124323, 1702.7871516060493, 1702.8637708983251, 1717.544850614588, 378.09446375929497, 855.6577369052429, 903.4850135422878, 983.4394395194813, 992.3103443107116, 8294.668213271401, 9389.201917837061, 9941.105300522988, 10103.545340459697, 10413.843792343121, 825.640846231891, 836.4939211776909, 848.8896443462311, 857.8455877942031, 881.3918396306528, 5554.444555544414, 8690.608922598498, 8874.0, 9003.594838232295, 9128.26973842091, 158804.0, 159761.0, 510746.0, 523195.4562044717, 524577.0, 61303.38696613066, 61451.0, 63096.36903630997, 65548.0, 70891.64554177196, 945.9574319155655, 972.1445128287062, 1079.794838980591, 1095.7151140703475, 1143.8398624192453, 13904.37430315618, 14210.360533776211, 14411.711765764416, 14639.780403294171, 14683.853161468249, 29718.851405742833, 32004.0, 32235.677643224204, 32610.51084233691, 33569.83215083909, 32962.0, 33380.33239335248, 33466.33067338688, 34329.65670343264, 34340.48489272613, 6547.377999090078, 7066.081409416743, 7106.857862842818, 7123.715051397886, 7207.891881621885, 9776.462294573867, 10617.787644247226, 10644.467776610983, 10865.348079115278, 11220.66338009861, 9420.858687119562, 9440.771486802425, 9571.760705982406, 9963.25275604347, 10202.030807073315, 9864.358816676893, 10036.749081273027, 10265.5450109269, 10294.3823370595, 10322.380657160595, 9985.400875947176, 10001.449920254456, 10152.289339746147, 10347.327423717434, 10353.482325883826, 6669.83325416849, 6897.068895699016, 6937.549059311129, 7041.295870412918, 7112.6088065154845, 9747.415155090717, 10017.849732254168, 10044.849327259952, 10138.391696498235, 10202.693919182437], "unit": "score", "name": "jquery.html", "value": 7790.519509491275}, {"lowerIsBetter": false, "replicates": [1188.9643310700683, 1437.5687293811857, 1455.1705527849126, 1600.4638446120548, 1758.6482703459303, 6952.478564107693, 7561.810954726127, 7726.575038372887, 7743.303102720754, 7751.379889608817, 7615.238476152382, 7824.843503129934, 7829.843403131948, 7835.764927052183, 7839.882401763978, 2028.1076326416403, 2080.906359213839, 2083.3854013066107, 2262.298687406905, 2283.54329134173, 2020.5756791073893, 2030.9796902031012, 2308.8268379871492, 2356.2695564375013, 2363.196513185517, 2273.068042102738, 2314.2825724025606, 2320.779525945041, 2321.5472982768365, 2323.0475505042937, 2271.2731925783755, 2274.6465852817546, 2275.7155355580553, 2276.6015947209253, 2277.271273192579, 2237.9328620141423, 2278.2026290798253, 2295.5294164696197, 2299.252742858561, 2300.5628930503317, 7905.486143400661, 7937.682492700343, 7950.681972721084, 7955.960220198862, 7968.243016913384, 4684.32077348786, 4768.2847572864, 4801.927971080401, 4809.1343558159515, 4810.206315957863, 3146.3392687535643, 3173.825439600821, 3262.13553408347, 3297.55483009793, 3299.9175020624434, 966.1739212972877, 998.5007496251874, 1013.8023085498331, 1029.8918613545545, 1065.6696424108475, 10705.090067344285, 10705.46472676363, 10713.785724285548, 10736.892631073668, 10764.300320479144, 4233.0, 4277.422547955986, 4329.610335069859, 4359.782010899442, 4368.912621747547, 9187.586558604879, 9220.953895230616, 9221.216196623362, 9221.40060896053, 9221.677241296522, 4736.550027747358, 4764.30917516965, 4770.546798054249, 4775.808967641325, 4778.116048531033, 4311.655067594585, 4324.805383757738, 4343.478782546114, 4346.65226781863, 4356.281213599784, 3286.2113092857544, 3614.6023937366867, 3624.8187590620364, 3640.7997560133917, 3675.0996005978704, 1067.5729708116814, 1073.120041565924, 1088.151242031217, 1139.6239241050434, 1150.6202953025481, 1289.0589869395394, 1298.8960883129516, 1308.9214647121203, 1316.0261406559268, 1335.3523541082568, 7109.75115870942, 7125.5368401053765, 7134.892976605355, 7135.964320178366, 7193.712251509881, 1077.6443773554709, 1092.7377429416883, 1095.3646884806792, 1100.3233011697748, 1106.1758989552834, 5833.7083145842535, 5880.470757631833, 5883.794067207627, 5899.67551784656, 5900.675462849585, 9529.475878826592, 9589.184919281799, 9888.950555247178, 9941.155001824782, 9960.352577082467, 9672.032796720272, 9765.121139097515, 9785.902140978642, 9793.363431376938, 9805.754856128511, 6964.0, 7105.076340075757, 7153.463490238253, 7170.533915295489, 7273.054502914587, 7249.601271930094, 7280.344768970818, 7304.707811687473, 7305.379042781423, 7308.196098429275, 8180.672773089248, 8215.301699355621, 8335.24982751531, 8501.489910605384, 8519.95740021296, 8370.4559203654, 8459.196376344238, 8600.22597966186, 8605.139486051345, 8613.741587752127, 6920.169579650475, 7030.3321184487395, 7034.859302814018, 7035.33164349386, 7036.894446583407, 7160.140783105852, 7208.207097219197, 7218.602976836114, 7220.519793442227, 7356.080489938758, 6032.90950635732, 7000.789976300719, 7209.170945341353, 7249.456290778318, 7363.926360736538, 6087.269527656709, 6555.704993275219, 6979.127609048869, 7076.752313668997, 7085.964570177116, 6989.231184569591, 7013.929860701328, 7037.612931288828, 7040.331168538981, 7054.294570542905, 6485.578437401554, 6513.609183449008, 6517.608943463408, 6535.673216339069, 6539.869202616016, 6617.8014659560295, 6636.601803891782, 6650.401463868275, 6658.1011563438315, 6660.100886380276], "unit": "score", "name": "mootools.html", "value": 4502.689341623848}, {"lowerIsBetter": false, "replicates": [312.1540624906503, 316.2583741127058, 319.53188578732136, 319.8432767943705, 322.4453939224533, 5895.85260368491, 6059.787907423241, 6069.544784141185, 6070.605410648316, 6078.665673387962, 5821.476067153955, 5925.762969481227, 5927.911081333773, 5928.644281343111, 5939.940600593993, 4278.9786051069705, 4367.628751556122, 4406.933895991563, 4549.704269222499, 4563.794629241692, 4348.869533913988, 4395.824167033331, 4410.889727756816, 4411.88970275744, 4500.774961251941, 4444.799984000711, 4452.042810795679, 4455.710378825383, 4471.39636149119, 4474.731516109027, 4428.645708343325, 4438.400815889846, 4442.555744425547, 4443.2446484097945, 4449.154660614506, 3653.2328211075705, 3704.6110158433244, 3771.3211621908044, 3862.2854771867296, 3862.382018876994, 5545.916811247835, 5566.415526369713, 5589.636673616202, 5615.157726341082, 5618.747156377932, 5150.510701483353, 5165.66423182492, 5169.431362550116, 5170.457102004273, 5175.637705360627, 6153.969230153821, 6188.39101833522, 6189.040698691665, 6191.4118158774845, 6202.286737025254, 3969.2458432897656, 4013.7190396672245, 4267.850625228133, 4278.144371125756, 4279.529251782302, 6284.025975973731, 6354.904676429857, 6412.487001039905, 6413.551051426402, 6502.967485162591, 4236.322188449833, 4291.098869237433, 4299.763513006815, 4322.546132656089, 4339.218940590724, 4354.912901742011, 4391.165678521071, 4399.274119770266, 4404.66964977628, 4406.845760398371, 4959.776810043557, 5084.110280700863, 5089.618278629117, 5119.564836988823, 5141.2288156776785, 6229.96885015572, 6285.685715714288, 6289.55973081889, 6299.716512756937, 6302.558820882494, 1518.293993293124, 1542.460138951358, 1544.050408998458, 1545.5363390982661, 1546.1418912503668, 1018.2464975917768, 1021.9795604087876, 1023.0587859169582, 1024.4672770159475, 1041.8489319048695, 5859.121131830174, 5880.676562789087, 5896.882062358729, 5898.056310990221, 5900.970495147497, 6393.328700486382, 6423.261324947597, 6432.195975503062, 6442.61344319333, 6446.065320528497, 5868.471837534642, 5874.353821079678, 5874.941250587525, 5878.647281163144, 5879.941200588025, 3354.1279267390164, 3493.9126521836647, 3496.0, 3503.404421248394, 3508.1755787389943, 6736.2253340865445, 6739.157605299338, 6741.089952856301, 6744.62904540255, 6759.087523184406, 6609.933900660932, 6610.504212184009, 6612.834679132964, 6625.4037136657935, 6626.900596491057, 6509.9023514647315, 6694.330566943364, 6700.296468870796, 6705.2624211336715, 6818.28408017151, 6515.934840651723, 6519.282878883224, 6520.413162815369, 6528.510361722795, 6533.0, 6157.291911430243, 6234.817813765328, 6274.090256912631, 6452.225732911893, 6463.030545418225, 6731.394174524316, 6736.292689267556, 6751.493637977073, 6781.864362712619, 6787.966060169668, 4397.8900527485785, 4438.223310920641, 4442.4669039715445, 4445.110977804387, 4445.866624001285, 6333.65164915934, 6491.253505846699, 6527.249366322933, 6555.4427873629365, 6559.901601475886, 6296.496280297657, 6319.24169099711, 6338.619682819046, 6358.109864619049, 6366.299707032315, 6334.049892516159, 6336.429721325103, 6338.207724034496, 6339.524535659752, 6347.079673447417, 6005.408566729733, 6188.226471691039, 6197.194364732556, 6201.255849298113, 6223.937760622517, 6341.524385671001, 6343.270523889812, 6349.841253968688, 6356.9046464304, 6357.745690172342, 6202.0, 6212.254529456313, 6217.222847144107, 6220.440160385587, 6226.3151053385], "unit": "score", "name": "prototype.html", "value": 4680.835935677528}, {"lowerIsBetter": false, "replicates": [724.6087112959002, 805.3758337288605, 812.9309008734257, 832.1803024021334, 834.8872902158208, 15430.459933902315, 15594.532164035068, 15602.063876167438, 15630.765538516931, 15650.139242341667, 13547.525836595722, 13582.117162384462, 13632.931835340834, 13677.931610341935, 13689.110207836484, 665.3944910131781, 771.4291424345986, 789.0058526256901, 790.0677200902933, 790.328221012138, 669.3975422120083, 792.239450127878, 801.4229754576725, 801.5471258738824, 801.7314199743093, 824.6989848705209, 827.7020272701823, 833.1210572845646, 834.8580741273998, 835.5989125219899, 687.5084314714953, 688.8587839492892, 822.173715416009, 830.2610676497922, 832.0431503770652, 602.5059451249977, 610.4505944649807, 613.702354358136, 613.7667686279229, 614.4899733221415, 13139.474421023147, 13267.86732132676, 13349.933250333783, 13407.396667150002, 13441.66395840102, 10908.727281817939, 11404.54381824726, 12393.938030309791, 12531.43608537618, 12572.371381430892, 10125.189984801198, 10127.0, 10426.635067772591, 10427.165826733843, 10731.0, 3494.5806503219524, 3513.6135025147214, 3532.6290739472242, 3536.7877927324184, 3622.2936527377174, 41448.1710365791, 42265.0, 42328.0, 42407.36388954168, 42408.36387454191, 9663.565139568736, 9702.75743106428, 9740.853887191697, 10037.146842518321, 10092.091711745978, 17474.0, 17485.47543573695, 17500.562485937953, 17502.91248543749, 17508.737368939477, 7088.645567721696, 7122.180949190806, 7214.098237720285, 7274.927250727425, 7514.211834808889, 4228.725132866354, 4251.3771154784645, 4262.126777339739, 4271.765052922057, 4274.551172126944, 3065.739412149948, 3097.6902309768843, 3098.2719061020643, 3099.9225019374694, 3104.456720073978, 541.5992165797281, 546.592788372657, 547.4990383798859, 548.1366847215651, 554.0968221798443, 504.87551353759636, 514.3210961530818, 514.729766872395, 518.8184135552602, 535.8955003774226, 8034.758957231293, 8629.0, 8712.477251364939, 8832.725767602415, 8927.776805579913, 496.6051988669017, 572.7995201679379, 648.8377905523619, 704.9718011279491, 737.8413641067197, 4027.335489644176, 4228.534861165269, 4276.828926842892, 4313.309870420718, 4505.346724724962, 54717.179242311395, 55016.17475737867, 55109.724451378286, 55169.72415137979, 55186.448135518935, 48569.0, 49644.0, 50163.74918125386, 50218.74890625597, 50245.24632130521, 42415.787921060815, 42537.36193957093, 42801.0, 43598.7820060904, 43646.56353436488, 8906.777330566787, 8907.955460222658, 9099.636014559343, 9145.451272923647, 9270.768230794283, 30743.385132296782, 31414.842925785226, 31875.84062079675, 32163.51754723634, 35427.468587971714, 43230.13539729125, 43255.78372108119, 44367.33448998203, 45111.774441127585, 45995.77002114968, 11054.0, 11074.11407087415, 11116.174474703623, 11116.277441966246, 11354.943225283821, 12034.277943323428, 12537.686557836127, 12588.748225035264, 12600.243985360908, 12663.556775512812, 11737.47181376823, 11914.30064448716, 11945.16383853122, 12164.0, 12454.25274483534, 11800.881991180322, 11844.28934263947, 11992.74076221984, 12375.319357435428, 12382.876171238173, 11669.76660466769, 11991.520339186683, 12260.632181034583, 12535.93732031334, 12566.874331256571, 9605.279604029865, 9849.26130540198, 9934.254930880068, 10108.84836727435, 10177.49112544355, 9610.375325603813, 9648.565814538222, 9838.557264922953, 9895.158911492605, 9988.101070903653], "unit": "score", "name": "yui.html", "value": 6226.469289332893}], "name": "dromaeo_css", "value": 6708.216199610478}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 107.0, 110.0, 108.0, 111.0, 110.0, 110.0, 102.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [154.0, 124.0, 148.0, 167.0, 128.0, 148.0, 146.0, 126.0, 170.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 143.6}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 161.0, 160.0, 162.0, 162.0, 159.0, 167.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 77.0, 155.0, 76.0, 73.0, 73.0, 73.0, 149.0, 75.0], "unit": "score", "name": "audio-fft", "value": 89.6}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 149.0, 95.0, 97.0, 97.0, 139.0, 95.0, 104.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 110.4}, {"lowerIsBetter": true, "replicates": [120.0, 115.0, 114.0, 115.0, 115.0, 117.0, 115.0, 114.0, 116.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.6}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [58.0, 55.0, 56.0, 55.0, 56.0, 57.0, 55.0, 55.0, 60.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 68.0, 66.0, 67.0, 67.0, 66.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.9}, {"lowerIsBetter": true, "replicates": [93.0, 84.0, 84.0, 83.0, 83.0, 83.0, 84.0, 83.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [123.0, 114.0, 115.0, 125.0, 118.0, 130.0, 116.0, 116.0, 131.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.2}, {"lowerIsBetter": true, "replicates": [143.0, 131.0, 143.0, 142.0, 141.0, 133.0, 143.0, 133.0, 142.0, 155.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.6}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 71.0, 70.0, 67.0, 69.0, 69.0, 67.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1508.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.0843776106934], "unit": "score", "name": "Richards", "value": 211.28247000000007}, {"lowerIsBetter": false, "replicates": [189.000189000189], "unit": "score", "name": "DeltaBlue", "value": 349.8303379999999}, {"lowerIsBetter": false, "replicates": [272.8512960436562], "unit": "score", "name": "Encrypt", "value": 975.5533650000004}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1951.2670565302144], "unit": "score", "name": "RayTrace", "value": 379.23512187812196}, {"lowerIsBetter": false, "replicates": [772.2007722007722], "unit": "score", "name": "Earley", "value": 863.0695849999998}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [42270.833333333336], "unit": "score", "name": "RegExp", "value": 21.551148348940345}, {"lowerIsBetter": false, "replicates": [596.7837998808815], "unit": "score", "name": "Splay", "value": 136.55028842315363}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 19045.702606854287}]} 17:46:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19045.70"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1508.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6708.22"}}} 17:46:08 INFO - Return code: 0 17:46:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:46:08 INFO - # TBPL SUCCESS # 17:46:08 INFO - Running post-action listener: _resource_record_post_action 17:46:08 INFO - Running post-run listener: _resource_record_post_run 17:46:09 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540459008; Read time: 16; Write time: 476224 17:46:09 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236355584; Read time: 0; Write time: 255052 17:46:09 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 304103424; Read time: 16; Write time: 221172 17:46:09 INFO - Running post-run listener: _upload_blobber_files 17:46:09 INFO - Blob upload gear active. 17:46:09 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:46:09 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:46:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:46:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:46:09 INFO - (blobuploader) - INFO - Open directory for files ... 17:46:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:46:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:46:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:46:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:46:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:46:11 INFO - (blobuploader) - INFO - Done attempting. 17:46:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:46:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:46:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:46:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:46:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:46:12 INFO - (blobuploader) - INFO - Done attempting. 17:46:12 INFO - (blobuploader) - INFO - Iteration through files over. 17:46:12 INFO - Return code: 0 17:46:12 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:46:12 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:46:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/13580b8d474c7420dbe65d4ebc5790bee2421c9cc061684fa6dc51d259246a490eb1282e8bd34ebb78060d7276cd1ee8d12ae2482ec095d87e3e5216c81fe48c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/37e015b1b3eb334bbda4cf54366a270996f1599df6655565654b00379f7747b89a4aefad3b4a169d20fc075cd6687484df74e746c87c112b03011f51951469c5"} 17:46:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:46:12 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:46:12 INFO - Contents: 17:46:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/13580b8d474c7420dbe65d4ebc5790bee2421c9cc061684fa6dc51d259246a490eb1282e8bd34ebb78060d7276cd1ee8d12ae2482ec095d87e3e5216c81fe48c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/37e015b1b3eb334bbda4cf54366a270996f1599df6655565654b00379f7747b89a4aefad3b4a169d20fc075cd6687484df74e746c87c112b03011f51951469c5"} 17:46:12 INFO - Running post-run listener: copy_logs_to_upload_dir 17:46:12 INFO - Copying logs to upload dir... 17:46:12 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:46:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.932427 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-02-02 17:46:12.578297) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-02 17:46:12.581873) ========= 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=ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/13580b8d474c7420dbe65d4ebc5790bee2421c9cc061684fa6dc51d259246a490eb1282e8bd34ebb78060d7276cd1ee8d12ae2482ec095d87e3e5216c81fe48c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/37e015b1b3eb334bbda4cf54366a270996f1599df6655565654b00379f7747b89a4aefad3b4a169d20fc075cd6687484df74e746c87c112b03011f51951469c5"} build_url:https://queue.taskcluster.net/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011495 build_url: 'https://queue.taskcluster.net/v1/task/bM55wTZ_RF2mp0J-27dupQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/13580b8d474c7420dbe65d4ebc5790bee2421c9cc061684fa6dc51d259246a490eb1282e8bd34ebb78060d7276cd1ee8d12ae2482ec095d87e3e5216c81fe48c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/37e015b1b3eb334bbda4cf54366a270996f1599df6655565654b00379f7747b89a4aefad3b4a169d20fc075cd6687484df74e746c87c112b03011f51951469c5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-02 17:46:12.608317) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 17:46:12.608797) ========= 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=ed14279e38b05397cf4aa391000001a4-1454462705.95226-1607468061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 17:46:12.692576) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-02 17:46:12.693002) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-02 17:46:12.693425) ========= ========= Total master_lag: 0.28 =========