builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-069 starttime: 1454721312.43 results: success (0) buildid: 20160205143007 builduid: 0ca2eca012894339934c7a275cb9b2e9 revision: beea9ac7d82391a03247940e2a1e9ee0f7d44940 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-05 17:15:12.433967) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-05 17:15:12.434433) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-05 17:15:12.434744) ========= 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=1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006351 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-05 17:15:12.458290) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-05 17:15:12.458588) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-05 17:15:12.491752) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 17:15:12.492015) ========= 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=1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 17:15:12.543290) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-05 17:15:12.543568) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-05 17:15:12.543933) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 17:15:12.544221) ========= 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=1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-05 17:15:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.5M=0s 2016-02-05 17:15:13 (84.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156250 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 17:15:12.722643) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 17:15:12.723196) ========= 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=1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016507 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 17:15:12.773774) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 17:15:12.774158) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev beea9ac7d82391a03247940e2a1e9ee0f7d44940 --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 beea9ac7d82391a03247940e2a1e9ee0f7d44940 --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=1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-05 17:15:13,249 truncating revision to first 12 chars 2016-02-05 17:15:13,249 Setting DEBUG logging. 2016-02-05 17:15:13,249 attempt 1/10 2016-02-05 17:15:13,249 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/beea9ac7d823?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-05 17:15:13,763 unpacking tar archive at: b2g-inbound-beea9ac7d823/testing/mozharness/ program finished with exit code 0 elapsedTime=0.812897 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 17:15:13.600140) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-05 17:15:13.600495) ========= echo beea9ac7d82391a03247940e2a1e9ee0f7d44940 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'beea9ac7d82391a03247940e2a1e9ee0f7d44940'] 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=1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False beea9ac7d82391a03247940e2a1e9ee0f7d44940 program finished with exit code 0 elapsedTime=0.004678 script_repo_revision: 'beea9ac7d82391a03247940e2a1e9ee0f7d44940' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-05 17:15:13.651760) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-05 17:15:13.652093) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-05 17:15:13.662385) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-02-05 17:15:13.662790) ========= /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=1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:15:14 INFO - MultiFileLogger online at 20160205 17:15:14 in /builds/slave/test-pgo 17:15:14 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:15:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:15:14 INFO - {'append_to_log': False, 17:15:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:15:14 INFO - 'blob_upload_branch': 'B2G-Inbound', 17:15:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:15:14 INFO - 'branch': 'B2G-Inbound', 17:15:14 INFO - 'buildbot_json_path': 'buildprops.json', 17:15:14 INFO - 'config_files': ('talos/linux_config.py',), 17:15:14 INFO - 'default_actions': ('clobber', 17:15:14 INFO - 'read-buildbot-config', 17:15:14 INFO - 'download-and-extract', 17:15:14 INFO - 'populate-webroot', 17:15:14 INFO - 'create-virtualenv', 17:15:14 INFO - 'install', 17:15:14 INFO - 'run-tests'), 17:15:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:15:14 INFO - 'download_minidump_stackwalk': True, 17:15:14 INFO - 'download_symbols': 'ondemand', 17:15:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:15:14 INFO - 'tooltool.py': '/tools/tooltool.py', 17:15:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:15:14 INFO - '/tools/misc-python/virtualenv.py')}, 17:15:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:15:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:15:14 INFO - 'installer_path': 'installer.exe', 17:15:14 INFO - 'log_level': 'info', 17:15:14 INFO - 'log_name': 'talos', 17:15:14 INFO - 'log_to_console': True, 17:15:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:15:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:15:14 INFO - 'opt_config_files': (), 17:15:14 INFO - 'pip_index': False, 17:15:14 INFO - 'sps_profile': False, 17:15:14 INFO - 'sps_profile_interval': 0, 17:15:14 INFO - 'suite': 'dromaeojs', 17:15:14 INFO - 'system_bits': '32', 17:15:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:15:14 INFO - 'title': 'talos-linux64-ix-069', 17:15:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:15:14 INFO - 'use_talos_json': True, 17:15:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:15:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:15:14 INFO - 'work_dir': 'build'} 17:15:14 INFO - ##### 17:15:14 INFO - ##### Running clobber step. 17:15:14 INFO - ##### 17:15:14 INFO - Running pre-action listener: _resource_record_pre_action 17:15:14 INFO - Running main action method: clobber 17:15:14 INFO - rmtree: /builds/slave/test-pgo/build 17:15:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:15:14 INFO - Running post-action listener: _resource_record_post_action 17:15:14 INFO - ##### 17:15:14 INFO - ##### Running read-buildbot-config step. 17:15:14 INFO - ##### 17:15:14 INFO - Running pre-action listener: _resource_record_pre_action 17:15:14 INFO - Running main action method: read_buildbot_config 17:15:14 INFO - Using buildbot properties: 17:15:14 INFO - { 17:15:14 INFO - "project": "", 17:15:14 INFO - "product": "firefox", 17:15:14 INFO - "script_repo_revision": "production", 17:15:14 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 17:15:14 INFO - "repository": "", 17:15:14 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 17:15:14 INFO - "buildid": "20160205143007", 17:15:14 INFO - "pgo_build": "True", 17:15:14 INFO - "basedir": "/builds/slave/test-pgo", 17:15:14 INFO - "buildnumber": 257, 17:15:14 INFO - "slavename": "talos-linux64-ix-069", 17:15:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:15:14 INFO - "platform": "ubuntu64_hw", 17:15:14 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 17:15:14 INFO - "branch": "b2g-inbound", 17:15:14 INFO - "repo_path": "integration/b2g-inbound", 17:15:14 INFO - "revision": "beea9ac7d82391a03247940e2a1e9ee0f7d44940", 17:15:14 INFO - "stage_platform": "linux64-pgo", 17:15:14 INFO - "builduid": "0ca2eca012894339934c7a275cb9b2e9", 17:15:14 INFO - "slavebuilddir": "test" 17:15:14 INFO - } 17:15:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 17:15:14 INFO - Running post-action listener: _resource_record_post_action 17:15:14 INFO - ##### 17:15:14 INFO - ##### Running download-and-extract step. 17:15:14 INFO - ##### 17:15:14 INFO - Running pre-action listener: _resource_record_pre_action 17:15:14 INFO - Running main action method: download_and_extract 17:15:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:14 INFO - https://queue.taskcluster.net/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:15:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/artifacts/public/build/test_packages.json 17:15:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/artifacts/public/build/test_packages.json 17:15:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:15:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:15:15 INFO - Downloaded 1448 bytes. 17:15:15 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:15:15 INFO - Using the following test package requirements: 17:15:15 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:15:15 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:15:15 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:15:15 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:15 INFO - u'jsshell-linux-x86_64.zip'], 17:15:15 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:15:15 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:15:15 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:15:15 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:15:15 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:15:15 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:15:15 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:15:15 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:15:15 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:15:15 INFO - https://queue.taskcluster.net/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:15:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:15:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:15:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/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:15:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/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:15:17 INFO - Downloaded 22498939 bytes. 17:15:17 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:15:17 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:15:18 INFO - Return code: 0 17:15:18 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:15: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:15:18 INFO - https://queue.taskcluster.net/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:15:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:15:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:15:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/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:15:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/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:15:20 INFO - Downloaded 22498939 bytes. 17:15:20 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:15:20 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:15:22 INFO - Return code: 0 17:15:22 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:15:22 INFO - https://queue.taskcluster.net/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:15:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:15:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:15:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/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:15:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/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:15:23 INFO - Downloaded 10706572 bytes. 17:15:23 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:15:23 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:15:23 INFO - Return code: 0 17:15: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:15:23 INFO - https://queue.taskcluster.net/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:15:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:15:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:15:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/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:15:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/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:15:26 INFO - Downloaded 55983067 bytes. 17:15:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:15:26 INFO - mkdir: /builds/slave/test-pgo/properties 17:15:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:15:26 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:15:26 INFO - Contents: 17:15:26 INFO - build_url:https://queue.taskcluster.net/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:15:26 INFO - Running post-action listener: _resource_record_post_action 17:15:26 INFO - Running post-action listener: set_extra_try_arguments 17:15:26 INFO - ##### 17:15:26 INFO - ##### Running populate-webroot step. 17:15:26 INFO - ##### 17:15:26 INFO - Running pre-action listener: _resource_record_pre_action 17:15:26 INFO - Running main action method: populate_webroot 17:15:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:15:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:15:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:15:26 INFO - '--tppagecycles', 17:15:26 INFO - '7'], 17:15:26 INFO - 'tests': ['tsvgm']}}, 17:15:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:15:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:15:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:15:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:15:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:15:26 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:15:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:26 INFO - 'talos_options': ['--e10s'], 17:15:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:26 INFO - 'tests': ['damp', 'tps']}, 17:15:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:26 INFO - 'talos_options': ['--e10s'], 17:15:26 INFO - 'tests': ['damp', 'tps']}, 17:15:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:15:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:15:26 INFO - 'other': {'tests': ['a11yr', 17:15:26 INFO - 'ts_paint', 17:15:26 INFO - 'tpaint', 17:15:26 INFO - 'sessionrestore', 17:15:26 INFO - 'sessionrestore_no_auto_restore']}, 17:15:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:15:26 INFO - 'tests': ['a11yr', 17:15:26 INFO - 'ts_paint', 17:15:26 INFO - 'tpaint', 17:15:26 INFO - 'sessionrestore', 17:15:26 INFO - 'sessionrestore_no_auto_restore']}, 17:15:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:15:26 INFO - 'tests': ['a11yr', 17:15:26 INFO - 'ts_paint', 17:15:26 INFO - 'tpaint', 17:15:26 INFO - 'sessionrestore', 17:15:26 INFO - 'sessionrestore_no_auto_restore']}, 17:15:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:15:26 INFO - 'tests': ['a11yr', 17:15:26 INFO - 'ts_paint', 17:15:26 INFO - 'tpaint', 17:15:26 INFO - 'sessionrestore', 17:15:26 INFO - 'sessionrestore_no_auto_restore']}, 17:15:26 INFO - 'other_l64': {'tests': ['a11yr', 17:15:26 INFO - 'ts_paint', 17:15:26 INFO - 'tpaint', 17:15:26 INFO - 'sessionrestore', 17:15:26 INFO - 'sessionrestore_no_auto_restore']}, 17:15:26 INFO - 'other_nol64': {'tests': ['a11yr', 17:15:26 INFO - 'ts_paint', 17:15:26 INFO - 'tpaint', 17:15:26 INFO - 'sessionrestore', 17:15:26 INFO - 'sessionrestore_no_auto_restore']}, 17:15:26 INFO - 'svgr': {'tests': ['tsvgx', 17:15:26 INFO - 'tsvgr_opacity', 17:15:26 INFO - 'tart', 17:15:26 INFO - 'tscrollx', 17:15:26 INFO - 'cart']}, 17:15:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:15:26 INFO - 'tests': ['tsvgx', 17:15:26 INFO - 'tsvgr_opacity', 17:15:26 INFO - 'tart', 17:15:26 INFO - 'tscrollx', 17:15:26 INFO - 'cart']}, 17:15:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:26 INFO - 'tests': ['tp5o']}, 17:15:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:26 INFO - 'talos_options': ['--e10s'], 17:15:26 INFO - 'tests': ['tp5o']}, 17:15:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:26 INFO - 'talos_options': ['--xperf_path', 17:15:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:26 INFO - 'tests': ['tp5n']}, 17:15:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:26 INFO - 'talos_options': ['--e10s', 17:15:26 INFO - '--xperf_path', 17:15:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:26 INFO - 'tests': ['tp5n']}}, 17:15:26 INFO - 'talos.zip': {'path': '', 17:15:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:15:26 INFO - Running post-action listener: _resource_record_post_action 17:15:26 INFO - ##### 17:15:26 INFO - ##### Running create-virtualenv step. 17:15:26 INFO - ##### 17:15:26 INFO - Running pre-action listener: _resource_record_pre_action 17:15:26 INFO - Running main action method: create_virtualenv 17:15:26 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:15:26 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:15:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:15:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:15:26 INFO - Using real prefix '/usr' 17:15:26 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:15:26 INFO - Installing distribute.............................................................................................................................................................................................done. 17:15:28 INFO - Installing pip.................done. 17:15:28 INFO - Return code: 0 17:15:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:15:28 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:15:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:28 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:15:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:28 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 0x7f720ff67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b73840>, '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 0x2ae06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0b60>, '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': '1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417', '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:15:28 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:15:28 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:15:28 INFO - Using env: {'DISPLAY': ':0', 17:15:28 INFO - 'HOME': '/home/cltbld', 17:15:28 INFO - 'LANG': 'en_US.UTF-8', 17:15:28 INFO - 'LANGUAGE': 'en_US:en', 17:15:28 INFO - 'LOGNAME': 'cltbld', 17:15:28 INFO - 'MAIL': '/var/mail/cltbld', 17:15:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:28 INFO - 'MOZ_NO_REMOTE': '1', 17:15:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:28 INFO - 'NO_EM_RESTART': '1', 17:15:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:28 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:28 INFO - 'SHELL': '/bin/bash', 17:15:28 INFO - 'SHLVL': '1', 17:15:28 INFO - 'TERM': 'linux', 17:15:28 INFO - 'TMOUT': '86400', 17:15:28 INFO - 'USER': 'cltbld', 17:15:28 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417', 17:15:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:28 INFO - '_': '/tools/buildbot/bin/python'} 17:15:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:28 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:15:28 INFO - Cleaning up... 17:15:28 INFO - Return code: 0 17:15:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:15:28 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:15:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:28 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:15:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:28 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 0x7f720ff67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b73840>, '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 0x2ae06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0b60>, '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': '1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417', '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:15:28 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:15:28 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:15:28 INFO - Using env: {'DISPLAY': ':0', 17:15:28 INFO - 'HOME': '/home/cltbld', 17:15:28 INFO - 'LANG': 'en_US.UTF-8', 17:15:28 INFO - 'LANGUAGE': 'en_US:en', 17:15:28 INFO - 'LOGNAME': 'cltbld', 17:15:28 INFO - 'MAIL': '/var/mail/cltbld', 17:15:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:28 INFO - 'MOZ_NO_REMOTE': '1', 17:15:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:28 INFO - 'NO_EM_RESTART': '1', 17:15:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:28 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:28 INFO - 'SHELL': '/bin/bash', 17:15:28 INFO - 'SHLVL': '1', 17:15:28 INFO - 'TERM': 'linux', 17:15:28 INFO - 'TMOUT': '86400', 17:15:28 INFO - 'USER': 'cltbld', 17:15:28 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417', 17:15:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:28 INFO - '_': '/tools/buildbot/bin/python'} 17:15:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:29 INFO - Downloading/unpacking psutil>=0.7.1 17:15:29 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:15:29 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:15:29 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:15:29 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:15:29 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:15:29 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:15:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:15:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:15:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:15:30 INFO - Installing collected packages: psutil 17:15:30 INFO - Running setup.py install for psutil 17:15:31 INFO - building 'psutil._psutil_linux' extension 17:15:31 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:15:31 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:15:31 INFO - building 'psutil._psutil_posix' extension 17:15:31 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:15:31 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:15:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:15:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:15:31 INFO - Successfully installed psutil 17:15:31 INFO - Cleaning up... 17:15:31 INFO - Return code: 0 17:15:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:31 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 0x7f720ff67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b73840>, '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 0x2ae06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0b60>, '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': '1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417', '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:15:31 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:15:31 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:15:31 INFO - Using env: {'DISPLAY': ':0', 17:15:31 INFO - 'HOME': '/home/cltbld', 17:15:31 INFO - 'LANG': 'en_US.UTF-8', 17:15:31 INFO - 'LANGUAGE': 'en_US:en', 17:15:31 INFO - 'LOGNAME': 'cltbld', 17:15:31 INFO - 'MAIL': '/var/mail/cltbld', 17:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:31 INFO - 'MOZ_NO_REMOTE': '1', 17:15:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:31 INFO - 'NO_EM_RESTART': '1', 17:15:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:31 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:31 INFO - 'SHELL': '/bin/bash', 17:15:31 INFO - 'SHLVL': '1', 17:15:31 INFO - 'TERM': 'linux', 17:15:31 INFO - 'TMOUT': '86400', 17:15:31 INFO - 'USER': 'cltbld', 17:15:31 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417', 17:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:31 INFO - '_': '/tools/buildbot/bin/python'} 17:15:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:15: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:15: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:15: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:15: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:15: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:15: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:15:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:15:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:15:33 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:15:33 INFO - Installing collected packages: mozsystemmonitor 17:15:33 INFO - Running setup.py install for mozsystemmonitor 17:15:33 INFO - Successfully installed mozsystemmonitor 17:15:33 INFO - Cleaning up... 17:15:33 INFO - Return code: 0 17:15:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:15: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:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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:15:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:33 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 0x7f720ff67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b73840>, '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 0x2ae06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0b60>, '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': '1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417', '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:15:33 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:15:33 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:15:33 INFO - Using env: {'DISPLAY': ':0', 17:15:33 INFO - 'HOME': '/home/cltbld', 17:15:33 INFO - 'LANG': 'en_US.UTF-8', 17:15:33 INFO - 'LANGUAGE': 'en_US:en', 17:15:33 INFO - 'LOGNAME': 'cltbld', 17:15:33 INFO - 'MAIL': '/var/mail/cltbld', 17:15:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:33 INFO - 'MOZ_NO_REMOTE': '1', 17:15:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:33 INFO - 'NO_EM_RESTART': '1', 17:15:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:33 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:33 INFO - 'SHELL': '/bin/bash', 17:15:33 INFO - 'SHLVL': '1', 17:15:33 INFO - 'TERM': 'linux', 17:15:33 INFO - 'TMOUT': '86400', 17:15:33 INFO - 'USER': 'cltbld', 17:15:33 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417', 17:15:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:33 INFO - '_': '/tools/buildbot/bin/python'} 17:15:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:33 INFO - Downloading/unpacking blobuploader==1.2.4 17:15:33 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:15:33 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:15:33 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:15:33 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:15:33 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:15:33 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:15:35 INFO - Downloading blobuploader-1.2.4.tar.gz 17:15:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:15:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:15:35 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:15:35 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:15:35 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:15:35 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:15:35 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:15:35 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:15:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:15:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:15: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:15: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:15: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:15: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:15: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:15: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:15:36 INFO - Downloading docopt-0.6.1.tar.gz 17:15:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:15:36 INFO - Installing collected packages: blobuploader, requests, docopt 17:15:36 INFO - Running setup.py install for blobuploader 17:15:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:15:36 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:15:36 INFO - Running setup.py install for requests 17:15:36 INFO - Running setup.py install for docopt 17:15:36 INFO - Successfully installed blobuploader requests docopt 17:15:36 INFO - Cleaning up... 17:15:37 INFO - Return code: 0 17:15:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:37 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 0x7f720ff67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b73840>, '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 0x2ae06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0b60>, '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': '1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417', '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:15:37 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:15:37 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:15:37 INFO - Using env: {'DISPLAY': ':0', 17:15:37 INFO - 'HOME': '/home/cltbld', 17:15:37 INFO - 'LANG': 'en_US.UTF-8', 17:15:37 INFO - 'LANGUAGE': 'en_US:en', 17:15:37 INFO - 'LOGNAME': 'cltbld', 17:15:37 INFO - 'MAIL': '/var/mail/cltbld', 17:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:37 INFO - 'MOZ_NO_REMOTE': '1', 17:15:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:37 INFO - 'NO_EM_RESTART': '1', 17:15:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:37 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:37 INFO - 'SHELL': '/bin/bash', 17:15:37 INFO - 'SHLVL': '1', 17:15:37 INFO - 'TERM': 'linux', 17:15:37 INFO - 'TMOUT': '86400', 17:15:37 INFO - 'USER': 'cltbld', 17:15:37 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417', 17:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:37 INFO - '_': '/tools/buildbot/bin/python'} 17:15:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:15:37 INFO - Running setup.py (path:/tmp/pip-s_B4_T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:15:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:15:37 INFO - Running setup.py (path:/tmp/pip-FMKSSi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:15:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:15:37 INFO - Running setup.py (path:/tmp/pip-y_rMKa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:15:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:15:37 INFO - Running setup.py (path:/tmp/pip-HWWoC_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:15:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:15:37 INFO - Running setup.py (path:/tmp/pip-viebhM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:15:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:15:37 INFO - Running setup.py (path:/tmp/pip-jkE3Js-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:15:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:15:37 INFO - Running setup.py (path:/tmp/pip-NuACNq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:15:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:15:37 INFO - Running setup.py (path:/tmp/pip-Fuyjon-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:15:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:15:37 INFO - Running setup.py (path:/tmp/pip-MuRh5t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:15:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:15:37 INFO - Running setup.py (path:/tmp/pip-qgRQPz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:15:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:15:37 INFO - Running setup.py (path:/tmp/pip-9hybMI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:15:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:15:38 INFO - Running setup.py (path:/tmp/pip-qvfAQ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:15:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:15:38 INFO - Running setup.py (path:/tmp/pip-IcYsdG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:15:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:15:38 INFO - Running setup.py (path:/tmp/pip-Btlt9E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:15:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:15:38 INFO - Running setup.py (path:/tmp/pip-cEYjHU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:15:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:15:38 INFO - Running setup.py (path:/tmp/pip-mFMpVq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:15:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:15:38 INFO - Running setup.py (path:/tmp/pip-RAISQE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:15:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:15:38 INFO - Running setup.py install for manifestparser 17:15:38 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:15:38 INFO - Running setup.py install for mozcrash 17:15:38 INFO - Running setup.py install for mozdebug 17:15:38 INFO - Running setup.py install for mozdevice 17:15:38 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:15:38 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:15:38 INFO - Running setup.py install for mozfile 17:15:39 INFO - Running setup.py install for mozhttpd 17:15:39 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:15:39 INFO - Running setup.py install for mozinfo 17:15:39 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:15:39 INFO - Running setup.py install for mozInstall 17:15:39 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:15:39 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:15:39 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:15:39 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:15:39 INFO - Running setup.py install for mozleak 17:15:39 INFO - Running setup.py install for mozlog 17:15:39 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:15:39 INFO - Running setup.py install for moznetwork 17:15:39 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:15:39 INFO - Running setup.py install for mozprocess 17:15:39 INFO - Running setup.py install for mozprofile 17:15:39 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:15:39 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:15:39 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:15:39 INFO - Running setup.py install for mozrunner 17:15:39 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:15:39 INFO - Running setup.py install for mozscreenshot 17:15:40 INFO - Running setup.py install for moztest 17:15:40 INFO - Running setup.py install for mozversion 17:15:40 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:15:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:15:40 INFO - Cleaning up... 17:15:40 INFO - Return code: 0 17:15:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:40 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 0x7f720ff67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b73840>, '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 0x2ae06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0b60>, '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': '1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417', '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:15:40 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:15:40 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:15:40 INFO - Using env: {'DISPLAY': ':0', 17:15:40 INFO - 'HOME': '/home/cltbld', 17:15:40 INFO - 'LANG': 'en_US.UTF-8', 17:15:40 INFO - 'LANGUAGE': 'en_US:en', 17:15:40 INFO - 'LOGNAME': 'cltbld', 17:15:40 INFO - 'MAIL': '/var/mail/cltbld', 17:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:40 INFO - 'MOZ_NO_REMOTE': '1', 17:15:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:40 INFO - 'NO_EM_RESTART': '1', 17:15:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:40 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:40 INFO - 'SHELL': '/bin/bash', 17:15:40 INFO - 'SHLVL': '1', 17:15:40 INFO - 'TERM': 'linux', 17:15:40 INFO - 'TMOUT': '86400', 17:15:40 INFO - 'USER': 'cltbld', 17:15:40 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417', 17:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:40 INFO - '_': '/tools/buildbot/bin/python'} 17:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:15:40 INFO - Running setup.py (path:/tmp/pip-kTKHt2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:15:40 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:15:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:15:40 INFO - Running setup.py (path:/tmp/pip-zTM5S_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:15:40 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:15:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:15:40 INFO - Running setup.py (path:/tmp/pip-rI2dC8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:15:40 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:15:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:15:40 INFO - Running setup.py (path:/tmp/pip-uZ1IB3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:15:40 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:15:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:15:40 INFO - Running setup.py (path:/tmp/pip-6Bqcls-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:15:40 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:15:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:15:40 INFO - Running setup.py (path:/tmp/pip-fNEDpL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:15:40 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:15:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:15:40 INFO - Running setup.py (path:/tmp/pip-wrGh92-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:15:40 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:15:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:15:40 INFO - Running setup.py (path:/tmp/pip-RwM_7N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:15:41 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:15:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:15:41 INFO - Running setup.py (path:/tmp/pip-GLz1_w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:15:41 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:15:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:15:41 INFO - Running setup.py (path:/tmp/pip-9rNOrF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:15:41 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:15:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:15:41 INFO - Running setup.py (path:/tmp/pip-GvdnR9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:15:41 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:15:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:15:41 INFO - Running setup.py (path:/tmp/pip-Nv5otD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:15:41 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:15:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:15:41 INFO - Running setup.py (path:/tmp/pip-HK8DFc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:15:41 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:15:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:15:41 INFO - Running setup.py (path:/tmp/pip-csiOd5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:15:41 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:15:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:15:41 INFO - Running setup.py (path:/tmp/pip-5QCF1x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:15:41 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:15:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:15:41 INFO - Running setup.py (path:/tmp/pip-pCBdP1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:15:41 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:15:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:15:41 INFO - Running setup.py (path:/tmp/pip-5mb3Eg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:15:41 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:15:41 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:15:41 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:15:41 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:15:41 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:15:41 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:15:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:15:41 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:15:41 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:15:41 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:15:41 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:15:41 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:15:41 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:15:43 INFO - Downloading blessings-1.6.tar.gz 17:15:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:15:43 INFO - Installing collected packages: blessings 17:15:43 INFO - Running setup.py install for blessings 17:15:43 INFO - Successfully installed blessings 17:15:43 INFO - Cleaning up... 17:15:43 INFO - Return code: 0 17:15:43 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:15:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:15:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:15:43 INFO - Reading from file tmpfile_stdout 17:15:43 INFO - Current package versions: 17:15:43 INFO - argparse == 1.2.1 17:15:43 INFO - blessings == 1.6 17:15:43 INFO - blobuploader == 1.2.4 17:15:43 INFO - docopt == 0.6.1 17:15:43 INFO - manifestparser == 1.1 17:15:43 INFO - mozInstall == 1.12 17:15:43 INFO - mozcrash == 0.16 17:15:43 INFO - mozdebug == 0.1 17:15:43 INFO - mozdevice == 0.48 17:15:43 INFO - mozfile == 1.2 17:15:43 INFO - mozhttpd == 0.7 17:15:43 INFO - mozinfo == 0.9 17:15:43 INFO - mozleak == 0.1 17:15:43 INFO - mozlog == 3.1 17:15:43 INFO - moznetwork == 0.27 17:15:43 INFO - mozprocess == 0.22 17:15:43 INFO - mozprofile == 0.28 17:15:43 INFO - mozrunner == 6.11 17:15:43 INFO - mozscreenshot == 0.1 17:15:43 INFO - mozsystemmonitor == 0.0 17:15:43 INFO - moztest == 0.7 17:15:43 INFO - mozversion == 1.4 17:15:43 INFO - psutil == 3.1.1 17:15:43 INFO - requests == 1.2.3 17:15:43 INFO - wsgiref == 0.1.2 17:15:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:43 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 0x7f720ff67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b73840>, '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 0x2ae06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0b60>, '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': '1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417', '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:15:43 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:15:43 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:15:43 INFO - Using env: {'DISPLAY': ':0', 17:15:43 INFO - 'HOME': '/home/cltbld', 17:15:43 INFO - 'LANG': 'en_US.UTF-8', 17:15:43 INFO - 'LANGUAGE': 'en_US:en', 17:15:43 INFO - 'LOGNAME': 'cltbld', 17:15:43 INFO - 'MAIL': '/var/mail/cltbld', 17:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:43 INFO - 'MOZ_NO_REMOTE': '1', 17:15:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:43 INFO - 'NO_EM_RESTART': '1', 17:15:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:43 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:43 INFO - 'SHELL': '/bin/bash', 17:15:43 INFO - 'SHLVL': '1', 17:15:43 INFO - 'TERM': 'linux', 17:15:43 INFO - 'TMOUT': '86400', 17:15:43 INFO - 'USER': 'cltbld', 17:15:43 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417', 17:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:43 INFO - '_': '/tools/buildbot/bin/python'} 17:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:44 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:15:44 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:15:44 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:15:44 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:15:44 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:15:44 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:15:44 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:15:44 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:15:44 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:15:44 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:15:44 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:15:44 INFO - Cleaning up... 17:15:44 INFO - Return code: 0 17:15:44 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:44 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 0x7f720ff67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b73840>, '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 0x2ae06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0b60>, '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': '1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417', '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:15:44 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:15:44 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:15:44 INFO - Using env: {'DISPLAY': ':0', 17:15:44 INFO - 'HOME': '/home/cltbld', 17:15:44 INFO - 'LANG': 'en_US.UTF-8', 17:15:44 INFO - 'LANGUAGE': 'en_US:en', 17:15:44 INFO - 'LOGNAME': 'cltbld', 17:15:44 INFO - 'MAIL': '/var/mail/cltbld', 17:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:44 INFO - 'MOZ_NO_REMOTE': '1', 17:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:44 INFO - 'NO_EM_RESTART': '1', 17:15:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:44 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:44 INFO - 'SHELL': '/bin/bash', 17:15:44 INFO - 'SHLVL': '1', 17:15:44 INFO - 'TERM': 'linux', 17:15:44 INFO - 'TMOUT': '86400', 17:15:44 INFO - 'USER': 'cltbld', 17:15:44 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417', 17:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:44 INFO - '_': '/tools/buildbot/bin/python'} 17:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:44 INFO - Downloading/unpacking jsonschema 17:15:44 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:15:44 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:15:44 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:15:44 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:15:44 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:15:44 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:15:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:15:46 INFO - Downloading/unpacking functools32 (from jsonschema) 17:15:46 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:15:46 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:15:46 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:15:46 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:15:46 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:15:46 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:15:46 INFO - Downloading functools32-3.2.3-2.tar.gz 17:15:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:15:46 INFO - warning: no files found matching '*.txt' 17:15:46 INFO - no previously-included directories found matching 'build' 17:15:46 INFO - no previously-included directories found matching 'dist' 17:15:46 INFO - no previously-included directories found matching '.git*' 17:15:46 INFO - Installing collected packages: jsonschema, functools32 17:15:46 INFO - Running setup.py install for functools32 17:15:46 INFO - warning: no files found matching '*.txt' 17:15:46 INFO - no previously-included directories found matching 'build' 17:15:46 INFO - no previously-included directories found matching 'dist' 17:15:46 INFO - no previously-included directories found matching '.git*' 17:15:46 INFO - Successfully installed jsonschema functools32 17:15:46 INFO - Cleaning up... 17:15:46 INFO - Return code: 0 17:15:46 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:46 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 0x7f720ff67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b73840>, '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 0x2ae06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0b60>, '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': '1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417', '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:15:46 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:15:46 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:15:46 INFO - Using env: {'DISPLAY': ':0', 17:15:46 INFO - 'HOME': '/home/cltbld', 17:15:46 INFO - 'LANG': 'en_US.UTF-8', 17:15:46 INFO - 'LANGUAGE': 'en_US:en', 17:15:46 INFO - 'LOGNAME': 'cltbld', 17:15:46 INFO - 'MAIL': '/var/mail/cltbld', 17:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:46 INFO - 'MOZ_NO_REMOTE': '1', 17:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:46 INFO - 'NO_EM_RESTART': '1', 17:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:46 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:46 INFO - 'SHELL': '/bin/bash', 17:15:46 INFO - 'SHLVL': '1', 17:15:46 INFO - 'TERM': 'linux', 17:15:46 INFO - 'TMOUT': '86400', 17:15:46 INFO - 'USER': 'cltbld', 17:15:46 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417', 17:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:46 INFO - '_': '/tools/buildbot/bin/python'} 17:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:46 INFO - Downloading/unpacking flake8 17:15:46 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:15:46 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:15:46 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:15:46 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:15:46 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:15:46 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:15:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:15:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:15:48 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:15:48 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:15:48 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:15:48 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:15:48 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:15:48 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:15:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:15:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:15:48 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:15:48 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:15:48 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:15:48 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:15:48 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:15:48 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:15:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:15:48 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:15:48 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:15:48 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:15:48 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:15:48 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:15:48 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:15:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:15:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:15:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:15:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:15:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:15:49 INFO - no previously-included directories found matching 'docs/_build' 17:15:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:15:49 INFO - Running setup.py install for pep8 17:15:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:15:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:15:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:15:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:15:49 INFO - no previously-included directories found matching 'docs/_build' 17:15:49 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:15:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:15:49 INFO - Cleaning up... 17:15:49 INFO - Return code: 0 17:15:49 INFO - Running post-action listener: _resource_record_post_action 17:15:49 INFO - Running post-action listener: _start_resource_monitoring 17:15:49 INFO - Starting resource monitoring. 17:15:49 INFO - ##### 17:15:49 INFO - ##### Running install step. 17:15:49 INFO - ##### 17:15:49 INFO - Running pre-action listener: _resource_record_pre_action 17:15:49 INFO - Running main action method: install 17:15:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:15:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:15:49 INFO - Reading from file tmpfile_stdout 17:15:49 INFO - Detecting whether we're running mozinstall >=1.0... 17:15:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:15:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:15:49 INFO - Reading from file tmpfile_stdout 17:15:49 INFO - Output received: 17:15:49 INFO - Usage: mozinstall [options] installer 17:15:49 INFO - Options: 17:15:49 INFO - -h, --help show this help message and exit 17:15:49 INFO - -d DEST, --destination=DEST 17:15:49 INFO - Directory to install application into. [default: 17:15:49 INFO - "/builds/slave/test-pgo"] 17:15:49 INFO - --app=APP Application being installed. [default: firefox] 17:15:49 INFO - mkdir: /builds/slave/test-pgo/build/application 17:15:49 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:15:49 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:16:05 INFO - Reading from file tmpfile_stdout 17:16:05 INFO - Output received: 17:16:05 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:16:05 INFO - Running post-action listener: _resource_record_post_action 17:16:05 INFO - ##### 17:16:05 INFO - ##### Running run-tests step. 17:16:05 INFO - ##### 17:16:05 INFO - Running pre-action listener: _resource_record_pre_action 17:16:05 INFO - Running main action method: run_tests 17:16:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:16:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:16:05 INFO - Python 2.7.3 17:16:05 INFO - Return code: 0 17:16:05 INFO - grabbing minidump binary from tooltool 17:16:05 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:16:05 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 0x2b73840>, '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 0x2ae06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:16:05 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:16:05 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:16:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:16:06 INFO - Return code: 0 17:16:06 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:16:06 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:16:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:16:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:16:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:16:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:16:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:16:07 INFO - Return code: 0 17:16:07 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/Gs_50eyMTMGJ2gK7d5zvsg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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:16:07 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/Gs_50eyMTMGJ2gK7d5zvsg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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:16:07 INFO - Using env: {'DISPLAY': ':0', 17:16:07 INFO - 'HOME': '/home/cltbld', 17:16:07 INFO - 'LANG': 'en_US.UTF-8', 17:16:07 INFO - 'LANGUAGE': 'en_US:en', 17:16:07 INFO - 'LOGNAME': 'cltbld', 17:16:07 INFO - 'MAIL': '/var/mail/cltbld', 17:16:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:16:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:07 INFO - 'MOZ_NO_REMOTE': '1', 17:16:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:07 INFO - 'NO_EM_RESTART': '1', 17:16:07 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:16:07 INFO - 'PWD': '/builds/slave/test-pgo', 17:16:07 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:16:07 INFO - 'SHELL': '/bin/bash', 17:16:07 INFO - 'SHLVL': '1', 17:16:07 INFO - 'TERM': 'linux', 17:16:07 INFO - 'TMOUT': '86400', 17:16:07 INFO - 'USER': 'cltbld', 17:16:07 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417', 17:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:07 INFO - '_': '/tools/buildbot/bin/python'} 17:16:07 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/Gs_50eyMTMGJ2gK7d5zvsg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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:16:07 INFO - mozversion application_buildid: 20160205143007 17:16:07 INFO - mozversion application_changeset: beea9ac7d82391a03247940e2a1e9ee0f7d44940 17:16:07 INFO - mozversion application_display_name: Nightly 17:16:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:16:07 INFO - mozversion application_name: Firefox 17:16:07 INFO - mozversion application_remotingname: firefox 17:16:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 17:16:07 INFO - mozversion application_vendor: Mozilla 17:16:07 INFO - mozversion application_version: 47.0a1 17:16:07 INFO - mozversion platform_buildid: 20160205143007 17:16:07 INFO - mozversion platform_changeset: beea9ac7d82391a03247940e2a1e9ee0f7d44940 17:16:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 17:16:07 INFO - mozversion platform_version: 47.0a1 17:16:07 INFO - using testdate: 1454721367 17:16:07 INFO - actual date: 1454721367 17:16:07 INFO - starting webserver on 'localhost:52204' 17:16:07 INFO - SUITE-START | Running 3 tests 17:16:07 INFO - TEST-START | dromaeo_css 17:16:07 INFO - operating with platform_type : linux_ 17:16:07 INFO - Initialising browser for dromaeo_css test... 17:16:07 INFO - TEST-INFO | started process 27625 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprQ2yKW/profile http://localhost:52204/getInfo.html) 17:16:11 INFO - PROCESS | 27625 | __metrics Screen width/height:1600/1200 17:16:11 INFO - PROCESS | 27625 | colorDepth:24 17:16:11 INFO - PROCESS | 27625 | Browser inner width/height: 1024/697 17:16:11 INFO - PROCESS | 27625 | __metrics 17:16:11 INFO - PROCESS | 27625 | 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:16:11 INFO - PROCESS | 27625 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:16:13 INFO - TEST-INFO | 27625: exit 0 17:16:13 INFO - Browser initialized. 17:16:13 INFO - Running cycle 1/1 for dromaeo_css test... 17:16:13 INFO - TEST-INFO | started process 27716 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprQ2yKW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:16:25 INFO - PROCESS | 27716 | RSS: Main: 148561920 17:16:25 INFO - PROCESS | 27716 | 17:17:16 INFO - PROCESS | 27716 | 1454721436633 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:19:24 INFO - PROCESS | 27716 | Cycle 1(1): loaded http://localhost:52204/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52204/tests/dromaeo/cssquery-ext.html) 17:19:25 INFO - PROCESS | 27716 | RSS: Main: 233095168 17:19:25 INFO - PROCESS | 27716 | 17:22:27 INFO - PROCESS | 27716 | Cycle 1(1): loaded http://localhost:52204/tests/dromaeo/cssquery-ext.html (next: http://localhost:52204/tests/dromaeo/cssquery-jquery.html) 17:22:28 INFO - PROCESS | 27716 | RSS: Main: 232353792 17:22:28 INFO - PROCESS | 27716 | 17:25:30 INFO - PROCESS | 27716 | Cycle 1(1): loaded http://localhost:52204/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52204/tests/dromaeo/cssquery-mootools.html) 17:25:31 INFO - PROCESS | 27716 | RSS: Main: 229326848 17:25:31 INFO - PROCESS | 27716 | 17:28:33 INFO - PROCESS | 27716 | Cycle 1(1): loaded http://localhost:52204/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52204/tests/dromaeo/cssquery-prototype.html) 17:28:33 INFO - PROCESS | 27716 | RSS: Main: 215216128 17:28:33 INFO - PROCESS | 27716 | 17:31:36 INFO - PROCESS | 27716 | Cycle 1(1): loaded http://localhost:52204/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52204/tests/dromaeo/cssquery-yui.html) 17:31:36 INFO - PROCESS | 27716 | RSS: Main: 217714688 17:31:36 INFO - PROCESS | 27716 | 17:34:39 INFO - PROCESS | 27716 | Cycle 1(1): loaded http://localhost:52204/tests/dromaeo/cssquery-yui.html (next: http://localhost:52204/tests/dromaeo/cssquery-dojo.html) 17:34:39 INFO - PROCESS | 27716 | RSS: Main: 275537920 17:34:39 INFO - PROCESS | 27716 | 17:34:39 INFO - PROCESS | 27716 | __start_tp_report 17:34:39 INFO - PROCESS | 27716 | _x_x_mozilla_page_load 17:34:39 INFO - PROCESS | 27716 | _x_x_mozilla_page_load_details 17:34:39 INFO - PROCESS | 27716 | |i|pagename|runs| 17:34:39 INFO - PROCESS | 27716 | |0;dojo.html;3111.393278310729;3130.4678204705197;3170.1599076244797;3174.0319202643186;3203.439398105331;4931.235658472942;4997.950020499794;5049.823256186034;5066.797328106881;5099.133147364948;5018.598512119031;5043.646944713872;5064.316317297164;5068.518490743382;5191.221316802482;4598.81604735811;4608.654350923677;4627.930581041287;4665.533446655341;4763.595094416979;4716.410448693913;4744.478107408182;4747.05058988202;4750.5724484796365;4760.8333708320215;4533.569310915458;4559.45286565611;4584.679072464929;4625.976870115662;4656.65075119364;4583.289590113504;4621.65337599678;4632.930506042412;4637.258038713823;4674.065186962621;4591.173588754056;4598.126355992385;4605.055963527502;4636.420447444069;4657.790399432034;4770.284457331393;4849.393825771778;4928.753562321869;4939.753012349368;4965.081459929888;5408.756605952703;5421.21392398104;5430.294061771944;5430.782768689248;5436.646617969859;5258.605604579634;5392.2181283714035;5415.970965516539;5449.918251226235;5458.836234912959;5021.322121513622;5033.798648054073;5054.49455054499;5071.1632580624155;5097.821576244851;5552.41699621542;5555.250041244381;5558.6942718150085;5561.694106824163;5575.0522411190195;5268.394134674485;5331.173668081454;5361.463853614685;5375.3280839895015;5377.7580008899695;5352.223927530564;5354.330708661418;5386.569074474032;5388.91916621251;5429.375621803464;5359.946400535945;5401.000814849187;5403.2165336026055;5403.972980135074;5453.945460545423;5187.06632806091;5268.104422248227;5341.198820177005;5382.838514844561;5390.0836857734275;4228.302330115496;4245.299525578307;4259.2759230930815;4268.551802060801;4274.893127671833;3826.081740382288;3839.827207775657;3841.078141246081;3858.9228215435533;3873.767573945572;4931.926021109686;4974.701517908937;5061.038402703474;5062.594992400599;5076.2131869559535;5375.1131063374105;5394.433584473652;5396.757145928443;5399.514043736082;5401.540869026098;5020.673656212334;5029.2958985742025;5029.321041659402;5035;5074.2895994560795;4504.684672072989;4583.289590113538;4610.838620648261;4654.348391225231;4686.039361930796;5533.723313834292;5540.556755459635;5582.134769110794;5611.158326251013;5625.409332020161;5319.840404787863;5364.7049412282695;5375.865603359947;5377.758000890048;5410.97294513525;5556;5574.331080270394;5700.629459085146;5707.343655479673;5734.885302294014;5323.148296272578;5343.65266257692;5345.412004679404;5345.572354211731;5349.117395629678;5396.379416367011;5406.810761623325;5408.78364865401;5410.026195284887;5452;5257.763400646903;5318.175682769177;5352.036633405869;5355.946440535545;5403.108487099742;5283.233931080049;5287.68273903567;5293.497117773805;5296.311479507639;5299.8410047698635;5156.819511317086;5179.533841954091;5219.217117432416;5228.294180285765;5260.342457192851;5230.529252367305;5236.162214045735;5254.527092561688;5329.760160792696;5332.466753324637;5218;5221.060209162387;5222.321098257202;5226.817061402832;5227.111391063452 17:34:39 INFO - PROCESS | 27716 | |1;ext.html;530.9230161626567;531.6252042310172;551.1732401397903;557.2198921509886;573.6816067082768;26921.19236422908;27291.590626140623;27308.45383092337;37320.066998325055;37825.621743782554;41907.79046104773;42469.362959555634;42503;42583.361249581205;42762;8542.615582298797;8768.649254029831;8786;8791.560421978875;8802.779930501756;8466.703665371713;8594.699185528507;8600.440971336875;8603.655853765842;8607.053224145338;8579.227869491744;8640.092790257027;8691.739247822576;8698;8699.608517616722;8560.657573697044;8566.27186689126;8616.913830861737;8641.870371944426;8643.783905402352;8387.62255698495;8422.620982055822;8441.451305665174;8454.154584541559;8517.659293628247;37826.43260351097;38186;38202.42696359557;38213.044673883094;38214.61785382166;3021.5769792228884;3184.26761844777;3186.808791472496;3381.1547113221695;3514.912127196815;29475;29693.257668558243;30087.699123008708;30132;30137.547936780968;3781.659650631429;3859.6526312631718;3870.148567315186;3881.262560113569;3889.436031775405;198542;199399;199479;199914;200177;47716.52283477121;48635.75682121567;52167.217491737654;54065.72967135139;55186.448135518134;50588.747056265216;50611;50807.74596126996;50834.74582627137;50885;12074.396280185956;13705.109167904055;14075.296235188405;14119.152850828983;14125.929370353288;8751.737447876574;10446.529906154241;10561.63034293796;10660.893391066145;10688.465576721133;18284.268629254948;18371.72442413365;18492.167852446673;18500.722489162672;18502.167402466923;7254.274572542704;7497.1753107158165;7510.286522780327;7531.171571127172;7590;854.4189950833369;894.874717539545;897.8383890899701;921.7925966657582;1034.7620047388991;27678.281665809227;27837.443251134864;27942.441151176863;28077.71922280792;28163.859180703967;969.0745338202;971.2521358553875;1006.5470538257813;1051.994740026295;1092.9781404372027;14093.365798539091;14722.63193420173;14766.704665906622;14791.186484743443;14863.554093377215;434255;439858;443255;445283;445931;47163.76418117888;47468;47473;47489;47491.77590465046;1251.393074358935;1255.2844878419214;1262.1354372255034;1284.6916739982523;1288.433089440643;26072.608910865973;27068.593971090057;27197.86401067982;27234;27253.182404527895;45106.77446612746;45308.773456132505;45384.319235212155;45450.31824522569;45529;242028;243101;243491;243599;243672;26964.73035269622;27498.45003099887;29904.401911961202;30787.230319242197;31240.37519249557;35516.82241588776;36158.4576231362;36237.45643815292;36370.636293637785;36422.27155456823;30232.244193895327;31216.21959450941;31684.841575791972;32334.35331293314;32469.51295730613;27039.729602703723;32759.836200818845;33498.162545936546;34363.312733744686;34366;24032.39919002039;33739.325213496086;34051.4892276621;34290.314193716484;34400.311993760486;30989.69010309868;31431.371372571964;31950.20124496813;31981.36037279288;32065.358692825546;24137.879310603334;24209.273721788373;24294.392640184138;24514.38714032092;24529.386765330295 17:34:39 INFO - PROCESS | 27716 | |2;jquery.html;359.2186993289595;362.1832767110166;362.3694771098289;365.44634878159576;366.4155671703633;13558.254296013716;13674.52139175129;15705.921470392646;17120.914395428023;18267.451976440694;15496.612584685388;15511.92244038781;16016.75974860375;16075.437359692412;16075.598110047255;5267.578593712513;5448.42791506892;5451.972740136293;5453.2092846537225;5457.754401051962;4008.799560022002;4142.5857414258635;4694;5482.890342193174;5651.434856514356;5777.508911742486;5942.732577034044;5992.310884248323;6004.249468816398;6007.948608993431;6019.969900150493;6056.091586262052;6062.181605483292;6081.27024757032;6085.178500902388;5178.844634660966;5350.3312085989255;5354.43778403266;5361.410244873061;5364.302640656729;19876.204951801912;19937.102830372667;20370;21245.575088498143;21301.786982130292;2129.4463439505685;2157.3851452336007;2190.4085896807774;2226.654868495386;2271.704678391815;12531.498740050387;12856.807147892789;12872.420741066675;13050.216986980811;13414.798778018338;1681.4871464203413;1762.3743571032355;1769.3807167491404;1781.6080462298273;1807.6655818673455;56375;56622;58522.41477585212;58709.41290587125;59205.703971480296;9651.517424128766;9810.313278070467;9993.250506211918;10023.799524009479;10082.344647597884;13193.868061319456;13227.73544529104;13263.270520121292;13279.800802987962;13281.402336894864;7091.432685385157;7152.642367881585;7160.212376638566;7464.328210461084;7506.28690274423;6694.899576506356;6839.384455399038;6881.071055407556;6909.412699920563;6958.93041069593;5905.704714764331;5918.644881307136;5953.374895635982;6000.249968753906;6013.819585412444;1661.2358315175154;1728.6283449058512;1755.8419742223261;1786.7855857297207;1790.1765188013399;807.4283407347617;828.035338830256;895.3106108296705;962.8507581324906;995.5171741705267;16468;17373.3050677974;17384.391546295818;17666;18044.18801153951;888.693400776731;889.768660148366;891.3404080980029;893.3300024981264;905.42053086025;9984.400935943866;10272.948635256926;10361.689149325532;10385.169186465064;10414.114800241912;497747;503484;504499;505124;518417;67852.66073669698;68783;68929;69278.65360673165;70182.64908675425;1015.223354134088;1043.4261156363968;1086.397049637443;1140.4468832616174;1159.8666153392298;14692.632684182981;15705.607359816097;15751.842481575037;15902.204889755234;16415.507534773977;32326.080110372168;32394.514082289257;32669.346613068083;32759.836200818845;32795.99999999905;37923;38057.28742206552;39957.80021099876;40248.3962740565;40423;6601.50488713358;7208.747693830691;7241.203467618663;7283;7479.139898911695;10571.94714026425;10714.73213169677;11068.889311106786;11412.600558980728;11483.48324325424;9675.951620241854;9711.3202075854;9993;9999.100080992746;10026.147777438999;9838.262130340396;10011;10251.641192558225;10287.948560257151;10343.896561034595;9705.6603018894;9802.950985245314;10090.394576325443;10324.845127322946;10447.895521044693;7438.218987006503;7455.0681164854395;7465.962670186832;7542;7546.735864244725;9101.453912765255;9320.114589114024;9407.247420206504;9775.413475191512;10248.128909042814 17:34:39 INFO - PROCESS | 27716 | |3;mootools.html;1264.9873501264997;1454.1711224601977;1469.228654956148;1616.8140663823656;1769.6814573376787;7152;7721.961390193048;7918.326942209905;7924.167962363956;7930.325922296612;7516.135644400895;7688.115866675334;7694.499857509272;7697.422693297997;7737.41969352298;1997.710332001859;2009.1159889648509;2025.3417639267223;2318.038014224095;2341.3912382780513;2024.6659301215282;2027.5742094160244;2282.5206706591553;2329.697139371879;2330.4057465346314;2272.3523795718224;2314.513952070059;2320.071971211512;2323.6863023491865;2326.1393284484766;2216.069250914604;2218.811401030914;2238.4515793630503;2243.2036626997424;2250.6061439248147;2235.899384527684;2241.921532746346;2242.0471299697724;2265.535565209145;2269.943251418728;8118.75643730689;8203.179682031809;8204.712835050745;8233.217844304781;8238.588070596446;4824.421069471686;4881.365422495053;4918.532739389752;4930.087933732235;4933.80264789408;3129.546215798719;3132.0916934089087;3223.7427403312727;3252.235724604716;3257.641659417462;976.3507267666993;991.1525645573004;1014.6144465103288;1016.0601443664655;1018.0328687746596;11284.887151128465;11288.830667539993;11290.604828831034;11305.547778088867;11320.660380188607;4362.650987920959;4409.470863496337;4441.045175287264;4442.3336499524685;4493.618042466427;9681.70954871355;9699.51502424876;9700.563474643657;9711.708648740549;9713.805723885484;4909.0672772173175;4936.506349365035;4942.777575009133;4947.90104197914;4948.4309304429735;4414.249577571821;4446.177457170369;4449.332600109945;4451.77741112943;4453.933191002137;3461.1174150591437;3533.2403533240476;3658.268346330691;3763.8306276217636;3766.3408903441787;1199.8080307150815;1199.9460024298928;1228.2814553486132;1232.057476030837;1241.944112514939;1207.5773479282182;1233.4141282890555;1249.5189352099326;1261.224347026572;1280.417410078412;7246.637668116573;7320.341169294789;7321.524100933422;7322.707091716378;7367.447441441914;1071.6570697376922;1097.4951522299673;1099.087757161554;1108.9168312376603;1113.4766659669942;5823.097419899922;5912.3496415394275;5914.349421563625;5914.733836977346;5923.052311630118;9601.711948641552;9650.613975440903;9985.251106167067;9995.650152244636;10121.544530495998;9865.75335616601;9914.107730304308;9941.204703623693;9993.300468967247;10026.849597256047;7100;7316.122065352191;7373.29953654402;7381.1511676157925;7404.481686282016;7206.459515536251;7248.383887369422;7274.5635261882335;7291.453141014551;7302.452316076209;8257.463264888003;8378.664853406039;8498.32013438911;8646.56767161652;8670.393072484865;8636.352273579381;8736.563171841255;8762.912370876466;8859.158379953895;8887.15572020657;7026.367626913602;7152.392046676091;7161.104861892263;7164.534305270141;7166.856662866609;6630.138082049302;6793.5244532882225;7033.437325014089;7564.281393267631;7638.15980242184;6723.831904202239;6851.725930962905;6866.828329291808;6955.234924158237;7103.183133939663;6742.359475849787;6761.628110453972;6793.218779840184;6932;6940.9652951734915;6761.357671021442;6790.524663273523;6807.047013418027;6811.795646130624;6813.523053386215;6199.16311297969;6265.937340626718;6330.272018717907;6374.681265936591;6380.266269379081;6359.046143078575;6386.265579458422;6406.455451286693;6409.262934762375;6409.903851442139 17:34:39 INFO - PROCESS | 27716 | |4;prototype.html;345.2904281701104;352.96823285904264;353.1418652674004;353.5721776650253;356.75562239865695;5812.157237200603;5836.5914385993;5921.970390148054;5933.34733179351;5964.642121472704;5511.173324001402;5594.916076258859;5651.9152212716735;5788.913166302498;5810;4471.552844715535;4486.506484286726;4490.7081039732475;4500.504944456107;4502.279635258359;4304.634106100985;4506.549345065484;4508.188526065307;4510.075434535912;4519.34469501922;4324.6107850293465;4348.065165989312;4446.866594002169;4457.064016556527;4484.327350897375;4431.069475410151;4443.289073748185;4443.933340999887;4450.399196108532;4465.665075119379;3944.7435916665327;3949.269385163725;3952.7628342299554;3956.5054368203973;3963.7819919904396;5452.427495113036;5560.304961879765;5561.499465048125;5563.36021357545;5568.415316391802;5201.869953251161;5210.557102646279;5212.348456442945;5212.530872221519;5214.5306922376785;6131.96934015327;6148.139260503488;6149.907751383733;6150;6158.5381096417495;4372.89067773305;4374.781260936972;4385.320275357325;4399.714018588781;4403.493598236212;6286.07697420697;6414.550981431302;6414.871702565969;6428.389303016206;6434.099226108348;4462.062966776948;4462.352958820953;4463.152001119842;4464.129494748558;4474.284114541658;4512.954870451319;4517.412736344254;4518.887027824265;4522.4573051234065;4523.163214805271;5153.407358153785;5164.225366195025;5166.715830629276;5167.715775632376;5182.689038657692;6074.240719910012;6148.1699970504305;6182.443580077725;6191.25704915413;6204;1582.1456413536791;1597.8322276161068;1600.407849095842;1601.6316247263194;1603.2064128256588;1058.5183741397645;1072.3190773858655;1078.719532921446;1105.850710154135;1118.3625333559792;5859.1797148399255;5876.382979787147;5879.412058794086;5882.294124704978;5886.852828679317;6342.460890824332;6361.681915904186;6379.043143528508;6379.393957574023;6382.968085159545;5687.43125687428;5766.221560089418;5789.073748200268;5842.328132264759;5879.617824841372;3448.3103379324234;3466.6013408457848;3469.5663042119736;3475.8609655614;3477.4088404971217;6684;6747.493937954575;6751.864962700718;6754.18949726036;6756.4932630052945;6335.208098987627;6469.7412103515335;6522.543421960418;6605.306442823435;6613.239477460057;6757.222919364336;6757.324267573302;6759.053732477457;6767.35710107539;6768.661566921634;6453.9354606453335;6456.7740129095255;6459.709313080829;6461.450776684034;6461.838454038687;6254.124422580933;6314.336994615499;6349.14286571307;6363.745450181941;6377.107204991212;6669.7332106715185;6693.431058360094;6733.3939945405145;6739.157605299338;6741.460683145435;4414.55854414556;4426.5130835607415;4439.400680908166;4442.311441726538;4452.844150454848;6300.653464059521;6460.644664543495;6466.612003279818;6470.870582588228;6490.188726409199;6299.748010079728;6305.936940630535;6313.810585682437;6341.397567231105;6373.426391624591;6280.811575652555;6283.403076707706;6289.654069026247;6292.433680968735;6295.18162638854;6057.666828324484;6160.075988601746;6166.907496387647;6167.259928808572;6170.043643235305;6287.119803227643;6287.685615719287;6297.275813281532;6297.527685423704;6302.3067462578165;6174.289956655042;6181.443670069715;6184.041473571604;6191.133241346125;6191.81424557264 17:34:39 INFO - PROCESS | 27716 | |5;yui.html;815.9224873637004;818.7298191596774;820.7127505373116;833.050322632199;841.8526757817388;14308.427662893484;14657.486987955424;14663.780043299359;14673.559793206194;14704.411823527045;14314.141151530916;14335.856641433582;14337.354819033142;14374.856251437483;14393.928030359833;651.5471747135742;662.595816551903;786.1980779604785;804.3565147881701;805.7461899501668;783.2950344689768;790.7983464216645;796.7888509544975;797.0674311056079;797.3421926910294;838.2037064788445;842.8946381702287;843.3127001493763;844.3329769482102;844.7550210438965;678.3250665587747;690.5925503952692;816.8774683797418;833.295864994079;841.6927821345226;604.2356419129804;604.685563506974;604.7973928733879;607.6445279511491;609.2871340531589;12864.807027894589;12934.288614126219;12936.641652626433;12940.676483087998;12942.935285323512;11860;12240.653528111901;12407.93796031014;12413.875861241362;12650.873491265154;9379.859302110473;9470.655527437824;9515.857262141073;9591.568379422943;9686.128248457673;3422.9657703422895;3466.0814884055744;3469.60099588548;3483.285926385085;3483.8258087095796;45839.54160458386;46516.7674161627;47898.28152577714;49256.261156082684;49328.75335623335;9472.384295020802;9513.714588562354;9545.188658963927;9668.033196680275;9705.369151005161;16353.672926541403;16366.345346186257;16422.917885410498;16456.6708665826;16494.83505164957;7180.246074162243;7383.593902335316;7607.239276072459;7778.961105194551;7792.571408572583;4104.800023836264;4201.936970945439;4216.91566168681;4229.59818817218;4337.7614231217585;3077.6306843178513;3103.9912028590797;3106.1613364391937;3109.176068341891;3113.408452394038;575.0913556580592;584.1383958661027;585.4847733994143;595.0687174571781;601.897677394844;532.816178418445;584.3893131677407;626.7211091064523;629.4523764325066;706.8444942112727;8130.878036829452;8176.223258790405;8235.547044912468;8307.584620768937;8527.232549070613;586.9354371019184;621.1583304622262;636.6307541625846;655.6951017776756;675.2639622811062;3785.2240290740333;3799.069228039148;3868.2775367222775;3945.2306800174265;4037.9192416151513;54571.18143227855;54887.45112548903;54995;55461.44538554644;55856.72071639616;42324.57675423268;42584.14831703348;42622;42667.14665706668;43193;42550.36174457386;42609.78695106505;42709.78645106754;44556.77721611371;45105;8508.957455212685;8629.13708629132;8775.341849361195;8828.558572071499;8885.80041694363;31992.840035799672;32472;32477.51283730793;32602.673973259964;32671;38769.4184587237;43134.56865431431;43939.78030109957;43972.56027439813;44568.77715611401;10236.232282578985;10435.895641043797;10581.735456613646;10648.733781655521;10810.29733067348;11837.940810295893;12196.817047744113;12255.938720306342;12288.692782680148;12295.446704898122;11265.211435199784;11390.658280251606;11550;11709.707257318636;12093.153479256367;10801.837972430578;11205.215634905479;11235.831462527905;11243.088674925446;11470.197086203885;10307.845382319421;10450.895491044992;10560.102391296827;10981.945090274497;10987.725306867393;5966.492848107786;9223.400478968846;9255.213306868991;9401.38890972112;9442.15020648145;9161.358704890594;9313.348065635611;9374.343795934219;9521.952390238004;9604.27967902396 17:34:39 INFO - PROCESS | 27716 | __end_tp_report 17:34:39 INFO - PROCESS | 27716 | __start_cc_report 17:34:39 INFO - PROCESS | 27716 | _x_x_mozilla_cycle_collect,703 17:34:39 INFO - PROCESS | 27716 | __end_cc_report 17:34:39 INFO - PROCESS | 27716 | __startTimestamp1454722479360__endTimestamp 17:34:39 INFO - PROCESS | 27716 | 17:34:39 INFO - PROCESS | 27716 | ------- Summary: start ------- 17:34:39 INFO - PROCESS | 27716 | Number of tests: 6 17:34:39 INFO - PROCESS | 27716 | 17:34:39 INFO - PROCESS | 27716 | [#0] dojo.html Cycles:165 Average:5034.32 Median:5226.82 stddev:523.75 (10.0%) stddev-sans-first:503.16 17:34:39 INFO - PROCESS | 27716 | Values: 3111.4 3130.5 3170.2 3174.0 3203.4 4931.2 4998.0 5049.8 5066.8 5099.1 5018.6 5043.6 5064.3 5068.5 5191.2 4598.8 4608.7 4627.9 4665.5 4763.6 4716.4 4744.5 4747.1 4750.6 4760.8 4533.6 4559.5 4584.7 4626.0 4656.7 4583.3 4621.7 4632.9 4637.3 4674.1 4591.2 4598.1 4605.1 4636.4 4657.8 4770.3 4849.4 4928.8 4939.8 4965.1 5408.8 5421.2 5430.3 5430.8 5436.6 5258.6 5392.2 5416.0 5449.9 5458.8 5021.3 5033.8 5054.5 5071.2 5097.8 5552.4 5555.3 5558.7 5561.7 5575.1 5268.4 5331.2 5361.5 5375.3 5377.8 5352.2 5354.3 5386.6 5388.9 5429.4 5359.9 5401.0 5403.2 5404.0 5453.9 5187.1 5268.1 5341.2 5382.8 5390.1 4228.3 4245.3 4259.3 4268.6 4274.9 3826.1 3839.8 3841.1 3858.9 3873.8 4931.9 4974.7 5061.0 5062.6 5076.2 5375.1 5394.4 5396.8 5399.5 5401.5 5020.7 5029.3 5029.3 5035.0 5074.3 4504.7 4583.3 4610.8 4654.3 4686.0 5533.7 5540.6 5582.1 5611.2 5625.4 5319.8 5364.7 5375.9 5377.8 5411.0 5556.0 5574.3 5700.6 5707.3 5734.9 5323.1 5343.7 5345.4 5345.6 5349.1 5396.4 5406.8 5408.8 5410.0 5452.0 5257.8 5318.2 5352.0 5355.9 5403.1 5283.2 5287.7 5293.5 5296.3 5299.8 5156.8 5179.5 5219.2 5228.3 5260.3 5230.5 5236.2 5254.5 5329.8 5332.5 5218.0 5221.1 5222.3 5226.8 5227.1 17:34:39 INFO - PROCESS | 27716 | 17:34:39 INFO - PROCESS | 27716 | [#1] ext.html Cycles:180 Average:44778.20 Median:19515.87 stddev:82939.33 (425.0%) stddev-sans-first:83105.46 17:34:39 INFO - PROCESS | 27716 | Values: 530.9 531.6 551.2 557.2 573.7 26921.2 27291.6 27308.5 37320.1 37825.6 41907.8 42469.4 42503.0 42583.4 42762.0 8542.6 8768.6 8786.0 8791.6 8802.8 8466.7 8594.7 8600.4 8603.7 8607.1 8579.2 8640.1 8691.7 8698.0 8699.6 8560.7 8566.3 8616.9 8641.9 8643.8 8387.6 8422.6 8441.5 8454.2 8517.7 37826.4 38186.0 38202.4 38213.0 38214.6 3021.6 3184.3 3186.8 3381.2 3514.9 29475.0 29693.3 30087.7 30132.0 30137.5 3781.7 3859.7 3870.1 3881.3 3889.4 198542.0 199399.0 199479.0 199914.0 200177.0 47716.5 48635.8 52167.2 54065.7 55186.4 50588.7 50611.0 50807.7 50834.7 50885.0 12074.4 13705.1 14075.3 14119.2 14125.9 8751.7 10446.5 10561.6 10660.9 10688.5 18284.3 18371.7 18492.2 18500.7 18502.2 7254.3 7497.2 7510.3 7531.2 7590.0 854.4 894.9 897.8 921.8 1034.8 27678.3 27837.4 27942.4 28077.7 28163.9 969.1 971.3 1006.5 1052.0 1093.0 14093.4 14722.6 14766.7 14791.2 14863.6 434255.0 439858.0 443255.0 445283.0 445931.0 47163.8 47468.0 47473.0 47489.0 47491.8 1251.4 1255.3 1262.1 1284.7 1288.4 26072.6 27068.6 27197.9 27234.0 27253.2 45106.8 45308.8 45384.3 45450.3 45529.0 242028.0 243101.0 243491.0 243599.0 243672.0 26964.7 27498.5 29904.4 30787.2 31240.4 35516.8 36158.5 36237.5 36370.6 36422.3 30232.2 31216.2 31684.8 32334.4 32469.5 27039.7 32759.8 33498.2 34363.3 34366.0 24032.4 33739.3 34051.5 34290.3 34400.3 30989.7 31431.4 31950.2 31981.4 32065.4 24137.9 24209.3 24294.4 24514.4 24529.4 17:34:39 INFO - PROCESS | 27716 | 17:34:39 INFO - PROCESS | 27716 | [#2] jquery.html Cycles:180 Average:26614.55 Median:22282.79 stddev:82574.45 (370.6%) stddev-sans-first:82782.56 17:34:39 INFO - PROCESS | 27716 | Values: 359.2 362.2 362.4 365.4 366.4 13558.3 13674.5 15705.9 17120.9 18267.5 15496.6 15511.9 16016.8 16075.4 16075.6 5267.6 5448.4 5452.0 5453.2 5457.8 4008.8 4142.6 4694.0 5482.9 5651.4 5777.5 5942.7 5992.3 6004.2 6007.9 6020.0 6056.1 6062.2 6081.3 6085.2 5178.8 5350.3 5354.4 5361.4 5364.3 19876.2 19937.1 20370.0 21245.6 21301.8 2129.4 2157.4 2190.4 2226.7 2271.7 12531.5 12856.8 12872.4 13050.2 13414.8 1681.5 1762.4 1769.4 1781.6 1807.7 56375.0 56622.0 58522.4 58709.4 59205.7 9651.5 9810.3 9993.3 10023.8 10082.3 13193.9 13227.7 13263.3 13279.8 13281.4 7091.4 7152.6 7160.2 7464.3 7506.3 6694.9 6839.4 6881.1 6909.4 6958.9 5905.7 5918.6 5953.4 6000.2 6013.8 1661.2 1728.6 1755.8 1786.8 1790.2 807.4 828.0 895.3 962.9 995.5 16468.0 17373.3 17384.4 17666.0 18044.2 888.7 889.8 891.3 893.3 905.4 9984.4 10272.9 10361.7 10385.2 10414.1 497747.0 503484.0 504499.0 505124.0 518417.0 67852.7 68783.0 68929.0 69278.7 70182.6 1015.2 1043.4 1086.4 1140.4 1159.9 14692.6 15705.6 15751.8 15902.2 16415.5 32326.1 32394.5 32669.3 32759.8 32796.0 37923.0 38057.3 39957.8 40248.4 40423.0 6601.5 7208.7 7241.2 7283.0 7479.1 10571.9 10714.7 11068.9 11412.6 11483.5 9676.0 9711.3 9993.0 9999.1 10026.1 9838.3 10011.0 10251.6 10287.9 10343.9 9705.7 9803.0 10090.4 10324.8 10447.9 7438.2 7455.1 7466.0 7542.0 7546.7 9101.5 9320.1 9407.2 9775.4 10248.1 17:34:39 INFO - PROCESS | 27716 | 17:34:39 INFO - PROCESS | 27716 | [#3] mootools.html Cycles:180 Average:5548.20 Median:6232.55 stddev:2925.78 (46.9%) stddev-sans-first:2916.27 17:34:39 INFO - PROCESS | 27716 | Values: 1265.0 1454.2 1469.2 1616.8 1769.7 7152.0 7722.0 7918.3 7924.2 7930.3 7516.1 7688.1 7694.5 7697.4 7737.4 1997.7 2009.1 2025.3 2318.0 2341.4 2024.7 2027.6 2282.5 2329.7 2330.4 2272.4 2314.5 2320.1 2323.7 2326.1 2216.1 2218.8 2238.5 2243.2 2250.6 2235.9 2241.9 2242.0 2265.5 2269.9 8118.8 8203.2 8204.7 8233.2 8238.6 4824.4 4881.4 4918.5 4930.1 4933.8 3129.5 3132.1 3223.7 3252.2 3257.6 976.4 991.2 1014.6 1016.1 1018.0 11284.9 11288.8 11290.6 11305.5 11320.7 4362.7 4409.5 4441.0 4442.3 4493.6 9681.7 9699.5 9700.6 9711.7 9713.8 4909.1 4936.5 4942.8 4947.9 4948.4 4414.2 4446.2 4449.3 4451.8 4453.9 3461.1 3533.2 3658.3 3763.8 3766.3 1199.8 1199.9 1228.3 1232.1 1241.9 1207.6 1233.4 1249.5 1261.2 1280.4 7246.6 7320.3 7321.5 7322.7 7367.4 1071.7 1097.5 1099.1 1108.9 1113.5 5823.1 5912.3 5914.3 5914.7 5923.1 9601.7 9650.6 9985.3 9995.7 10121.5 9865.8 9914.1 9941.2 9993.3 10026.8 7100.0 7316.1 7373.3 7381.2 7404.5 7206.5 7248.4 7274.6 7291.5 7302.5 8257.5 8378.7 8498.3 8646.6 8670.4 8636.4 8736.6 8762.9 8859.2 8887.2 7026.4 7152.4 7161.1 7164.5 7166.9 6630.1 6793.5 7033.4 7564.3 7638.2 6723.8 6851.7 6866.8 6955.2 7103.2 6742.4 6761.6 6793.2 6932.0 6941.0 6761.4 6790.5 6807.0 6811.8 6813.5 6199.2 6265.9 6330.3 6374.7 6380.3 6359.0 6386.3 6406.5 6409.3 6409.9 17:34:39 INFO - PROCESS | 27716 | 17:34:39 INFO - PROCESS | 27716 | [#4] prototype.html Cycles:180 Average:5208.35 Median:5850.75 stddev:1563.05 (26.7%) stddev-sans-first:1524.22 17:34:39 INFO - PROCESS | 27716 | Values: 345.3 353.0 353.1 353.6 356.8 5812.2 5836.6 5922.0 5933.3 5964.6 5511.2 5594.9 5651.9 5788.9 5810.0 4471.6 4486.5 4490.7 4500.5 4502.3 4304.6 4506.5 4508.2 4510.1 4519.3 4324.6 4348.1 4446.9 4457.1 4484.3 4431.1 4443.3 4443.9 4450.4 4465.7 3944.7 3949.3 3952.8 3956.5 3963.8 5452.4 5560.3 5561.5 5563.4 5568.4 5201.9 5210.6 5212.3 5212.5 5214.5 6132.0 6148.1 6149.9 6150.0 6158.5 4372.9 4374.8 4385.3 4399.7 4403.5 6286.1 6414.6 6414.9 6428.4 6434.1 4462.1 4462.4 4463.2 4464.1 4474.3 4513.0 4517.4 4518.9 4522.5 4523.2 5153.4 5164.2 5166.7 5167.7 5182.7 6074.2 6148.2 6182.4 6191.3 6204.0 1582.1 1597.8 1600.4 1601.6 1603.2 1058.5 1072.3 1078.7 1105.9 1118.4 5859.2 5876.4 5879.4 5882.3 5886.9 6342.5 6361.7 6379.0 6379.4 6383.0 5687.4 5766.2 5789.1 5842.3 5879.6 3448.3 3466.6 3469.6 3475.9 3477.4 6684.0 6747.5 6751.9 6754.2 6756.5 6335.2 6469.7 6522.5 6605.3 6613.2 6757.2 6757.3 6759.1 6767.4 6768.7 6453.9 6456.8 6459.7 6461.5 6461.8 6254.1 6314.3 6349.1 6363.7 6377.1 6669.7 6693.4 6733.4 6739.2 6741.5 4414.6 4426.5 4439.4 4442.3 4452.8 6300.7 6460.6 6466.6 6470.9 6490.2 6299.7 6305.9 6313.8 6341.4 6373.4 6280.8 6283.4 6289.7 6292.4 6295.2 6057.7 6160.1 6166.9 6167.3 6170.0 6287.1 6287.7 6297.3 6297.5 6302.3 6174.3 6181.4 6184.0 6191.1 6191.8 17:34:39 INFO - PROCESS | 27716 | 17:34:39 INFO - PROCESS | 27716 | [#5] yui.html Cycles:180 Average:13167.00 Median:46178.15 stddev:14897.09 (32.3%) stddev-sans-first:14910.00 17:34:39 INFO - PROCESS | 27716 | Values: 815.9 818.7 820.7 833.1 841.9 14308.4 14657.5 14663.8 14673.6 14704.4 14314.1 14335.9 14337.4 14374.9 14393.9 651.5 662.6 786.2 804.4 805.7 783.3 790.8 796.8 797.1 797.3 838.2 842.9 843.3 844.3 844.8 678.3 690.6 816.9 833.3 841.7 604.2 604.7 604.8 607.6 609.3 12864.8 12934.3 12936.6 12940.7 12942.9 11860.0 12240.7 12407.9 12413.9 12650.9 9379.9 9470.7 9515.9 9591.6 9686.1 3423.0 3466.1 3469.6 3483.3 3483.8 45839.5 46516.8 47898.3 49256.3 49328.8 9472.4 9513.7 9545.2 9668.0 9705.4 16353.7 16366.3 16422.9 16456.7 16494.8 7180.2 7383.6 7607.2 7779.0 7792.6 4104.8 4201.9 4216.9 4229.6 4337.8 3077.6 3104.0 3106.2 3109.2 3113.4 575.1 584.1 585.5 595.1 601.9 532.8 584.4 626.7 629.5 706.8 8130.9 8176.2 8235.5 8307.6 8527.2 586.9 621.2 636.6 655.7 675.3 3785.2 3799.1 3868.3 3945.2 4037.9 54571.2 54887.5 54995.0 55461.4 55856.7 42324.6 42584.1 42622.0 42667.1 43193.0 42550.4 42609.8 42709.8 44556.8 45105.0 8509.0 8629.1 8775.3 8828.6 8885.8 31992.8 32472.0 32477.5 32602.7 32671.0 38769.4 43134.6 43939.8 43972.6 44568.8 10236.2 10435.9 10581.7 10648.7 10810.3 11837.9 12196.8 12255.9 12288.7 12295.4 11265.2 11390.7 11550.0 11709.7 12093.2 10801.8 11205.2 11235.8 11243.1 11470.2 10307.8 10450.9 10560.1 10981.9 10987.7 5966.5 9223.4 9255.2 9401.4 9442.2 9161.4 9313.3 9374.3 9522.0 9604.3 17:34:39 INFO - PROCESS | 27716 | -------- Summary: end -------- 17:34:39 INFO - PROCESS | 27716 | 17:34:40 INFO - TEST-INFO | 27716: exit 0 17:34:40 INFO - TEST-OK | dromaeo_css | took 1112840ms 17:34:40 INFO - TEST-START | kraken 17:34:40 INFO - operating with platform_type : linux_ 17:34:40 INFO - Initialising browser for kraken test... 17:34:40 INFO - TEST-INFO | started process 27920 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvO0FC8/profile http://localhost:52204/getInfo.html) 17:34:44 INFO - PROCESS | 27920 | __metrics Screen width/height:1600/1200 17:34:44 INFO - PROCESS | 27920 | colorDepth:24 17:34:44 INFO - PROCESS | 27920 | Browser inner width/height: 1024/697 17:34:44 INFO - PROCESS | 27920 | __metrics 17:34:44 INFO - PROCESS | 27920 | 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:34:44 INFO - PROCESS | 27920 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:34:45 INFO - TEST-INFO | 27920: exit 0 17:34:45 INFO - Browser initialized. 17:34:45 INFO - Running cycle 1/1 for kraken test... 17:34:45 INFO - TEST-INFO | started process 28001 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvO0FC8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:34:57 INFO - PROCESS | 28001 | RSS: Main: 148045824 17:34:57 INFO - PROCESS | 28001 | 17:35:00 INFO - PROCESS | 28001 | Cycle 1(1): loaded http://localhost:52204/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52204/tests/kraken/driver.html?testName=audio-beat-detection) 17:35:00 INFO - PROCESS | 28001 | RSS: Main: 185942016 17:35:00 INFO - PROCESS | 28001 | 17:35:03 INFO - PROCESS | 28001 | Cycle 1(1): loaded http://localhost:52204/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52204/tests/kraken/driver.html?testName=audio-dft) 17:35:03 INFO - PROCESS | 28001 | RSS: Main: 177606656 17:35:03 INFO - PROCESS | 28001 | 17:35:06 INFO - PROCESS | 28001 | Cycle 1(1): loaded http://localhost:52204/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52204/tests/kraken/driver.html?testName=audio-fft) 17:35:07 INFO - PROCESS | 28001 | RSS: Main: 162791424 17:35:07 INFO - PROCESS | 28001 | 17:35:09 INFO - PROCESS | 28001 | Cycle 1(1): loaded http://localhost:52204/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52204/tests/kraken/driver.html?testName=audio-oscillator) 17:35:09 INFO - PROCESS | 28001 | RSS: Main: 165715968 17:35:09 INFO - PROCESS | 28001 | 17:35:12 INFO - PROCESS | 28001 | Cycle 1(1): loaded http://localhost:52204/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52204/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:35:12 INFO - PROCESS | 28001 | RSS: Main: 167591936 17:35:12 INFO - PROCESS | 28001 | 17:35:15 INFO - PROCESS | 28001 | Cycle 1(1): loaded http://localhost:52204/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52204/tests/kraken/driver.html?testName=imaging-darkroom) 17:35:16 INFO - PROCESS | 28001 | RSS: Main: 168525824 17:35:16 INFO - PROCESS | 28001 | 17:35:19 INFO - PROCESS | 28001 | Cycle 1(1): loaded http://localhost:52204/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52204/tests/kraken/driver.html?testName=imaging-desaturate) 17:35:20 INFO - PROCESS | 28001 | RSS: Main: 168546304 17:35:20 INFO - PROCESS | 28001 | 17:35:23 INFO - PROCESS | 28001 | Cycle 1(1): loaded http://localhost:52204/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52204/tests/kraken/driver.html?testName=json-parse-financial) 17:35:23 INFO - PROCESS | 28001 | RSS: Main: 168009728 17:35:23 INFO - PROCESS | 28001 | 17:35:25 INFO - PROCESS | 28001 | Cycle 1(1): loaded http://localhost:52204/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52204/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:35:25 INFO - PROCESS | 28001 | RSS: Main: 179920896 17:35:25 INFO - PROCESS | 28001 | 17:35:27 INFO - PROCESS | 28001 | Cycle 1(1): loaded http://localhost:52204/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52204/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:35:28 INFO - PROCESS | 28001 | RSS: Main: 177217536 17:35:28 INFO - PROCESS | 28001 | 17:35:30 INFO - PROCESS | 28001 | Cycle 1(1): loaded http://localhost:52204/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52204/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:35:30 INFO - PROCESS | 28001 | RSS: Main: 182603776 17:35:30 INFO - PROCESS | 28001 | 17:35:33 INFO - PROCESS | 28001 | Cycle 1(1): loaded http://localhost:52204/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52204/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:35:33 INFO - PROCESS | 28001 | RSS: Main: 190439424 17:35:33 INFO - PROCESS | 28001 | 17:35:36 INFO - PROCESS | 28001 | Cycle 1(1): loaded http://localhost:52204/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52204/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:35:36 INFO - PROCESS | 28001 | RSS: Main: 190742528 17:35:36 INFO - PROCESS | 28001 | 17:35:38 INFO - PROCESS | 28001 | Cycle 1(1): loaded http://localhost:52204/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52204/tests/kraken/driver.html?testName=ai-astar) 17:35:38 INFO - PROCESS | 28001 | RSS: Main: 249765888 17:35:38 INFO - PROCESS | 28001 | 17:35:38 INFO - PROCESS | 28001 | __start_tp_report 17:35:38 INFO - PROCESS | 28001 | _x_x_mozilla_page_load 17:35:38 INFO - PROCESS | 28001 | _x_x_mozilla_page_load_details 17:35:38 INFO - PROCESS | 28001 | |i|pagename|runs| 17:35:38 INFO - PROCESS | 28001 | |0;ai-astar;110;110;105;110;109;109;110;110;103;110 17:35:38 INFO - PROCESS | 28001 | |1;audio-beat-detection;163;127;155;167;127;155;150;128;163;129 17:35:38 INFO - PROCESS | 28001 | |2;audio-dft;162;165;160;160;161;160;159;158;161;161 17:35:38 INFO - PROCESS | 28001 | |3;audio-fft;72;72;96;96;72;72;74;121;97;72 17:35:38 INFO - PROCESS | 28001 | |4;audio-oscillator;104;96;151;95;97;98;141;95;96;136 17:35:38 INFO - PROCESS | 28001 | |5;imaging-gaussian-blur;119;115;115;115;115;115;114;114;114;115 17:35:38 INFO - PROCESS | 28001 | |6;imaging-darkroom;146;145;146;145;146;145;144;145;144;146 17:35:38 INFO - PROCESS | 28001 | |7;imaging-desaturate;96;96;96;96;96;95;96;96;95;95 17:35:38 INFO - PROCESS | 28001 | |8;json-parse-financial;57;54;56;55;56;56;56;55;55;53 17:35:38 INFO - PROCESS | 28001 | |9;json-stringify-tinderbox;66;68;67;67;68;68;67;67;68;67 17:35:38 INFO - PROCESS | 28001 | |10;stanford-crypto-aes;83;85;84;84;84;85;85;92;85;94 17:35:38 INFO - PROCESS | 28001 | |11;stanford-crypto-ccm;113;122;114;115;113;117;123;113;113;121 17:35:38 INFO - PROCESS | 28001 | |12;stanford-crypto-pbkdf2;145;133;145;143;153;133;141;153;142;144 17:35:38 INFO - PROCESS | 28001 | |13;stanford-crypto-sha256-iterative;68;68;72;69;67;72;67;67;72;67 17:35:38 INFO - PROCESS | 28001 | __end_tp_report 17:35:38 INFO - PROCESS | 28001 | __start_cc_report 17:35:38 INFO - PROCESS | 28001 | _x_x_mozilla_cycle_collect,945 17:35:38 INFO - PROCESS | 28001 | __end_cc_report 17:35:38 INFO - PROCESS | 28001 | __startTimestamp1454722538884__endTimestamp 17:35:38 INFO - PROCESS | 28001 | 17:35:38 INFO - PROCESS | 28001 | ------- Summary: start ------- 17:35:38 INFO - PROCESS | 28001 | Number of tests: 14 17:35:38 INFO - PROCESS | 28001 | 17:35:38 INFO - PROCESS | 28001 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:2.50 (2.3%) stddev-sans-first:2.60 17:35:38 INFO - PROCESS | 28001 | Values: 110.0 110.0 105.0 110.0 109.0 109.0 110.0 110.0 103.0 110.0 17:35:38 INFO - PROCESS | 28001 | 17:35:38 INFO - PROCESS | 28001 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:155.00 stddev:16.77 (10.8%) stddev-sans-first:16.67 17:35:38 INFO - PROCESS | 28001 | Values: 163.0 127.0 155.0 167.0 127.0 155.0 150.0 128.0 163.0 129.0 17:35:38 INFO - PROCESS | 28001 | 17:35:38 INFO - PROCESS | 28001 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.89 (1.2%) stddev-sans-first:1.94 17:35:38 INFO - PROCESS | 28001 | Values: 162.0 165.0 160.0 160.0 161.0 160.0 159.0 158.0 161.0 161.0 17:35:38 INFO - PROCESS | 28001 | 17:35:38 INFO - PROCESS | 28001 | [#3] audio-fft Cycles:10 Average:84.40 Median:73.00 stddev:17.14 (23.5%) stddev-sans-first:17.58 17:35:38 INFO - PROCESS | 28001 | Values: 72.0 72.0 96.0 96.0 72.0 72.0 74.0 121.0 97.0 72.0 17:35:38 INFO - PROCESS | 28001 | 17:35:38 INFO - PROCESS | 28001 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:95.50 stddev:22.36 (23.4%) stddev-sans-first:23.58 17:35:38 INFO - PROCESS | 28001 | Values: 104.0 96.0 151.0 95.0 97.0 98.0 141.0 95.0 96.0 136.0 17:35:38 INFO - PROCESS | 28001 | 17:35:38 INFO - PROCESS | 28001 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:115.00 stddev:1.45 (1.3%) stddev-sans-first:0.50 17:35:38 INFO - PROCESS | 28001 | Values: 119.0 115.0 115.0 115.0 115.0 115.0 114.0 114.0 114.0 115.0 17:35:38 INFO - PROCESS | 28001 | 17:35:38 INFO - PROCESS | 28001 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 17:35:38 INFO - PROCESS | 28001 | Values: 146.0 145.0 146.0 145.0 146.0 145.0 144.0 145.0 144.0 146.0 17:35:38 INFO - PROCESS | 28001 | 17:35:38 INFO - PROCESS | 28001 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:35:38 INFO - PROCESS | 28001 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 17:35:38 INFO - PROCESS | 28001 | 17:35:38 INFO - PROCESS | 28001 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:56.00 stddev:1.16 (2.1%) stddev-sans-first:1.05 17:35:38 INFO - PROCESS | 28001 | Values: 57.0 54.0 56.0 55.0 56.0 56.0 56.0 55.0 55.0 53.0 17:35:38 INFO - PROCESS | 28001 | 17:35:38 INFO - PROCESS | 28001 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.50 stddev:0.67 (1.0%) stddev-sans-first:0.53 17:35:38 INFO - PROCESS | 28001 | Values: 66.0 68.0 67.0 67.0 68.0 68.0 67.0 67.0 68.0 67.0 17:35:38 INFO - PROCESS | 28001 | 17:35:38 INFO - PROCESS | 28001 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:85.00 stddev:3.73 (4.4%) stddev-sans-first:3.78 17:35:38 INFO - PROCESS | 28001 | Values: 83.0 85.0 84.0 84.0 84.0 85.0 85.0 92.0 85.0 94.0 17:35:38 INFO - PROCESS | 28001 | 17:35:38 INFO - PROCESS | 28001 | [#11] stanford-crypto-ccm Cycles:10 Average:116.40 Median:116.00 stddev:4.09 (3.5%) stddev-sans-first:4.15 17:35:38 INFO - PROCESS | 28001 | Values: 113.0 122.0 114.0 115.0 113.0 117.0 123.0 113.0 113.0 121.0 17:35:38 INFO - PROCESS | 28001 | 17:35:38 INFO - PROCESS | 28001 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.20 Median:144.50 stddev:6.78 (4.7%) stddev-sans-first:7.16 17:35:38 INFO - PROCESS | 28001 | Values: 145.0 133.0 145.0 143.0 153.0 133.0 141.0 153.0 142.0 144.0 17:35:38 INFO - PROCESS | 28001 | 17:35:38 INFO - PROCESS | 28001 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:68.50 stddev:2.23 (3.3%) stddev-sans-first:2.35 17:35:38 INFO - PROCESS | 28001 | Values: 68.0 68.0 72.0 69.0 67.0 72.0 67.0 67.0 72.0 67.0 17:35:38 INFO - PROCESS | 28001 | -------- Summary: end -------- 17:35:38 INFO - PROCESS | 28001 | 17:35:40 INFO - TEST-INFO | 28001: exit 0 17:35:40 INFO - TEST-OK | kraken | took 60022ms 17:35:40 INFO - TEST-START | v8_7 17:35:40 INFO - operating with platform_type : linux_ 17:35:40 INFO - Initialising browser for v8_7 test... 17:35:40 INFO - TEST-INFO | started process 28249 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkH4K3M/profile http://localhost:52204/getInfo.html) 17:35:44 INFO - PROCESS | 28249 | __metrics Screen width/height:1600/1200 17:35:44 INFO - PROCESS | 28249 | colorDepth:24 17:35:44 INFO - PROCESS | 28249 | Browser inner width/height: 1024/697 17:35:44 INFO - PROCESS | 28249 | __metrics 17:35:44 INFO - PROCESS | 28249 | 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:35:44 INFO - PROCESS | 28249 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:35:45 INFO - TEST-INFO | 28249: exit 0 17:35:45 INFO - Browser initialized. 17:35:45 INFO - Running cycle 1/1 for v8_7 test... 17:35:45 INFO - TEST-INFO | started process 28334 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkH4K3M/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:35:57 INFO - PROCESS | 28334 | RSS: Main: 148418560 17:35:57 INFO - PROCESS | 28334 | 17:36:19 INFO - PROCESS | 28334 | Cycle 1(1): loaded http://localhost:52204/tests/v8_7/run.html (next: http://localhost:52204/tests/v8_7/run.html) 17:36:20 INFO - PROCESS | 28334 | RSS: Main: 505036800 17:36:20 INFO - PROCESS | 28334 | 17:36:20 INFO - PROCESS | 28334 | __start_tp_report 17:36:20 INFO - PROCESS | 28334 | _x_x_mozilla_page_load 17:36:20 INFO - PROCESS | 28334 | _x_x_mozilla_page_load_details 17:36:20 INFO - PROCESS | 28334 | |i|pagename|runs| 17:36:20 INFO - PROCESS | 28334 | |0;Richards;166.75004168751042 17:36:20 INFO - PROCESS | 28334 | |1;DeltaBlue;190.47619047619048 17:36:20 INFO - PROCESS | 28334 | |2;Encrypt;272.8512960436562 17:36:20 INFO - PROCESS | 28334 | |3;Decrypt;5240.837696335078 17:36:20 INFO - PROCESS | 28334 | |4;RayTrace;1113.5857461024498 17:36:20 INFO - PROCESS | 28334 | |5;Earley;777.6049766718507 17:36:20 INFO - PROCESS | 28334 | |6;Boyer;12481.481481481482 17:36:20 INFO - PROCESS | 28334 | |7;RegExp;41958.333333333336 17:36:20 INFO - PROCESS | 28334 | |8;Splay;579.3742757821552 17:36:20 INFO - PROCESS | 28334 | |9;NavierStokes;4817.307692307692 17:36:20 INFO - PROCESS | 28334 | __end_tp_report 17:36:20 INFO - PROCESS | 28334 | __startTimestamp1454722580190__endTimestamp 17:36:20 INFO - PROCESS | 28334 | 17:36:20 INFO - PROCESS | 28334 | ------- Summary: start ------- 17:36:20 INFO - PROCESS | 28334 | Number of tests: 10 17:36:20 INFO - PROCESS | 28334 | 17:36:20 INFO - PROCESS | 28334 | [#0] Richards Cycles:1 Average:166.75 Median:166.75 stddev:0.00 (0.0%) 17:36:20 INFO - PROCESS | 28334 | Values: 166.8 17:36:20 INFO - PROCESS | 28334 | 17:36:20 INFO - PROCESS | 28334 | [#1] DeltaBlue Cycles:1 Average:190.48 Median:190.48 stddev:0.00 (0.0%) 17:36:20 INFO - PROCESS | 28334 | Values: 190.5 17:36:20 INFO - PROCESS | 28334 | 17:36:20 INFO - PROCESS | 28334 | [#2] Encrypt Cycles:1 Average:272.85 Median:272.85 stddev:0.00 (0.0%) 17:36:20 INFO - PROCESS | 28334 | Values: 272.9 17:36:20 INFO - PROCESS | 28334 | 17:36:20 INFO - PROCESS | 28334 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 17:36:20 INFO - PROCESS | 28334 | Values: 5240.8 17:36:20 INFO - PROCESS | 28334 | 17:36:20 INFO - PROCESS | 28334 | [#4] RayTrace Cycles:1 Average:1113.59 Median:1113.59 stddev:0.00 (0.0%) 17:36:20 INFO - PROCESS | 28334 | Values: 1113.6 17:36:20 INFO - PROCESS | 28334 | 17:36:20 INFO - PROCESS | 28334 | [#5] Earley Cycles:1 Average:777.60 Median:777.60 stddev:0.00 (0.0%) 17:36:20 INFO - PROCESS | 28334 | Values: 777.6 17:36:20 INFO - PROCESS | 28334 | 17:36:20 INFO - PROCESS | 28334 | [#6] Boyer Cycles:1 Average:12481.48 Median:12481.48 stddev:0.00 (0.0%) 17:36:20 INFO - PROCESS | 28334 | Values: 12481.5 17:36:20 INFO - PROCESS | 28334 | 17:36:20 INFO - PROCESS | 28334 | [#7] RegExp Cycles:1 Average:41958.33 Median:41958.33 stddev:0.00 (0.0%) 17:36:20 INFO - PROCESS | 28334 | Values: 41958.3 17:36:20 INFO - PROCESS | 28334 | 17:36:20 INFO - PROCESS | 28334 | [#8] Splay Cycles:1 Average:579.37 Median:579.37 stddev:0.00 (0.0%) 17:36:20 INFO - PROCESS | 28334 | Values: 579.4 17:36:20 INFO - PROCESS | 28334 | 17:36:20 INFO - PROCESS | 28334 | [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 17:36:20 INFO - PROCESS | 28334 | Values: 4817.3 17:36:20 INFO - PROCESS | 28334 | -------- Summary: end -------- 17:36:20 INFO - PROCESS | 28334 | 17:36:21 INFO - TEST-INFO | 28334: exit 0 17:36:21 INFO - TEST-OK | v8_7 | took 40978ms 17:36:21 INFO - SUITE-END | took 1213s 17:36:21 INFO - Completed test suite (00:20:13) 17:36:21 INFO - Working with test: dromaeo_css 17:36:21 INFO - Generating results file: dromaeo_css 17:36:21 INFO - Working with test: kraken 17:36:21 INFO - Generating results file: kraken 17:36:21 INFO - javascript benchmark 17:36:21 INFO - Working with test: v8_7 17:36:21 INFO - Generating results file: v8_7 17:36:21 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:36:21 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 17:36:21 INFO - process_Request line: dromaeo_css 6744.20 graph.html#tests=[[72,201,35]] 17:36:21 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:36:21 INFO - process_Request line: kraken 1504.20 graph.html#tests=[[232,201,35]] 17:36:21 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:36:21 INFO - process_Request line: v8_7 20145.14 graph.html#tests=[[230,201,35]] 17:36:21 INFO - RETURN: dromaeo_css: 6744.20 17:36:21 INFO - RETURN: kraken: 1504.20 17:36:21 INFO - RETURN: v8_7: 20145.14 17:36:21 INFO - javascript benchmark 17:36:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3111.393278310729, 3130.4678204705197, 3170.1599076244797, 3174.0319202643186, 3203.439398105331, 4931.235658472942, 4997.950020499794, 5049.823256186034, 5066.797328106881, 5099.133147364948, 5018.598512119031, 5043.646944713872, 5064.316317297164, 5068.518490743382, 5191.221316802482, 4598.81604735811, 4608.654350923677, 4627.930581041287, 4665.533446655341, 4763.595094416979, 4716.410448693913, 4744.478107408182, 4747.05058988202, 4750.5724484796365, 4760.8333708320215, 4533.569310915458, 4559.45286565611, 4584.679072464929, 4625.976870115662, 4656.65075119364, 4583.289590113504, 4621.65337599678, 4632.930506042412, 4637.258038713823, 4674.065186962621, 4591.173588754056, 4598.126355992385, 4605.055963527502, 4636.420447444069, 4657.790399432034, 4770.284457331393, 4849.393825771778, 4928.753562321869, 4939.753012349368, 4965.081459929888, 5408.756605952703, 5421.21392398104, 5430.294061771944, 5430.782768689248, 5436.646617969859, 5258.605604579634, 5392.2181283714035, 5415.970965516539, 5449.918251226235, 5458.836234912959, 5021.322121513622, 5033.798648054073, 5054.49455054499, 5071.1632580624155, 5097.821576244851, 5552.41699621542, 5555.250041244381, 5558.6942718150085, 5561.694106824163, 5575.0522411190195, 5268.394134674485, 5331.173668081454, 5361.463853614685, 5375.3280839895015, 5377.7580008899695, 5352.223927530564, 5354.330708661418, 5386.569074474032, 5388.91916621251, 5429.375621803464, 5359.946400535945, 5401.000814849187, 5403.2165336026055, 5403.972980135074, 5453.945460545423, 5187.06632806091, 5268.104422248227, 5341.198820177005, 5382.838514844561, 5390.0836857734275, 4228.302330115496, 4245.299525578307, 4259.2759230930815, 4268.551802060801, 4274.893127671833, 3826.081740382288, 3839.827207775657, 3841.078141246081, 3858.9228215435533, 3873.767573945572, 4931.926021109686, 4974.701517908937, 5061.038402703474, 5062.594992400599, 5076.2131869559535, 5375.1131063374105, 5394.433584473652, 5396.757145928443, 5399.514043736082, 5401.540869026098, 5020.673656212334, 5029.2958985742025, 5029.321041659402, 5035.0, 5074.2895994560795, 4504.684672072989, 4583.289590113538, 4610.838620648261, 4654.348391225231, 4686.039361930796, 5533.723313834292, 5540.556755459635, 5582.134769110794, 5611.158326251013, 5625.409332020161, 5319.840404787863, 5364.7049412282695, 5375.865603359947, 5377.758000890048, 5410.97294513525, 5556.0, 5574.331080270394, 5700.629459085146, 5707.343655479673, 5734.885302294014, 5323.148296272578, 5343.65266257692, 5345.412004679404, 5345.572354211731, 5349.117395629678, 5396.379416367011, 5406.810761623325, 5408.78364865401, 5410.026195284887, 5452.0, 5257.763400646903, 5318.175682769177, 5352.036633405869, 5355.946440535545, 5403.108487099742, 5283.233931080049, 5287.68273903567, 5293.497117773805, 5296.311479507639, 5299.8410047698635, 5156.819511317086, 5179.533841954091, 5219.217117432416, 5228.294180285765, 5260.342457192851, 5230.529252367305, 5236.162214045735, 5254.527092561688, 5329.760160792696, 5332.466753324637, 5218.0, 5221.060209162387, 5222.321098257202, 5226.817061402832, 5227.111391063452], "unit": "score", "name": "dojo.html", "value": 5003.026605185518}, {"lowerIsBetter": false, "replicates": [530.9230161626567, 531.6252042310172, 551.1732401397903, 557.2198921509886, 573.6816067082768, 26921.19236422908, 27291.590626140623, 27308.45383092337, 37320.066998325055, 37825.621743782554, 41907.79046104773, 42469.362959555634, 42503.0, 42583.361249581205, 42762.0, 8542.615582298797, 8768.649254029831, 8786.0, 8791.560421978875, 8802.779930501756, 8466.703665371713, 8594.699185528507, 8600.440971336875, 8603.655853765842, 8607.053224145338, 8579.227869491744, 8640.092790257027, 8691.739247822576, 8698.0, 8699.608517616722, 8560.657573697044, 8566.27186689126, 8616.913830861737, 8641.870371944426, 8643.783905402352, 8387.62255698495, 8422.620982055822, 8441.451305665174, 8454.154584541559, 8517.659293628247, 37826.43260351097, 38186.0, 38202.42696359557, 38213.044673883094, 38214.61785382166, 3021.5769792228884, 3184.26761844777, 3186.808791472496, 3381.1547113221695, 3514.912127196815, 29475.0, 29693.257668558243, 30087.699123008708, 30132.0, 30137.547936780968, 3781.659650631429, 3859.6526312631718, 3870.148567315186, 3881.262560113569, 3889.436031775405, 198542.0, 199399.0, 199479.0, 199914.0, 200177.0, 47716.52283477121, 48635.75682121567, 52167.217491737654, 54065.72967135139, 55186.448135518134, 50588.747056265216, 50611.0, 50807.74596126996, 50834.74582627137, 50885.0, 12074.396280185956, 13705.109167904055, 14075.296235188405, 14119.152850828983, 14125.929370353288, 8751.737447876574, 10446.529906154241, 10561.63034293796, 10660.893391066145, 10688.465576721133, 18284.268629254948, 18371.72442413365, 18492.167852446673, 18500.722489162672, 18502.167402466923, 7254.274572542704, 7497.1753107158165, 7510.286522780327, 7531.171571127172, 7590.0, 854.4189950833369, 894.874717539545, 897.8383890899701, 921.7925966657582, 1034.7620047388991, 27678.281665809227, 27837.443251134864, 27942.441151176863, 28077.71922280792, 28163.859180703967, 969.0745338202, 971.2521358553875, 1006.5470538257813, 1051.994740026295, 1092.9781404372027, 14093.365798539091, 14722.63193420173, 14766.704665906622, 14791.186484743443, 14863.554093377215, 434255.0, 439858.0, 443255.0, 445283.0, 445931.0, 47163.76418117888, 47468.0, 47473.0, 47489.0, 47491.77590465046, 1251.393074358935, 1255.2844878419214, 1262.1354372255034, 1284.6916739982523, 1288.433089440643, 26072.608910865973, 27068.593971090057, 27197.86401067982, 27234.0, 27253.182404527895, 45106.77446612746, 45308.773456132505, 45384.319235212155, 45450.31824522569, 45529.0, 242028.0, 243101.0, 243491.0, 243599.0, 243672.0, 26964.73035269622, 27498.45003099887, 29904.401911961202, 30787.230319242197, 31240.37519249557, 35516.82241588776, 36158.4576231362, 36237.45643815292, 36370.636293637785, 36422.27155456823, 30232.244193895327, 31216.21959450941, 31684.841575791972, 32334.35331293314, 32469.51295730613, 27039.729602703723, 32759.836200818845, 33498.162545936546, 34363.312733744686, 34366.0, 24032.39919002039, 33739.325213496086, 34051.4892276621, 34290.314193716484, 34400.311993760486, 30989.69010309868, 31431.371372571964, 31950.20124496813, 31981.36037279288, 32065.358692825546, 24137.879310603334, 24209.273721788373, 24294.392640184138, 24514.38714032092, 24529.386765330295], "unit": "score", "name": "ext.html", "value": 17339.935865509226}, {"lowerIsBetter": false, "replicates": [359.2186993289595, 362.1832767110166, 362.3694771098289, 365.44634878159576, 366.4155671703633, 13558.254296013716, 13674.52139175129, 15705.921470392646, 17120.914395428023, 18267.451976440694, 15496.612584685388, 15511.92244038781, 16016.75974860375, 16075.437359692412, 16075.598110047255, 5267.578593712513, 5448.42791506892, 5451.972740136293, 5453.2092846537225, 5457.754401051962, 4008.799560022002, 4142.5857414258635, 4694.0, 5482.890342193174, 5651.434856514356, 5777.508911742486, 5942.732577034044, 5992.310884248323, 6004.249468816398, 6007.948608993431, 6019.969900150493, 6056.091586262052, 6062.181605483292, 6081.27024757032, 6085.178500902388, 5178.844634660966, 5350.3312085989255, 5354.43778403266, 5361.410244873061, 5364.302640656729, 19876.204951801912, 19937.102830372667, 20370.0, 21245.575088498143, 21301.786982130292, 2129.4463439505685, 2157.3851452336007, 2190.4085896807774, 2226.654868495386, 2271.704678391815, 12531.498740050387, 12856.807147892789, 12872.420741066675, 13050.216986980811, 13414.798778018338, 1681.4871464203413, 1762.3743571032355, 1769.3807167491404, 1781.6080462298273, 1807.6655818673455, 56375.0, 56622.0, 58522.41477585212, 58709.41290587125, 59205.703971480296, 9651.517424128766, 9810.313278070467, 9993.250506211918, 10023.799524009479, 10082.344647597884, 13193.868061319456, 13227.73544529104, 13263.270520121292, 13279.800802987962, 13281.402336894864, 7091.432685385157, 7152.642367881585, 7160.212376638566, 7464.328210461084, 7506.28690274423, 6694.899576506356, 6839.384455399038, 6881.071055407556, 6909.412699920563, 6958.93041069593, 5905.704714764331, 5918.644881307136, 5953.374895635982, 6000.249968753906, 6013.819585412444, 1661.2358315175154, 1728.6283449058512, 1755.8419742223261, 1786.7855857297207, 1790.1765188013399, 807.4283407347617, 828.035338830256, 895.3106108296705, 962.8507581324906, 995.5171741705267, 16468.0, 17373.3050677974, 17384.391546295818, 17666.0, 18044.18801153951, 888.693400776731, 889.768660148366, 891.3404080980029, 893.3300024981264, 905.42053086025, 9984.400935943866, 10272.948635256926, 10361.689149325532, 10385.169186465064, 10414.114800241912, 497747.0, 503484.0, 504499.0, 505124.0, 518417.0, 67852.66073669698, 68783.0, 68929.0, 69278.65360673165, 70182.64908675425, 1015.223354134088, 1043.4261156363968, 1086.397049637443, 1140.4468832616174, 1159.8666153392298, 14692.632684182981, 15705.607359816097, 15751.842481575037, 15902.204889755234, 16415.507534773977, 32326.080110372168, 32394.514082289257, 32669.346613068083, 32759.836200818845, 32795.99999999905, 37923.0, 38057.28742206552, 39957.80021099876, 40248.3962740565, 40423.0, 6601.50488713358, 7208.747693830691, 7241.203467618663, 7283.0, 7479.139898911695, 10571.94714026425, 10714.73213169677, 11068.889311106786, 11412.600558980728, 11483.48324325424, 9675.951620241854, 9711.3202075854, 9993.0, 9999.100080992746, 10026.147777438999, 9838.262130340396, 10011.0, 10251.641192558225, 10287.948560257151, 10343.896561034595, 9705.6603018894, 9802.950985245314, 10090.394576325443, 10324.845127322946, 10447.895521044693, 7438.218987006503, 7455.0681164854395, 7465.962670186832, 7542.0, 7546.735864244725, 9101.453912765255, 9320.114589114024, 9407.247420206504, 9775.413475191512, 10248.128909042814], "unit": "score", "name": "jquery.html", "value": 8286.045887104056}, {"lowerIsBetter": false, "replicates": [1264.9873501264997, 1454.1711224601977, 1469.228654956148, 1616.8140663823656, 1769.6814573376787, 7152.0, 7721.961390193048, 7918.326942209905, 7924.167962363956, 7930.325922296612, 7516.135644400895, 7688.115866675334, 7694.499857509272, 7697.422693297997, 7737.41969352298, 1997.710332001859, 2009.1159889648509, 2025.3417639267223, 2318.038014224095, 2341.3912382780513, 2024.6659301215282, 2027.5742094160244, 2282.5206706591553, 2329.697139371879, 2330.4057465346314, 2272.3523795718224, 2314.513952070059, 2320.071971211512, 2323.6863023491865, 2326.1393284484766, 2216.069250914604, 2218.811401030914, 2238.4515793630503, 2243.2036626997424, 2250.6061439248147, 2235.899384527684, 2241.921532746346, 2242.0471299697724, 2265.535565209145, 2269.943251418728, 8118.75643730689, 8203.179682031809, 8204.712835050745, 8233.217844304781, 8238.588070596446, 4824.421069471686, 4881.365422495053, 4918.532739389752, 4930.087933732235, 4933.80264789408, 3129.546215798719, 3132.0916934089087, 3223.7427403312727, 3252.235724604716, 3257.641659417462, 976.3507267666993, 991.1525645573004, 1014.6144465103288, 1016.0601443664655, 1018.0328687746596, 11284.887151128465, 11288.830667539993, 11290.604828831034, 11305.547778088867, 11320.660380188607, 4362.650987920959, 4409.470863496337, 4441.045175287264, 4442.3336499524685, 4493.618042466427, 9681.70954871355, 9699.51502424876, 9700.563474643657, 9711.708648740549, 9713.805723885484, 4909.0672772173175, 4936.506349365035, 4942.777575009133, 4947.90104197914, 4948.4309304429735, 4414.249577571821, 4446.177457170369, 4449.332600109945, 4451.77741112943, 4453.933191002137, 3461.1174150591437, 3533.2403533240476, 3658.268346330691, 3763.8306276217636, 3766.3408903441787, 1199.8080307150815, 1199.9460024298928, 1228.2814553486132, 1232.057476030837, 1241.944112514939, 1207.5773479282182, 1233.4141282890555, 1249.5189352099326, 1261.224347026572, 1280.417410078412, 7246.637668116573, 7320.341169294789, 7321.524100933422, 7322.707091716378, 7367.447441441914, 1071.6570697376922, 1097.4951522299673, 1099.087757161554, 1108.9168312376603, 1113.4766659669942, 5823.097419899922, 5912.3496415394275, 5914.349421563625, 5914.733836977346, 5923.052311630118, 9601.711948641552, 9650.613975440903, 9985.251106167067, 9995.650152244636, 10121.544530495998, 9865.75335616601, 9914.107730304308, 9941.204703623693, 9993.300468967247, 10026.849597256047, 7100.0, 7316.122065352191, 7373.29953654402, 7381.1511676157925, 7404.481686282016, 7206.459515536251, 7248.383887369422, 7274.5635261882335, 7291.453141014551, 7302.452316076209, 8257.463264888003, 8378.664853406039, 8498.32013438911, 8646.56767161652, 8670.393072484865, 8636.352273579381, 8736.563171841255, 8762.912370876466, 8859.158379953895, 8887.15572020657, 7026.367626913602, 7152.392046676091, 7161.104861892263, 7164.534305270141, 7166.856662866609, 6630.138082049302, 6793.5244532882225, 7033.437325014089, 7564.281393267631, 7638.15980242184, 6723.831904202239, 6851.725930962905, 6866.828329291808, 6955.234924158237, 7103.183133939663, 6742.359475849787, 6761.628110453972, 6793.218779840184, 6932.0, 6940.9652951734915, 6761.357671021442, 6790.524663273523, 6807.047013418027, 6811.795646130624, 6813.523053386215, 6199.16311297969, 6265.937340626718, 6330.272018717907, 6374.681265936591, 6380.266269379081, 6359.046143078575, 6386.265579458422, 6406.455451286693, 6409.262934762375, 6409.903851442139], "unit": "score", "name": "mootools.html", "value": 4540.524053253242}, {"lowerIsBetter": false, "replicates": [345.2904281701104, 352.96823285904264, 353.1418652674004, 353.5721776650253, 356.75562239865695, 5812.157237200603, 5836.5914385993, 5921.970390148054, 5933.34733179351, 5964.642121472704, 5511.173324001402, 5594.916076258859, 5651.9152212716735, 5788.913166302498, 5810.0, 4471.552844715535, 4486.506484286726, 4490.7081039732475, 4500.504944456107, 4502.279635258359, 4304.634106100985, 4506.549345065484, 4508.188526065307, 4510.075434535912, 4519.34469501922, 4324.6107850293465, 4348.065165989312, 4446.866594002169, 4457.064016556527, 4484.327350897375, 4431.069475410151, 4443.289073748185, 4443.933340999887, 4450.399196108532, 4465.665075119379, 3944.7435916665327, 3949.269385163725, 3952.7628342299554, 3956.5054368203973, 3963.7819919904396, 5452.427495113036, 5560.304961879765, 5561.499465048125, 5563.36021357545, 5568.415316391802, 5201.869953251161, 5210.557102646279, 5212.348456442945, 5212.530872221519, 5214.5306922376785, 6131.96934015327, 6148.139260503488, 6149.907751383733, 6150.0, 6158.5381096417495, 4372.89067773305, 4374.781260936972, 4385.320275357325, 4399.714018588781, 4403.493598236212, 6286.07697420697, 6414.550981431302, 6414.871702565969, 6428.389303016206, 6434.099226108348, 4462.062966776948, 4462.352958820953, 4463.152001119842, 4464.129494748558, 4474.284114541658, 4512.954870451319, 4517.412736344254, 4518.887027824265, 4522.4573051234065, 4523.163214805271, 5153.407358153785, 5164.225366195025, 5166.715830629276, 5167.715775632376, 5182.689038657692, 6074.240719910012, 6148.1699970504305, 6182.443580077725, 6191.25704915413, 6204.0, 1582.1456413536791, 1597.8322276161068, 1600.407849095842, 1601.6316247263194, 1603.2064128256588, 1058.5183741397645, 1072.3190773858655, 1078.719532921446, 1105.850710154135, 1118.3625333559792, 5859.1797148399255, 5876.382979787147, 5879.412058794086, 5882.294124704978, 5886.852828679317, 6342.460890824332, 6361.681915904186, 6379.043143528508, 6379.393957574023, 6382.968085159545, 5687.43125687428, 5766.221560089418, 5789.073748200268, 5842.328132264759, 5879.617824841372, 3448.3103379324234, 3466.6013408457848, 3469.5663042119736, 3475.8609655614, 3477.4088404971217, 6684.0, 6747.493937954575, 6751.864962700718, 6754.18949726036, 6756.4932630052945, 6335.208098987627, 6469.7412103515335, 6522.543421960418, 6605.306442823435, 6613.239477460057, 6757.222919364336, 6757.324267573302, 6759.053732477457, 6767.35710107539, 6768.661566921634, 6453.9354606453335, 6456.7740129095255, 6459.709313080829, 6461.450776684034, 6461.838454038687, 6254.124422580933, 6314.336994615499, 6349.14286571307, 6363.745450181941, 6377.107204991212, 6669.7332106715185, 6693.431058360094, 6733.3939945405145, 6739.157605299338, 6741.460683145435, 4414.55854414556, 4426.5130835607415, 4439.400680908166, 4442.311441726538, 4452.844150454848, 6300.653464059521, 6460.644664543495, 6466.612003279818, 6470.870582588228, 6490.188726409199, 6299.748010079728, 6305.936940630535, 6313.810585682437, 6341.397567231105, 6373.426391624591, 6280.811575652555, 6283.403076707706, 6289.654069026247, 6292.433680968735, 6295.18162638854, 6057.666828324484, 6160.075988601746, 6166.907496387647, 6167.259928808572, 6170.043643235305, 6287.119803227643, 6287.685615719287, 6297.275813281532, 6297.527685423704, 6302.3067462578165, 6174.289956655042, 6181.443670069715, 6184.041473571604, 6191.133241346125, 6191.81424557264], "unit": "score", "name": "prototype.html", "value": 4710.404580618765}, {"lowerIsBetter": false, "replicates": [815.9224873637004, 818.7298191596774, 820.7127505373116, 833.050322632199, 841.8526757817388, 14308.427662893484, 14657.486987955424, 14663.780043299359, 14673.559793206194, 14704.411823527045, 14314.141151530916, 14335.856641433582, 14337.354819033142, 14374.856251437483, 14393.928030359833, 651.5471747135742, 662.595816551903, 786.1980779604785, 804.3565147881701, 805.7461899501668, 783.2950344689768, 790.7983464216645, 796.7888509544975, 797.0674311056079, 797.3421926910294, 838.2037064788445, 842.8946381702287, 843.3127001493763, 844.3329769482102, 844.7550210438965, 678.3250665587747, 690.5925503952692, 816.8774683797418, 833.295864994079, 841.6927821345226, 604.2356419129804, 604.685563506974, 604.7973928733879, 607.6445279511491, 609.2871340531589, 12864.807027894589, 12934.288614126219, 12936.641652626433, 12940.676483087998, 12942.935285323512, 11860.0, 12240.653528111901, 12407.93796031014, 12413.875861241362, 12650.873491265154, 9379.859302110473, 9470.655527437824, 9515.857262141073, 9591.568379422943, 9686.128248457673, 3422.9657703422895, 3466.0814884055744, 3469.60099588548, 3483.285926385085, 3483.8258087095796, 45839.54160458386, 46516.7674161627, 47898.28152577714, 49256.261156082684, 49328.75335623335, 9472.384295020802, 9513.714588562354, 9545.188658963927, 9668.033196680275, 9705.369151005161, 16353.672926541403, 16366.345346186257, 16422.917885410498, 16456.6708665826, 16494.83505164957, 7180.246074162243, 7383.593902335316, 7607.239276072459, 7778.961105194551, 7792.571408572583, 4104.800023836264, 4201.936970945439, 4216.91566168681, 4229.59818817218, 4337.7614231217585, 3077.6306843178513, 3103.9912028590797, 3106.1613364391937, 3109.176068341891, 3113.408452394038, 575.0913556580592, 584.1383958661027, 585.4847733994143, 595.0687174571781, 601.897677394844, 532.816178418445, 584.3893131677407, 626.7211091064523, 629.4523764325066, 706.8444942112727, 8130.878036829452, 8176.223258790405, 8235.547044912468, 8307.584620768937, 8527.232549070613, 586.9354371019184, 621.1583304622262, 636.6307541625846, 655.6951017776756, 675.2639622811062, 3785.2240290740333, 3799.069228039148, 3868.2775367222775, 3945.2306800174265, 4037.9192416151513, 54571.18143227855, 54887.45112548903, 54995.0, 55461.44538554644, 55856.72071639616, 42324.57675423268, 42584.14831703348, 42622.0, 42667.14665706668, 43193.0, 42550.36174457386, 42609.78695106505, 42709.78645106754, 44556.77721611371, 45105.0, 8508.957455212685, 8629.13708629132, 8775.341849361195, 8828.558572071499, 8885.80041694363, 31992.840035799672, 32472.0, 32477.51283730793, 32602.673973259964, 32671.0, 38769.4184587237, 43134.56865431431, 43939.78030109957, 43972.56027439813, 44568.77715611401, 10236.232282578985, 10435.895641043797, 10581.735456613646, 10648.733781655521, 10810.29733067348, 11837.940810295893, 12196.817047744113, 12255.938720306342, 12288.692782680148, 12295.446704898122, 11265.211435199784, 11390.658280251606, 11550.0, 11709.707257318636, 12093.153479256367, 10801.837972430578, 11205.215634905479, 11235.831462527905, 11243.088674925446, 11470.197086203885, 10307.845382319421, 10450.895491044992, 10560.102391296827, 10981.945090274497, 10987.725306867393, 5966.492848107786, 9223.400478968846, 9255.213306868991, 9401.38890972112, 9442.15020648145, 9161.358704890594, 9313.348065635611, 9374.343795934219, 9521.952390238004, 9604.27967902396], "unit": "score", "name": "yui.html", "value": 6120.0415992670605}], "name": "dromaeo_css", "value": 6744.200639949627}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 105.0, 110.0, 109.0, 109.0, 110.0, 110.0, 103.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [163.0, 127.0, 155.0, 167.0, 127.0, 155.0, 150.0, 128.0, 163.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 146.4}, {"lowerIsBetter": true, "replicates": [162.0, 165.0, 160.0, 160.0, 161.0, 160.0, 159.0, 158.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 96.0, 96.0, 72.0, 72.0, 74.0, 121.0, 97.0, 72.0], "unit": "score", "name": "audio-fft", "value": 84.4}, {"lowerIsBetter": true, "replicates": [104.0, 96.0, 151.0, 95.0, 97.0, 98.0, 141.0, 95.0, 96.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 110.9}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 115.0, 115.0, 115.0, 115.0, 114.0, 114.0, 114.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.1}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 144.0, 145.0, 144.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [57.0, 54.0, 56.0, 55.0, 56.0, 56.0, 56.0, 55.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.3}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 67.0, 67.0, 68.0, 68.0, 67.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 84.0, 84.0, 84.0, 85.0, 85.0, 92.0, 85.0, 94.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.1}, {"lowerIsBetter": true, "replicates": [113.0, 122.0, 114.0, 115.0, 113.0, 117.0, 123.0, 113.0, 113.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.4}, {"lowerIsBetter": true, "replicates": [145.0, 133.0, 145.0, 143.0, 153.0, 133.0, 141.0, 153.0, 142.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 72.0, 69.0, 67.0, 72.0, 67.0, 67.0, 72.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1504.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.75004168751042], "unit": "score", "name": "Richards", "value": 211.70609399999992}, {"lowerIsBetter": false, "replicates": [190.47619047619048], "unit": "score", "name": "DeltaBlue", "value": 347.1194999999999}, {"lowerIsBetter": false, "replicates": [272.8512960436562], "unit": "score", "name": "Encrypt", "value": 975.5533650000004}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [1113.5857461024498], "unit": "score", "name": "RayTrace", "value": 664.510122}, {"lowerIsBetter": false, "replicates": [777.6049766718507], "unit": "score", "name": "Earley", "value": 857.0714179999998}, {"lowerIsBetter": false, "replicates": [12481.481481481482], "unit": "score", "name": "Boyer", "value": 53.39614540059344}, {"lowerIsBetter": false, "replicates": [41958.333333333336], "unit": "score", "name": "RegExp", "value": 21.71165839126117}, {"lowerIsBetter": false, "replicates": [579.3742757821552], "unit": "score", "name": "Splay", "value": 140.653466}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 20145.139064998}]} 17:36:21 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20145.14"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1504.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6744.20"}}} 17:36:21 INFO - Return code: 0 17:36:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:36:21 INFO - # TBPL SUCCESS # 17:36:21 INFO - Running post-action listener: _resource_record_post_action 17:36:21 INFO - Running post-run listener: _resource_record_post_run 17:36:22 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 0; Write bytes: 556347392; Read time: 0; Write time: 852368 17:36:22 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 248131584; Read time: 0; Write time: 474020 17:36:22 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 0; Write bytes: 308215808; Read time: 0; Write time: 378348 17:36:22 INFO - Running post-run listener: _upload_blobber_files 17:36:22 INFO - Blob upload gear active. 17:36:22 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:36:22 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:36:22 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:36:22 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:36:22 INFO - (blobuploader) - INFO - Open directory for files ... 17:36:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:36:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:36:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:24 INFO - (blobuploader) - INFO - Done attempting. 17:36:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:36:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:36:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:25 INFO - (blobuploader) - INFO - Done attempting. 17:36:25 INFO - (blobuploader) - INFO - Iteration through files over. 17:36:25 INFO - Return code: 0 17:36:25 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:36:25 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:36:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/77071abef1e220e901ee12174b87e9bb8979b0c17a499256b2069df76a1cf71bc45f41fa22a6689fc80e265427cc5a000a6e4d74deb34f5335ad6871a31018ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/653394ab78ee8e2fbda9d57a25ad920f4eeb8208edfc309fe1fd2c67abc49c120b9deaa4b9adbaac00559be820c2702778b4af81ad062610cc7d8b39ec76c80e"} 17:36:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:36:25 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:36:25 INFO - Contents: 17:36:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/77071abef1e220e901ee12174b87e9bb8979b0c17a499256b2069df76a1cf71bc45f41fa22a6689fc80e265427cc5a000a6e4d74deb34f5335ad6871a31018ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/653394ab78ee8e2fbda9d57a25ad920f4eeb8208edfc309fe1fd2c67abc49c120b9deaa4b9adbaac00559be820c2702778b4af81ad062610cc7d8b39ec76c80e"} 17:36:25 INFO - Running post-run listener: copy_logs_to_upload_dir 17:36:25 INFO - Copying logs to upload dir... 17:36:25 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:36:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.122822 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-02-05 17:36:24.776959) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-05 17:36:24.780247) ========= 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=1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417 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/77071abef1e220e901ee12174b87e9bb8979b0c17a499256b2069df76a1cf71bc45f41fa22a6689fc80e265427cc5a000a6e4d74deb34f5335ad6871a31018ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/653394ab78ee8e2fbda9d57a25ad920f4eeb8208edfc309fe1fd2c67abc49c120b9deaa4b9adbaac00559be820c2702778b4af81ad062610cc7d8b39ec76c80e"} build_url:https://queue.taskcluster.net/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://queue.taskcluster.net/v1/task/Gs_50eyMTMGJ2gK7d5zvsg/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/77071abef1e220e901ee12174b87e9bb8979b0c17a499256b2069df76a1cf71bc45f41fa22a6689fc80e265427cc5a000a6e4d74deb34f5335ad6871a31018ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/653394ab78ee8e2fbda9d57a25ad920f4eeb8208edfc309fe1fd2c67abc49c120b9deaa4b9adbaac00559be820c2702778b4af81ad062610cc7d8b39ec76c80e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-05 17:36:24.805608) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 17:36:24.806194) ========= 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=1861a34ebfea852630dec091000001fa-1454719902.97885-1475584417 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004593 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 17:36:24.887954) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-05 17:36:24.888268) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-05 17:36:24.888568) ========= ========= Total master_lag: 0.26 =========