builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1454538469.43 results: success (0) buildid: 20160203113045 builduid: 45c7791df2c540d88830938b1bb325bf revision: 4e40feb910f9a15a5ff3844efe7222b2a330e092 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-03 14:27:49.433614) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-03 14:27:49.433968) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-03 14:27:49.434262) ========= 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=62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006276 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-03 14:27:49.469139) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-03 14:27:49.469421) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-03 14:27:49.502240) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 14:27:49.502488) ========= 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=62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 14:27:49.553649) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-03 14:27:49.553907) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-03 14:27:49.554248) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 14:27:49.554520) ========= 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=62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-03 14:27:49-- 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% 35.5M=0s 2016-02-03 14:27:49 (35.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.190769 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 14:27:49.757322) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 14:27:49.757615) ========= 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=62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019355 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 14:27:49.807891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 14:27:49.808189) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 4e40feb910f9a15a5ff3844efe7222b2a330e092 --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 4e40feb910f9a15a5ff3844efe7222b2a330e092 --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=62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-03 14:27:49,980 truncating revision to first 12 chars 2016-02-03 14:27:49,980 Setting DEBUG logging. 2016-02-03 14:27:49,980 attempt 1/10 2016-02-03 14:27:49,980 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/4e40feb910f9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-03 14:27:50,212 unpacking tar archive at: b2g-inbound-4e40feb910f9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.511093 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 14:27:50.331567) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-03 14:27:50.331865) ========= echo 4e40feb910f9a15a5ff3844efe7222b2a330e092 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'4e40feb910f9a15a5ff3844efe7222b2a330e092'] 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=62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 4e40feb910f9a15a5ff3844efe7222b2a330e092 program finished with exit code 0 elapsedTime=0.003776 script_repo_revision: '4e40feb910f9a15a5ff3844efe7222b2a330e092' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-03 14:27:50.380385) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-03 14:27:50.380657) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-03 14:27:50.393512) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-02-03 14:27:50.393772) ========= /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=62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:27:50 INFO - MultiFileLogger online at 20160203 14:27:50 in /builds/slave/test-pgo 14:27:50 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 14:27:50 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:27:50 INFO - {'append_to_log': False, 14:27:50 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:27:50 INFO - 'blob_upload_branch': 'B2G-Inbound', 14:27:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:27:50 INFO - 'branch': 'B2G-Inbound', 14:27:50 INFO - 'buildbot_json_path': 'buildprops.json', 14:27:50 INFO - 'config_files': ('talos/linux_config.py',), 14:27:50 INFO - 'default_actions': ('clobber', 14:27:50 INFO - 'read-buildbot-config', 14:27:50 INFO - 'download-and-extract', 14:27:50 INFO - 'populate-webroot', 14:27:50 INFO - 'create-virtualenv', 14:27:50 INFO - 'install', 14:27:50 INFO - 'run-tests'), 14:27:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:27:50 INFO - 'download_minidump_stackwalk': True, 14:27:50 INFO - 'download_symbols': 'ondemand', 14:27:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:27:50 INFO - 'tooltool.py': '/tools/tooltool.py', 14:27:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:27:50 INFO - '/tools/misc-python/virtualenv.py')}, 14:27:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:27:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:27:50 INFO - 'installer_path': 'installer.exe', 14:27:50 INFO - 'log_level': 'info', 14:27:50 INFO - 'log_name': 'talos', 14:27:50 INFO - 'log_to_console': True, 14:27:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:27:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:27:50 INFO - 'opt_config_files': (), 14:27:50 INFO - 'pip_index': False, 14:27:50 INFO - 'sps_profile': False, 14:27:50 INFO - 'sps_profile_interval': 0, 14:27:50 INFO - 'suite': 'dromaeojs', 14:27:50 INFO - 'system_bits': '32', 14:27:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:27:50 INFO - 'title': 'talos-linux64-ix-018', 14:27:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:27:50 INFO - 'use_talos_json': True, 14:27:50 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:27:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:27:50 INFO - 'work_dir': 'build'} 14:27:50 INFO - ##### 14:27:50 INFO - ##### Running clobber step. 14:27:50 INFO - ##### 14:27:50 INFO - Running pre-action listener: _resource_record_pre_action 14:27:50 INFO - Running main action method: clobber 14:27:50 INFO - rmtree: /builds/slave/test-pgo/build 14:27:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:27:51 INFO - Running post-action listener: _resource_record_post_action 14:27:51 INFO - ##### 14:27:51 INFO - ##### Running read-buildbot-config step. 14:27:51 INFO - ##### 14:27:51 INFO - Running pre-action listener: _resource_record_pre_action 14:27:51 INFO - Running main action method: read_buildbot_config 14:27:51 INFO - Using buildbot properties: 14:27:51 INFO - { 14:27:51 INFO - "project": "", 14:27:51 INFO - "product": "firefox", 14:27:51 INFO - "script_repo_revision": "production", 14:27:51 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 14:27:51 INFO - "repository": "", 14:27:51 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 14:27:51 INFO - "buildid": "20160203113045", 14:27:51 INFO - "pgo_build": "True", 14:27:51 INFO - "basedir": "/builds/slave/test-pgo", 14:27:51 INFO - "buildnumber": 38, 14:27:51 INFO - "slavename": "talos-linux64-ix-018", 14:27:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:27:51 INFO - "platform": "ubuntu64_hw", 14:27:51 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 14:27:51 INFO - "branch": "b2g-inbound", 14:27:51 INFO - "repo_path": "integration/b2g-inbound", 14:27:51 INFO - "revision": "4e40feb910f9a15a5ff3844efe7222b2a330e092", 14:27:51 INFO - "stage_platform": "linux64-pgo", 14:27:51 INFO - "builduid": "45c7791df2c540d88830938b1bb325bf", 14:27:51 INFO - "slavebuilddir": "test" 14:27:51 INFO - } 14:27:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/eDBQNUuhRfGdFvGfZMlPZg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 14:27:51 INFO - Running post-action listener: _resource_record_post_action 14:27:51 INFO - ##### 14:27:51 INFO - ##### Running download-and-extract step. 14:27:51 INFO - ##### 14:27:51 INFO - Running pre-action listener: _resource_record_pre_action 14:27:51 INFO - Running main action method: download_and_extract 14:27:51 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:27:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:51 INFO - https://queue.taskcluster.net/v1/task/eDBQNUuhRfGdFvGfZMlPZg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:27:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eDBQNUuhRfGdFvGfZMlPZg/artifacts/public/build/test_packages.json 14:27:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eDBQNUuhRfGdFvGfZMlPZg/artifacts/public/build/test_packages.json 14:27:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eDBQNUuhRfGdFvGfZMlPZg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:27:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eDBQNUuhRfGdFvGfZMlPZg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:27:54 INFO - Downloaded 1448 bytes. 14:27:54 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:27:54 INFO - Using the following test package requirements: 14:27:54 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:27:54 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:27:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:27:54 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:27:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:27:54 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:27:54 INFO - u'jsshell-linux-x86_64.zip'], 14:27:54 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:27:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:27:54 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:27:54 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:27:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:27:54 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:27:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:27:54 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:27:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:27:54 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:27:54 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:27:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:27:54 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:27:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:54 INFO - https://queue.taskcluster.net/v1/task/eDBQNUuhRfGdFvGfZMlPZg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:27:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eDBQNUuhRfGdFvGfZMlPZg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:27:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eDBQNUuhRfGdFvGfZMlPZg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:27:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eDBQNUuhRfGdFvGfZMlPZg/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 14:27:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eDBQNUuhRfGdFvGfZMlPZg/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 14:27:56 INFO - Downloaded 22498941 bytes. 14:27:56 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'] 14:27:56 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 14:27:57 INFO - Return code: 0 14:27:57 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 14:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:57 INFO - https://queue.taskcluster.net/v1/task/eDBQNUuhRfGdFvGfZMlPZg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:27:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eDBQNUuhRfGdFvGfZMlPZg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:27:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eDBQNUuhRfGdFvGfZMlPZg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:27:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eDBQNUuhRfGdFvGfZMlPZg/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 14:27:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eDBQNUuhRfGdFvGfZMlPZg/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 14:27:59 INFO - Downloaded 22498941 bytes. 14:27:59 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'] 14:27:59 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 14:28:00 INFO - Return code: 0 14:28:00 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')]} 14:28:00 INFO - https://queue.taskcluster.net/v1/task/eDBQNUuhRfGdFvGfZMlPZg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:28:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eDBQNUuhRfGdFvGfZMlPZg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 14:28:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eDBQNUuhRfGdFvGfZMlPZg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 14:28:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eDBQNUuhRfGdFvGfZMlPZg/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 14:28:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eDBQNUuhRfGdFvGfZMlPZg/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 14:28:01 INFO - Downloaded 10706572 bytes. 14:28:01 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'] 14:28:01 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 14:28:01 INFO - Return code: 0 14:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:01 INFO - https://queue.taskcluster.net/v1/task/eDBQNUuhRfGdFvGfZMlPZg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:28:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eDBQNUuhRfGdFvGfZMlPZg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:28:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eDBQNUuhRfGdFvGfZMlPZg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:28:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eDBQNUuhRfGdFvGfZMlPZg/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 14:28:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eDBQNUuhRfGdFvGfZMlPZg/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 14:28:03 INFO - Downloaded 55989388 bytes. 14:28:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eDBQNUuhRfGdFvGfZMlPZg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:28:03 INFO - mkdir: /builds/slave/test-pgo/properties 14:28:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:28:03 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:28:03 INFO - Contents: 14:28:03 INFO - build_url:https://queue.taskcluster.net/v1/task/eDBQNUuhRfGdFvGfZMlPZg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:28:03 INFO - Running post-action listener: _resource_record_post_action 14:28:03 INFO - Running post-action listener: set_extra_try_arguments 14:28:03 INFO - ##### 14:28:03 INFO - ##### Running populate-webroot step. 14:28:03 INFO - ##### 14:28:03 INFO - Running pre-action listener: _resource_record_pre_action 14:28:03 INFO - Running main action method: populate_webroot 14:28:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:28:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:28:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:28:03 INFO - '--tppagecycles', 14:28:03 INFO - '7'], 14:28:03 INFO - 'tests': ['tsvgm']}}, 14:28:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:28:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:28:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:28:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:28:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:28:03 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:28:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:28:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:03 INFO - 'talos_options': ['--e10s'], 14:28:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:28:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:03 INFO - 'tests': ['damp', 'tps']}, 14:28:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:03 INFO - 'talos_options': ['--e10s'], 14:28:03 INFO - 'tests': ['damp', 'tps']}, 14:28:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:28:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:28:03 INFO - 'other': {'tests': ['a11yr', 14:28:03 INFO - 'ts_paint', 14:28:03 INFO - 'tpaint', 14:28:03 INFO - 'sessionrestore', 14:28:03 INFO - 'sessionrestore_no_auto_restore']}, 14:28:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:28:03 INFO - 'tests': ['a11yr', 14:28:03 INFO - 'ts_paint', 14:28:03 INFO - 'tpaint', 14:28:03 INFO - 'sessionrestore', 14:28:03 INFO - 'sessionrestore_no_auto_restore']}, 14:28:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:28:03 INFO - 'tests': ['a11yr', 14:28:03 INFO - 'ts_paint', 14:28:03 INFO - 'tpaint', 14:28:03 INFO - 'sessionrestore', 14:28:03 INFO - 'sessionrestore_no_auto_restore']}, 14:28:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:28:03 INFO - 'tests': ['a11yr', 14:28:03 INFO - 'ts_paint', 14:28:03 INFO - 'tpaint', 14:28:03 INFO - 'sessionrestore', 14:28:03 INFO - 'sessionrestore_no_auto_restore']}, 14:28:03 INFO - 'other_l64': {'tests': ['a11yr', 14:28:03 INFO - 'ts_paint', 14:28:03 INFO - 'tpaint', 14:28:03 INFO - 'sessionrestore', 14:28:03 INFO - 'sessionrestore_no_auto_restore']}, 14:28:03 INFO - 'other_nol64': {'tests': ['a11yr', 14:28:03 INFO - 'ts_paint', 14:28:03 INFO - 'tpaint', 14:28:03 INFO - 'sessionrestore', 14:28:03 INFO - 'sessionrestore_no_auto_restore']}, 14:28:03 INFO - 'svgr': {'tests': ['tsvgx', 14:28:03 INFO - 'tsvgr_opacity', 14:28:03 INFO - 'tart', 14:28:03 INFO - 'tscrollx', 14:28:03 INFO - 'cart']}, 14:28:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:28:03 INFO - 'tests': ['tsvgx', 14:28:03 INFO - 'tsvgr_opacity', 14:28:03 INFO - 'tart', 14:28:03 INFO - 'tscrollx', 14:28:03 INFO - 'cart']}, 14:28:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:03 INFO - 'tests': ['tp5o']}, 14:28:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:03 INFO - 'talos_options': ['--e10s'], 14:28:03 INFO - 'tests': ['tp5o']}, 14:28:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:03 INFO - 'talos_options': ['--xperf_path', 14:28:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:28:03 INFO - 'tests': ['tp5n']}, 14:28:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:03 INFO - 'talos_options': ['--e10s', 14:28:03 INFO - '--xperf_path', 14:28:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:28:03 INFO - 'tests': ['tp5n']}}, 14:28:03 INFO - 'talos.zip': {'path': '', 14:28:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:28:03 INFO - Running post-action listener: _resource_record_post_action 14:28:03 INFO - ##### 14:28:03 INFO - ##### Running create-virtualenv step. 14:28:03 INFO - ##### 14:28:03 INFO - Running pre-action listener: _resource_record_pre_action 14:28:03 INFO - Running main action method: create_virtualenv 14:28:03 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:28:03 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 14:28:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:28:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:28:03 INFO - Using real prefix '/usr' 14:28:03 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:28:04 INFO - Installing distribute.............................................................................................................................................................................................done. 14:28:06 INFO - Installing pip.................done. 14:28:06 INFO - Return code: 0 14:28:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:06 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 0x7f9319f2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b30660>, '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 0x1b31560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b31a10>, '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': '62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959', '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 14:28:06 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 14:28:06 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 14:28:06 INFO - Using env: {'DISPLAY': ':0', 14:28:06 INFO - 'HOME': '/home/cltbld', 14:28:06 INFO - 'LANG': 'en_US.UTF-8', 14:28:06 INFO - 'LANGUAGE': 'en_US:en', 14:28:06 INFO - 'LOGNAME': 'cltbld', 14:28:06 INFO - 'MAIL': '/var/mail/cltbld', 14:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:06 INFO - 'MOZ_NO_REMOTE': '1', 14:28:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:06 INFO - 'NO_EM_RESTART': '1', 14:28:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:28:06 INFO - 'PWD': '/builds/slave/test-pgo', 14:28:06 INFO - 'SHELL': '/bin/bash', 14:28:06 INFO - 'SHLVL': '1', 14:28:06 INFO - 'TERM': 'linux', 14:28:06 INFO - 'TMOUT': '86400', 14:28:06 INFO - 'USER': 'cltbld', 14:28:06 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959', 14:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:06 INFO - '_': '/tools/buildbot/bin/python'} 14:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:06 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 14:28:06 INFO - Cleaning up... 14:28:06 INFO - Return code: 0 14:28:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:06 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 0x7f9319f2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b30660>, '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 0x1b31560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b31a10>, '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': '62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959', '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 14:28:06 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 14:28:06 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 14:28:06 INFO - Using env: {'DISPLAY': ':0', 14:28:06 INFO - 'HOME': '/home/cltbld', 14:28:06 INFO - 'LANG': 'en_US.UTF-8', 14:28:06 INFO - 'LANGUAGE': 'en_US:en', 14:28:06 INFO - 'LOGNAME': 'cltbld', 14:28:06 INFO - 'MAIL': '/var/mail/cltbld', 14:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:06 INFO - 'MOZ_NO_REMOTE': '1', 14:28:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:06 INFO - 'NO_EM_RESTART': '1', 14:28:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:28:06 INFO - 'PWD': '/builds/slave/test-pgo', 14:28:06 INFO - 'SHELL': '/bin/bash', 14:28:06 INFO - 'SHLVL': '1', 14:28:06 INFO - 'TERM': 'linux', 14:28:06 INFO - 'TMOUT': '86400', 14:28:06 INFO - 'USER': 'cltbld', 14:28:06 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959', 14:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:06 INFO - '_': '/tools/buildbot/bin/python'} 14:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:06 INFO - Downloading/unpacking psutil>=0.7.1 14:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:28:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:28:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:28:08 INFO - Installing collected packages: psutil 14:28:08 INFO - Running setup.py install for psutil 14:28:08 INFO - building 'psutil._psutil_linux' extension 14:28:08 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 14:28:09 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 14:28:09 INFO - building 'psutil._psutil_posix' extension 14:28:09 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 14:28:09 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 14:28:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:28:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:28:09 INFO - Successfully installed psutil 14:28:09 INFO - Cleaning up... 14:28:09 INFO - Return code: 0 14:28:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:09 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 0x7f9319f2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b30660>, '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 0x1b31560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b31a10>, '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': '62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959', '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 14:28:09 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 14:28:09 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 14:28:09 INFO - Using env: {'DISPLAY': ':0', 14:28:09 INFO - 'HOME': '/home/cltbld', 14:28:09 INFO - 'LANG': 'en_US.UTF-8', 14:28:09 INFO - 'LANGUAGE': 'en_US:en', 14:28:09 INFO - 'LOGNAME': 'cltbld', 14:28:09 INFO - 'MAIL': '/var/mail/cltbld', 14:28:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:09 INFO - 'MOZ_NO_REMOTE': '1', 14:28:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:09 INFO - 'NO_EM_RESTART': '1', 14:28:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:28:09 INFO - 'PWD': '/builds/slave/test-pgo', 14:28:09 INFO - 'SHELL': '/bin/bash', 14:28:09 INFO - 'SHLVL': '1', 14:28:09 INFO - 'TERM': 'linux', 14:28:09 INFO - 'TMOUT': '86400', 14:28:09 INFO - 'USER': 'cltbld', 14:28:09 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959', 14:28:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:09 INFO - '_': '/tools/buildbot/bin/python'} 14:28:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:28:09 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 14:28:09 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 14:28:09 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 14:28:09 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 14:28:09 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 14:28:09 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 14:28:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:28:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:28:11 INFO - Installing collected packages: mozsystemmonitor 14:28:11 INFO - Running setup.py install for mozsystemmonitor 14:28:11 INFO - Successfully installed mozsystemmonitor 14:28:11 INFO - Cleaning up... 14:28:11 INFO - Return code: 0 14:28:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:28:11 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')]} 14:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:11 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')]} 14:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:11 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 0x7f9319f2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b30660>, '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 0x1b31560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b31a10>, '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': '62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959', '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 14:28:11 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 14:28:11 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 14:28:11 INFO - Using env: {'DISPLAY': ':0', 14:28:11 INFO - 'HOME': '/home/cltbld', 14:28:11 INFO - 'LANG': 'en_US.UTF-8', 14:28:11 INFO - 'LANGUAGE': 'en_US:en', 14:28:11 INFO - 'LOGNAME': 'cltbld', 14:28:11 INFO - 'MAIL': '/var/mail/cltbld', 14:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:11 INFO - 'MOZ_NO_REMOTE': '1', 14:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:11 INFO - 'NO_EM_RESTART': '1', 14:28:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:28:11 INFO - 'PWD': '/builds/slave/test-pgo', 14:28:11 INFO - 'SHELL': '/bin/bash', 14:28:11 INFO - 'SHLVL': '1', 14:28:11 INFO - 'TERM': 'linux', 14:28:11 INFO - 'TMOUT': '86400', 14:28:11 INFO - 'USER': 'cltbld', 14:28:11 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959', 14:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:11 INFO - '_': '/tools/buildbot/bin/python'} 14:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:11 INFO - Downloading/unpacking blobuploader==1.2.4 14:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:13 INFO - Downloading blobuploader-1.2.4.tar.gz 14:28:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:28:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:28:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:14 INFO - Downloading docopt-0.6.1.tar.gz 14:28:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:28:14 INFO - Installing collected packages: blobuploader, requests, docopt 14:28:14 INFO - Running setup.py install for blobuploader 14:28:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:28:14 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:28:14 INFO - Running setup.py install for requests 14:28:14 INFO - Running setup.py install for docopt 14:28:14 INFO - Successfully installed blobuploader requests docopt 14:28:14 INFO - Cleaning up... 14:28:14 INFO - Return code: 0 14:28:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:28: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')]} 14:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28: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')]} 14:28:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:14 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 0x7f9319f2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b30660>, '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 0x1b31560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b31a10>, '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': '62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959', '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 14:28:14 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 14:28:14 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 14:28:14 INFO - Using env: {'DISPLAY': ':0', 14:28:14 INFO - 'HOME': '/home/cltbld', 14:28:14 INFO - 'LANG': 'en_US.UTF-8', 14:28:14 INFO - 'LANGUAGE': 'en_US:en', 14:28:14 INFO - 'LOGNAME': 'cltbld', 14:28:14 INFO - 'MAIL': '/var/mail/cltbld', 14:28:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:14 INFO - 'MOZ_NO_REMOTE': '1', 14:28:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:14 INFO - 'NO_EM_RESTART': '1', 14:28:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:28:14 INFO - 'PWD': '/builds/slave/test-pgo', 14:28:14 INFO - 'SHELL': '/bin/bash', 14:28:14 INFO - 'SHLVL': '1', 14:28:14 INFO - 'TERM': 'linux', 14:28:14 INFO - 'TMOUT': '86400', 14:28:14 INFO - 'USER': 'cltbld', 14:28:14 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959', 14:28:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:14 INFO - '_': '/tools/buildbot/bin/python'} 14:28:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:28:15 INFO - Running setup.py (path:/tmp/pip-iR8fVo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:28:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:28:15 INFO - Running setup.py (path:/tmp/pip-7DPfUt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:28:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:28:15 INFO - Running setup.py (path:/tmp/pip-bnplVm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:28:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:28:15 INFO - Running setup.py (path:/tmp/pip-f0RE6r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:28:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:28:15 INFO - Running setup.py (path:/tmp/pip-upX7bs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:28:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:28:15 INFO - Running setup.py (path:/tmp/pip-XAsVtv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:28:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:28:15 INFO - Running setup.py (path:/tmp/pip-J_zpda-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:28:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:28:15 INFO - Running setup.py (path:/tmp/pip-ThZJ7w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:28:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:28:15 INFO - Running setup.py (path:/tmp/pip-79uQMv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:28:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:28:15 INFO - Running setup.py (path:/tmp/pip-SrQorz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:28:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:28:15 INFO - Running setup.py (path:/tmp/pip-Dkn1dy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:28:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:28:15 INFO - Running setup.py (path:/tmp/pip-q7mNIV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:28:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:28:15 INFO - Running setup.py (path:/tmp/pip-QeK8cF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:28:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:28:15 INFO - Running setup.py (path:/tmp/pip-n4m6fw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:28:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:28:16 INFO - Running setup.py (path:/tmp/pip-vgkWyx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:28:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:28:16 INFO - Running setup.py (path:/tmp/pip-RqTf1V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:28:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:28:16 INFO - Running setup.py (path:/tmp/pip-GXCMS6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:28:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:28:16 INFO - Running setup.py install for manifestparser 14:28:16 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:28:16 INFO - Running setup.py install for mozcrash 14:28:16 INFO - Running setup.py install for mozdebug 14:28:16 INFO - Running setup.py install for mozdevice 14:28:16 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:28:16 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:28:16 INFO - Running setup.py install for mozfile 14:28:16 INFO - Running setup.py install for mozhttpd 14:28:16 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:28:16 INFO - Running setup.py install for mozinfo 14:28:16 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:28:16 INFO - Running setup.py install for mozInstall 14:28:17 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:28:17 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:28:17 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:28:17 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:28:17 INFO - Running setup.py install for mozleak 14:28:17 INFO - Running setup.py install for mozlog 14:28:17 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:28:17 INFO - Running setup.py install for moznetwork 14:28:17 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:28:17 INFO - Running setup.py install for mozprocess 14:28:17 INFO - Running setup.py install for mozprofile 14:28:17 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:28:17 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:28:17 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:28:17 INFO - Running setup.py install for mozrunner 14:28:17 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:28:17 INFO - Running setup.py install for mozscreenshot 14:28:17 INFO - Running setup.py install for moztest 14:28:17 INFO - Running setup.py install for mozversion 14:28:18 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:28:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:28:18 INFO - Cleaning up... 14:28:18 INFO - Return code: 0 14:28:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:28: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')]} 14:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28: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')]} 14:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:18 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 0x7f9319f2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b30660>, '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 0x1b31560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b31a10>, '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': '62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959', '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 14:28:18 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 14:28:18 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 14:28:18 INFO - Using env: {'DISPLAY': ':0', 14:28:18 INFO - 'HOME': '/home/cltbld', 14:28:18 INFO - 'LANG': 'en_US.UTF-8', 14:28:18 INFO - 'LANGUAGE': 'en_US:en', 14:28:18 INFO - 'LOGNAME': 'cltbld', 14:28:18 INFO - 'MAIL': '/var/mail/cltbld', 14:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:18 INFO - 'MOZ_NO_REMOTE': '1', 14:28:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:18 INFO - 'NO_EM_RESTART': '1', 14:28:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:28:18 INFO - 'PWD': '/builds/slave/test-pgo', 14:28:18 INFO - 'SHELL': '/bin/bash', 14:28:18 INFO - 'SHLVL': '1', 14:28:18 INFO - 'TERM': 'linux', 14:28:18 INFO - 'TMOUT': '86400', 14:28:18 INFO - 'USER': 'cltbld', 14:28:18 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959', 14:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:18 INFO - '_': '/tools/buildbot/bin/python'} 14:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:28:18 INFO - Running setup.py (path:/tmp/pip-MVAlna-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:28:18 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)) 14:28:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:28:18 INFO - Running setup.py (path:/tmp/pip-mcCEHr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:28:18 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)) 14:28:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:28:18 INFO - Running setup.py (path:/tmp/pip-FbjqvJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:28:18 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)) 14:28:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:28:18 INFO - Running setup.py (path:/tmp/pip-3mDnpr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:28:18 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)) 14:28:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:28:18 INFO - Running setup.py (path:/tmp/pip-gLO3Kr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:28:18 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)) 14:28:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:28:18 INFO - Running setup.py (path:/tmp/pip-3kVwdX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:28:18 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)) 14:28:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:28:18 INFO - Running setup.py (path:/tmp/pip-pzsNUk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:28:18 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)) 14:28:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:28:18 INFO - Running setup.py (path:/tmp/pip-9a9Y2Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:28:18 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)) 14:28:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:28:18 INFO - Running setup.py (path:/tmp/pip-TEQ9si-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:28:18 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)) 14:28:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:28:18 INFO - Running setup.py (path:/tmp/pip-nGbcnu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:28:19 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)) 14:28:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:28:19 INFO - Running setup.py (path:/tmp/pip-Zc14yq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:28:19 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)) 14:28:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:28:19 INFO - Running setup.py (path:/tmp/pip-P4AqJU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:28:19 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)) 14:28:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:28:19 INFO - Running setup.py (path:/tmp/pip-5RwlPD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:28:19 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)) 14:28:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:28:19 INFO - Running setup.py (path:/tmp/pip-KjOZSL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:28:19 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)) 14:28:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:28:19 INFO - Running setup.py (path:/tmp/pip-32ylo5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:28:19 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)) 14:28:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:28:19 INFO - Running setup.py (path:/tmp/pip-O7hU3G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:28:19 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)) 14:28:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:28:19 INFO - Running setup.py (path:/tmp/pip-oNatKb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:28:19 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)) 14:28:19 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)) 14:28:19 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)) 14:28:19 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)) 14:28:19 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)) 14:28:19 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)) 14:28:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:21 INFO - Downloading blessings-1.6.tar.gz 14:28:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:28:21 INFO - Installing collected packages: blessings 14:28:21 INFO - Running setup.py install for blessings 14:28:21 INFO - Successfully installed blessings 14:28:21 INFO - Cleaning up... 14:28:21 INFO - Return code: 0 14:28:21 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:28:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:28:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:28:21 INFO - Reading from file tmpfile_stdout 14:28:21 INFO - Current package versions: 14:28:21 INFO - argparse == 1.2.1 14:28:21 INFO - blessings == 1.6 14:28:21 INFO - blobuploader == 1.2.4 14:28:21 INFO - docopt == 0.6.1 14:28:21 INFO - manifestparser == 1.1 14:28:21 INFO - mozInstall == 1.12 14:28:21 INFO - mozcrash == 0.16 14:28:21 INFO - mozdebug == 0.1 14:28:21 INFO - mozdevice == 0.48 14:28:21 INFO - mozfile == 1.2 14:28:21 INFO - mozhttpd == 0.7 14:28:21 INFO - mozinfo == 0.9 14:28:21 INFO - mozleak == 0.1 14:28:21 INFO - mozlog == 3.1 14:28:21 INFO - moznetwork == 0.27 14:28:21 INFO - mozprocess == 0.22 14:28:21 INFO - mozprofile == 0.28 14:28:21 INFO - mozrunner == 6.11 14:28:21 INFO - mozscreenshot == 0.1 14:28:21 INFO - mozsystemmonitor == 0.0 14:28:21 INFO - moztest == 0.7 14:28:21 INFO - mozversion == 1.4 14:28:21 INFO - psutil == 3.1.1 14:28:21 INFO - requests == 1.2.3 14:28:21 INFO - wsgiref == 0.1.2 14:28:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:28:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:21 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 0x7f9319f2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b30660>, '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 0x1b31560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b31a10>, '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': '62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959', '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 14:28:21 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 14:28:21 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 14:28:21 INFO - Using env: {'DISPLAY': ':0', 14:28:21 INFO - 'HOME': '/home/cltbld', 14:28:21 INFO - 'LANG': 'en_US.UTF-8', 14:28:21 INFO - 'LANGUAGE': 'en_US:en', 14:28:21 INFO - 'LOGNAME': 'cltbld', 14:28:21 INFO - 'MAIL': '/var/mail/cltbld', 14:28:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:21 INFO - 'MOZ_NO_REMOTE': '1', 14:28:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:21 INFO - 'NO_EM_RESTART': '1', 14:28:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:28:21 INFO - 'PWD': '/builds/slave/test-pgo', 14:28:21 INFO - 'SHELL': '/bin/bash', 14:28:21 INFO - 'SHLVL': '1', 14:28:21 INFO - 'TERM': 'linux', 14:28:21 INFO - 'TMOUT': '86400', 14:28:21 INFO - 'USER': 'cltbld', 14:28:21 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959', 14:28:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:21 INFO - '_': '/tools/buildbot/bin/python'} 14:28:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:21 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)) 14:28:21 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)) 14:28:21 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)) 14:28:21 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)) 14:28:21 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)) 14:28:21 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)) 14:28:21 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)) 14:28:21 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)) 14:28:21 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)) 14:28:21 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)) 14:28:21 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)) 14:28:21 INFO - Cleaning up... 14:28:21 INFO - Return code: 0 14:28:21 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:28:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9319f2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b30660>, '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 0x1b31560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b31a10>, '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': '62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959', '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 14:28:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 14:28:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:28:21 INFO - Using env: {'DISPLAY': ':0', 14:28:21 INFO - 'HOME': '/home/cltbld', 14:28:21 INFO - 'LANG': 'en_US.UTF-8', 14:28:21 INFO - 'LANGUAGE': 'en_US:en', 14:28:21 INFO - 'LOGNAME': 'cltbld', 14:28:21 INFO - 'MAIL': '/var/mail/cltbld', 14:28:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:21 INFO - 'MOZ_NO_REMOTE': '1', 14:28:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:21 INFO - 'NO_EM_RESTART': '1', 14:28:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:28:21 INFO - 'PWD': '/builds/slave/test-pgo', 14:28:21 INFO - 'SHELL': '/bin/bash', 14:28:21 INFO - 'SHLVL': '1', 14:28:21 INFO - 'TERM': 'linux', 14:28:21 INFO - 'TMOUT': '86400', 14:28:21 INFO - 'USER': 'cltbld', 14:28:21 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959', 14:28:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:21 INFO - '_': '/tools/buildbot/bin/python'} 14:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:22 INFO - Downloading/unpacking jsonschema 14:28:22 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 14:28:22 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 14:28:22 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 14:28:22 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 14:28:22 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 14:28:22 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 14:28:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:28:23 INFO - Downloading/unpacking functools32 (from jsonschema) 14:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:24 INFO - Downloading functools32-3.2.3-2.tar.gz 14:28:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:28:24 INFO - warning: no files found matching '*.txt' 14:28:24 INFO - no previously-included directories found matching 'build' 14:28:24 INFO - no previously-included directories found matching 'dist' 14:28:24 INFO - no previously-included directories found matching '.git*' 14:28:24 INFO - Installing collected packages: jsonschema, functools32 14:28:24 INFO - Running setup.py install for functools32 14:28:24 INFO - warning: no files found matching '*.txt' 14:28:24 INFO - no previously-included directories found matching 'build' 14:28:24 INFO - no previously-included directories found matching 'dist' 14:28:24 INFO - no previously-included directories found matching '.git*' 14:28:24 INFO - Successfully installed jsonschema functools32 14:28:24 INFO - Cleaning up... 14:28:24 INFO - Return code: 0 14:28:24 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:28:24 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')]} 14:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:24 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')]} 14:28:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:24 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 0x7f9319f2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b30660>, '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 0x1b31560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b31a10>, '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': '62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959', '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 14:28:24 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 14:28:24 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 14:28:24 INFO - Using env: {'DISPLAY': ':0', 14:28:24 INFO - 'HOME': '/home/cltbld', 14:28:24 INFO - 'LANG': 'en_US.UTF-8', 14:28:24 INFO - 'LANGUAGE': 'en_US:en', 14:28:24 INFO - 'LOGNAME': 'cltbld', 14:28:24 INFO - 'MAIL': '/var/mail/cltbld', 14:28:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:24 INFO - 'MOZ_NO_REMOTE': '1', 14:28:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:24 INFO - 'NO_EM_RESTART': '1', 14:28:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:28:24 INFO - 'PWD': '/builds/slave/test-pgo', 14:28:24 INFO - 'SHELL': '/bin/bash', 14:28:24 INFO - 'SHLVL': '1', 14:28:24 INFO - 'TERM': 'linux', 14:28:24 INFO - 'TMOUT': '86400', 14:28:24 INFO - 'USER': 'cltbld', 14:28:24 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959', 14:28:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:24 INFO - '_': '/tools/buildbot/bin/python'} 14:28:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:24 INFO - Downloading/unpacking flake8 14:28:24 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 14:28:24 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 14:28:24 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 14:28:24 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 14:28:24 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 14:28:24 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 14:28:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:28:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:28:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:28:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:28:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:28:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:28:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:28:27 INFO - no previously-included directories found matching 'docs/_build' 14:28:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:28:27 INFO - Running setup.py install for pep8 14:28:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:28:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:28:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:28:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:28:27 INFO - no previously-included directories found matching 'docs/_build' 14:28:27 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:28:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:28:27 INFO - Cleaning up... 14:28:27 INFO - Return code: 0 14:28:27 INFO - Running post-action listener: _resource_record_post_action 14:28:27 INFO - Running post-action listener: _start_resource_monitoring 14:28:27 INFO - Starting resource monitoring. 14:28:27 INFO - ##### 14:28:27 INFO - ##### Running install step. 14:28:27 INFO - ##### 14:28:27 INFO - Running pre-action listener: _resource_record_pre_action 14:28:27 INFO - Running main action method: install 14:28:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:28:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:28:27 INFO - Reading from file tmpfile_stdout 14:28:27 INFO - Detecting whether we're running mozinstall >=1.0... 14:28:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:28:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:28:27 INFO - Reading from file tmpfile_stdout 14:28:27 INFO - Output received: 14:28:27 INFO - Usage: mozinstall [options] installer 14:28:27 INFO - Options: 14:28:27 INFO - -h, --help show this help message and exit 14:28:27 INFO - -d DEST, --destination=DEST 14:28:27 INFO - Directory to install application into. [default: 14:28:27 INFO - "/builds/slave/test-pgo"] 14:28:27 INFO - --app=APP Application being installed. [default: firefox] 14:28:27 INFO - mkdir: /builds/slave/test-pgo/build/application 14:28:27 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'] 14:28:27 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 14:28:43 INFO - Reading from file tmpfile_stdout 14:28:43 INFO - Output received: 14:28:43 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:28:43 INFO - Running post-action listener: _resource_record_post_action 14:28:43 INFO - ##### 14:28:43 INFO - ##### Running run-tests step. 14:28:43 INFO - ##### 14:28:43 INFO - Running pre-action listener: _resource_record_pre_action 14:28:43 INFO - Running main action method: run_tests 14:28:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:28:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:28:43 INFO - Python 2.7.3 14:28:43 INFO - Return code: 0 14:28:43 INFO - grabbing minidump binary from tooltool 14:28: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')]} 14:28:43 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 0x1b30660>, '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 0x1b31560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b31a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:28:43 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 14:28:43 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 14:28:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:28:43 INFO - Return code: 0 14:28:43 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:28:43 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:28:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:28:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:28:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:28:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:28:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:28:44 INFO - Return code: 0 14:28:44 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/eDBQNUuhRfGdFvGfZMlPZg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 14:28:44 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/eDBQNUuhRfGdFvGfZMlPZg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 14:28:44 INFO - Using env: {'DISPLAY': ':0', 14:28:44 INFO - 'HOME': '/home/cltbld', 14:28:44 INFO - 'LANG': 'en_US.UTF-8', 14:28:44 INFO - 'LANGUAGE': 'en_US:en', 14:28:44 INFO - 'LOGNAME': 'cltbld', 14:28:44 INFO - 'MAIL': '/var/mail/cltbld', 14:28:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:28:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:44 INFO - 'MOZ_NO_REMOTE': '1', 14:28:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:28:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:44 INFO - 'NO_EM_RESTART': '1', 14:28:44 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:28:44 INFO - 'PWD': '/builds/slave/test-pgo', 14:28:44 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:28:44 INFO - 'SHELL': '/bin/bash', 14:28:44 INFO - 'SHLVL': '1', 14:28:44 INFO - 'TERM': 'linux', 14:28:44 INFO - 'TMOUT': '86400', 14:28:44 INFO - 'USER': 'cltbld', 14:28:44 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959', 14:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:44 INFO - '_': '/tools/buildbot/bin/python'} 14:28:44 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/eDBQNUuhRfGdFvGfZMlPZg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 14:28:45 INFO - mozversion application_buildid: 20160203113045 14:28:45 INFO - mozversion application_changeset: 4e40feb910f9a15a5ff3844efe7222b2a330e092 14:28:45 INFO - mozversion application_display_name: Nightly 14:28:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:28:45 INFO - mozversion application_name: Firefox 14:28:45 INFO - mozversion application_remotingname: firefox 14:28:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 14:28:45 INFO - mozversion application_vendor: Mozilla 14:28:45 INFO - mozversion application_version: 47.0a1 14:28:45 INFO - mozversion platform_buildid: 20160203113045 14:28:45 INFO - mozversion platform_changeset: 4e40feb910f9a15a5ff3844efe7222b2a330e092 14:28:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 14:28:45 INFO - mozversion platform_version: 47.0a1 14:28:45 INFO - using testdate: 1454538525 14:28:45 INFO - actual date: 1454538525 14:28:45 INFO - starting webserver on 'localhost:51626' 14:28:45 INFO - SUITE-START | Running 3 tests 14:28:45 INFO - TEST-START | dromaeo_css 14:28:45 INFO - operating with platform_type : linux_ 14:28:45 INFO - Initialising browser for dromaeo_css test... 14:28:45 INFO - TEST-INFO | started process 24410 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGi1IMF/profile http://localhost:51626/getInfo.html) 14:28:49 INFO - PROCESS | 24410 | __metrics Screen width/height:1600/1200 14:28:49 INFO - PROCESS | 24410 | colorDepth:24 14:28:49 INFO - PROCESS | 24410 | Browser inner width/height: 1024/697 14:28:49 INFO - PROCESS | 24410 | __metrics 14:28:49 INFO - PROCESS | 24410 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:28:49 INFO - PROCESS | 24410 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:28:50 INFO - TEST-INFO | 24410: exit 0 14:28:50 INFO - Browser initialized. 14:28:50 INFO - Running cycle 1/1 for dromaeo_css test... 14:28:50 INFO - TEST-INFO | started process 24501 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGi1IMF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:29:02 INFO - PROCESS | 24501 | RSS: Main: 148426752 14:29:02 INFO - PROCESS | 24501 | 14:29:53 INFO - PROCESS | 24501 | 1454538593573 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] 14:32:02 INFO - PROCESS | 24501 | Cycle 1(1): loaded http://localhost:51626/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51626/tests/dromaeo/cssquery-ext.html) 14:32:03 INFO - PROCESS | 24501 | RSS: Main: 255827968 14:32:03 INFO - PROCESS | 24501 | 14:35:05 INFO - PROCESS | 24501 | Cycle 1(1): loaded http://localhost:51626/tests/dromaeo/cssquery-ext.html (next: http://localhost:51626/tests/dromaeo/cssquery-jquery.html) 14:35:06 INFO - PROCESS | 24501 | RSS: Main: 239378432 14:35:06 INFO - PROCESS | 24501 | 14:38:08 INFO - PROCESS | 24501 | Cycle 1(1): loaded http://localhost:51626/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51626/tests/dromaeo/cssquery-mootools.html) 14:38:08 INFO - PROCESS | 24501 | RSS: Main: 255066112 14:38:08 INFO - PROCESS | 24501 | 14:41:10 INFO - PROCESS | 24501 | Cycle 1(1): loaded http://localhost:51626/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51626/tests/dromaeo/cssquery-prototype.html) 14:41:11 INFO - PROCESS | 24501 | RSS: Main: 215760896 14:41:11 INFO - PROCESS | 24501 | 14:44:13 INFO - PROCESS | 24501 | Cycle 1(1): loaded http://localhost:51626/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51626/tests/dromaeo/cssquery-yui.html) 14:44:14 INFO - PROCESS | 24501 | RSS: Main: 219136000 14:44:14 INFO - PROCESS | 24501 | 14:47:17 INFO - PROCESS | 24501 | Cycle 1(1): loaded http://localhost:51626/tests/dromaeo/cssquery-yui.html (next: http://localhost:51626/tests/dromaeo/cssquery-dojo.html) 14:47:17 INFO - PROCESS | 24501 | RSS: Main: 277266432 14:47:17 INFO - PROCESS | 24501 | 14:47:17 INFO - PROCESS | 24501 | __start_tp_report 14:47:17 INFO - PROCESS | 24501 | _x_x_mozilla_page_load 14:47:17 INFO - PROCESS | 24501 | _x_x_mozilla_page_load_details 14:47:17 INFO - PROCESS | 24501 | |i|pagename|runs| 14:47:17 INFO - PROCESS | 24501 | |0;dojo.html;3135.4983202687567;3152.8423578821053;3194.16951592586;3208.5828842250503;3225.3549290141964;5143.125668636331;5161.071007218699;5180.766865491052;5211.661242019276;5228.843134705955;5189.766460509277;5261.237120617518;5298.09932311507;5324.015057214408;5343.839684809453;4711;4735.6921800083055;4762.595179409755;4772.498887616803;4803;4814.229723244282;4879;4907.779149938261;4930.112579735646;4955.900881982358;4699.318598803188;4780.952190478086;4843.0313937212695;4863.27050942358;4904.117258893398;4742.715437073786;4746.311784791221;4753.287006948951;4753.548412900769;4758.809647614091;4739.0758802033615;4739.9526004739855;4743.739094349844;4776.11641846256;4789.042191561667;5060.974695126501;5061.645684802065;5074.949250507485;5081.034603425337;5082.23766435034;5514.862128446781;5587.580931430159;5596.524295434893;5608.635438696471;5663.7168141593165;5689.402612725687;5709.0865461525955;5730.7707691692285;5731.770729170828;5759.395263497315;5323.121684921984;5328.893422131536;5332.653377530448;5334.413214546396;5336.119540275849;5666.376698563155;5744.770209191669;5763.711814409263;5782.479576838105;5801.448862358069;5475.342958844884;5525.060739674265;5525.889482210333;5530.889382212334;5579.972100139555;5577.553795696334;5590.888182236333;5606.775728970877;5618.550515958714;5623.465770751772;5446.591505637093;5537.058700021006;5569.359523654832;5580.218769372291;5606.383297837235;5619.915701264485;5640.407757185519;5641.746121424546;5645.633033852787;5670.376258611549;4384.912301753947;4391.14372697321;4391.890202744957;4428.844990425384;4431.911361772811;3863.265979463893;3898;3934.744241624285;3962.5641179470235;3976.8409263629133;5248.8425347239645;5255;5272.7100009499845;5275.63070585063;5320.973395133;5629.7185140742795;5636.126400407943;5641.915371269434;5642.689652069175;5646.85882852932;5180.9740951295;5232.529072383504;5247.10799164143;5286.15421532553;5340.732963351817;4748.477667456577;4758.666893317434;4762.047590481918;4762.190427627243;4806.735629540409;5757.712114394263;5765.077587586134;5796.652200867877;5808.88382232353;5822.243108395882;5542.057850165401;5544.445555444423;5629.521490673339;5691.943080569141;5716.085426331767;5885.529157667462;5887.499562537232;5890.734916928663;5896.764129434775;5903.970480147744;5375;5547.362053363915;5550.389457159628;5552.111662134201;5561.555075594024;5595.804146855004;5613.214150018919;5633.549316054624;5660.4905558498285;5679.977604031314;5500.147477141049;5502.422245664147;5503.559715222853;5511.862203444946;5513.145462453326;5367.597430192673;5481.835544933659;5503.614746967673;5503.944960550503;5557.416471270459;5317.1226747586215;5406.810761623325;5462.289902312674;5467.507924286833;5504.4770746778995;5486.1770734388565;5545.750441230073;5547.084731019498;5547.611667183259;5548.223248745098;5330.280412144466;5363.061464243664;5397.406285308534;5412.107002344569;5420.566354691694 14:47:17 INFO - PROCESS | 24501 | |1;ext.html;511.5805039867309;524.095934512965;524.3995625009364;539.1669870050771;549.1625271461024;27786;28919.56620650692;29027.129186124424;34905.476417853686;35678.821605892;38401.61598384015;38690.226195476076;38790.8060459698;38804.80597597015;38806.22387552254;8281.83436331273;8413.326933845277;8420.368472364567;8462.280706139985;8485.0666426693;7306.305900939429;8550.444221125637;8552.35857310701;8559.27246184072;8560.101189375087;8554.18735220153;8628.65485380584;8636.784080397978;8637.870431943526;8643.049264580892;8457.365697572675;8519.659213631447;8541.530215838158;8545.01732300787;8545.572721363907;8472.703455379033;8596.441231319945;8601.870971935426;8602.913970860274;8641.783955401103;38546;38973.80513097445;39022.414663780066;39032;39045.41431878524;3305.272839975202;3351.765376423651;3393.490976353542;3595.388783906742;4088.1414902870433;27366.5895011573;29259;30135;30639.38721225563;30796.538051929238;3937.1338305572726;4011.5587285398583;4012.1775036117524;4063.674906007512;4167.354060120686;261710;263186;263365;263415;263550;50731.23903141456;52213;56996.430035699945;58397.416025840044;59496;54309.72845135828;54386.72806636021;54388;54403;54746.72626636921;12465.439055242536;12618.053645976588;12648.873511264954;12660.430280637393;12665.810012849815;9180.081991800767;9290.256779457628;9329.393589416666;9438.480883551334;9450.338476306593;19335.226590936207;19392;19479.707804382946;19530.70703939442;19542.902285488482;7312.122545294599;7629.855521671793;7639.3575381293285;7675.539467631848;7709.768706938801;941.3410612571228;980.5293459139652;990.841465365538;1058.3385384134915;1066.7759770448292;26657.083532981706;28483;28791.856040719664;28792.42415151685;28929.710702893124;1007.315025782475;1016.5832008876325;1027.3733022856052;1032.385730490357;1038.693585392311;13599.796003059962;13685.315734213249;13780.10429322091;13903.30483475822;13989.3704783285;375692;380062;380097;380481;381792;51705.224421633706;52171.95656086857;52205.17281895191;52251.95496090057;52266.738666306424;1295.352323838081;1310.351376068833;1317.736452709462;1323.0209644862732;1328;26227;26686.466270674868;26934;26974.1907742768;26989.325266868484;41395.379069314586;42181.57818421899;42520.14959700851;42684;46019;192714;194621;195997;196128;196478;31473.21316967094;31688;31736;31860;31897.202569935936;30210.395792084473;36083.45874811932;41722.58277417187;44150.779246103564;45787;34359.85087009102;35683.28633427369;35778.463323049655;36915.261694766494;37100;36046.20517844144;36753.448698269014;37052.25895482129;37263;37274;33841.83079084589;33945.15137121493;34121.48817767686;34381.656183437844;36116;31729.365412692077;32879.67120328862;33277;33306.666933331326;33403.1649208762;26781;27608.447831043668;27810.582841256994;27835.860820695765;27884.442311154067 14:47:17 INFO - PROCESS | 24501 | |2;jquery.html;361.8389816531643;365.75128912339596;366.3479007366888;368.04675889446327;374.30753106752496;13094.083414161012;13196.208227506357;15392.461263855766;16497.58756031098;17511.036892970897;9665.613375464973;12665.113442059059;13107.37852429513;13129.474821007172;13169.934150329258;4605.148047611195;4798.712077275357;4799.184138696412;4801.207800712878;4802.087603355369;3707.925841483169;3818.3127037133304;4694.577488026077;4736.478987311393;5104.974475127619;5217.295665085203;5258.947410525903;5269.841904742864;5273.288106105684;5276.234945932837;5037.949620503785;5192.350956130484;5215.921761173586;5218.634695571312;5220.686758794465;4888.755562221874;5009.699418034929;5034.270030845507;5035.3454050973505;5223.6343455958095;12271.754564908651;12273.877261227362;15891.36434542617;18299.817001830077;19562.217511299532;2162.4593851537115;2163.5240247145603;2167.880766557839;2183.748868880083;2219.911203551856;8648.740537783877;8861.734147975507;9071.138241867013;9215.44707317563;12361.876381236163;1771.60138968731;1816.809235030316;1841.318712076527;1843.9354622588146;1866.2534986005571;48202.75898620485;53667.19499207515;54883.45116548823;54918.725406372716;55388.44611553873;9220.907790922005;9751.512424378752;9772.413655180711;9824.950875245579;9883.209343252522;12584.11911166228;12617.36913154357;12664.36678166088;12664.620061398173;12701.428435720414;6840.828979275558;6879.380855723009;6884.51808373409;6886.586804791728;6918.273581273995;6288.779892703734;6319.557630965788;6346.936530634727;6353.968230158912;6365.3316401778075;4259.531451540328;4275.144971005749;4408.25059739845;4459.5986361227;4516.299973504112;1712.5632963594453;1771.3888708395582;1800.8649351298704;1815.872888897791;1873.203147538382;420.70971029989823;894.2577660541734;926.2636204217529;967.7483854197959;1008.3899240959261;8958.776030599156;9458.290628202913;9911.355761875599;10041.548130334153;10131.696049118538;420.76437195170803;439.5780051150931;447.2575524629165;450.06835849791275;458.3468557305826;5496.4503549645515;5750.453706897838;9209.63161473547;9681.70954871355;9893.109620134079;493256;494127;494302.22791088675;514228;524649;68577;72465;72811.2718872815;72876.63561682157;73891;1116.938568378747;1124.9469717764948;1131.1177281720272;1150.384544268829;1152.458344578047;14043;14489.20309382952;14551.636209094857;14815.555533334018;15067.171305578298;29401.264968375963;29936.85031574828;30265;30353.089407317817;30656.693433065382;35674.643253567134;35705.25094865002;36088;36754.26491470102;38276.80861595674;7014.403775679124;7083.220845707071;7137.928620713934;7216.855662886818;7308.634568271672;8021.558814265271;10076.596936122472;10577.62978295756;11267.26762760418;11332.546698131982;9080.455172689659;9257.21313688344;9699.175570076623;10016.899831001596;10126.39241645474;9464.242860571276;9739.75650608712;9748.122668959828;9888.851667224853;9938.254630902857;9514.096160864707;9730.708078757649;9941.950290248791;9945.403275803475;10037.849432258376;7141.678624461808;7143.321384468467;7247.383972362408;7280.9271907280245;7326.351570896506;8182.877256841033;9654.131128198214;9822.803543928938;9864.309498335335;10015.649452269136 14:47:17 INFO - PROCESS | 24501 | |3;mootools.html;1285.1196930102885;1457.7084583083383;1466.1349803615865;1611.1380411479854;1765.9823401765987;7124.715011399544;7652.426068044898;7848.7645370638975;7859.764207073783;7871.291583757461;7650.120236172842;7766.262205090507;7826.960865195666;7835.412344074189;7844.254795794404;2027.7161197432297;2082.7188329575465;2083.2396175395947;2314.386687527802;2341.6370462578243;2153.321703663341;2276.8975396107217;2338.251759436981;2348.53029394121;2350.247920665388;2289.164454973939;2336;2342.7071616047992;2353.0587764894094;2353.1528649686184;2286.5084006938587;2339.7777211165;2340.742518322983;2345.870977096259;2346.894389752457;2311.3528212100637;2315.2128276385943;2321.8374713770045;2324.2794733632627;2337.625979843217;8003.4797738146835;8031.477953932976;8063.354931605516;8079.192080791932;8093.716719914833;4739.0758802033615;4872.975635121802;4875.707457552523;4880.829170979035;4888;3166.1293144385477;3229.6447390786993;3295.07737833407;3314.453115235983;3334.683205095512;1077.2136340471422;1082.8862969388178;1106.623747925709;1126.8253420719802;1141.9200655954087;11218.326900386002;11225.214235003554;11242;11246.49390777417;11249.381284029376;4450.443694538183;4461.776911154429;4567.086582683477;4575.794089265991;4582.931256031162;9624.37441566296;9634.277429192838;9637.518124093767;9642.469664168399;9648.662296819577;4877.365942427462;4884.975575122102;4909.70541767488;4912.901741965141;4913.87715307113;4349.195398851222;4451.443569553806;4458.9331160032625;4472.1502914446155;4474.172278128557;3578.248567800791;3645.179834537208;3871.4192871069004;3891.5524714658177;3941.172353805733;1187.2579637726421;1270.879266469684;1276.2980360801523;1280.5774094548963;1281.6859869331886;1304.8303720516271;1305.895528357729;1317.4730107956893;1330.5941687785319;1348.575198812371;7281.490295679251;7309.488335816548;7316.268373162641;7318.817029574197;7323.853522929511;1086.8858769829212;1100.1254003067581;1107.5735841700841;1125.8705248896317;1150.3098141115431;5743.827685169368;5825.242718446575;5843.620164689281;5855.531557475391;5859.1797148399255;9432.622695092257;9919.702408927744;10036.64871729486;10046.447445390428;10052.497375131214;9783.412995220167;9790.902090979142;9795.510224488748;9867.457289848984;9907;7269.818254543678;7497.850042999109;7541.773746787496;7542.924570754332;7581.01446811911;7304.3791277739865;7333.083364579427;7395.630218489162;7398.815029624302;7429.777106686808;8473.839171011352;8547.358948078794;8668.739937801876;8699;8864.20222180007;9018.549072546477;9306.06939306064;9316.394434361744;9317.44095354281;9359.719208423758;7139.679159355536;7263.673134708845;7270.454715896223;7271.600061996641;7275.854482910207;7620.047494063242;7627.923720762721;7709.113451953097;7720.227977202235;7740.032495938008;7229.4095299034125;7266.96366518164;7342.5227360221415;7479.289467500579;7480.027596412431;6932.0988271524375;7106.289371063059;7148.678309475982;7297.781066568012;7330.890036649348;6886.380225779704;6908.378245957888;6950.270221626859;6950.930490695028;6957.686904089227;6491.707873145814;6558.573692709959;6572.145621069421;6625.271220165681;6643.202815662152;6617.966910165418;6667.899981500184;6674.799756007327;6675.599464032173;6679.632620205741 14:47:17 INFO - PROCESS | 24501 | |4;prototype.html;333.7563578587631;334.85433836281237;337.73319077928437;344.0315511834188;345.3179969560118;5771.394003629622;5846.503047240979;5868.119782032697;5896.852578685535;5938.792142275021;5698.829035128942;5809.2738407699035;5838.474537291643;5841.182234487164;5854.268216472941;4527.818887244506;4529.864104076866;4529.909401811979;4535.092981403716;4539.59143677069;4332.0469496710675;4411.691181617288;4440.245158323093;4504.639628829702;4527.954720452803;4464.218761716703;4481.46222453306;4481.775911204443;4495.303227999665;4505.5719706627815;4481.865544033684;4487.394201782767;4489.977550112261;4500.797464114123;4501.864944051684;3963.286608410485;3966.2662407454422;3971.6425521703186;3972.1261322509004;3981.4824072870633;5459.563234941195;5557.083081291582;5566.415526369713;5618.719064046782;5638.323401191883;5171.741412929338;5174.818881339135;5178.14560597501;5179.300794392747;5180.197069454203;5847.181394604759;6237.6257424554215;6260.499160067184;6267.153934218868;6267.9686601567155;4143.937840932388;4202.936955945664;4326.63223625989;4336.956630433687;4339.869803905888;6404.551681382305;6498.285188629247;6502.967485162591;6508.511861610398;6508.902366464459;4381.868543943687;4382.758948257876;4383.539728328544;4384.210842048462;4390.5828946250695;4263.957360426418;4397.84607538741;4441.533638967861;4444.1333939881415;4445.333200019958;5085.982803439327;5086.237064440364;5090.287359769635;5091.363579552556;5092.6435149539175;6231.283402408691;6252.3122456529745;6274.843128921813;6280.183576135073;6281.748730050746;1544.8686861616889;1564.5619226616566;1565.5538171621033;1566.0290619815787;1566.6631674190103;1034.8706411698538;1038.159091136182;1039.8284283093205;1054.7626783973544;1065.547142464465;5892.7642894283745;5901.085331773582;5947.167396564484;5954.196183515257;5959.821205363846;6416.390442907917;6464.385883341075;6501.349865013555;6506.512011599054;6513.609183449008;5827.155062515912;5940.405959404025;5947.04847224442;5947.940520594825;5949.226600541989;3357.9664203358143;3466.913327166841;3474.861005559749;3483.494893240466;3496.440569508917;6813.318668133147;6817.69320380584;6865.176178858569;6877.312268773083;6897.068895699117;6655.966720166368;6686.899696504556;6688.197416310074;6688.498362622823;6691.1636045494315;6595.505337099737;6759.966200168968;6761.492888033417;6764.154480689914;6765.932340676629;6165.691715414122;6272.874542509216;6450.774222902176;6525.282218956006;6527.02094685782;6208.534359922934;6223.813285601439;6308.842278943063;6431.839204019937;6452.290248072614;6769.153855768029;6821.693023814039;6825.931740682529;6832.077669514751;6834.589924604539;4266;4325.913481730285;4350.434443522322;4386.210482113251;4391.780410979502;6394.4884409246215;6446.7098980546925;6457.67711614408;6465.547411681137;6468.8059358219325;6293.622382657055;6301.149344838388;6303.180586523723;6305.337939516285;6313.463355614824;6188.81433556994;6226.159468471698;6287.779927702509;6290.46531044848;6296.559240853279;6072.969635151796;6107.053406721965;6108.847278818065;6113;6116.3272040076445;6278.277998030285;6290;6290.811275661737;6293.842653933688;6302.71637776292;6037.455410226026;6080.300765412034;6132.386761323832;6139.324674285915;6144.969275153596 14:47:17 INFO - PROCESS | 24501 | |5;yui.html;744.2631794523422;788.5465857132147;811.05107024781;825.8141918068435;856.1096459681927;13272.137311074786;13467.730645387086;13477.326133693325;13482.393292301846;13516.256605886672;13693.657658558515;13909.652258693537;13914.30428478577;13973.860261397384;13985.510507132252;669.8425869920565;675.2470994840767;801.3909428834085;802.743122200896;816.3713940265992;799.1409235072321;805.1706742055692;805.3476683886071;805.4563169860351;805.605253425823;847.656699036891;852.0116664668985;852.927501162402;853.2320911179957;853.7780177153953;702.3959394920364;707.9398251148658;836.5315423362875;849.0957130655831;850.8638617821119;620.011082323693;623.834683808791;624.7719582352454;624.7750809708501;627.0907184582373;12637.43131559082;12677.492900283978;12712.364381780966;12743.107982441234;12757.362131893367;11550.59572914944;12265.448054837554;12383.75232495354;12611.873881261161;12618.305993170372;10272.178225741924;10288.485575721184;10418.9479052605;10719.946400267949;10839.891601084046;3618.764780289273;3670.926581468382;3698.33429982603;3770.1517158639363;3772.8679496217774;43574.34638480425;43737.343939840925;43771;43816.78091609522;43985.99999999968;9084.137006984325;9328.160465558132;9457.33798634089;9677.612895484242;9700.078492543196;16774.412895548598;17479.126043697765;17491.650166996842;17505.387311444294;17511.824881751276;7130.679119439637;7234.855302894018;7286.089238845145;7296.854062918712;7341.853162936712;4072.3280658690983;4124.8143833527565;4131.710780245354;4155.522114956819;4159.584041595816;3025.319303156816;3047.1924939890946;3052.648945371266;3062.9540556891666;3063.9693603063683;564.2805423085599;574.6408494690818;581.4766709960984;583.5040215816522;585.6632436349116;508.0474111041797;512.2623422271917;538.5556915544613;540.8972295263887;583.0117950074583;8276.751697449086;8281.585920703941;8535.957320213483;8559.272461840688;8619.6983105591;569.5244470866872;653.9803805885831;660.2802944790202;661.7452280871898;666.7199776094052;3779.9433008504893;4065.308897487434;4087.162131763041;4198.958010419857;4329.9134017319475;54284.728576356865;55143;55358.44641553533;55393.723031385394;55511.72244138754;48008;49106.50893491019;49456.75271623619;49469.257961130614;50120;44164.337534937;44281.33577996332;44322.778386107864;44384.77807610876;44713.55286447159;7950.204979502004;8219.30135938428;8240.381971352053;8290.336773058261;8384.790380240544;33019.504707428925;33029;33517.497237541946;34025.48961765526;34042.31915361728;39567;40443.3933490992;42934.14131717411;43595.34606980961;43701.344479832194;10739.731506712395;10836.620718274822;10892.346459212473;11012.779744404907;11130.499127539118;12036.63890083299;12189.75620487603;12214.694632634255;12678.429470673658;12743.681407964876;10703.518341674799;10946.726331841768;11092.168087393638;11257.549698011988;11497.310161390344;11196.104311654884;11561.653150405502;11571.421428928688;11635.709107272385;11876.703082423008;10152.746181345525;10174.694759157237;10248.743781405525;10254.333468324536;10402.58389664405;8453.196946290092;8820.691275805317;8860.64557417696;8932.871876101826;9069.229115525255;8133.593320334078;8614.18165274298;8810.515421651871;8933.910660893307;9180.632774688938 14:47:17 INFO - PROCESS | 24501 | __end_tp_report 14:47:17 INFO - PROCESS | 24501 | __start_cc_report 14:47:17 INFO - PROCESS | 24501 | _x_x_mozilla_cycle_collect,831 14:47:17 INFO - PROCESS | 24501 | __end_cc_report 14:47:17 INFO - PROCESS | 24501 | __startTimestamp1454539637346__endTimestamp 14:47:17 INFO - PROCESS | 24501 | 14:47:17 INFO - PROCESS | 24501 | ------- Summary: start ------- 14:47:17 INFO - PROCESS | 24501 | Number of tests: 6 14:47:17 INFO - PROCESS | 24501 | 14:47:17 INFO - PROCESS | 24501 | [#0] dojo.html Cycles:165 Average:5227.35 Median:5412.11 stddev:568.54 (10.5%) stddev-sans-first:546.09 14:47:17 INFO - PROCESS | 24501 | Values: 3135.5 3152.8 3194.2 3208.6 3225.4 5143.1 5161.1 5180.8 5211.7 5228.8 5189.8 5261.2 5298.1 5324.0 5343.8 4711.0 4735.7 4762.6 4772.5 4803.0 4814.2 4879.0 4907.8 4930.1 4955.9 4699.3 4781.0 4843.0 4863.3 4904.1 4742.7 4746.3 4753.3 4753.5 4758.8 4739.1 4740.0 4743.7 4776.1 4789.0 5061.0 5061.6 5074.9 5081.0 5082.2 5514.9 5587.6 5596.5 5608.6 5663.7 5689.4 5709.1 5730.8 5731.8 5759.4 5323.1 5328.9 5332.7 5334.4 5336.1 5666.4 5744.8 5763.7 5782.5 5801.4 5475.3 5525.1 5525.9 5530.9 5580.0 5577.6 5590.9 5606.8 5618.6 5623.5 5446.6 5537.1 5569.4 5580.2 5606.4 5619.9 5640.4 5641.7 5645.6 5670.4 4384.9 4391.1 4391.9 4428.8 4431.9 3863.3 3898.0 3934.7 3962.6 3976.8 5248.8 5255.0 5272.7 5275.6 5321.0 5629.7 5636.1 5641.9 5642.7 5646.9 5181.0 5232.5 5247.1 5286.2 5340.7 4748.5 4758.7 4762.0 4762.2 4806.7 5757.7 5765.1 5796.7 5808.9 5822.2 5542.1 5544.4 5629.5 5691.9 5716.1 5885.5 5887.5 5890.7 5896.8 5904.0 5375.0 5547.4 5550.4 5552.1 5561.6 5595.8 5613.2 5633.5 5660.5 5680.0 5500.1 5502.4 5503.6 5511.9 5513.1 5367.6 5481.8 5503.6 5503.9 5557.4 5317.1 5406.8 5462.3 5467.5 5504.5 5486.2 5545.8 5547.1 5547.6 5548.2 5330.3 5363.1 5397.4 5412.1 5420.6 14:47:17 INFO - PROCESS | 24501 | 14:47:17 INFO - PROCESS | 24501 | [#1] ext.html Cycles:180 Average:44233.80 Median:37181.50 stddev:76144.30 (204.8%) stddev-sans-first:76287.14 14:47:17 INFO - PROCESS | 24501 | Values: 511.6 524.1 524.4 539.2 549.2 27786.0 28919.6 29027.1 34905.5 35678.8 38401.6 38690.2 38790.8 38804.8 38806.2 8281.8 8413.3 8420.4 8462.3 8485.1 7306.3 8550.4 8552.4 8559.3 8560.1 8554.2 8628.7 8636.8 8637.9 8643.0 8457.4 8519.7 8541.5 8545.0 8545.6 8472.7 8596.4 8601.9 8602.9 8641.8 38546.0 38973.8 39022.4 39032.0 39045.4 3305.3 3351.8 3393.5 3595.4 4088.1 27366.6 29259.0 30135.0 30639.4 30796.5 3937.1 4011.6 4012.2 4063.7 4167.4 261710.0 263186.0 263365.0 263415.0 263550.0 50731.2 52213.0 56996.4 58397.4 59496.0 54309.7 54386.7 54388.0 54403.0 54746.7 12465.4 12618.1 12648.9 12660.4 12665.8 9180.1 9290.3 9329.4 9438.5 9450.3 19335.2 19392.0 19479.7 19530.7 19542.9 7312.1 7629.9 7639.4 7675.5 7709.8 941.3 980.5 990.8 1058.3 1066.8 26657.1 28483.0 28791.9 28792.4 28929.7 1007.3 1016.6 1027.4 1032.4 1038.7 13599.8 13685.3 13780.1 13903.3 13989.4 375692.0 380062.0 380097.0 380481.0 381792.0 51705.2 52172.0 52205.2 52252.0 52266.7 1295.4 1310.4 1317.7 1323.0 1328.0 26227.0 26686.5 26934.0 26974.2 26989.3 41395.4 42181.6 42520.1 42684.0 46019.0 192714.0 194621.0 195997.0 196128.0 196478.0 31473.2 31688.0 31736.0 31860.0 31897.2 30210.4 36083.5 41722.6 44150.8 45787.0 34359.9 35683.3 35778.5 36915.3 37100.0 36046.2 36753.4 37052.3 37263.0 37274.0 33841.8 33945.2 34121.5 34381.7 36116.0 31729.4 32879.7 33277.0 33306.7 33403.2 26781.0 27608.4 27810.6 27835.9 27884.4 14:47:17 INFO - PROCESS | 24501 | 14:47:17 INFO - PROCESS | 24501 | [#2] jquery.html Cycles:180 Average:25497.08 Median:26502.42 stddev:82454.08 (311.1%) stddev-sans-first:82663.78 14:47:17 INFO - PROCESS | 24501 | Values: 361.8 365.8 366.3 368.0 374.3 13094.1 13196.2 15392.5 16497.6 17511.0 9665.6 12665.1 13107.4 13129.5 13169.9 4605.1 4798.7 4799.2 4801.2 4802.1 3707.9 3818.3 4694.6 4736.5 5105.0 5217.3 5258.9 5269.8 5273.3 5276.2 5037.9 5192.4 5215.9 5218.6 5220.7 4888.8 5009.7 5034.3 5035.3 5223.6 12271.8 12273.9 15891.4 18299.8 19562.2 2162.5 2163.5 2167.9 2183.7 2219.9 8648.7 8861.7 9071.1 9215.4 12361.9 1771.6 1816.8 1841.3 1843.9 1866.3 48202.8 53667.2 54883.5 54918.7 55388.4 9220.9 9751.5 9772.4 9825.0 9883.2 12584.1 12617.4 12664.4 12664.6 12701.4 6840.8 6879.4 6884.5 6886.6 6918.3 6288.8 6319.6 6346.9 6354.0 6365.3 4259.5 4275.1 4408.3 4459.6 4516.3 1712.6 1771.4 1800.9 1815.9 1873.2 420.7 894.3 926.3 967.7 1008.4 8958.8 9458.3 9911.4 10041.5 10131.7 420.8 439.6 447.3 450.1 458.3 5496.5 5750.5 9209.6 9681.7 9893.1 493256.0 494127.0 494302.2 514228.0 524649.0 68577.0 72465.0 72811.3 72876.6 73891.0 1116.9 1124.9 1131.1 1150.4 1152.5 14043.0 14489.2 14551.6 14815.6 15067.2 29401.3 29936.9 30265.0 30353.1 30656.7 35674.6 35705.3 36088.0 36754.3 38276.8 7014.4 7083.2 7137.9 7216.9 7308.6 8021.6 10076.6 10577.6 11267.3 11332.5 9080.5 9257.2 9699.2 10016.9 10126.4 9464.2 9739.8 9748.1 9888.9 9938.3 9514.1 9730.7 9942.0 9945.4 10037.8 7141.7 7143.3 7247.4 7280.9 7326.4 8182.9 9654.1 9822.8 9864.3 10015.6 14:47:17 INFO - PROCESS | 24501 | 14:47:17 INFO - PROCESS | 24501 | [#3] mootools.html Cycles:180 Average:5644.07 Median:5849.58 stddev:2941.67 (50.3%) stddev-sans-first:2931.67 14:47:17 INFO - PROCESS | 24501 | Values: 1285.1 1457.7 1466.1 1611.1 1766.0 7124.7 7652.4 7848.8 7859.8 7871.3 7650.1 7766.3 7827.0 7835.4 7844.3 2027.7 2082.7 2083.2 2314.4 2341.6 2153.3 2276.9 2338.3 2348.5 2350.2 2289.2 2336.0 2342.7 2353.1 2353.2 2286.5 2339.8 2340.7 2345.9 2346.9 2311.4 2315.2 2321.8 2324.3 2337.6 8003.5 8031.5 8063.4 8079.2 8093.7 4739.1 4873.0 4875.7 4880.8 4888.0 3166.1 3229.6 3295.1 3314.5 3334.7 1077.2 1082.9 1106.6 1126.8 1141.9 11218.3 11225.2 11242.0 11246.5 11249.4 4450.4 4461.8 4567.1 4575.8 4582.9 9624.4 9634.3 9637.5 9642.5 9648.7 4877.4 4885.0 4909.7 4912.9 4913.9 4349.2 4451.4 4458.9 4472.2 4474.2 3578.2 3645.2 3871.4 3891.6 3941.2 1187.3 1270.9 1276.3 1280.6 1281.7 1304.8 1305.9 1317.5 1330.6 1348.6 7281.5 7309.5 7316.3 7318.8 7323.9 1086.9 1100.1 1107.6 1125.9 1150.3 5743.8 5825.2 5843.6 5855.5 5859.2 9432.6 9919.7 10036.6 10046.4 10052.5 9783.4 9790.9 9795.5 9867.5 9907.0 7269.8 7497.9 7541.8 7542.9 7581.0 7304.4 7333.1 7395.6 7398.8 7429.8 8473.8 8547.4 8668.7 8699.0 8864.2 9018.5 9306.1 9316.4 9317.4 9359.7 7139.7 7263.7 7270.5 7271.6 7275.9 7620.0 7627.9 7709.1 7720.2 7740.0 7229.4 7267.0 7342.5 7479.3 7480.0 6932.1 7106.3 7148.7 7297.8 7330.9 6886.4 6908.4 6950.3 6950.9 6957.7 6491.7 6558.6 6572.1 6625.3 6643.2 6618.0 6667.9 6674.8 6675.6 6679.6 14:47:17 INFO - PROCESS | 24501 | 14:47:17 INFO - PROCESS | 24501 | [#4] prototype.html Cycles:180 Average:5216.56 Median:5894.81 stddev:1588.85 (27.0%) stddev-sans-first:1550.46 14:47:17 INFO - PROCESS | 24501 | Values: 333.8 334.9 337.7 344.0 345.3 5771.4 5846.5 5868.1 5896.9 5938.8 5698.8 5809.3 5838.5 5841.2 5854.3 4527.8 4529.9 4529.9 4535.1 4539.6 4332.0 4411.7 4440.2 4504.6 4528.0 4464.2 4481.5 4481.8 4495.3 4505.6 4481.9 4487.4 4490.0 4500.8 4501.9 3963.3 3966.3 3971.6 3972.1 3981.5 5459.6 5557.1 5566.4 5618.7 5638.3 5171.7 5174.8 5178.1 5179.3 5180.2 5847.2 6237.6 6260.5 6267.2 6268.0 4143.9 4202.9 4326.6 4337.0 4339.9 6404.6 6498.3 6503.0 6508.5 6508.9 4381.9 4382.8 4383.5 4384.2 4390.6 4264.0 4397.8 4441.5 4444.1 4445.3 5086.0 5086.2 5090.3 5091.4 5092.6 6231.3 6252.3 6274.8 6280.2 6281.7 1544.9 1564.6 1565.6 1566.0 1566.7 1034.9 1038.2 1039.8 1054.8 1065.5 5892.8 5901.1 5947.2 5954.2 5959.8 6416.4 6464.4 6501.3 6506.5 6513.6 5827.2 5940.4 5947.0 5947.9 5949.2 3358.0 3466.9 3474.9 3483.5 3496.4 6813.3 6817.7 6865.2 6877.3 6897.1 6656.0 6686.9 6688.2 6688.5 6691.2 6595.5 6760.0 6761.5 6764.2 6765.9 6165.7 6272.9 6450.8 6525.3 6527.0 6208.5 6223.8 6308.8 6431.8 6452.3 6769.2 6821.7 6825.9 6832.1 6834.6 4266.0 4325.9 4350.4 4386.2 4391.8 6394.5 6446.7 6457.7 6465.5 6468.8 6293.6 6301.1 6303.2 6305.3 6313.5 6188.8 6226.2 6287.8 6290.5 6296.6 6073.0 6107.1 6108.8 6113.0 6116.3 6278.3 6290.0 6290.8 6293.8 6302.7 6037.5 6080.3 6132.4 6139.3 6145.0 14:47:17 INFO - PROCESS | 24501 | 14:47:17 INFO - PROCESS | 24501 | [#5] yui.html Cycles:180 Average:13244.42 Median:44222.84 stddev:15097.55 (34.1%) stddev-sans-first:15110.71 14:47:17 INFO - PROCESS | 24501 | Values: 744.3 788.5 811.1 825.8 856.1 13272.1 13467.7 13477.3 13482.4 13516.3 13693.7 13909.7 13914.3 13973.9 13985.5 669.8 675.2 801.4 802.7 816.4 799.1 805.2 805.3 805.5 805.6 847.7 852.0 852.9 853.2 853.8 702.4 707.9 836.5 849.1 850.9 620.0 623.8 624.8 624.8 627.1 12637.4 12677.5 12712.4 12743.1 12757.4 11550.6 12265.4 12383.8 12611.9 12618.3 10272.2 10288.5 10418.9 10719.9 10839.9 3618.8 3670.9 3698.3 3770.2 3772.9 43574.3 43737.3 43771.0 43816.8 43986.0 9084.1 9328.2 9457.3 9677.6 9700.1 16774.4 17479.1 17491.7 17505.4 17511.8 7130.7 7234.9 7286.1 7296.9 7341.9 4072.3 4124.8 4131.7 4155.5 4159.6 3025.3 3047.2 3052.6 3063.0 3064.0 564.3 574.6 581.5 583.5 585.7 508.0 512.3 538.6 540.9 583.0 8276.8 8281.6 8536.0 8559.3 8619.7 569.5 654.0 660.3 661.7 666.7 3779.9 4065.3 4087.2 4199.0 4329.9 54284.7 55143.0 55358.4 55393.7 55511.7 48008.0 49106.5 49456.8 49469.3 50120.0 44164.3 44281.3 44322.8 44384.8 44713.6 7950.2 8219.3 8240.4 8290.3 8384.8 33019.5 33029.0 33517.5 34025.5 34042.3 39567.0 40443.4 42934.1 43595.3 43701.3 10739.7 10836.6 10892.3 11012.8 11130.5 12036.6 12189.8 12214.7 12678.4 12743.7 10703.5 10946.7 11092.2 11257.5 11497.3 11196.1 11561.7 11571.4 11635.7 11876.7 10152.7 10174.7 10248.7 10254.3 10402.6 8453.2 8820.7 8860.6 8932.9 9069.2 8133.6 8614.2 8810.5 8933.9 9180.6 14:47:17 INFO - PROCESS | 24501 | -------- Summary: end -------- 14:47:17 INFO - PROCESS | 24501 | 14:47:18 INFO - TEST-INFO | 24501: exit 0 14:47:18 INFO - TEST-OK | dromaeo_css | took 1113032ms 14:47:18 INFO - TEST-START | kraken 14:47:18 INFO - operating with platform_type : linux_ 14:47:18 INFO - Initialising browser for kraken test... 14:47:18 INFO - TEST-INFO | started process 24699 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOmWaG2/profile http://localhost:51626/getInfo.html) 14:47:22 INFO - PROCESS | 24699 | __metrics Screen width/height:1600/1200 14:47:22 INFO - PROCESS | 24699 | colorDepth:24 14:47:22 INFO - PROCESS | 24699 | Browser inner width/height: 1024/697 14:47:22 INFO - PROCESS | 24699 | __metrics 14:47:22 INFO - PROCESS | 24699 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:47:22 INFO - PROCESS | 24699 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:47:23 INFO - TEST-INFO | 24699: exit 0 14:47:23 INFO - Browser initialized. 14:47:23 INFO - Running cycle 1/1 for kraken test... 14:47:23 INFO - TEST-INFO | started process 24779 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOmWaG2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:47:34 INFO - PROCESS | 24779 | RSS: Main: 146952192 14:47:34 INFO - PROCESS | 24779 | 14:47:37 INFO - PROCESS | 24779 | Cycle 1(1): loaded http://localhost:51626/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51626/tests/kraken/driver.html?testName=audio-beat-detection) 14:47:37 INFO - PROCESS | 24779 | RSS: Main: 187072512 14:47:37 INFO - PROCESS | 24779 | 14:47:40 INFO - PROCESS | 24779 | Cycle 1(1): loaded http://localhost:51626/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51626/tests/kraken/driver.html?testName=audio-dft) 14:47:41 INFO - PROCESS | 24779 | RSS: Main: 177831936 14:47:41 INFO - PROCESS | 24779 | 14:47:43 INFO - PROCESS | 24779 | Cycle 1(1): loaded http://localhost:51626/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51626/tests/kraken/driver.html?testName=audio-fft) 14:47:44 INFO - PROCESS | 24779 | RSS: Main: 162340864 14:47:44 INFO - PROCESS | 24779 | 14:47:46 INFO - PROCESS | 24779 | Cycle 1(1): loaded http://localhost:51626/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51626/tests/kraken/driver.html?testName=audio-oscillator) 14:47:47 INFO - PROCESS | 24779 | RSS: Main: 164982784 14:47:47 INFO - PROCESS | 24779 | 14:47:49 INFO - PROCESS | 24779 | Cycle 1(1): loaded http://localhost:51626/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51626/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:47:50 INFO - PROCESS | 24779 | RSS: Main: 166105088 14:47:50 INFO - PROCESS | 24779 | 14:47:52 INFO - PROCESS | 24779 | Cycle 1(1): loaded http://localhost:51626/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51626/tests/kraken/driver.html?testName=imaging-darkroom) 14:47:53 INFO - PROCESS | 24779 | RSS: Main: 167346176 14:47:53 INFO - PROCESS | 24779 | 14:47:56 INFO - PROCESS | 24779 | Cycle 1(1): loaded http://localhost:51626/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51626/tests/kraken/driver.html?testName=imaging-desaturate) 14:47:57 INFO - PROCESS | 24779 | RSS: Main: 166727680 14:47:57 INFO - PROCESS | 24779 | 14:48:00 INFO - PROCESS | 24779 | Cycle 1(1): loaded http://localhost:51626/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51626/tests/kraken/driver.html?testName=json-parse-financial) 14:48:00 INFO - PROCESS | 24779 | RSS: Main: 168017920 14:48:00 INFO - PROCESS | 24779 | 14:48:02 INFO - PROCESS | 24779 | Cycle 1(1): loaded http://localhost:51626/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51626/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:48:03 INFO - PROCESS | 24779 | RSS: Main: 181149696 14:48:03 INFO - PROCESS | 24779 | 14:48:04 INFO - PROCESS | 24779 | Cycle 1(1): loaded http://localhost:51626/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51626/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:48:05 INFO - PROCESS | 24779 | RSS: Main: 176992256 14:48:05 INFO - PROCESS | 24779 | 14:48:07 INFO - PROCESS | 24779 | Cycle 1(1): loaded http://localhost:51626/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51626/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:48:08 INFO - PROCESS | 24779 | RSS: Main: 188039168 14:48:08 INFO - PROCESS | 24779 | 14:48:10 INFO - PROCESS | 24779 | Cycle 1(1): loaded http://localhost:51626/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51626/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:48:11 INFO - PROCESS | 24779 | RSS: Main: 195940352 14:48:11 INFO - PROCESS | 24779 | 14:48:13 INFO - PROCESS | 24779 | Cycle 1(1): loaded http://localhost:51626/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51626/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:48:14 INFO - PROCESS | 24779 | RSS: Main: 195403776 14:48:14 INFO - PROCESS | 24779 | 14:48:15 INFO - PROCESS | 24779 | Cycle 1(1): loaded http://localhost:51626/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51626/tests/kraken/driver.html?testName=ai-astar) 14:48:16 INFO - PROCESS | 24779 | RSS: Main: 255037440 14:48:16 INFO - PROCESS | 24779 | 14:48:16 INFO - PROCESS | 24779 | __start_tp_report 14:48:16 INFO - PROCESS | 24779 | _x_x_mozilla_page_load 14:48:16 INFO - PROCESS | 24779 | _x_x_mozilla_page_load_details 14:48:16 INFO - PROCESS | 24779 | |i|pagename|runs| 14:48:16 INFO - PROCESS | 24779 | |0;ai-astar;110;109;105;110;110;110;110;110;103;109 14:48:16 INFO - PROCESS | 24779 | |1;audio-beat-detection;154;127;156;162;129;160;149;127;171;130 14:48:16 INFO - PROCESS | 24779 | |2;audio-dft;164;172;163;164;162;164;162;163;164;163 14:48:16 INFO - PROCESS | 24779 | |3;audio-fft;74;74;101;101;73;73;76;109;94;74 14:48:16 INFO - PROCESS | 24779 | |4;audio-oscillator;96;96;155;96;96;96;146;97;97;142 14:48:16 INFO - PROCESS | 24779 | |5;imaging-gaussian-blur;118;115;114;114;114;115;114;115;114;114 14:48:16 INFO - PROCESS | 24779 | |6;imaging-darkroom;145;144;145;147;145;145;145;146;144;144 14:48:16 INFO - PROCESS | 24779 | |7;imaging-desaturate;96;96;96;96;96;97;97;96;96;96 14:48:16 INFO - PROCESS | 24779 | |8;json-parse-financial;57;55;56;56;56;55;56;56;62;64 14:48:16 INFO - PROCESS | 24779 | |9;json-stringify-tinderbox;67;68;67;68;68;68;68;68;68;68 14:48:16 INFO - PROCESS | 24779 | |10;stanford-crypto-aes;82;83;82;83;101;82;84;83;83;88 14:48:16 INFO - PROCESS | 24779 | |11;stanford-crypto-ccm;118;113;113;119;120;114;124;116;120;113 14:48:16 INFO - PROCESS | 24779 | |12;stanford-crypto-pbkdf2;146;135;144;142;147;136;134;136;144;143 14:48:16 INFO - PROCESS | 24779 | |13;stanford-crypto-sha256-iterative;66;67;69;68;68;67;68;68;67;72 14:48:16 INFO - PROCESS | 24779 | __end_tp_report 14:48:16 INFO - PROCESS | 24779 | __start_cc_report 14:48:16 INFO - PROCESS | 24779 | _x_x_mozilla_cycle_collect,962 14:48:16 INFO - PROCESS | 24779 | __end_cc_report 14:48:16 INFO - PROCESS | 24779 | __startTimestamp1454539696108__endTimestamp 14:48:16 INFO - PROCESS | 24779 | 14:48:16 INFO - PROCESS | 24779 | ------- Summary: start ------- 14:48:16 INFO - PROCESS | 24779 | Number of tests: 14 14:48:16 INFO - PROCESS | 24779 | 14:48:16 INFO - PROCESS | 24779 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:2.50 (2.3%) stddev-sans-first:2.60 14:48:16 INFO - PROCESS | 24779 | Values: 110.0 109.0 105.0 110.0 110.0 110.0 110.0 110.0 103.0 109.0 14:48:16 INFO - PROCESS | 24779 | 14:48:16 INFO - PROCESS | 24779 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:155.00 stddev:16.71 (10.8%) stddev-sans-first:17.51 14:48:16 INFO - PROCESS | 24779 | Values: 154.0 127.0 156.0 162.0 129.0 160.0 149.0 127.0 171.0 130.0 14:48:16 INFO - PROCESS | 24779 | 14:48:16 INFO - PROCESS | 24779 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:2.88 (1.8%) stddev-sans-first:3.06 14:48:16 INFO - PROCESS | 24779 | Values: 164.0 172.0 163.0 164.0 162.0 164.0 162.0 163.0 164.0 163.0 14:48:16 INFO - PROCESS | 24779 | 14:48:16 INFO - PROCESS | 24779 | [#3] audio-fft Cycles:10 Average:84.90 Median:74.00 stddev:14.53 (19.6%) stddev-sans-first:14.87 14:48:16 INFO - PROCESS | 24779 | Values: 74.0 74.0 101.0 101.0 73.0 73.0 76.0 109.0 94.0 74.0 14:48:16 INFO - PROCESS | 24779 | 14:48:16 INFO - PROCESS | 24779 | [#4] audio-oscillator Cycles:10 Average:111.70 Median:96.00 stddev:25.02 (26.1%) stddev-sans-first:25.88 14:48:16 INFO - PROCESS | 24779 | Values: 96.0 96.0 155.0 96.0 96.0 96.0 146.0 97.0 97.0 142.0 14:48:16 INFO - PROCESS | 24779 | 14:48:16 INFO - PROCESS | 24779 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.50 stddev:1.25 (1.1%) stddev-sans-first:0.50 14:48:16 INFO - PROCESS | 24779 | Values: 118.0 115.0 114.0 114.0 114.0 115.0 114.0 115.0 114.0 114.0 14:48:16 INFO - PROCESS | 24779 | 14:48:16 INFO - PROCESS | 24779 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.94 (0.7%) stddev-sans-first:1.00 14:48:16 INFO - PROCESS | 24779 | Values: 145.0 144.0 145.0 147.0 145.0 145.0 145.0 146.0 144.0 144.0 14:48:16 INFO - PROCESS | 24779 | 14:48:16 INFO - PROCESS | 24779 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:48:16 INFO - PROCESS | 24779 | Values: 96.0 96.0 96.0 96.0 96.0 97.0 97.0 96.0 96.0 96.0 14:48:16 INFO - PROCESS | 24779 | 14:48:16 INFO - PROCESS | 24779 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:56.00 stddev:3.09 (5.5%) stddev-sans-first:3.28 14:48:16 INFO - PROCESS | 24779 | Values: 57.0 55.0 56.0 56.0 56.0 55.0 56.0 56.0 62.0 64.0 14:48:16 INFO - PROCESS | 24779 | 14:48:16 INFO - PROCESS | 24779 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 14:48:16 INFO - PROCESS | 24779 | Values: 67.0 68.0 67.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 14:48:16 INFO - PROCESS | 24779 | 14:48:16 INFO - PROCESS | 24779 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:83.00 stddev:5.86 (7.1%) stddev-sans-first:6.11 14:48:16 INFO - PROCESS | 24779 | Values: 82.0 83.0 82.0 83.0 101.0 82.0 84.0 83.0 83.0 88.0 14:48:16 INFO - PROCESS | 24779 | 14:48:16 INFO - PROCESS | 24779 | [#11] stanford-crypto-ccm Cycles:10 Average:117.00 Median:118.50 stddev:3.80 (3.2%) stddev-sans-first:4.01 14:48:16 INFO - PROCESS | 24779 | Values: 118.0 113.0 113.0 119.0 120.0 114.0 124.0 116.0 120.0 113.0 14:48:16 INFO - PROCESS | 24779 | 14:48:16 INFO - PROCESS | 24779 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.70 Median:143.50 stddev:4.92 (3.4%) stddev-sans-first:4.83 14:48:16 INFO - PROCESS | 24779 | Values: 146.0 135.0 144.0 142.0 147.0 136.0 134.0 136.0 144.0 143.0 14:48:16 INFO - PROCESS | 24779 | 14:48:16 INFO - PROCESS | 24779 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.63 (2.4%) stddev-sans-first:1.56 14:48:16 INFO - PROCESS | 24779 | Values: 66.0 67.0 69.0 68.0 68.0 67.0 68.0 68.0 67.0 72.0 14:48:16 INFO - PROCESS | 24779 | -------- Summary: end -------- 14:48:16 INFO - PROCESS | 24779 | 14:48:16 INFO - TEST-INFO | 24779: exit 0 14:48:17 INFO - TEST-OK | kraken | took 58925ms 14:48:17 INFO - TEST-START | v8_7 14:48:17 INFO - operating with platform_type : linux_ 14:48:17 INFO - Initialising browser for v8_7 test... 14:48:17 INFO - TEST-INFO | started process 25028 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcM2A6v/profile http://localhost:51626/getInfo.html) 14:48:20 INFO - PROCESS | 25028 | __metrics Screen width/height:1600/1200 14:48:20 INFO - PROCESS | 25028 | colorDepth:24 14:48:20 INFO - PROCESS | 25028 | Browser inner width/height: 1024/697 14:48:20 INFO - PROCESS | 25028 | __metrics 14:48:21 INFO - PROCESS | 25028 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:48:21 INFO - PROCESS | 25028 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:48:21 INFO - TEST-INFO | 25028: exit 0 14:48:21 INFO - Browser initialized. 14:48:21 INFO - Running cycle 1/1 for v8_7 test... 14:48:21 INFO - TEST-INFO | started process 25109 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcM2A6v/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:48:33 INFO - PROCESS | 25109 | RSS: Main: 149118976 14:48:33 INFO - PROCESS | 25109 | 14:48:56 INFO - PROCESS | 25109 | Cycle 1(1): loaded http://localhost:51626/tests/v8_7/run.html (next: http://localhost:51626/tests/v8_7/run.html) 14:48:56 INFO - PROCESS | 25109 | RSS: Main: 534458368 14:48:56 INFO - PROCESS | 25109 | 14:48:56 INFO - PROCESS | 25109 | __start_tp_report 14:48:56 INFO - PROCESS | 25109 | _x_x_mozilla_page_load 14:48:56 INFO - PROCESS | 25109 | _x_x_mozilla_page_load_details 14:48:56 INFO - PROCESS | 25109 | |i|pagename|runs| 14:48:56 INFO - PROCESS | 25109 | |0;Richards;166.47244880972198 14:48:56 INFO - PROCESS | 25109 | |1;DeltaBlue;190.47619047619048 14:48:56 INFO - PROCESS | 25109 | |2;Encrypt;274.95188342040143 14:48:56 INFO - PROCESS | 25109 | |3;Decrypt;5196.891191709845 14:48:56 INFO - PROCESS | 25109 | |4;RayTrace;1115.9420289855072 14:48:56 INFO - PROCESS | 25109 | |5;Earley;768.0491551459294 14:48:56 INFO - PROCESS | 25109 | |6;Boyer;12365.853658536585 14:48:56 INFO - PROCESS | 25109 | |7;RegExp;42102.04081632653 14:48:56 INFO - PROCESS | 25109 | |8;Splay;565.2911249293386 14:48:56 INFO - PROCESS | 25109 | |9;NavierStokes;4822.115384615385 14:48:56 INFO - PROCESS | 25109 | __end_tp_report 14:48:56 INFO - PROCESS | 25109 | __startTimestamp1454539736364__endTimestamp 14:48:56 INFO - PROCESS | 25109 | 14:48:56 INFO - PROCESS | 25109 | ------- Summary: start ------- 14:48:56 INFO - PROCESS | 25109 | Number of tests: 10 14:48:56 INFO - PROCESS | 25109 | 14:48:56 INFO - PROCESS | 25109 | [#0] Richards Cycles:1 Average:166.47 Median:166.47 stddev:0.00 (0.0%) 14:48:56 INFO - PROCESS | 25109 | Values: 166.5 14:48:56 INFO - PROCESS | 25109 | 14:48:56 INFO - PROCESS | 25109 | [#1] DeltaBlue Cycles:1 Average:190.48 Median:190.48 stddev:0.00 (0.0%) 14:48:56 INFO - PROCESS | 25109 | Values: 190.5 14:48:56 INFO - PROCESS | 25109 | 14:48:56 INFO - PROCESS | 25109 | [#2] Encrypt Cycles:1 Average:274.95 Median:274.95 stddev:0.00 (0.0%) 14:48:56 INFO - PROCESS | 25109 | Values: 275.0 14:48:56 INFO - PROCESS | 25109 | 14:48:56 INFO - PROCESS | 25109 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 14:48:56 INFO - PROCESS | 25109 | Values: 5196.9 14:48:56 INFO - PROCESS | 25109 | 14:48:56 INFO - PROCESS | 25109 | [#4] RayTrace Cycles:1 Average:1115.94 Median:1115.94 stddev:0.00 (0.0%) 14:48:56 INFO - PROCESS | 25109 | Values: 1115.9 14:48:56 INFO - PROCESS | 25109 | 14:48:56 INFO - PROCESS | 25109 | [#5] Earley Cycles:1 Average:768.05 Median:768.05 stddev:0.00 (0.0%) 14:48:56 INFO - PROCESS | 25109 | Values: 768.0 14:48:56 INFO - PROCESS | 25109 | 14:48:56 INFO - PROCESS | 25109 | [#6] Boyer Cycles:1 Average:12365.85 Median:12365.85 stddev:0.00 (0.0%) 14:48:56 INFO - PROCESS | 25109 | Values: 12365.9 14:48:56 INFO - PROCESS | 25109 | 14:48:56 INFO - PROCESS | 25109 | [#7] RegExp Cycles:1 Average:42102.04 Median:42102.04 stddev:0.00 (0.0%) 14:48:56 INFO - PROCESS | 25109 | Values: 42102.0 14:48:56 INFO - PROCESS | 25109 | 14:48:56 INFO - PROCESS | 25109 | [#8] Splay Cycles:1 Average:565.29 Median:565.29 stddev:0.00 (0.0%) 14:48:56 INFO - PROCESS | 25109 | Values: 565.3 14:48:56 INFO - PROCESS | 25109 | 14:48:56 INFO - PROCESS | 25109 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 14:48:56 INFO - PROCESS | 25109 | Values: 4822.1 14:48:56 INFO - PROCESS | 25109 | -------- Summary: end -------- 14:48:56 INFO - PROCESS | 25109 | 14:48:57 INFO - TEST-INFO | 25109: exit 0 14:48:57 INFO - TEST-OK | v8_7 | took 40179ms 14:48:57 INFO - SUITE-END | took 1212s 14:48:57 INFO - Completed test suite (00:20:12) 14:48:57 INFO - Working with test: dromaeo_css 14:48:57 INFO - Generating results file: dromaeo_css 14:48:57 INFO - Working with test: kraken 14:48:57 INFO - Generating results file: kraken 14:48:57 INFO - javascript benchmark 14:48:57 INFO - Working with test: v8_7 14:48:57 INFO - Generating results file: v8_7 14:48:57 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:48:57 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 14:48:57 INFO - process_Request line: dromaeo_css 6707.80 graph.html#tests=[[72,201,35]] 14:48:57 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:48:57 INFO - process_Request line: kraken 1507.60 graph.html#tests=[[232,201,35]] 14:48:57 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:48:57 INFO - process_Request line: v8_7 20229.95 graph.html#tests=[[230,201,35]] 14:48:57 INFO - RETURN: dromaeo_css: 6707.80 14:48:57 INFO - RETURN: kraken: 1507.60 14:48:57 INFO - RETURN: v8_7: 20229.95 14:48:57 INFO - javascript benchmark 14:48:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3135.4983202687567, 3152.8423578821053, 3194.16951592586, 3208.5828842250503, 3225.3549290141964, 5143.125668636331, 5161.071007218699, 5180.766865491052, 5211.661242019276, 5228.843134705955, 5189.766460509277, 5261.237120617518, 5298.09932311507, 5324.015057214408, 5343.839684809453, 4711.0, 4735.6921800083055, 4762.595179409755, 4772.498887616803, 4803.0, 4814.229723244282, 4879.0, 4907.779149938261, 4930.112579735646, 4955.900881982358, 4699.318598803188, 4780.952190478086, 4843.0313937212695, 4863.27050942358, 4904.117258893398, 4742.715437073786, 4746.311784791221, 4753.287006948951, 4753.548412900769, 4758.809647614091, 4739.0758802033615, 4739.9526004739855, 4743.739094349844, 4776.11641846256, 4789.042191561667, 5060.974695126501, 5061.645684802065, 5074.949250507485, 5081.034603425337, 5082.23766435034, 5514.862128446781, 5587.580931430159, 5596.524295434893, 5608.635438696471, 5663.7168141593165, 5689.402612725687, 5709.0865461525955, 5730.7707691692285, 5731.770729170828, 5759.395263497315, 5323.121684921984, 5328.893422131536, 5332.653377530448, 5334.413214546396, 5336.119540275849, 5666.376698563155, 5744.770209191669, 5763.711814409263, 5782.479576838105, 5801.448862358069, 5475.342958844884, 5525.060739674265, 5525.889482210333, 5530.889382212334, 5579.972100139555, 5577.553795696334, 5590.888182236333, 5606.775728970877, 5618.550515958714, 5623.465770751772, 5446.591505637093, 5537.058700021006, 5569.359523654832, 5580.218769372291, 5606.383297837235, 5619.915701264485, 5640.407757185519, 5641.746121424546, 5645.633033852787, 5670.376258611549, 4384.912301753947, 4391.14372697321, 4391.890202744957, 4428.844990425384, 4431.911361772811, 3863.265979463893, 3898.0, 3934.744241624285, 3962.5641179470235, 3976.8409263629133, 5248.8425347239645, 5255.0, 5272.7100009499845, 5275.63070585063, 5320.973395133, 5629.7185140742795, 5636.126400407943, 5641.915371269434, 5642.689652069175, 5646.85882852932, 5180.9740951295, 5232.529072383504, 5247.10799164143, 5286.15421532553, 5340.732963351817, 4748.477667456577, 4758.666893317434, 4762.047590481918, 4762.190427627243, 4806.735629540409, 5757.712114394263, 5765.077587586134, 5796.652200867877, 5808.88382232353, 5822.243108395882, 5542.057850165401, 5544.445555444423, 5629.521490673339, 5691.943080569141, 5716.085426331767, 5885.529157667462, 5887.499562537232, 5890.734916928663, 5896.764129434775, 5903.970480147744, 5375.0, 5547.362053363915, 5550.389457159628, 5552.111662134201, 5561.555075594024, 5595.804146855004, 5613.214150018919, 5633.549316054624, 5660.4905558498285, 5679.977604031314, 5500.147477141049, 5502.422245664147, 5503.559715222853, 5511.862203444946, 5513.145462453326, 5367.597430192673, 5481.835544933659, 5503.614746967673, 5503.944960550503, 5557.416471270459, 5317.1226747586215, 5406.810761623325, 5462.289902312674, 5467.507924286833, 5504.4770746778995, 5486.1770734388565, 5545.750441230073, 5547.084731019498, 5547.611667183259, 5548.223248745098, 5330.280412144466, 5363.061464243664, 5397.406285308534, 5412.107002344569, 5420.566354691694], "unit": "score", "name": "dojo.html", "value": 5191.392274781347}, {"lowerIsBetter": false, "replicates": [511.5805039867309, 524.095934512965, 524.3995625009364, 539.1669870050771, 549.1625271461024, 27786.0, 28919.56620650692, 29027.129186124424, 34905.476417853686, 35678.821605892, 38401.61598384015, 38690.226195476076, 38790.8060459698, 38804.80597597015, 38806.22387552254, 8281.83436331273, 8413.326933845277, 8420.368472364567, 8462.280706139985, 8485.0666426693, 7306.305900939429, 8550.444221125637, 8552.35857310701, 8559.27246184072, 8560.101189375087, 8554.18735220153, 8628.65485380584, 8636.784080397978, 8637.870431943526, 8643.049264580892, 8457.365697572675, 8519.659213631447, 8541.530215838158, 8545.01732300787, 8545.572721363907, 8472.703455379033, 8596.441231319945, 8601.870971935426, 8602.913970860274, 8641.783955401103, 38546.0, 38973.80513097445, 39022.414663780066, 39032.0, 39045.41431878524, 3305.272839975202, 3351.765376423651, 3393.490976353542, 3595.388783906742, 4088.1414902870433, 27366.5895011573, 29259.0, 30135.0, 30639.38721225563, 30796.538051929238, 3937.1338305572726, 4011.5587285398583, 4012.1775036117524, 4063.674906007512, 4167.354060120686, 261710.0, 263186.0, 263365.0, 263415.0, 263550.0, 50731.23903141456, 52213.0, 56996.430035699945, 58397.416025840044, 59496.0, 54309.72845135828, 54386.72806636021, 54388.0, 54403.0, 54746.72626636921, 12465.439055242536, 12618.053645976588, 12648.873511264954, 12660.430280637393, 12665.810012849815, 9180.081991800767, 9290.256779457628, 9329.393589416666, 9438.480883551334, 9450.338476306593, 19335.226590936207, 19392.0, 19479.707804382946, 19530.70703939442, 19542.902285488482, 7312.122545294599, 7629.855521671793, 7639.3575381293285, 7675.539467631848, 7709.768706938801, 941.3410612571228, 980.5293459139652, 990.841465365538, 1058.3385384134915, 1066.7759770448292, 26657.083532981706, 28483.0, 28791.856040719664, 28792.42415151685, 28929.710702893124, 1007.315025782475, 1016.5832008876325, 1027.3733022856052, 1032.385730490357, 1038.693585392311, 13599.796003059962, 13685.315734213249, 13780.10429322091, 13903.30483475822, 13989.3704783285, 375692.0, 380062.0, 380097.0, 380481.0, 381792.0, 51705.224421633706, 52171.95656086857, 52205.17281895191, 52251.95496090057, 52266.738666306424, 1295.352323838081, 1310.351376068833, 1317.736452709462, 1323.0209644862732, 1328.0, 26227.0, 26686.466270674868, 26934.0, 26974.1907742768, 26989.325266868484, 41395.379069314586, 42181.57818421899, 42520.14959700851, 42684.0, 46019.0, 192714.0, 194621.0, 195997.0, 196128.0, 196478.0, 31473.21316967094, 31688.0, 31736.0, 31860.0, 31897.202569935936, 30210.395792084473, 36083.45874811932, 41722.58277417187, 44150.779246103564, 45787.0, 34359.85087009102, 35683.28633427369, 35778.463323049655, 36915.261694766494, 37100.0, 36046.20517844144, 36753.448698269014, 37052.25895482129, 37263.0, 37274.0, 33841.83079084589, 33945.15137121493, 34121.48817767686, 34381.656183437844, 36116.0, 31729.365412692077, 32879.67120328862, 33277.0, 33306.666933331326, 33403.1649208762, 26781.0, 27608.447831043668, 27810.582841256994, 27835.860820695765, 27884.442311154067], "unit": "score", "name": "ext.html", "value": 17671.202471285986}, {"lowerIsBetter": false, "replicates": [361.8389816531643, 365.75128912339596, 366.3479007366888, 368.04675889446327, 374.30753106752496, 13094.083414161012, 13196.208227506357, 15392.461263855766, 16497.58756031098, 17511.036892970897, 9665.613375464973, 12665.113442059059, 13107.37852429513, 13129.474821007172, 13169.934150329258, 4605.148047611195, 4798.712077275357, 4799.184138696412, 4801.207800712878, 4802.087603355369, 3707.925841483169, 3818.3127037133304, 4694.577488026077, 4736.478987311393, 5104.974475127619, 5217.295665085203, 5258.947410525903, 5269.841904742864, 5273.288106105684, 5276.234945932837, 5037.949620503785, 5192.350956130484, 5215.921761173586, 5218.634695571312, 5220.686758794465, 4888.755562221874, 5009.699418034929, 5034.270030845507, 5035.3454050973505, 5223.6343455958095, 12271.754564908651, 12273.877261227362, 15891.36434542617, 18299.817001830077, 19562.217511299532, 2162.4593851537115, 2163.5240247145603, 2167.880766557839, 2183.748868880083, 2219.911203551856, 8648.740537783877, 8861.734147975507, 9071.138241867013, 9215.44707317563, 12361.876381236163, 1771.60138968731, 1816.809235030316, 1841.318712076527, 1843.9354622588146, 1866.2534986005571, 48202.75898620485, 53667.19499207515, 54883.45116548823, 54918.725406372716, 55388.44611553873, 9220.907790922005, 9751.512424378752, 9772.413655180711, 9824.950875245579, 9883.209343252522, 12584.11911166228, 12617.36913154357, 12664.36678166088, 12664.620061398173, 12701.428435720414, 6840.828979275558, 6879.380855723009, 6884.51808373409, 6886.586804791728, 6918.273581273995, 6288.779892703734, 6319.557630965788, 6346.936530634727, 6353.968230158912, 6365.3316401778075, 4259.531451540328, 4275.144971005749, 4408.25059739845, 4459.5986361227, 4516.299973504112, 1712.5632963594453, 1771.3888708395582, 1800.8649351298704, 1815.872888897791, 1873.203147538382, 420.70971029989823, 894.2577660541734, 926.2636204217529, 967.7483854197959, 1008.3899240959261, 8958.776030599156, 9458.290628202913, 9911.355761875599, 10041.548130334153, 10131.696049118538, 420.76437195170803, 439.5780051150931, 447.2575524629165, 450.06835849791275, 458.3468557305826, 5496.4503549645515, 5750.453706897838, 9209.63161473547, 9681.70954871355, 9893.109620134079, 493256.0, 494127.0, 494302.22791088675, 514228.0, 524649.0, 68577.0, 72465.0, 72811.2718872815, 72876.63561682157, 73891.0, 1116.938568378747, 1124.9469717764948, 1131.1177281720272, 1150.384544268829, 1152.458344578047, 14043.0, 14489.20309382952, 14551.636209094857, 14815.555533334018, 15067.171305578298, 29401.264968375963, 29936.85031574828, 30265.0, 30353.089407317817, 30656.693433065382, 35674.643253567134, 35705.25094865002, 36088.0, 36754.26491470102, 38276.80861595674, 7014.403775679124, 7083.220845707071, 7137.928620713934, 7216.855662886818, 7308.634568271672, 8021.558814265271, 10076.596936122472, 10577.62978295756, 11267.26762760418, 11332.546698131982, 9080.455172689659, 9257.21313688344, 9699.175570076623, 10016.899831001596, 10126.39241645474, 9464.242860571276, 9739.75650608712, 9748.122668959828, 9888.851667224853, 9938.254630902857, 9514.096160864707, 9730.708078757649, 9941.950290248791, 9945.403275803475, 10037.849432258376, 7141.678624461808, 7143.321384468467, 7247.383972362408, 7280.9271907280245, 7326.351570896506, 8182.877256841033, 9654.131128198214, 9822.803543928938, 9864.309498335335, 10015.649452269136], "unit": "score", "name": "jquery.html", "value": 7442.422208313771}, {"lowerIsBetter": false, "replicates": [1285.1196930102885, 1457.7084583083383, 1466.1349803615865, 1611.1380411479854, 1765.9823401765987, 7124.715011399544, 7652.426068044898, 7848.7645370638975, 7859.764207073783, 7871.291583757461, 7650.120236172842, 7766.262205090507, 7826.960865195666, 7835.412344074189, 7844.254795794404, 2027.7161197432297, 2082.7188329575465, 2083.2396175395947, 2314.386687527802, 2341.6370462578243, 2153.321703663341, 2276.8975396107217, 2338.251759436981, 2348.53029394121, 2350.247920665388, 2289.164454973939, 2336.0, 2342.7071616047992, 2353.0587764894094, 2353.1528649686184, 2286.5084006938587, 2339.7777211165, 2340.742518322983, 2345.870977096259, 2346.894389752457, 2311.3528212100637, 2315.2128276385943, 2321.8374713770045, 2324.2794733632627, 2337.625979843217, 8003.4797738146835, 8031.477953932976, 8063.354931605516, 8079.192080791932, 8093.716719914833, 4739.0758802033615, 4872.975635121802, 4875.707457552523, 4880.829170979035, 4888.0, 3166.1293144385477, 3229.6447390786993, 3295.07737833407, 3314.453115235983, 3334.683205095512, 1077.2136340471422, 1082.8862969388178, 1106.623747925709, 1126.8253420719802, 1141.9200655954087, 11218.326900386002, 11225.214235003554, 11242.0, 11246.49390777417, 11249.381284029376, 4450.443694538183, 4461.776911154429, 4567.086582683477, 4575.794089265991, 4582.931256031162, 9624.37441566296, 9634.277429192838, 9637.518124093767, 9642.469664168399, 9648.662296819577, 4877.365942427462, 4884.975575122102, 4909.70541767488, 4912.901741965141, 4913.87715307113, 4349.195398851222, 4451.443569553806, 4458.9331160032625, 4472.1502914446155, 4474.172278128557, 3578.248567800791, 3645.179834537208, 3871.4192871069004, 3891.5524714658177, 3941.172353805733, 1187.2579637726421, 1270.879266469684, 1276.2980360801523, 1280.5774094548963, 1281.6859869331886, 1304.8303720516271, 1305.895528357729, 1317.4730107956893, 1330.5941687785319, 1348.575198812371, 7281.490295679251, 7309.488335816548, 7316.268373162641, 7318.817029574197, 7323.853522929511, 1086.8858769829212, 1100.1254003067581, 1107.5735841700841, 1125.8705248896317, 1150.3098141115431, 5743.827685169368, 5825.242718446575, 5843.620164689281, 5855.531557475391, 5859.1797148399255, 9432.622695092257, 9919.702408927744, 10036.64871729486, 10046.447445390428, 10052.497375131214, 9783.412995220167, 9790.902090979142, 9795.510224488748, 9867.457289848984, 9907.0, 7269.818254543678, 7497.850042999109, 7541.773746787496, 7542.924570754332, 7581.01446811911, 7304.3791277739865, 7333.083364579427, 7395.630218489162, 7398.815029624302, 7429.777106686808, 8473.839171011352, 8547.358948078794, 8668.739937801876, 8699.0, 8864.20222180007, 9018.549072546477, 9306.06939306064, 9316.394434361744, 9317.44095354281, 9359.719208423758, 7139.679159355536, 7263.673134708845, 7270.454715896223, 7271.600061996641, 7275.854482910207, 7620.047494063242, 7627.923720762721, 7709.113451953097, 7720.227977202235, 7740.032495938008, 7229.4095299034125, 7266.96366518164, 7342.5227360221415, 7479.289467500579, 7480.027596412431, 6932.0988271524375, 7106.289371063059, 7148.678309475982, 7297.781066568012, 7330.890036649348, 6886.380225779704, 6908.378245957888, 6950.270221626859, 6950.930490695028, 6957.686904089227, 6491.707873145814, 6558.573692709959, 6572.145621069421, 6625.271220165681, 6643.202815662152, 6617.966910165418, 6667.899981500184, 6674.799756007327, 6675.599464032173, 6679.632620205741], "unit": "score", "name": "mootools.html", "value": 4640.053979876559}, {"lowerIsBetter": false, "replicates": [333.7563578587631, 334.85433836281237, 337.73319077928437, 344.0315511834188, 345.3179969560118, 5771.394003629622, 5846.503047240979, 5868.119782032697, 5896.852578685535, 5938.792142275021, 5698.829035128942, 5809.2738407699035, 5838.474537291643, 5841.182234487164, 5854.268216472941, 4527.818887244506, 4529.864104076866, 4529.909401811979, 4535.092981403716, 4539.59143677069, 4332.0469496710675, 4411.691181617288, 4440.245158323093, 4504.639628829702, 4527.954720452803, 4464.218761716703, 4481.46222453306, 4481.775911204443, 4495.303227999665, 4505.5719706627815, 4481.865544033684, 4487.394201782767, 4489.977550112261, 4500.797464114123, 4501.864944051684, 3963.286608410485, 3966.2662407454422, 3971.6425521703186, 3972.1261322509004, 3981.4824072870633, 5459.563234941195, 5557.083081291582, 5566.415526369713, 5618.719064046782, 5638.323401191883, 5171.741412929338, 5174.818881339135, 5178.14560597501, 5179.300794392747, 5180.197069454203, 5847.181394604759, 6237.6257424554215, 6260.499160067184, 6267.153934218868, 6267.9686601567155, 4143.937840932388, 4202.936955945664, 4326.63223625989, 4336.956630433687, 4339.869803905888, 6404.551681382305, 6498.285188629247, 6502.967485162591, 6508.511861610398, 6508.902366464459, 4381.868543943687, 4382.758948257876, 4383.539728328544, 4384.210842048462, 4390.5828946250695, 4263.957360426418, 4397.84607538741, 4441.533638967861, 4444.1333939881415, 4445.333200019958, 5085.982803439327, 5086.237064440364, 5090.287359769635, 5091.363579552556, 5092.6435149539175, 6231.283402408691, 6252.3122456529745, 6274.843128921813, 6280.183576135073, 6281.748730050746, 1544.8686861616889, 1564.5619226616566, 1565.5538171621033, 1566.0290619815787, 1566.6631674190103, 1034.8706411698538, 1038.159091136182, 1039.8284283093205, 1054.7626783973544, 1065.547142464465, 5892.7642894283745, 5901.085331773582, 5947.167396564484, 5954.196183515257, 5959.821205363846, 6416.390442907917, 6464.385883341075, 6501.349865013555, 6506.512011599054, 6513.609183449008, 5827.155062515912, 5940.405959404025, 5947.04847224442, 5947.940520594825, 5949.226600541989, 3357.9664203358143, 3466.913327166841, 3474.861005559749, 3483.494893240466, 3496.440569508917, 6813.318668133147, 6817.69320380584, 6865.176178858569, 6877.312268773083, 6897.068895699117, 6655.966720166368, 6686.899696504556, 6688.197416310074, 6688.498362622823, 6691.1636045494315, 6595.505337099737, 6759.966200168968, 6761.492888033417, 6764.154480689914, 6765.932340676629, 6165.691715414122, 6272.874542509216, 6450.774222902176, 6525.282218956006, 6527.02094685782, 6208.534359922934, 6223.813285601439, 6308.842278943063, 6431.839204019937, 6452.290248072614, 6769.153855768029, 6821.693023814039, 6825.931740682529, 6832.077669514751, 6834.589924604539, 4266.0, 4325.913481730285, 4350.434443522322, 4386.210482113251, 4391.780410979502, 6394.4884409246215, 6446.7098980546925, 6457.67711614408, 6465.547411681137, 6468.8059358219325, 6293.622382657055, 6301.149344838388, 6303.180586523723, 6305.337939516285, 6313.463355614824, 6188.81433556994, 6226.159468471698, 6287.779927702509, 6290.46531044848, 6296.559240853279, 6072.969635151796, 6107.053406721965, 6108.847278818065, 6113.0, 6116.3272040076445, 6278.277998030285, 6290.0, 6290.811275661737, 6293.842653933688, 6302.71637776292, 6037.455410226026, 6080.300765412034, 6132.386761323832, 6139.324674285915, 6144.969275153596], "unit": "score", "name": "prototype.html", "value": 4702.586337352918}, {"lowerIsBetter": false, "replicates": [744.2631794523422, 788.5465857132147, 811.05107024781, 825.8141918068435, 856.1096459681927, 13272.137311074786, 13467.730645387086, 13477.326133693325, 13482.393292301846, 13516.256605886672, 13693.657658558515, 13909.652258693537, 13914.30428478577, 13973.860261397384, 13985.510507132252, 669.8425869920565, 675.2470994840767, 801.3909428834085, 802.743122200896, 816.3713940265992, 799.1409235072321, 805.1706742055692, 805.3476683886071, 805.4563169860351, 805.605253425823, 847.656699036891, 852.0116664668985, 852.927501162402, 853.2320911179957, 853.7780177153953, 702.3959394920364, 707.9398251148658, 836.5315423362875, 849.0957130655831, 850.8638617821119, 620.011082323693, 623.834683808791, 624.7719582352454, 624.7750809708501, 627.0907184582373, 12637.43131559082, 12677.492900283978, 12712.364381780966, 12743.107982441234, 12757.362131893367, 11550.59572914944, 12265.448054837554, 12383.75232495354, 12611.873881261161, 12618.305993170372, 10272.178225741924, 10288.485575721184, 10418.9479052605, 10719.946400267949, 10839.891601084046, 3618.764780289273, 3670.926581468382, 3698.33429982603, 3770.1517158639363, 3772.8679496217774, 43574.34638480425, 43737.343939840925, 43771.0, 43816.78091609522, 43985.99999999968, 9084.137006984325, 9328.160465558132, 9457.33798634089, 9677.612895484242, 9700.078492543196, 16774.412895548598, 17479.126043697765, 17491.650166996842, 17505.387311444294, 17511.824881751276, 7130.679119439637, 7234.855302894018, 7286.089238845145, 7296.854062918712, 7341.853162936712, 4072.3280658690983, 4124.8143833527565, 4131.710780245354, 4155.522114956819, 4159.584041595816, 3025.319303156816, 3047.1924939890946, 3052.648945371266, 3062.9540556891666, 3063.9693603063683, 564.2805423085599, 574.6408494690818, 581.4766709960984, 583.5040215816522, 585.6632436349116, 508.0474111041797, 512.2623422271917, 538.5556915544613, 540.8972295263887, 583.0117950074583, 8276.751697449086, 8281.585920703941, 8535.957320213483, 8559.272461840688, 8619.6983105591, 569.5244470866872, 653.9803805885831, 660.2802944790202, 661.7452280871898, 666.7199776094052, 3779.9433008504893, 4065.308897487434, 4087.162131763041, 4198.958010419857, 4329.9134017319475, 54284.728576356865, 55143.0, 55358.44641553533, 55393.723031385394, 55511.72244138754, 48008.0, 49106.50893491019, 49456.75271623619, 49469.257961130614, 50120.0, 44164.337534937, 44281.33577996332, 44322.778386107864, 44384.77807610876, 44713.55286447159, 7950.204979502004, 8219.30135938428, 8240.381971352053, 8290.336773058261, 8384.790380240544, 33019.504707428925, 33029.0, 33517.497237541946, 34025.48961765526, 34042.31915361728, 39567.0, 40443.3933490992, 42934.14131717411, 43595.34606980961, 43701.344479832194, 10739.731506712395, 10836.620718274822, 10892.346459212473, 11012.779744404907, 11130.499127539118, 12036.63890083299, 12189.75620487603, 12214.694632634255, 12678.429470673658, 12743.681407964876, 10703.518341674799, 10946.726331841768, 11092.168087393638, 11257.549698011988, 11497.310161390344, 11196.104311654884, 11561.653150405502, 11571.421428928688, 11635.709107272385, 11876.703082423008, 10152.746181345525, 10174.694759157237, 10248.743781405525, 10254.333468324536, 10402.58389664405, 8453.196946290092, 8820.691275805317, 8860.64557417696, 8932.871876101826, 9069.229115525255, 8133.593320334078, 8614.18165274298, 8810.515421651871, 8933.910660893307, 9180.632774688938], "unit": "score", "name": "yui.html", "value": 6113.964149012369}], "name": "dromaeo_css", "value": 6707.8036362166495}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 109.0, 105.0, 110.0, 110.0, 110.0, 110.0, 110.0, 103.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [154.0, 127.0, 156.0, 162.0, 129.0, 160.0, 149.0, 127.0, 171.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 146.5}, {"lowerIsBetter": true, "replicates": [164.0, 172.0, 163.0, 164.0, 162.0, 164.0, 162.0, 163.0, 164.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.1}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 101.0, 101.0, 73.0, 73.0, 76.0, 109.0, 94.0, 74.0], "unit": "score", "name": "audio-fft", "value": 84.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 155.0, 96.0, 96.0, 96.0, 146.0, 97.0, 97.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 111.7}, {"lowerIsBetter": true, "replicates": [118.0, 115.0, 114.0, 114.0, 114.0, 115.0, 114.0, 115.0, 114.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 114.7}, {"lowerIsBetter": true, "replicates": [145.0, 144.0, 145.0, 147.0, 145.0, 145.0, 145.0, 146.0, 144.0, 144.0], "unit": "score", "name": "imaging-darkroom", "value": 145.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 56.0, 56.0, 56.0, 55.0, 56.0, 56.0, 62.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 82.0, 83.0, 101.0, 82.0, 84.0, 83.0, 83.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [118.0, 113.0, 113.0, 119.0, 120.0, 114.0, 124.0, 116.0, 120.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.0}, {"lowerIsBetter": true, "replicates": [146.0, 135.0, 144.0, 142.0, 147.0, 136.0, 134.0, 136.0, 144.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.7}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 69.0, 68.0, 68.0, 67.0, 68.0, 68.0, 67.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1507.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.47244880972198], "unit": "score", "name": "Richards", "value": 212.05911400000002}, {"lowerIsBetter": false, "replicates": [190.47619047619048], "unit": "score", "name": "DeltaBlue", "value": 347.1194999999999}, {"lowerIsBetter": false, "replicates": [274.95188342040143], "unit": "score", "name": "Encrypt", "value": 968.1002970000004}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1115.9420289855072], "unit": "score", "name": "RayTrace", "value": 663.1070259740256}, {"lowerIsBetter": false, "replicates": [768.0491551459294], "unit": "score", "name": "Earley", "value": 867.7348259999999}, {"lowerIsBetter": false, "replicates": [12365.853658536585], "unit": "score", "name": "Boyer", "value": 53.89542998027611}, {"lowerIsBetter": false, "replicates": [42102.04081632653], "unit": "score", "name": "RegExp", "value": 21.637549684924874}, {"lowerIsBetter": false, "replicates": [565.2911249293386], "unit": "score", "name": "Splay", "value": 144.15757899999994}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 20229.953616280152}]} 14:48:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20229.95"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1507.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6707.80"}}} 14:48:57 INFO - Return code: 0 14:48:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:48:57 INFO - # TBPL SUCCESS # 14:48:57 INFO - Running post-action listener: _resource_record_post_action 14:48:57 INFO - Running post-run listener: _resource_record_post_run 14:48:58 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549376000; Read time: 148; Write time: 682688 14:48:58 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 247615488; Read time: 0; Write time: 382428 14:48:58 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 4096; Write bytes: 301760512; Read time: 148; Write time: 300260 14:48:58 INFO - Running post-run listener: _upload_blobber_files 14:48:58 INFO - Blob upload gear active. 14:48:58 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:48:58 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 14:48:58 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'] 14:48:58 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 14:48:59 INFO - (blobuploader) - INFO - Open directory for files ... 14:48:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:48:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:48:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:49:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:49:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:49:00 INFO - (blobuploader) - INFO - Done attempting. 14:49:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:49:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:49:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:49:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:49:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:49:01 INFO - (blobuploader) - INFO - Done attempting. 14:49:01 INFO - (blobuploader) - INFO - Iteration through files over. 14:49:01 INFO - Return code: 0 14:49:01 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:49:01 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:49:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/6fffe174422e1cc1182e01518fcd076c289b9e411497514412ebb527a53a8fa836e1eb59105d61a590ed334c760e575cde5a8f82dcf0d14dba6fe3e99e661af3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d73475b685d0e9f83bc7a49e9518ce5ec0c293ea3546b9ecc1904601f1fd946e0df0976adfe122b22fd85c6ee23931cca64c4b08a329ede34bc5c53be9abfdaa"} 14:49:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:49:01 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:49:01 INFO - Contents: 14:49:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/6fffe174422e1cc1182e01518fcd076c289b9e411497514412ebb527a53a8fa836e1eb59105d61a590ed334c760e575cde5a8f82dcf0d14dba6fe3e99e661af3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d73475b685d0e9f83bc7a49e9518ce5ec0c293ea3546b9ecc1904601f1fd946e0df0976adfe122b22fd85c6ee23931cca64c4b08a329ede34bc5c53be9abfdaa"} 14:49:01 INFO - Running post-run listener: copy_logs_to_upload_dir 14:49:01 INFO - Copying logs to upload dir... 14:49:01 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 14:49:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.568820 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-02-03 14:49:00.987124) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-03 14:49:00.990693) ========= 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=62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959 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/6fffe174422e1cc1182e01518fcd076c289b9e411497514412ebb527a53a8fa836e1eb59105d61a590ed334c760e575cde5a8f82dcf0d14dba6fe3e99e661af3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d73475b685d0e9f83bc7a49e9518ce5ec0c293ea3546b9ecc1904601f1fd946e0df0976adfe122b22fd85c6ee23931cca64c4b08a329ede34bc5c53be9abfdaa"} build_url:https://queue.taskcluster.net/v1/task/eDBQNUuhRfGdFvGfZMlPZg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011510 build_url: 'https://queue.taskcluster.net/v1/task/eDBQNUuhRfGdFvGfZMlPZg/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/6fffe174422e1cc1182e01518fcd076c289b9e411497514412ebb527a53a8fa836e1eb59105d61a590ed334c760e575cde5a8f82dcf0d14dba6fe3e99e661af3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d73475b685d0e9f83bc7a49e9518ce5ec0c293ea3546b9ecc1904601f1fd946e0df0976adfe122b22fd85c6ee23931cca64c4b08a329ede34bc5c53be9abfdaa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-03 14:49:01.017512) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 14:49:01.018012) ========= 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=62c568580acbfdaac3eec7be000001dc-1454537000.195186-1104787959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 14:49:01.103887) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-03 14:49:01.104630) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-03 14:49:01.105074) ========= ========= Total master_lag: 0.30 =========