builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1453734497.87 results: success (0) buildid: 20160125043014 builduid: 2296c3fc72a44dd783b5698cb8d900c2 revision: 5ae2ccf49f97e518715e8dfbbbab4dd9eda5348c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 07:08:17.870265) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 07:08:17.870805) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 07:08:17.871167) ========= 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=0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006482 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 07:08:17.894845) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 07:08:17.895285) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 07:08:17.909156) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 07:08:17.909488) ========= 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=0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004712 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 07:08:17.959376) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 07:08:17.959737) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 07:08:17.960229) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 07:08:17.960583) ========= 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=0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 07:08:18-- 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% 83.7M=0s 2016-01-25 07:08:18 (83.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162228 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 07:08:18.136673) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 07:08:18.137106) ========= 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=0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021650 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 07:08:18.189937) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-25 07:08:18.190615) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5ae2ccf49f97e518715e8dfbbbab4dd9eda5348c --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/mozilla-inbound --rev 5ae2ccf49f97e518715e8dfbbbab4dd9eda5348c --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=0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 07:08:19,001 truncating revision to first 12 chars 2016-01-25 07:08:19,001 Setting DEBUG logging. 2016-01-25 07:08:19,001 attempt 1/10 2016-01-25 07:08:19,001 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/5ae2ccf49f97?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 07:08:19,829 unpacking tar archive at: mozilla-inbound-5ae2ccf49f97/testing/mozharness/ program finished with exit code 0 elapsedTime=1.095297 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-25 07:08:19.300037) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 07:08:19.300391) ========= echo 5ae2ccf49f97e518715e8dfbbbab4dd9eda5348c in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5ae2ccf49f97e518715e8dfbbbab4dd9eda5348c'] 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=0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5ae2ccf49f97e518715e8dfbbbab4dd9eda5348c program finished with exit code 0 elapsedTime=0.004491 script_repo_revision: '5ae2ccf49f97e518715e8dfbbbab4dd9eda5348c' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 07:08:19.350808) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 07:08:19.351153) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 07:08:19.365301) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-01-25 07:08:19.365652) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-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=0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:08:20 INFO - MultiFileLogger online at 20160125 07:08:20 in /builds/slave/test-pgo 07:08:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:08:20 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:08:20 INFO - {'append_to_log': False, 07:08:20 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:08:20 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:08:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:08:20 INFO - 'branch': 'Mozilla-Inbound', 07:08:20 INFO - 'buildbot_json_path': 'buildprops.json', 07:08:20 INFO - 'config_files': ('talos/linux_config.py',), 07:08:20 INFO - 'default_actions': ('clobber', 07:08:20 INFO - 'read-buildbot-config', 07:08:20 INFO - 'download-and-extract', 07:08:20 INFO - 'populate-webroot', 07:08:20 INFO - 'create-virtualenv', 07:08:20 INFO - 'install', 07:08:20 INFO - 'run-tests'), 07:08:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:08:20 INFO - 'download_minidump_stackwalk': True, 07:08:20 INFO - 'download_symbols': 'ondemand', 07:08:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:08:20 INFO - 'tooltool.py': '/tools/tooltool.py', 07:08:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:08:20 INFO - '/tools/misc-python/virtualenv.py')}, 07:08:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:08:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:08:20 INFO - 'installer_path': 'installer.exe', 07:08:20 INFO - 'log_level': 'info', 07:08:20 INFO - 'log_name': 'talos', 07:08:20 INFO - 'log_to_console': True, 07:08:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:08:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:08:20 INFO - 'opt_config_files': (), 07:08:20 INFO - 'pip_index': False, 07:08:20 INFO - 'sps_profile': False, 07:08:20 INFO - 'sps_profile_interval': 0, 07:08:20 INFO - 'suite': 'dromaeojs', 07:08:20 INFO - 'system_bits': '32', 07:08:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:08:20 INFO - 'title': 'talos-linux64-ix-017', 07:08:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:08:20 INFO - 'use_talos_json': True, 07:08:20 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:08:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:08:20 INFO - 'work_dir': 'build'} 07:08:20 INFO - ##### 07:08:20 INFO - ##### Running clobber step. 07:08:20 INFO - ##### 07:08:20 INFO - Running pre-action listener: _resource_record_pre_action 07:08:20 INFO - Running main action method: clobber 07:08:20 INFO - rmtree: /builds/slave/test-pgo/build 07:08:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:08:21 INFO - Running post-action listener: _resource_record_post_action 07:08:21 INFO - ##### 07:08:21 INFO - ##### Running read-buildbot-config step. 07:08:21 INFO - ##### 07:08:21 INFO - Running pre-action listener: _resource_record_pre_action 07:08:21 INFO - Running main action method: read_buildbot_config 07:08:21 INFO - Using buildbot properties: 07:08:21 INFO - { 07:08:21 INFO - "project": "", 07:08:21 INFO - "product": "firefox", 07:08:21 INFO - "script_repo_revision": "production", 07:08:21 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 07:08:21 INFO - "repository": "", 07:08:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 07:08:21 INFO - "buildid": "20160125043014", 07:08:21 INFO - "pgo_build": "True", 07:08:21 INFO - "basedir": "/builds/slave/test-pgo", 07:08:21 INFO - "buildnumber": 632, 07:08:21 INFO - "slavename": "talos-linux64-ix-017", 07:08:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:08:21 INFO - "platform": "ubuntu64_hw", 07:08:21 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:08:21 INFO - "branch": "mozilla-inbound", 07:08:21 INFO - "repo_path": "integration/mozilla-inbound", 07:08:21 INFO - "revision": "5ae2ccf49f97e518715e8dfbbbab4dd9eda5348c", 07:08:21 INFO - "stage_platform": "linux64-pgo", 07:08:21 INFO - "builduid": "2296c3fc72a44dd783b5698cb8d900c2", 07:08:21 INFO - "slavebuilddir": "test" 07:08:21 INFO - } 07:08:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:08:21 INFO - Running post-action listener: _resource_record_post_action 07:08:21 INFO - ##### 07:08:21 INFO - ##### Running download-and-extract step. 07:08:21 INFO - ##### 07:08:21 INFO - Running pre-action listener: _resource_record_pre_action 07:08:21 INFO - Running main action method: download_and_extract 07:08:21 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:08: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')]} 07:08:21 INFO - https://queue.taskcluster.net/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:08:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/test_packages.json 07:08:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/test_packages.json 07:08:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:08:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:08:22 INFO - Downloaded 1448 bytes. 07:08:22 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:08:22 INFO - Using the following test package requirements: 07:08:22 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:08:22 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:08:22 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:08:22 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:22 INFO - u'jsshell-linux-x86_64.zip'], 07:08:22 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:08:22 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:08:22 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:08:22 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:08:22 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:08:22 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:08:22 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:08:22 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:22 INFO - https://queue.taskcluster.net/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:08:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:08:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:08:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:08:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:08:23 INFO - Downloaded 22494400 bytes. 07:08:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:08:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 07:08:24 INFO - Return code: 0 07:08:24 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:08: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')]} 07:08:24 INFO - https://queue.taskcluster.net/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:08:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:08:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:08:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:08:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:08:26 INFO - Downloaded 22494400 bytes. 07:08:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:08:26 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 07:08:28 INFO - Return code: 0 07:08:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:28 INFO - https://queue.taskcluster.net/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:08:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:08:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:08:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:08:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:08:29 INFO - Downloaded 10706572 bytes. 07:08:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:08:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 07:08:29 INFO - Return code: 0 07:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:29 INFO - https://queue.taskcluster.net/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:08:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:08:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:08:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:08:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:08:31 INFO - Downloaded 55982257 bytes. 07:08:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:08:31 INFO - mkdir: /builds/slave/test-pgo/properties 07:08:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:08:31 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:08:31 INFO - Contents: 07:08:31 INFO - build_url:https://queue.taskcluster.net/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:08:31 INFO - Running post-action listener: _resource_record_post_action 07:08:31 INFO - Running post-action listener: set_extra_try_arguments 07:08:31 INFO - ##### 07:08:31 INFO - ##### Running populate-webroot step. 07:08:31 INFO - ##### 07:08:31 INFO - Running pre-action listener: _resource_record_pre_action 07:08:31 INFO - Running main action method: populate_webroot 07:08:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:08:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:08:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:08:31 INFO - '--tppagecycles', 07:08:31 INFO - '7'], 07:08:31 INFO - 'tests': ['tsvgm']}}, 07:08:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:08:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:08:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:08:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:08:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:08:31 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:08:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:08:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:31 INFO - 'talos_options': ['--e10s'], 07:08:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:08:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:31 INFO - 'tests': ['damp', 'tps']}, 07:08:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:31 INFO - 'talos_options': ['--e10s'], 07:08:31 INFO - 'tests': ['damp', 'tps']}, 07:08:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:08:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:08:31 INFO - 'other': {'tests': ['a11yr', 07:08:31 INFO - 'ts_paint', 07:08:31 INFO - 'tpaint', 07:08:31 INFO - 'sessionrestore', 07:08:31 INFO - 'sessionrestore_no_auto_restore']}, 07:08:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:08:31 INFO - 'tests': ['a11yr', 07:08:31 INFO - 'ts_paint', 07:08:31 INFO - 'tpaint', 07:08:31 INFO - 'sessionrestore', 07:08:31 INFO - 'sessionrestore_no_auto_restore']}, 07:08:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:08:31 INFO - 'tests': ['a11yr', 07:08:31 INFO - 'ts_paint', 07:08:31 INFO - 'tpaint', 07:08:31 INFO - 'sessionrestore', 07:08:31 INFO - 'sessionrestore_no_auto_restore']}, 07:08:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:08:31 INFO - 'tests': ['a11yr', 07:08:31 INFO - 'ts_paint', 07:08:31 INFO - 'tpaint', 07:08:31 INFO - 'sessionrestore', 07:08:31 INFO - 'sessionrestore_no_auto_restore']}, 07:08:31 INFO - 'other_l64': {'tests': ['a11yr', 07:08:31 INFO - 'ts_paint', 07:08:31 INFO - 'tpaint', 07:08:31 INFO - 'sessionrestore', 07:08:31 INFO - 'sessionrestore_no_auto_restore']}, 07:08:31 INFO - 'other_nol64': {'tests': ['a11yr', 07:08:31 INFO - 'ts_paint', 07:08:31 INFO - 'tpaint', 07:08:31 INFO - 'sessionrestore', 07:08:31 INFO - 'sessionrestore_no_auto_restore']}, 07:08:31 INFO - 'svgr': {'tests': ['tsvgx', 07:08:31 INFO - 'tsvgr_opacity', 07:08:31 INFO - 'tart', 07:08:31 INFO - 'tscrollx', 07:08:31 INFO - 'cart']}, 07:08:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:08:31 INFO - 'tests': ['tsvgx', 07:08:31 INFO - 'tsvgr_opacity', 07:08:31 INFO - 'tart', 07:08:31 INFO - 'tscrollx', 07:08:31 INFO - 'cart']}, 07:08:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:31 INFO - 'tests': ['tp5o']}, 07:08:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:31 INFO - 'talos_options': ['--e10s'], 07:08:31 INFO - 'tests': ['tp5o']}, 07:08:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:31 INFO - 'talos_options': ['--xperf_path', 07:08:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:08:31 INFO - 'tests': ['tp5n']}, 07:08:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:31 INFO - 'talos_options': ['--e10s', 07:08:31 INFO - '--xperf_path', 07:08:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:08:31 INFO - 'tests': ['tp5n']}}, 07:08:31 INFO - 'talos.zip': {'path': '', 07:08:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:08:31 INFO - Running post-action listener: _resource_record_post_action 07:08:31 INFO - ##### 07:08:31 INFO - ##### Running create-virtualenv step. 07:08:31 INFO - ##### 07:08:31 INFO - Running pre-action listener: _resource_record_pre_action 07:08:31 INFO - Running main action method: create_virtualenv 07:08:31 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:08:31 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 07:08:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:08:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:08:31 INFO - Using real prefix '/usr' 07:08:31 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:08:31 INFO - Installing distribute.............................................................................................................................................................................................done. 07:08:33 INFO - Installing pip.................done. 07:08:33 INFO - Return code: 0 07:08:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f06ba4d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1848230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18da7f0>, '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 0x18462d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1846760>, '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': '0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506', '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 07:08:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 07:08:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:08:33 INFO - Using env: {'DISPLAY': ':0', 07:08:33 INFO - 'HOME': '/home/cltbld', 07:08:33 INFO - 'LANG': 'en_US.UTF-8', 07:08:33 INFO - 'LANGUAGE': 'en_US:en', 07:08:33 INFO - 'LOGNAME': 'cltbld', 07:08:33 INFO - 'MAIL': '/var/mail/cltbld', 07:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:33 INFO - 'MOZ_NO_REMOTE': '1', 07:08:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:33 INFO - 'NO_EM_RESTART': '1', 07:08:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:08:33 INFO - 'PWD': '/builds/slave/test-pgo', 07:08:33 INFO - 'SHELL': '/bin/bash', 07:08:33 INFO - 'SHLVL': '1', 07:08:33 INFO - 'TERM': 'linux', 07:08:33 INFO - 'TMOUT': '86400', 07:08:33 INFO - 'USER': 'cltbld', 07:08:33 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506', 07:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:33 INFO - '_': '/tools/buildbot/bin/python'} 07:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:34 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 07:08:34 INFO - Cleaning up... 07:08:34 INFO - Return code: 0 07:08:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f06ba4d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1848230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18da7f0>, '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 0x18462d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1846760>, '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': '0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506', '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 07:08:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 07:08:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:08:34 INFO - Using env: {'DISPLAY': ':0', 07:08:34 INFO - 'HOME': '/home/cltbld', 07:08:34 INFO - 'LANG': 'en_US.UTF-8', 07:08:34 INFO - 'LANGUAGE': 'en_US:en', 07:08:34 INFO - 'LOGNAME': 'cltbld', 07:08:34 INFO - 'MAIL': '/var/mail/cltbld', 07:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:34 INFO - 'MOZ_NO_REMOTE': '1', 07:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:34 INFO - 'NO_EM_RESTART': '1', 07:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:08:34 INFO - 'PWD': '/builds/slave/test-pgo', 07:08:34 INFO - 'SHELL': '/bin/bash', 07:08:34 INFO - 'SHLVL': '1', 07:08:34 INFO - 'TERM': 'linux', 07:08:34 INFO - 'TMOUT': '86400', 07:08:34 INFO - 'USER': 'cltbld', 07:08:34 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506', 07:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:34 INFO - '_': '/tools/buildbot/bin/python'} 07:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:34 INFO - Downloading/unpacking psutil>=0.7.1 07:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:08:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:08:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:08:36 INFO - Installing collected packages: psutil 07:08:36 INFO - Running setup.py install for psutil 07:08:36 INFO - building 'psutil._psutil_linux' extension 07:08:36 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 07:08:36 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 07:08:36 INFO - building 'psutil._psutil_posix' extension 07:08:36 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 07:08:36 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 07:08:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:08:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:08:36 INFO - Successfully installed psutil 07:08:36 INFO - Cleaning up... 07:08:36 INFO - Return code: 0 07:08:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f06ba4d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1848230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18da7f0>, '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 0x18462d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1846760>, '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': '0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506', '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 07:08:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 07:08:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:08:36 INFO - Using env: {'DISPLAY': ':0', 07:08:36 INFO - 'HOME': '/home/cltbld', 07:08:36 INFO - 'LANG': 'en_US.UTF-8', 07:08:36 INFO - 'LANGUAGE': 'en_US:en', 07:08:36 INFO - 'LOGNAME': 'cltbld', 07:08:36 INFO - 'MAIL': '/var/mail/cltbld', 07:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:36 INFO - 'MOZ_NO_REMOTE': '1', 07:08:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:36 INFO - 'NO_EM_RESTART': '1', 07:08:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:08:36 INFO - 'PWD': '/builds/slave/test-pgo', 07:08:36 INFO - 'SHELL': '/bin/bash', 07:08:36 INFO - 'SHLVL': '1', 07:08:36 INFO - 'TERM': 'linux', 07:08:36 INFO - 'TMOUT': '86400', 07:08:36 INFO - 'USER': 'cltbld', 07:08:36 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506', 07:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:36 INFO - '_': '/tools/buildbot/bin/python'} 07:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:08:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:08:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:08:38 INFO - Installing collected packages: mozsystemmonitor 07:08:38 INFO - Running setup.py install for mozsystemmonitor 07:08:38 INFO - Successfully installed mozsystemmonitor 07:08:38 INFO - Cleaning up... 07:08:38 INFO - Return code: 0 07:08:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:08:38 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')]} 07:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:38 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')]} 07:08:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:38 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 0x7f06ba4d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1848230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18da7f0>, '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 0x18462d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1846760>, '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': '0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506', '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 07:08:38 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 07:08:38 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 07:08:38 INFO - Using env: {'DISPLAY': ':0', 07:08:38 INFO - 'HOME': '/home/cltbld', 07:08:38 INFO - 'LANG': 'en_US.UTF-8', 07:08:38 INFO - 'LANGUAGE': 'en_US:en', 07:08:38 INFO - 'LOGNAME': 'cltbld', 07:08:38 INFO - 'MAIL': '/var/mail/cltbld', 07:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:38 INFO - 'MOZ_NO_REMOTE': '1', 07:08:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:38 INFO - 'NO_EM_RESTART': '1', 07:08:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:08:38 INFO - 'PWD': '/builds/slave/test-pgo', 07:08:38 INFO - 'SHELL': '/bin/bash', 07:08:38 INFO - 'SHLVL': '1', 07:08:38 INFO - 'TERM': 'linux', 07:08:38 INFO - 'TMOUT': '86400', 07:08:38 INFO - 'USER': 'cltbld', 07:08:38 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506', 07:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:38 INFO - '_': '/tools/buildbot/bin/python'} 07:08:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:39 INFO - Downloading/unpacking blobuploader==1.2.4 07:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:41 INFO - Downloading blobuploader-1.2.4.tar.gz 07:08:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:08:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:08:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:41 INFO - Downloading docopt-0.6.1.tar.gz 07:08:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:08:41 INFO - Installing collected packages: blobuploader, requests, docopt 07:08:41 INFO - Running setup.py install for blobuploader 07:08:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:08:41 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:08:41 INFO - Running setup.py install for requests 07:08:42 INFO - Running setup.py install for docopt 07:08:42 INFO - Successfully installed blobuploader requests docopt 07:08:42 INFO - Cleaning up... 07:08:42 INFO - Return code: 0 07:08:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:42 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 0x7f06ba4d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1848230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18da7f0>, '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 0x18462d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1846760>, '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': '0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506', '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 07:08:42 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 07:08:42 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 07:08:42 INFO - Using env: {'DISPLAY': ':0', 07:08:42 INFO - 'HOME': '/home/cltbld', 07:08:42 INFO - 'LANG': 'en_US.UTF-8', 07:08:42 INFO - 'LANGUAGE': 'en_US:en', 07:08:42 INFO - 'LOGNAME': 'cltbld', 07:08:42 INFO - 'MAIL': '/var/mail/cltbld', 07:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:42 INFO - 'MOZ_NO_REMOTE': '1', 07:08:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:42 INFO - 'NO_EM_RESTART': '1', 07:08:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:08:42 INFO - 'PWD': '/builds/slave/test-pgo', 07:08:42 INFO - 'SHELL': '/bin/bash', 07:08:42 INFO - 'SHLVL': '1', 07:08:42 INFO - 'TERM': 'linux', 07:08:42 INFO - 'TMOUT': '86400', 07:08:42 INFO - 'USER': 'cltbld', 07:08:42 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506', 07:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:42 INFO - '_': '/tools/buildbot/bin/python'} 07:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:08:42 INFO - Running setup.py (path:/tmp/pip-S0vWmO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:08:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:08:42 INFO - Running setup.py (path:/tmp/pip-t_iUMb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:08:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:08:42 INFO - Running setup.py (path:/tmp/pip-xkR7Hl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:08:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:08:42 INFO - Running setup.py (path:/tmp/pip-vFqKOG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:08:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:08:42 INFO - Running setup.py (path:/tmp/pip-PWoSGm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:08:43 INFO - Running setup.py (path:/tmp/pip-r5TT2R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:08:43 INFO - Running setup.py (path:/tmp/pip-OvMo86-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:08:43 INFO - Running setup.py (path:/tmp/pip-r3FogK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:08:43 INFO - Running setup.py (path:/tmp/pip-0Sykg9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:08:43 INFO - Running setup.py (path:/tmp/pip-ZDWX3R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:08:43 INFO - Running setup.py (path:/tmp/pip-MDnTQC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:08:43 INFO - Running setup.py (path:/tmp/pip-vB_9HO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:08:43 INFO - Running setup.py (path:/tmp/pip-J2YTZW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:08:43 INFO - Running setup.py (path:/tmp/pip-dklF_6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:08:43 INFO - Running setup.py (path:/tmp/pip-C5vxFJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:08:43 INFO - Running setup.py (path:/tmp/pip-1EC9Ex-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:08:43 INFO - Running setup.py (path:/tmp/pip-k6j8V5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:08:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:08:43 INFO - Running setup.py install for manifestparser 07:08:43 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:08:44 INFO - Running setup.py install for mozcrash 07:08:44 INFO - Running setup.py install for mozdebug 07:08:44 INFO - Running setup.py install for mozdevice 07:08:44 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:08:44 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:08:44 INFO - Running setup.py install for mozfile 07:08:44 INFO - Running setup.py install for mozhttpd 07:08:44 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:08:44 INFO - Running setup.py install for mozinfo 07:08:44 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:08:44 INFO - Running setup.py install for mozInstall 07:08:44 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:08:44 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:08:44 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:08:44 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:08:44 INFO - Running setup.py install for mozleak 07:08:44 INFO - Running setup.py install for mozlog 07:08:44 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:08:44 INFO - Running setup.py install for moznetwork 07:08:45 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:08:45 INFO - Running setup.py install for mozprocess 07:08:45 INFO - Running setup.py install for mozprofile 07:08:45 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:08:45 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:08:45 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:08:45 INFO - Running setup.py install for mozrunner 07:08:45 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:08:45 INFO - Running setup.py install for mozscreenshot 07:08:45 INFO - Running setup.py install for moztest 07:08:45 INFO - Running setup.py install for mozversion 07:08:45 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:08:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:08:45 INFO - Cleaning up... 07:08:45 INFO - Return code: 0 07:08:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:08:45 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')]} 07:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:45 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')]} 07:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:45 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 0x7f06ba4d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1848230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18da7f0>, '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 0x18462d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1846760>, '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': '0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506', '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 07:08:45 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 07:08:45 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 07:08:45 INFO - Using env: {'DISPLAY': ':0', 07:08:45 INFO - 'HOME': '/home/cltbld', 07:08:45 INFO - 'LANG': 'en_US.UTF-8', 07:08:45 INFO - 'LANGUAGE': 'en_US:en', 07:08:45 INFO - 'LOGNAME': 'cltbld', 07:08:45 INFO - 'MAIL': '/var/mail/cltbld', 07:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:45 INFO - 'MOZ_NO_REMOTE': '1', 07:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:45 INFO - 'NO_EM_RESTART': '1', 07:08:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:08:45 INFO - 'PWD': '/builds/slave/test-pgo', 07:08:45 INFO - 'SHELL': '/bin/bash', 07:08:45 INFO - 'SHLVL': '1', 07:08:45 INFO - 'TERM': 'linux', 07:08:45 INFO - 'TMOUT': '86400', 07:08:45 INFO - 'USER': 'cltbld', 07:08:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506', 07:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:45 INFO - '_': '/tools/buildbot/bin/python'} 07:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:08:45 INFO - Running setup.py (path:/tmp/pip-YTHUHA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:08:45 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)) 07:08:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:08:45 INFO - Running setup.py (path:/tmp/pip-bjaILR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:08:46 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)) 07:08:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:08:46 INFO - Running setup.py (path:/tmp/pip-SDjC4_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:08:46 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)) 07:08:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:08:46 INFO - Running setup.py (path:/tmp/pip-PlEFVG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:08:46 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)) 07:08:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:08:46 INFO - Running setup.py (path:/tmp/pip-S1GYpS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:08:46 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)) 07:08:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:08:46 INFO - Running setup.py (path:/tmp/pip-5opTir-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:08:46 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)) 07:08:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:08:46 INFO - Running setup.py (path:/tmp/pip-qAJrdZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:08:46 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)) 07:08:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:08:46 INFO - Running setup.py (path:/tmp/pip-W2GJWr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:08:46 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)) 07:08:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:08:46 INFO - Running setup.py (path:/tmp/pip-tBANBX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:08:46 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)) 07:08:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:08:46 INFO - Running setup.py (path:/tmp/pip-S_Oqxv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:08:46 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)) 07:08:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:08:46 INFO - Running setup.py (path:/tmp/pip-RErpj9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:08:46 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)) 07:08:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:08:46 INFO - Running setup.py (path:/tmp/pip-Yw7Jgh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:08:46 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)) 07:08:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:08:46 INFO - Running setup.py (path:/tmp/pip-XZTIAD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:08:46 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)) 07:08:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:08:46 INFO - Running setup.py (path:/tmp/pip-oWH94Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:08:46 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)) 07:08:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:08:46 INFO - Running setup.py (path:/tmp/pip-6ZrO5h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:08:47 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)) 07:08:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:08:47 INFO - Running setup.py (path:/tmp/pip-crScdT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:08:47 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)) 07:08:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:08:47 INFO - Running setup.py (path:/tmp/pip-rVnOba-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:08:47 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)) 07:08:47 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)) 07:08:47 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)) 07:08:47 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)) 07:08:47 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)) 07:08:47 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)) 07:08:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:08:47 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 07:08:47 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 07:08:47 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 07:08:47 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 07:08:47 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 07:08:47 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 07:08:48 INFO - Downloading blessings-1.6.tar.gz 07:08:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:08:48 INFO - Installing collected packages: blessings 07:08:48 INFO - Running setup.py install for blessings 07:08:49 INFO - Successfully installed blessings 07:08:49 INFO - Cleaning up... 07:08:49 INFO - Return code: 0 07:08:49 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:08:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:08:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:08:49 INFO - Reading from file tmpfile_stdout 07:08:49 INFO - Current package versions: 07:08:49 INFO - argparse == 1.2.1 07:08:49 INFO - blessings == 1.6 07:08:49 INFO - blobuploader == 1.2.4 07:08:49 INFO - docopt == 0.6.1 07:08:49 INFO - manifestparser == 1.1 07:08:49 INFO - mozInstall == 1.12 07:08:49 INFO - mozcrash == 0.16 07:08:49 INFO - mozdebug == 0.1 07:08:49 INFO - mozdevice == 0.48 07:08:49 INFO - mozfile == 1.2 07:08:49 INFO - mozhttpd == 0.7 07:08:49 INFO - mozinfo == 0.9 07:08:49 INFO - mozleak == 0.1 07:08:49 INFO - mozlog == 3.1 07:08:49 INFO - moznetwork == 0.27 07:08:49 INFO - mozprocess == 0.22 07:08:49 INFO - mozprofile == 0.28 07:08:49 INFO - mozrunner == 6.11 07:08:49 INFO - mozscreenshot == 0.1 07:08:49 INFO - mozsystemmonitor == 0.0 07:08:49 INFO - moztest == 0.7 07:08:49 INFO - mozversion == 1.4 07:08:49 INFO - psutil == 3.1.1 07:08:49 INFO - requests == 1.2.3 07:08:49 INFO - wsgiref == 0.1.2 07:08:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:49 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 0x7f06ba4d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1848230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18da7f0>, '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 0x18462d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1846760>, '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': '0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506', '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 07:08:49 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 07:08:49 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 07:08:49 INFO - Using env: {'DISPLAY': ':0', 07:08:49 INFO - 'HOME': '/home/cltbld', 07:08:49 INFO - 'LANG': 'en_US.UTF-8', 07:08:49 INFO - 'LANGUAGE': 'en_US:en', 07:08:49 INFO - 'LOGNAME': 'cltbld', 07:08:49 INFO - 'MAIL': '/var/mail/cltbld', 07:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:49 INFO - 'MOZ_NO_REMOTE': '1', 07:08:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:49 INFO - 'NO_EM_RESTART': '1', 07:08:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:08:49 INFO - 'PWD': '/builds/slave/test-pgo', 07:08:49 INFO - 'SHELL': '/bin/bash', 07:08:49 INFO - 'SHLVL': '1', 07:08:49 INFO - 'TERM': 'linux', 07:08:49 INFO - 'TMOUT': '86400', 07:08:49 INFO - 'USER': 'cltbld', 07:08:49 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506', 07:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:49 INFO - '_': '/tools/buildbot/bin/python'} 07:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:49 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)) 07:08:49 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)) 07:08:49 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)) 07:08:49 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)) 07:08:49 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)) 07:08:49 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)) 07:08:49 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)) 07:08:49 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)) 07:08:49 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)) 07:08:49 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)) 07:08:49 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)) 07:08:49 INFO - Cleaning up... 07:08:49 INFO - Return code: 0 07:08:49 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:49 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 0x7f06ba4d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1848230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18da7f0>, '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 0x18462d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1846760>, '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': '0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506', '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 07:08:49 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 07:08:49 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 07:08:49 INFO - Using env: {'DISPLAY': ':0', 07:08:49 INFO - 'HOME': '/home/cltbld', 07:08:49 INFO - 'LANG': 'en_US.UTF-8', 07:08:49 INFO - 'LANGUAGE': 'en_US:en', 07:08:49 INFO - 'LOGNAME': 'cltbld', 07:08:49 INFO - 'MAIL': '/var/mail/cltbld', 07:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:49 INFO - 'MOZ_NO_REMOTE': '1', 07:08:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:49 INFO - 'NO_EM_RESTART': '1', 07:08:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:08:49 INFO - 'PWD': '/builds/slave/test-pgo', 07:08:49 INFO - 'SHELL': '/bin/bash', 07:08:49 INFO - 'SHLVL': '1', 07:08:49 INFO - 'TERM': 'linux', 07:08:49 INFO - 'TMOUT': '86400', 07:08:49 INFO - 'USER': 'cltbld', 07:08:49 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506', 07:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:49 INFO - '_': '/tools/buildbot/bin/python'} 07:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:49 INFO - Downloading/unpacking jsonschema 07:08:49 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 07:08:49 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 07:08:49 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 07:08:49 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 07:08:49 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 07:08:49 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 07:08:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:08:51 INFO - Downloading/unpacking functools32 (from jsonschema) 07:08:51 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 07:08:51 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 07:08:51 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 07:08:51 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 07:08:51 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 07:08:51 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 07:08:51 INFO - Downloading functools32-3.2.3-2.tar.gz 07:08:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:08:51 INFO - warning: no files found matching '*.txt' 07:08:51 INFO - no previously-included directories found matching 'build' 07:08:51 INFO - no previously-included directories found matching 'dist' 07:08:51 INFO - no previously-included directories found matching '.git*' 07:08:51 INFO - Installing collected packages: jsonschema, functools32 07:08:51 INFO - Running setup.py install for functools32 07:08:51 INFO - warning: no files found matching '*.txt' 07:08:51 INFO - no previously-included directories found matching 'build' 07:08:51 INFO - no previously-included directories found matching 'dist' 07:08:51 INFO - no previously-included directories found matching '.git*' 07:08:52 INFO - Successfully installed jsonschema functools32 07:08:52 INFO - Cleaning up... 07:08:52 INFO - Return code: 0 07:08:52 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:08:52 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')]} 07:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:52 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')]} 07:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:52 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 0x7f06ba4d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1848230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18da7f0>, '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 0x18462d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1846760>, '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': '0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506', '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 07:08:52 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 07:08:52 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 07:08:52 INFO - Using env: {'DISPLAY': ':0', 07:08:52 INFO - 'HOME': '/home/cltbld', 07:08:52 INFO - 'LANG': 'en_US.UTF-8', 07:08:52 INFO - 'LANGUAGE': 'en_US:en', 07:08:52 INFO - 'LOGNAME': 'cltbld', 07:08:52 INFO - 'MAIL': '/var/mail/cltbld', 07:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:52 INFO - 'MOZ_NO_REMOTE': '1', 07:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:52 INFO - 'NO_EM_RESTART': '1', 07:08:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:08:52 INFO - 'PWD': '/builds/slave/test-pgo', 07:08:52 INFO - 'SHELL': '/bin/bash', 07:08:52 INFO - 'SHLVL': '1', 07:08:52 INFO - 'TERM': 'linux', 07:08:52 INFO - 'TMOUT': '86400', 07:08:52 INFO - 'USER': 'cltbld', 07:08:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506', 07:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:52 INFO - '_': '/tools/buildbot/bin/python'} 07:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:52 INFO - Downloading/unpacking flake8 07:08:52 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 07:08:52 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 07:08:52 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 07:08:52 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 07:08:52 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 07:08:52 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 07:08:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:08:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:08:54 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 07:08:54 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 07:08:54 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 07:08:54 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 07:08:54 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 07:08:54 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 07:08:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:08:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:08:54 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 07:08:54 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 07:08:54 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 07:08:54 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 07:08:54 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 07:08:54 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 07:08:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:08:54 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 07:08:54 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 07:08:54 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 07:08:54 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 07:08:54 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 07:08:54 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 07:08:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:08:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:08:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:08:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:08:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:08:54 INFO - no previously-included directories found matching 'docs/_build' 07:08:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:08:54 INFO - Running setup.py install for pep8 07:08:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:08:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:08:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:08:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:08:54 INFO - no previously-included directories found matching 'docs/_build' 07:08:54 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:08:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:08:54 INFO - Cleaning up... 07:08:54 INFO - Return code: 0 07:08:54 INFO - Running post-action listener: _resource_record_post_action 07:08:54 INFO - Running post-action listener: _start_resource_monitoring 07:08:54 INFO - Starting resource monitoring. 07:08:54 INFO - ##### 07:08:54 INFO - ##### Running install step. 07:08:54 INFO - ##### 07:08:54 INFO - Running pre-action listener: _resource_record_pre_action 07:08:54 INFO - Running main action method: install 07:08:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:08:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:08:55 INFO - Reading from file tmpfile_stdout 07:08:55 INFO - Detecting whether we're running mozinstall >=1.0... 07:08:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:08:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:08:55 INFO - Reading from file tmpfile_stdout 07:08:55 INFO - Output received: 07:08:55 INFO - Usage: mozinstall [options] installer 07:08:55 INFO - Options: 07:08:55 INFO - -h, --help show this help message and exit 07:08:55 INFO - -d DEST, --destination=DEST 07:08:55 INFO - Directory to install application into. [default: 07:08:55 INFO - "/builds/slave/test-pgo"] 07:08:55 INFO - --app=APP Application being installed. [default: firefox] 07:08:55 INFO - mkdir: /builds/slave/test-pgo/build/application 07:08:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 07:08:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 07:09:11 INFO - Reading from file tmpfile_stdout 07:09:11 INFO - Output received: 07:09:11 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:09:11 INFO - Running post-action listener: _resource_record_post_action 07:09:11 INFO - ##### 07:09:11 INFO - ##### Running run-tests step. 07:09:11 INFO - ##### 07:09:11 INFO - Running pre-action listener: _resource_record_pre_action 07:09:11 INFO - Running main action method: run_tests 07:09:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:09:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:09:11 INFO - Python 2.7.3 07:09:11 INFO - Return code: 0 07:09:11 INFO - grabbing minidump binary from tooltool 07:09: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')]} 07:09:11 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 0x18da7f0>, '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 0x18462d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1846760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:09:11 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 07:09:11 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 07:09:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:09:11 INFO - Return code: 0 07:09:11 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:09:11 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:09:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:09:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:09:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:09:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:09:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:09:12 INFO - Return code: 0 07:09:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 07:09:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 07:09:12 INFO - Using env: {'DISPLAY': ':0', 07:09:12 INFO - 'HOME': '/home/cltbld', 07:09:12 INFO - 'LANG': 'en_US.UTF-8', 07:09:12 INFO - 'LANGUAGE': 'en_US:en', 07:09:12 INFO - 'LOGNAME': 'cltbld', 07:09:12 INFO - 'MAIL': '/var/mail/cltbld', 07:09:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:09:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:12 INFO - 'MOZ_NO_REMOTE': '1', 07:09:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:09:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:12 INFO - 'NO_EM_RESTART': '1', 07:09:12 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:09:12 INFO - 'PWD': '/builds/slave/test-pgo', 07:09:12 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:09:12 INFO - 'SHELL': '/bin/bash', 07:09:12 INFO - 'SHLVL': '1', 07:09:12 INFO - 'TERM': 'linux', 07:09:12 INFO - 'TMOUT': '86400', 07:09:12 INFO - 'USER': 'cltbld', 07:09:12 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506', 07:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:12 INFO - '_': '/tools/buildbot/bin/python'} 07:09:12 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 07:09:12 INFO - mozversion application_buildid: 20160125043014 07:09:12 INFO - mozversion application_changeset: 5ae2ccf49f97e518715e8dfbbbab4dd9eda5348c 07:09:12 INFO - mozversion application_display_name: Nightly 07:09:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:09:12 INFO - mozversion application_name: Firefox 07:09:12 INFO - mozversion application_remotingname: firefox 07:09:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:09:12 INFO - mozversion application_vendor: Mozilla 07:09:12 INFO - mozversion application_version: 46.0a1 07:09:12 INFO - mozversion platform_buildid: 20160125043014 07:09:12 INFO - mozversion platform_changeset: 5ae2ccf49f97e518715e8dfbbbab4dd9eda5348c 07:09:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:09:12 INFO - mozversion platform_version: 46.0a1 07:09:12 INFO - using testdate: 1453734552 07:09:12 INFO - actual date: 1453734552 07:09:12 INFO - starting webserver on 'localhost:45064' 07:09:12 INFO - SUITE-START | Running 3 tests 07:09:12 INFO - TEST-START | dromaeo_css 07:09:12 INFO - operating with platform_type : linux_ 07:09:12 INFO - Initialising browser for dromaeo_css test... 07:09:12 INFO - TEST-INFO | started process 18141 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbGeywL/profile http://localhost:45064/getInfo.html) 07:09:16 INFO - PROCESS | 18141 | __metrics Screen width/height:1600/1200 07:09:16 INFO - PROCESS | 18141 | colorDepth:24 07:09:16 INFO - PROCESS | 18141 | Browser inner width/height: 1024/697 07:09:16 INFO - PROCESS | 18141 | __metrics 07:09:16 INFO - PROCESS | 18141 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:09:16 INFO - PROCESS | 18141 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:09:17 INFO - TEST-INFO | 18141: exit 0 07:09:17 INFO - Browser initialized. 07:09:17 INFO - Running cycle 1/1 for dromaeo_css test... 07:09:17 INFO - TEST-INFO | started process 18234 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbGeywL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:09:28 INFO - PROCESS | 18234 | RSS: Main: 148398080 07:09:28 INFO - PROCESS | 18234 | 07:10:20 INFO - PROCESS | 18234 | 1453734620429 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] 07:12:28 INFO - PROCESS | 18234 | Cycle 1(1): loaded http://localhost:45064/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45064/tests/dromaeo/cssquery-ext.html) 07:12:29 INFO - PROCESS | 18234 | RSS: Main: 232914944 07:12:29 INFO - PROCESS | 18234 | 07:15:31 INFO - PROCESS | 18234 | Cycle 1(1): loaded http://localhost:45064/tests/dromaeo/cssquery-ext.html (next: http://localhost:45064/tests/dromaeo/cssquery-jquery.html) 07:15:32 INFO - PROCESS | 18234 | RSS: Main: 235724800 07:15:32 INFO - PROCESS | 18234 | 07:18:34 INFO - PROCESS | 18234 | Cycle 1(1): loaded http://localhost:45064/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45064/tests/dromaeo/cssquery-mootools.html) 07:18:35 INFO - PROCESS | 18234 | RSS: Main: 229597184 07:18:35 INFO - PROCESS | 18234 | 07:21:36 INFO - PROCESS | 18234 | Cycle 1(1): loaded http://localhost:45064/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45064/tests/dromaeo/cssquery-prototype.html) 07:21:37 INFO - PROCESS | 18234 | RSS: Main: 211955712 07:21:37 INFO - PROCESS | 18234 | 07:24:40 INFO - PROCESS | 18234 | Cycle 1(1): loaded http://localhost:45064/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45064/tests/dromaeo/cssquery-yui.html) 07:24:40 INFO - PROCESS | 18234 | RSS: Main: 218972160 07:24:40 INFO - PROCESS | 18234 | 07:27:43 INFO - PROCESS | 18234 | Cycle 1(1): loaded http://localhost:45064/tests/dromaeo/cssquery-yui.html (next: http://localhost:45064/tests/dromaeo/cssquery-dojo.html) 07:27:43 INFO - PROCESS | 18234 | RSS: Main: 230510592 07:27:43 INFO - PROCESS | 18234 | 07:27:43 INFO - PROCESS | 18234 | __start_tp_report 07:27:43 INFO - PROCESS | 18234 | _x_x_mozilla_page_load 07:27:43 INFO - PROCESS | 18234 | _x_x_mozilla_page_load_details 07:27:43 INFO - PROCESS | 18234 | |i|pagename|runs| 07:27:43 INFO - PROCESS | 18234 | |0;dojo.html;3110.533419987002;3127.2025633463463;3171.381580591784;3179.2687681833177;3207.791493552919;4984.25236214568;5035.647504674675;5062.493750624935;5080.542751152396;5090.440051594326;5041.798328066873;5072.644914855961;5080.593552515799;5081.136206844836;5153.1239689252825;4532.161550113239;4546.749928753918;4557.430321209848;4571;4700.623950084002;4655.324977878206;4660.277656963159;4705.670603057787;4713.952860471386;4718.882027949295;4599.448066232074;4636.2581986882105;4704.506026867198;4719.693219940693;4721.787519561628;4676.7427791471455;4691.319758634979;4697.929531057037;4711.057788442291;4742;4673.182193116225;4674.976625116887;4677.111348843709;4682.531746825324;4719.433667959866;4854.247591623304;4913.975430122862;4935.851924442272;5006.849794506171;5015.699058056528;5455.536279416255;5471.316085489314;5471.644343117685;5479;5481.479259470344;5417.4311697272005;5496.0931446311315;5500.791894200899;5508.421615730371;5509.586780991402;5073.594112471031;5074.594032477393;5108.846734597968;5165.070287348276;5177.068127736969;5572.58205634579;5582.720863956786;5585;5585.888282234332;5587.357453892854;5243.973780131075;5280.234366016906;5360.383555891122;5371.355437347544;5375.596830237748;5418.485243901823;5453.727313634382;5472.261244731911;5472.50747432733;5518.91721624176;5337.332833395825;5387.353517577837;5399.082156033483;5399.37907140676;5445.9652665993335;5349.866253343697;5399.568034557226;5406.026915155231;5406.972965135149;5432.185172224198;4252.787360631956;4262.87211383659;4266;4292.12011537634;4309.202797482476;3838.692904567628;3852.5954774748807;3856.672182864488;3888.8444462221196;3893.610638936084;5000.574951129195;5056.924146137811;5115.897682046412;5135.306733590992;5144.768485418165;5339.172428273624;5349.545288650431;5357.330333708286;5362;5386.407495175527;5064.265681476165;5067.949320506821;5070.2141168119;5077.060743762416;5110.948890511122;4604.355390245369;4687.1328804171335;4696.436427628706;4769.284607308862;4777.355057067251;5708.543316534668;5709.514691251207;5711.228984087178;5715.828525144252;5718.79984200551;5429.809956651498;5435.157550579666;5438.646487978427;5439.48324909133;5442.673439593637;5540.944590554042;5644.266245388073;5662.263905692398;5689.784115271444;5783.595148339744;5369.812056578001;5376.650517716336;5382.892342153214;5403.189521571796;5406.702631355313;5446.264754258124;5478.839436115894;5479.945200548103;5480.835574932758;5528.530074943675;5236.136037553913;5278.155495120763;5299;5382.946170538245;5417.972910135424;5302.496262855023;5309.2301616266195;5325.946740532545;5332.093544097435;5344;5143.819966301162;5247.55395791362;5248.291480650063;5251.343582052244;5280.313559237275;5276.261323414648;5295.973520132375;5376.7580458878665;5426.647267927572;5444.8094316698725;5228.189630607262;5247.790088396421;5256.658317209369;5262.500062494057;5264.842054738364 07:27:43 INFO - PROCESS | 18234 | |1;ext.html;490.6246721258237;496.6275293529853;516.5144763921913;526.2001757328861;552.5220684108245;33976.320473590546;34333.31333373331;34357.1410714732;34391;34429.31141377171;37168.81415592918;37707.43438848413;37716.62283377165;37718.24563508728;37723.81138094312;8249.25756681897;8490.617922193485;8494.150584941519;8495.575221238912;8497.66009359628;8207.835843283161;8301.83396332073;8316.002079750438;8338.374621903382;8340.541270230135;8499.61751721171;8588.312934965219;8614.612342444574;8621.827563448727;8630.611622477003;8453.239208471236;8531.146885311482;8537.74386768401;8558.614862331178;8561.914380856175;8365.539895305756;8497.36269779769;8497.702580409656;8503.617337219777;8504.957475212646;36132;36372.09069773251;36618.63381366179;36652.450213246826;36669.63330366689;2808.4804311202492;2883.408901175275;2890.089621769136;3021.214484234093;3240.7731458797894;28158.577621335695;28308.575371369447;28439.857800710863;28848.711512884813;29271.41457170866;3852.84588616455;3859.7684138951754;3934.8426062957446;3947.921041579181;4053.067794407273;197250;197903;198575;198774;198889;49053.509464905605;50150.74924625354;54179.45820541823;55829.7208513963;55839;59934.400655993755;60603;60906.69546652238;60916.39083609107;60931;12428.440720167615;12669.303188324546;12671.683207919692;12687.429065692066;12693.682657933625;8327.916720832834;8584.184502472255;9312.394694344846;9320.161185493338;9323.72028839136;18106.63786724258;18373.26506939734;18496.537586560175;18552.907235464005;18610.720839187154;6641.302663220389;6801.625910574966;6823.69293381799;6959.19969203548;6984.720611175496;682.2018238660779;787.22851605427;788.9566073865992;792.1128336263422;819.971301004462;24516.877415613166;24841.378965526008;25020;25108;25126.623100653505;891.9241864441466;901;908.6047569307373;973.3673112476805;1029.1869423155624;12813.679658008625;13515.729685406237;15526.146061966474;15622.375104995901;15895.284712187979;371317;377694;380668;381187;381734;51660.22509662358;52084;52398;52444.475555244724;52535.47464525306;1153.976920461603;1158.901493373056;1177.8998785103363;1181.9822702659467;1191.5233906437495;27260.727392725817;28314.43371132607;28400.57399139056;28595;28663.283417914718;41523.37714934218;42130.157396852504;42156.36765448582;42201.36697949472;42211;286073;287945;289500;290028;290605;26313.4737305249;29472.263193420335;29504.852475737483;30118.94583689648;30144;33955.66044339525;35251.47122793109;35495.290094198484;35565.288694225455;35571.46642800412;31370.843145784125;32120.67879321177;35933.460998085575;36708.26583468369;37173.814130929175;31366.65801609051;33318.83340583282;33967.83016084904;33991.66008339885;34151.829240853636;33834.66165338315;36355.27289454249;36781.44827827531;36876;37063.25873482569;27847.72152278451;30869.228269293446;31484;31595;31622.367552648357;23943.450744358517;24337;24971.250862474153;25148.371290717147;25872.611910820975 07:27:43 INFO - PROCESS | 18234 | |2;jquery.html;335.43479237484826;342.42814499785374;344.5916588842222;345.25252827628185;345.4265918575166;13531.59405217845;13948.79076813846;14736.852631473683;14787.33456994435;16072.276747546344;12862.93568532156;13781.793273100911;15817.762733559006;15862.286197121128;15899.28453219605;4726.38556987592;4916.164252077156;4920.065187614342;4925.70445773253;4926.876828079308;3607.7113830893463;3738.1402277476195;4878.512148785128;4913.557779799818;6566.376194261537;6591.274959754423;6811.829704257384;6855.1088358513325;6857.485688573352;6870.690818913161;6818.863622727543;6833.453323734139;6849;6879.828004299908;6882.827929301758;6350.523710721714;6587;6590.868182636368;6594;6597.274299827015;19167.904160479247;20081.29715459952;20630.690539641917;20648.896755516125;21137.260195893225;2131.5843410534953;2242.439390152462;2251.6509940959177;2289.7252329720372;2291.51878105598;13437.529686460926;14048.157110573398;14202.147871127661;14545;14601.342939567745;1905.1712505060204;1963.4993076765334;1964.7052942058806;1996.610660921121;2011.4770159758568;60915.39084609142;61175;63292.36707632911;63439.68280158616;64860.67569662121;14181.85818141826;14578.927105364406;14581.85418145805;14601.415943362359;14611.561653150422;22707.318780436613;22996;23061.423464413525;23158.305250842503;23252.53494930092;7662.4253181011645;7677.808054798675;7866.646000929972;7983.401244906655;8010.279074883289;6516.609003459807;6539.738410463623;6581.670916454158;6590.967045164839;6671.366220209073;6573.704183311763;7420.814479637944;7440.218777028443;7555.697772089165;7617.362267112598;2386.773256540626;2749.3676454415595;2803.6074949507083;2804.340979869729;2805.5370863807652;779.6140910249463;803.325206826257;842.3934766967774;873.0047745570055;886.6674996876171;13129.934350328187;14680.926595366955;14942.327595258239;15078.396864125312;16242.75635865463;807.4993504027541;833.3874602167402;840.9117042710427;872.7207293665966;906.1980147569449;8384.916150838413;8854.822903541894;8858.766550209128;8859.512726800089;9046.909530904739;461712;465096;512881;518158;520204;68528.31471685319;72632.27367726361;72682;73352;75449.6227518859;899.1278459893892;920.7237828651512;931.9627214911328;1026.8305729554688;1045.7333379988054;10878.619248326271;13847.79228311556;13918;14066;14105.435782568582;32963.835180823946;33026.33947321088;33553.32893342071;33884.32231355408;33920.491192631634;42733.97426357497;42910.141797163255;44220;44506.55493445024;44753.77623111864;6461.515386345949;6493.350664933658;6515.087887695631;6570.342965703391;6840.828979275558;8742;10564.366138031743;10834.837477438003;10867.782644347228;11101.888981110085;9229.261659067393;9315.906840931504;9330.580123894306;9466;9549.61801527959;6908.721886451022;8878.245349145136;9339.439633621732;9532.809343813224;9728.416295022322;4903.779329930233;6352.920003599307;8923.33075019389;9415.529223538659;9947.403155810674;7093.680784364819;7129.607871567114;7154.678039488132;7155.606441645759;7164.176119746296;7905.920940790518;8844.690435834715;9256.907430925605;9436.433813971184;9520.476373799507 07:27:43 INFO - PROCESS | 18234 | |3;mootools.html;1093.436880006797;1292.3279894454884;1299.6425982854714;1337;1524.4359586952828;6938.479614028949;7630.9236907630975;7799.4930329528615;7802.765917022484;7803.219678032194;7648.349890259321;7840;7840.4511684182135;7841.098273698526;7848.175941526129;1972.260402349119;2034.1659919433037;2200.6588978708246;2244.394013616327;2265.694131292279;2225.2434172381386;2236.1279101150562;2236.709227800392;2237.9776202238013;2247.2359397804744;2187.103287652063;2235.765244649313;2237.1387015998876;2238.4292005538564;2239.4177513846435;2215.091812356926;2216.9556608867815;2222.144474377368;2258.8757618330983;2264.637657974716;2189.0477642225524;2190.868547887132;2210.9889450552646;2212.5906707259046;2251.043306594691;7785.766427007142;7850.450468467209;7853.96073019637;7856.096548896836;7874.803129921741;4608.539146085398;4694.108119457293;4706.435227772655;4741.57325840676;4741.691790033637;2966.1249931270327;3035.1501579557757;3079.1532328609587;3081.383723255358;3106.7980581262145;949.8955114937352;950.1543626172712;973.3429934793986;995.6415690351467;1005.8038682456923;10537.315074520131;10588.470576471145;10607.416592087433;10608.840867386996;10613.46932653372;4006.2187873364996;4087.754734715867;4109.054917368962;4132.214879172948;4190.643795277436;8305.46014509055;8458.788530286793;8480.830383392298;8489.4481858679;8494.320454363637;4590.908181836345;4605.447346318463;4612.76936153191;4615.169269531517;4616.446026476777;4240.957590424056;4259.339802330644;4261.531231564525;4261.680373971964;4263.722858014219;3270.149761062141;3283.474644056987;3319.751018673561;3511.5610548681416;3590.6893983695763;1031.4327120083924;1077.5258886090096;1086.9891301087046;1090.0625462102585;1096.8354746788045;971.820213260549;993.5677980078689;1267.7781388257017;1274.9107562470724;1308.7971364438527;7425.777226683208;7452.403807695371;7465.70137194517;7467.775966720898;7469;1004.1966426858484;1013.4578000769553;1026.1329176845554;1035.3942943378208;1045.9633912813167;5589.301337332833;5662.660240385508;5670.716464176775;5674.574406919498;5683.573731970118;9308.906910930804;9332.533373331305;9346.906530934604;9622;9915.603375865028;9424.90575094254;9591.616335346647;9707.611695532241;9708.6116555337;9711.27165462579;7148.892766608505;7278.8180295491975;7284.6721897514735;7385.409167266605;7480;7151.53515021522;7257.564546127249;7258.818529536804;7270.89093663606;7273.418126549969;8506.829863402574;8679.609417576097;8700.60847261862;8725.563721814011;8864.601092950703;8876.556172191495;8955.59699813523;9034.27725781949;9130.726078217664;9134.497602631653;6831.760888368884;6956.060931774348;6960.930390696029;6983.790486285419;6985.301469852974;6704.128463299739;6865.485088618274;7248.710051598088;7443.627818609156;7460.776176714708;6871.381575658214;6934.479914006369;7003.894941575779;7012.719491220294;7113;6892;6914.0666010088;6922.653867306513;6924.203716572457;7004.229534751072;6961.164660240804;6979.092717946634;6981.301869812978;6985.895211571932;6995.510314278155;6201.844953876189;6351.07909353132;6377.553571249968;6452.064450654722;6459.9031014533875;6602.735890564323;6604.5046621502615;6614;6618.536702430783;6625 07:27:43 INFO - PROCESS | 18234 | |4;prototype.html;311.1257366799294;319.49832809104714;319.571773823077;320.0781748564134;321.48080849428163;5620.606557540974;5683.318001839774;5731.598788084836;5793.59444838861;5794.5943783935145;5619.943800561993;5647.774089036434;5740.167675687023;5748.109043098327;5760.395158508359;4168.228877657643;4410.904820210399;4425.867223983286;4426.269665505204;4437.755923424211;4225.767582782945;4349.108432771274;4443.666724995638;4454.599086082252;4465.843695470659;4392.8023238954165;4403.361512580674;4409.360642706805;4410.31640095784;4425.048614547872;4422.402975598286;4423.783459548617;4427.712198707074;4427.778611069466;4428.202923473774;3880.1463677990796;3885.164689591723;3888.2612303662213;3890.396988466792;3890.7665540067687;5348.732563371816;5445.809396671137;5497.065498865202;5505.944940550583;5515.779368825242;5010.123228435009;5014.323066386064;5017.222330538772;5027.120253955543;5035.521625445577;5751.223584816038;5849.795257166022;6080.908786368208;6092.51259899207;6097.390260973912;4044.4539987101657;4072.0837811492474;4134.813933372975;4147.605977432139;4158.459400277945;6240.251169859601;6335.144755458046;6348.904766428507;6352.174217351715;6356.2054743157105;4185.24665560196;4186.476690413699;4188.078622703;4189.811458484375;4192.161567686475;4135.60711732385;4210.6841986851105;4230.746155230696;4243.236217480821;4243.639290660329;4919.77860996256;4923.040007198633;4928.433230178503;4930.926036109461;4936.8398426370495;6055.182550355646;6138.1099740537375;6175.69121543921;6176.8764624707255;6193.349698281706;1488.1666266890577;1535.0405996252343;1537.907725536449;1537.9231038448033;1538.2001359293329;1017.4200705597739;1022.085233715835;1024.2676486312173;1025.8461230815437;1045.8431235314763;5886.941130588725;5892.5285977122585;5894.970525147347;5895.793647222326;5904.586678932434;6280.152179455807;6290.370962903673;6290.55966082379;6294.961331380363;6299.874002519924;5890.293164820163;5891.646501209942;5895.4399332063385;5899.941000590025;5907.527397808251;3238.158078899503;3372.8819491317686;3375.8987230383127;3376.4260075787174;3378.408778463808;6505.4795616350575;6517.543771936013;6540.6729663516635;6549.672516374258;6550.312217217219;6407.967960160169;6414.807555773335;6421.197350331208;6422.58253213549;6423.646699431482;6379.457746091634;6513.381228783258;6549.6070235786;6556.180477440224;6559.442447392025;6049.667268300285;6101.908471372844;6128;6261.4364707174755;6264.279607844974;6200.3179650237535;6202.41077097675;6211.3478084802255;6263.342349053284;6266.655333956676;6562.77030303937;6571.638559879252;6581.868362632625;6592.604443733391;6596.670166491752;4188.141431006576;4295.205387003414;4296.505901821206;4307.763073031013;4328.350747387917;6285.308616052139;6300.086487459384;6303.306636270098;6306.9684651576445;6310.242770867525;6122.510199184144;6128.571000029955;6133.233345831771;6137.048757442603;6142.078688196806;5978.581499295182;6101.877962440815;6109.991851344478;6117.1741814856205;6119.265688117454;5976.850578735566;6002.609830361012;6006.15913772081;6010.398960103955;6015.669138197266;6132.264128304632;6132.509399247961;6133;6134.141220229082;6138.57030007913;5876.814085222711;5995.940040599538;6002.309734380602;6005.309389420273;6009.639421634716 07:27:43 INFO - PROCESS | 18234 | |5;yui.html;711.2318695808526;720.8738470767614;729.2525161709244;732.7655150351886;743.7657138001529;12268;12424.937875310634;12430.93784531076;12489;12496.187747796386;11149.108071354292;11192.328460292389;11219.943900280508;11230.438478076105;11235.943820280887;500.31207090250905;508.5626361329254;636.2714691678026;645.2901808011185;655.6131882189508;566.5043087298614;573.2662192393743;575.821495336447;576.1357963055417;576.1645613859899;611.10778263735;612.1368869893452;612.3325575123115;612.6599737145882;614.4193736918613;526.463007732113;532.1193424881847;613.5705006495449;614.9815505534841;626.4299487466384;447.52562283979086;447.8499702599633;447.8544473046273;448.206674186691;449.3888311895819;11069.446527673585;11092.667219983414;11102.222844400896;11109.666709998713;11156.944215278952;11772.882271177265;12114.575989840314;12291.631251062483;12415.255084694947;12448.564300249447;10112.848307275397;10123.088921997056;10243.436610986393;10326.793464130751;10388.896111038868;3519.419295816187;3576.5886923003927;3592.6227746086547;3595.514605528246;3599.6760291573883;44024.339634905504;44390.112197755865;46193.5380646196;46962.53037469616;47253.76373118113;9618.615255389846;9638.710838674851;9650.179734722627;9939.155171810333;10130.240231982483;15887.602809929613;16013.039217646978;16022.599435014217;16054;16065;7447.404207663374;7457.7016919323705;7754.302112809874;7763.534187948741;7910.564918929399;4381;4442.933355999663;4466.642668586505;4505.324201369755;4535.25168347219;2917.0957003329036;2932.4428358611794;2936.0751363320487;2952.320966177791;2955.3350496138196;538.9380221274525;540.8080131553321;543.2250517947278;550.5540512185142;560.7476635514035;505.03286206914083;539.323149447441;614.5483069943588;622.6150823306958;632.5445679111033;8803.823923521622;9092.181703646704;9112.95443522778;9252.491112988715;9620.422774633404;462.28807636239816;494.49314452686286;515.0497332421676;578.3435800366614;647.8749700980791;3869.4195870619633;3871.322518559241;4000.3599424092004;4006.318925782624;4097.467329247179;56384;56735.43264567384;57101;57101.428985710445;57279.14081288784;48404.75797620989;48589.514104859205;49177;49331;49421.752891235315;43438.13123737508;43882.12235755267;44377;44644.330335045;44820.3276950846;8331.12523185081;8382.911565709679;8458.027326857244;8709.825803484022;8824.249938755022;33145.33709325752;33431.16422089467;33459.83270083634;34915.82542087273;35086;41414.58585414107;42323.57676423196;42764;44052;44080.559194407644;10373.896261037293;10529.420881851265;10580.470976450993;10692.786144276915;10753.408562529135;11925.284482931052;11971.820422693492;12024.579139730067;12126.696832579257;12661.810072849099;11278.266912650652;11507.654770356903;11561.710957226136;11642.41787910618;11943.343116128697;10866.185036122164;11330.716732081764;11381;11446.542138314375;11742.941285293518;10762.784744305227;11141.554337826396;11164.385958772345;11420.31478111316;11465.828012579652;8881.42270752399;8895.154960278764;9160.816783664422;9233.861492077758;9255.629774809202;8632.093630168742;9031.774205644911;9309.813803724022;9419.529023548932;9632.855507167258 07:27:43 INFO - PROCESS | 18234 | __end_tp_report 07:27:43 INFO - PROCESS | 18234 | __start_cc_report 07:27:43 INFO - PROCESS | 18234 | _x_x_mozilla_cycle_collect,782 07:27:43 INFO - PROCESS | 18234 | __end_cc_report 07:27:43 INFO - PROCESS | 18234 | __startTimestamp1453735663611__endTimestamp 07:27:43 INFO - PROCESS | 18234 | 07:27:43 INFO - PROCESS | 18234 | ------- Summary: start ------- 07:27:43 INFO - PROCESS | 18234 | Number of tests: 6 07:27:43 INFO - PROCESS | 18234 | 07:27:43 INFO - PROCESS | 18234 | [#0] dojo.html Cycles:165 Average:5072.25 Median:5251.34 stddev:532.95 (10.1%) stddev-sans-first:511.88 07:27:43 INFO - PROCESS | 18234 | Values: 3110.5 3127.2 3171.4 3179.3 3207.8 4984.3 5035.6 5062.5 5080.5 5090.4 5041.8 5072.6 5080.6 5081.1 5153.1 4532.2 4546.7 4557.4 4571.0 4700.6 4655.3 4660.3 4705.7 4714.0 4718.9 4599.4 4636.3 4704.5 4719.7 4721.8 4676.7 4691.3 4697.9 4711.1 4742.0 4673.2 4675.0 4677.1 4682.5 4719.4 4854.2 4914.0 4935.9 5006.8 5015.7 5455.5 5471.3 5471.6 5479.0 5481.5 5417.4 5496.1 5500.8 5508.4 5509.6 5073.6 5074.6 5108.8 5165.1 5177.1 5572.6 5582.7 5585.0 5585.9 5587.4 5244.0 5280.2 5360.4 5371.4 5375.6 5418.5 5453.7 5472.3 5472.5 5518.9 5337.3 5387.4 5399.1 5399.4 5446.0 5349.9 5399.6 5406.0 5407.0 5432.2 4252.8 4262.9 4266.0 4292.1 4309.2 3838.7 3852.6 3856.7 3888.8 3893.6 5000.6 5056.9 5115.9 5135.3 5144.8 5339.2 5349.5 5357.3 5362.0 5386.4 5064.3 5067.9 5070.2 5077.1 5110.9 4604.4 4687.1 4696.4 4769.3 4777.4 5708.5 5709.5 5711.2 5715.8 5718.8 5429.8 5435.2 5438.6 5439.5 5442.7 5540.9 5644.3 5662.3 5689.8 5783.6 5369.8 5376.7 5382.9 5403.2 5406.7 5446.3 5478.8 5479.9 5480.8 5528.5 5236.1 5278.2 5299.0 5382.9 5418.0 5302.5 5309.2 5325.9 5332.1 5344.0 5143.8 5247.6 5248.3 5251.3 5280.3 5276.3 5296.0 5376.8 5426.6 5444.8 5228.2 5247.8 5256.7 5262.5 5264.8 07:27:43 INFO - PROCESS | 18234 | 07:27:43 INFO - PROCESS | 18234 | [#1] ext.html Cycles:180 Average:44498.47 Median:36688.95 stddev:78464.91 (213.9%) stddev-sans-first:78615.46 07:27:43 INFO - PROCESS | 18234 | Values: 490.6 496.6 516.5 526.2 552.5 33976.3 34333.3 34357.1 34391.0 34429.3 37168.8 37707.4 37716.6 37718.2 37723.8 8249.3 8490.6 8494.2 8495.6 8497.7 8207.8 8301.8 8316.0 8338.4 8340.5 8499.6 8588.3 8614.6 8621.8 8630.6 8453.2 8531.1 8537.7 8558.6 8561.9 8365.5 8497.4 8497.7 8503.6 8505.0 36132.0 36372.1 36618.6 36652.5 36669.6 2808.5 2883.4 2890.1 3021.2 3240.8 28158.6 28308.6 28439.9 28848.7 29271.4 3852.8 3859.8 3934.8 3947.9 4053.1 197250.0 197903.0 198575.0 198774.0 198889.0 49053.5 50150.7 54179.5 55829.7 55839.0 59934.4 60603.0 60906.7 60916.4 60931.0 12428.4 12669.3 12671.7 12687.4 12693.7 8327.9 8584.2 9312.4 9320.2 9323.7 18106.6 18373.3 18496.5 18552.9 18610.7 6641.3 6801.6 6823.7 6959.2 6984.7 682.2 787.2 789.0 792.1 820.0 24516.9 24841.4 25020.0 25108.0 25126.6 891.9 901.0 908.6 973.4 1029.2 12813.7 13515.7 15526.1 15622.4 15895.3 371317.0 377694.0 380668.0 381187.0 381734.0 51660.2 52084.0 52398.0 52444.5 52535.5 1154.0 1158.9 1177.9 1182.0 1191.5 27260.7 28314.4 28400.6 28595.0 28663.3 41523.4 42130.2 42156.4 42201.4 42211.0 286073.0 287945.0 289500.0 290028.0 290605.0 26313.5 29472.3 29504.9 30118.9 30144.0 33955.7 35251.5 35495.3 35565.3 35571.5 31370.8 32120.7 35933.5 36708.3 37173.8 31366.7 33318.8 33967.8 33991.7 34151.8 33834.7 36355.3 36781.4 36876.0 37063.3 27847.7 30869.2 31484.0 31595.0 31622.4 23943.5 24337.0 24971.3 25148.4 25872.6 07:27:43 INFO - PROCESS | 18234 | 07:27:43 INFO - PROCESS | 18234 | [#2] jquery.html Cycles:180 Average:26872.97 Median:290559.70 stddev:81145.04 (27.9%) stddev-sans-first:81348.20 07:27:43 INFO - PROCESS | 18234 | Values: 335.4 342.4 344.6 345.3 345.4 13531.6 13948.8 14736.9 14787.3 16072.3 12862.9 13781.8 15817.8 15862.3 15899.3 4726.4 4916.2 4920.1 4925.7 4926.9 3607.7 3738.1 4878.5 4913.6 6566.4 6591.3 6811.8 6855.1 6857.5 6870.7 6818.9 6833.5 6849.0 6879.8 6882.8 6350.5 6587.0 6590.9 6594.0 6597.3 19167.9 20081.3 20630.7 20648.9 21137.3 2131.6 2242.4 2251.7 2289.7 2291.5 13437.5 14048.2 14202.1 14545.0 14601.3 1905.2 1963.5 1964.7 1996.6 2011.5 60915.4 61175.0 63292.4 63439.7 64860.7 14181.9 14578.9 14581.9 14601.4 14611.6 22707.3 22996.0 23061.4 23158.3 23252.5 7662.4 7677.8 7866.6 7983.4 8010.3 6516.6 6539.7 6581.7 6591.0 6671.4 6573.7 7420.8 7440.2 7555.7 7617.4 2386.8 2749.4 2803.6 2804.3 2805.5 779.6 803.3 842.4 873.0 886.7 13129.9 14680.9 14942.3 15078.4 16242.8 807.5 833.4 840.9 872.7 906.2 8384.9 8854.8 8858.8 8859.5 9046.9 461712.0 465096.0 512881.0 518158.0 520204.0 68528.3 72632.3 72682.0 73352.0 75449.6 899.1 920.7 932.0 1026.8 1045.7 10878.6 13847.8 13918.0 14066.0 14105.4 32963.8 33026.3 33553.3 33884.3 33920.5 42734.0 42910.1 44220.0 44506.6 44753.8 6461.5 6493.4 6515.1 6570.3 6840.8 8742.0 10564.4 10834.8 10867.8 11101.9 9229.3 9315.9 9330.6 9466.0 9549.6 6908.7 8878.2 9339.4 9532.8 9728.4 4903.8 6352.9 8923.3 9415.5 9947.4 7093.7 7129.6 7154.7 7155.6 7164.2 7905.9 8844.7 9256.9 9436.4 9520.5 07:27:43 INFO - PROCESS | 18234 | 07:27:43 INFO - PROCESS | 18234 | [#3] mootools.html Cycles:180 Average:5430.44 Median:6609.25 stddev:2870.93 (43.4%) stddev-sans-first:2860.47 07:27:43 INFO - PROCESS | 18234 | Values: 1093.4 1292.3 1299.6 1337.0 1524.4 6938.5 7630.9 7799.5 7802.8 7803.2 7648.3 7840.0 7840.5 7841.1 7848.2 1972.3 2034.2 2200.7 2244.4 2265.7 2225.2 2236.1 2236.7 2238.0 2247.2 2187.1 2235.8 2237.1 2238.4 2239.4 2215.1 2217.0 2222.1 2258.9 2264.6 2189.0 2190.9 2211.0 2212.6 2251.0 7785.8 7850.5 7854.0 7856.1 7874.8 4608.5 4694.1 4706.4 4741.6 4741.7 2966.1 3035.2 3079.2 3081.4 3106.8 949.9 950.2 973.3 995.6 1005.8 10537.3 10588.5 10607.4 10608.8 10613.5 4006.2 4087.8 4109.1 4132.2 4190.6 8305.5 8458.8 8480.8 8489.4 8494.3 4590.9 4605.4 4612.8 4615.2 4616.4 4241.0 4259.3 4261.5 4261.7 4263.7 3270.1 3283.5 3319.8 3511.6 3590.7 1031.4 1077.5 1087.0 1090.1 1096.8 971.8 993.6 1267.8 1274.9 1308.8 7425.8 7452.4 7465.7 7467.8 7469.0 1004.2 1013.5 1026.1 1035.4 1046.0 5589.3 5662.7 5670.7 5674.6 5683.6 9308.9 9332.5 9346.9 9622.0 9915.6 9424.9 9591.6 9707.6 9708.6 9711.3 7148.9 7278.8 7284.7 7385.4 7480.0 7151.5 7257.6 7258.8 7270.9 7273.4 8506.8 8679.6 8700.6 8725.6 8864.6 8876.6 8955.6 9034.3 9130.7 9134.5 6831.8 6956.1 6960.9 6983.8 6985.3 6704.1 6865.5 7248.7 7443.6 7460.8 6871.4 6934.5 7003.9 7012.7 7113.0 6892.0 6914.1 6922.7 6924.2 7004.2 6961.2 6979.1 6981.3 6985.9 6995.5 6201.8 6351.1 6377.6 6452.1 6459.9 6602.7 6604.5 6614.0 6618.5 6625.0 07:27:43 INFO - PROCESS | 18234 | 07:27:43 INFO - PROCESS | 18234 | [#4] prototype.html Cycles:180 Average:5081.61 Median:5822.19 stddev:1545.81 (26.6%) stddev-sans-first:1508.10 07:27:43 INFO - PROCESS | 18234 | Values: 311.1 319.5 319.6 320.1 321.5 5620.6 5683.3 5731.6 5793.6 5794.6 5619.9 5647.8 5740.2 5748.1 5760.4 4168.2 4410.9 4425.9 4426.3 4437.8 4225.8 4349.1 4443.7 4454.6 4465.8 4392.8 4403.4 4409.4 4410.3 4425.0 4422.4 4423.8 4427.7 4427.8 4428.2 3880.1 3885.2 3888.3 3890.4 3890.8 5348.7 5445.8 5497.1 5505.9 5515.8 5010.1 5014.3 5017.2 5027.1 5035.5 5751.2 5849.8 6080.9 6092.5 6097.4 4044.5 4072.1 4134.8 4147.6 4158.5 6240.3 6335.1 6348.9 6352.2 6356.2 4185.2 4186.5 4188.1 4189.8 4192.2 4135.6 4210.7 4230.7 4243.2 4243.6 4919.8 4923.0 4928.4 4930.9 4936.8 6055.2 6138.1 6175.7 6176.9 6193.3 1488.2 1535.0 1537.9 1537.9 1538.2 1017.4 1022.1 1024.3 1025.8 1045.8 5886.9 5892.5 5895.0 5895.8 5904.6 6280.2 6290.4 6290.6 6295.0 6299.9 5890.3 5891.6 5895.4 5899.9 5907.5 3238.2 3372.9 3375.9 3376.4 3378.4 6505.5 6517.5 6540.7 6549.7 6550.3 6408.0 6414.8 6421.2 6422.6 6423.6 6379.5 6513.4 6549.6 6556.2 6559.4 6049.7 6101.9 6128.0 6261.4 6264.3 6200.3 6202.4 6211.3 6263.3 6266.7 6562.8 6571.6 6581.9 6592.6 6596.7 4188.1 4295.2 4296.5 4307.8 4328.4 6285.3 6300.1 6303.3 6307.0 6310.2 6122.5 6128.6 6133.2 6137.0 6142.1 5978.6 6101.9 6110.0 6117.2 6119.3 5976.9 6002.6 6006.2 6010.4 6015.7 6132.3 6132.5 6133.0 6134.1 6138.6 5876.8 5995.9 6002.3 6005.3 6009.6 07:27:43 INFO - PROCESS | 18234 | 07:27:43 INFO - PROCESS | 18234 | [#5] yui.html Cycles:180 Average:13236.38 Median:447.69 stddev:15397.58 (3439.4%) stddev-sans-first:15412.04 07:27:43 INFO - PROCESS | 18234 | Values: 711.2 720.9 729.3 732.8 743.8 12268.0 12424.9 12430.9 12489.0 12496.2 11149.1 11192.3 11219.9 11230.4 11235.9 500.3 508.6 636.3 645.3 655.6 566.5 573.3 575.8 576.1 576.2 611.1 612.1 612.3 612.7 614.4 526.5 532.1 613.6 615.0 626.4 447.5 447.8 447.9 448.2 449.4 11069.4 11092.7 11102.2 11109.7 11156.9 11772.9 12114.6 12291.6 12415.3 12448.6 10112.8 10123.1 10243.4 10326.8 10388.9 3519.4 3576.6 3592.6 3595.5 3599.7 44024.3 44390.1 46193.5 46962.5 47253.8 9618.6 9638.7 9650.2 9939.2 10130.2 15887.6 16013.0 16022.6 16054.0 16065.0 7447.4 7457.7 7754.3 7763.5 7910.6 4381.0 4442.9 4466.6 4505.3 4535.3 2917.1 2932.4 2936.1 2952.3 2955.3 538.9 540.8 543.2 550.6 560.7 505.0 539.3 614.5 622.6 632.5 8803.8 9092.2 9113.0 9252.5 9620.4 462.3 494.5 515.0 578.3 647.9 3869.4 3871.3 4000.4 4006.3 4097.5 56384.0 56735.4 57101.0 57101.4 57279.1 48404.8 48589.5 49177.0 49331.0 49421.8 43438.1 43882.1 44377.0 44644.3 44820.3 8331.1 8382.9 8458.0 8709.8 8824.2 33145.3 33431.2 33459.8 34915.8 35086.0 41414.6 42323.6 42764.0 44052.0 44080.6 10373.9 10529.4 10580.5 10692.8 10753.4 11925.3 11971.8 12024.6 12126.7 12661.8 11278.3 11507.7 11561.7 11642.4 11943.3 10866.2 11330.7 11381.0 11446.5 11742.9 10762.8 11141.6 11164.4 11420.3 11465.8 8881.4 8895.2 9160.8 9233.9 9255.6 8632.1 9031.8 9309.8 9419.5 9632.9 07:27:43 INFO - PROCESS | 18234 | -------- Summary: end -------- 07:27:43 INFO - PROCESS | 18234 | 07:27:44 INFO - TEST-INFO | 18234: exit 0 07:27:44 INFO - TEST-OK | dromaeo_css | took 1111566ms 07:27:44 INFO - TEST-START | kraken 07:27:44 INFO - operating with platform_type : linux_ 07:27:44 INFO - Initialising browser for kraken test... 07:27:44 INFO - TEST-INFO | started process 18438 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHIFktz/profile http://localhost:45064/getInfo.html) 07:27:47 INFO - PROCESS | 18438 | __metrics Screen width/height:1600/1200 07:27:47 INFO - PROCESS | 18438 | colorDepth:24 07:27:47 INFO - PROCESS | 18438 | Browser inner width/height: 1024/697 07:27:47 INFO - PROCESS | 18438 | __metrics 07:27:48 INFO - PROCESS | 18438 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:27:48 INFO - PROCESS | 18438 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:27:48 INFO - TEST-INFO | 18438: exit 0 07:27:48 INFO - Browser initialized. 07:27:48 INFO - Running cycle 1/1 for kraken test... 07:27:48 INFO - TEST-INFO | started process 18524 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHIFktz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:28:00 INFO - PROCESS | 18524 | RSS: Main: 147742720 07:28:00 INFO - PROCESS | 18524 | 07:28:03 INFO - PROCESS | 18524 | Cycle 1(1): loaded http://localhost:45064/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45064/tests/kraken/driver.html?testName=audio-beat-detection) 07:28:03 INFO - PROCESS | 18524 | RSS: Main: 187113472 07:28:03 INFO - PROCESS | 18524 | 07:28:06 INFO - PROCESS | 18524 | Cycle 1(1): loaded http://localhost:45064/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45064/tests/kraken/driver.html?testName=audio-dft) 07:28:06 INFO - PROCESS | 18524 | RSS: Main: 178294784 07:28:06 INFO - PROCESS | 18524 | 07:28:09 INFO - PROCESS | 18524 | Cycle 1(1): loaded http://localhost:45064/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45064/tests/kraken/driver.html?testName=audio-fft) 07:28:10 INFO - PROCESS | 18524 | RSS: Main: 162422784 07:28:10 INFO - PROCESS | 18524 | 07:28:12 INFO - PROCESS | 18524 | Cycle 1(1): loaded http://localhost:45064/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45064/tests/kraken/driver.html?testName=audio-oscillator) 07:28:13 INFO - PROCESS | 18524 | RSS: Main: 165412864 07:28:13 INFO - PROCESS | 18524 | 07:28:15 INFO - PROCESS | 18524 | Cycle 1(1): loaded http://localhost:45064/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45064/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:28:15 INFO - PROCESS | 18524 | RSS: Main: 166440960 07:28:15 INFO - PROCESS | 18524 | 07:28:18 INFO - PROCESS | 18524 | Cycle 1(1): loaded http://localhost:45064/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45064/tests/kraken/driver.html?testName=imaging-darkroom) 07:28:19 INFO - PROCESS | 18524 | RSS: Main: 168280064 07:28:19 INFO - PROCESS | 18524 | 07:28:22 INFO - PROCESS | 18524 | Cycle 1(1): loaded http://localhost:45064/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45064/tests/kraken/driver.html?testName=imaging-desaturate) 07:28:23 INFO - PROCESS | 18524 | RSS: Main: 168583168 07:28:23 INFO - PROCESS | 18524 | 07:28:26 INFO - PROCESS | 18524 | Cycle 1(1): loaded http://localhost:45064/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45064/tests/kraken/driver.html?testName=json-parse-financial) 07:28:26 INFO - PROCESS | 18524 | RSS: Main: 169078784 07:28:26 INFO - PROCESS | 18524 | 07:28:28 INFO - PROCESS | 18524 | Cycle 1(1): loaded http://localhost:45064/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45064/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:28:28 INFO - PROCESS | 18524 | RSS: Main: 182784000 07:28:28 INFO - PROCESS | 18524 | 07:28:30 INFO - PROCESS | 18524 | Cycle 1(1): loaded http://localhost:45064/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45064/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:28:31 INFO - PROCESS | 18524 | RSS: Main: 181379072 07:28:31 INFO - PROCESS | 18524 | 07:28:33 INFO - PROCESS | 18524 | Cycle 1(1): loaded http://localhost:45064/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45064/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:28:33 INFO - PROCESS | 18524 | RSS: Main: 190427136 07:28:33 INFO - PROCESS | 18524 | 07:28:36 INFO - PROCESS | 18524 | Cycle 1(1): loaded http://localhost:45064/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45064/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:28:36 INFO - PROCESS | 18524 | RSS: Main: 198668288 07:28:36 INFO - PROCESS | 18524 | 07:28:39 INFO - PROCESS | 18524 | Cycle 1(1): loaded http://localhost:45064/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45064/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:28:39 INFO - PROCESS | 18524 | RSS: Main: 194527232 07:28:39 INFO - PROCESS | 18524 | 07:28:41 INFO - PROCESS | 18524 | Cycle 1(1): loaded http://localhost:45064/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45064/tests/kraken/driver.html?testName=ai-astar) 07:28:41 INFO - PROCESS | 18524 | RSS: Main: 254185472 07:28:41 INFO - PROCESS | 18524 | 07:28:41 INFO - PROCESS | 18524 | __start_tp_report 07:28:41 INFO - PROCESS | 18524 | _x_x_mozilla_page_load 07:28:41 INFO - PROCESS | 18524 | _x_x_mozilla_page_load_details 07:28:41 INFO - PROCESS | 18524 | |i|pagename|runs| 07:28:41 INFO - PROCESS | 18524 | |0;ai-astar;110;111;105;109;109;110;111;112;104;112 07:28:41 INFO - PROCESS | 18524 | |1;audio-beat-detection;151;127;157;168;124;156;154;131;174;128 07:28:41 INFO - PROCESS | 18524 | |2;audio-dft;162;163;161;160;161;161;160;162;162;162 07:28:41 INFO - PROCESS | 18524 | |3;audio-fft;74;73;92;97;73;74;76;117;101;74 07:28:41 INFO - PROCESS | 18524 | |4;audio-oscillator;96;96;140;96;97;97;148;96;96;149 07:28:41 INFO - PROCESS | 18524 | |5;imaging-gaussian-blur;109;117;109;110;109;109;109;109;110;110 07:28:41 INFO - PROCESS | 18524 | |6;imaging-darkroom;145;145;145;146;145;145;147;145;145;145 07:28:41 INFO - PROCESS | 18524 | |7;imaging-desaturate;96;96;97;96;96;96;95;96;96;96 07:28:41 INFO - PROCESS | 18524 | |8;json-parse-financial;56;56;56;55;55;55;55;55;73;54 07:28:41 INFO - PROCESS | 18524 | |9;json-stringify-tinderbox;66;68;67;67;67;67;67;67;67;67 07:28:41 INFO - PROCESS | 18524 | |10;stanford-crypto-aes;81;80;80;81;82;82;83;83;81;82 07:28:41 INFO - PROCESS | 18524 | |11;stanford-crypto-ccm;117;113;123;125;126;129;123;114;114;116 07:28:41 INFO - PROCESS | 18524 | |12;stanford-crypto-pbkdf2;152;135;142;142;144;132;150;143;144;145 07:28:41 INFO - PROCESS | 18524 | |13;stanford-crypto-sha256-iterative;70;67;68;67;69;68;70;68;67;68 07:28:41 INFO - PROCESS | 18524 | __end_tp_report 07:28:41 INFO - PROCESS | 18524 | __start_cc_report 07:28:41 INFO - PROCESS | 18524 | _x_x_mozilla_cycle_collect,940 07:28:41 INFO - PROCESS | 18524 | __end_cc_report 07:28:41 INFO - PROCESS | 18524 | __startTimestamp1453735721796__endTimestamp 07:28:41 INFO - PROCESS | 18524 | 07:28:41 INFO - PROCESS | 18524 | ------- Summary: start ------- 07:28:41 INFO - PROCESS | 18524 | Number of tests: 14 07:28:41 INFO - PROCESS | 18524 | 07:28:41 INFO - PROCESS | 18524 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.50 stddev:2.75 (2.5%) stddev-sans-first:2.91 07:28:41 INFO - PROCESS | 18524 | Values: 110.0 111.0 105.0 109.0 109.0 110.0 111.0 112.0 104.0 112.0 07:28:41 INFO - PROCESS | 18524 | 07:28:41 INFO - PROCESS | 18524 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:155.00 stddev:18.14 (11.7%) stddev-sans-first:19.18 07:28:41 INFO - PROCESS | 18524 | Values: 151.0 127.0 157.0 168.0 124.0 156.0 154.0 131.0 174.0 128.0 07:28:41 INFO - PROCESS | 18524 | 07:28:41 INFO - PROCESS | 18524 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 07:28:41 INFO - PROCESS | 18524 | Values: 162.0 163.0 161.0 160.0 161.0 161.0 160.0 162.0 162.0 162.0 07:28:41 INFO - PROCESS | 18524 | 07:28:41 INFO - PROCESS | 18524 | [#3] audio-fft Cycles:10 Average:85.10 Median:74.00 stddev:15.65 (21.2%) stddev-sans-first:16.08 07:28:41 INFO - PROCESS | 18524 | Values: 74.0 73.0 92.0 97.0 73.0 74.0 76.0 117.0 101.0 74.0 07:28:41 INFO - PROCESS | 18524 | 07:28:41 INFO - PROCESS | 18524 | [#4] audio-oscillator Cycles:10 Average:111.10 Median:96.00 stddev:23.97 (25.0%) stddev-sans-first:24.79 07:28:41 INFO - PROCESS | 18524 | Values: 96.0 96.0 140.0 96.0 97.0 97.0 148.0 96.0 96.0 149.0 07:28:41 INFO - PROCESS | 18524 | 07:28:41 INFO - PROCESS | 18524 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:109.50 stddev:2.47 (2.3%) stddev-sans-first:2.59 07:28:41 INFO - PROCESS | 18524 | Values: 109.0 117.0 109.0 110.0 109.0 109.0 109.0 109.0 110.0 110.0 07:28:41 INFO - PROCESS | 18524 | 07:28:41 INFO - PROCESS | 18524 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 07:28:41 INFO - PROCESS | 18524 | Values: 145.0 145.0 145.0 146.0 145.0 145.0 147.0 145.0 145.0 145.0 07:28:41 INFO - PROCESS | 18524 | 07:28:41 INFO - PROCESS | 18524 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 07:28:41 INFO - PROCESS | 18524 | Values: 96.0 96.0 97.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 07:28:41 INFO - PROCESS | 18524 | 07:28:41 INFO - PROCESS | 18524 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:55.50 stddev:5.66 (10.2%) stddev-sans-first:5.99 07:28:41 INFO - PROCESS | 18524 | Values: 56.0 56.0 56.0 55.0 55.0 55.0 55.0 55.0 73.0 54.0 07:28:41 INFO - PROCESS | 18524 | 07:28:41 INFO - PROCESS | 18524 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:0.47 (0.7%) stddev-sans-first:0.33 07:28:41 INFO - PROCESS | 18524 | Values: 66.0 68.0 67.0 67.0 67.0 67.0 67.0 67.0 67.0 67.0 07:28:41 INFO - PROCESS | 18524 | 07:28:41 INFO - PROCESS | 18524 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:82.00 stddev:1.08 (1.3%) stddev-sans-first:1.13 07:28:41 INFO - PROCESS | 18524 | Values: 81.0 80.0 80.0 81.0 82.0 82.0 83.0 83.0 81.0 82.0 07:28:41 INFO - PROCESS | 18524 | 07:28:41 INFO - PROCESS | 18524 | [#11] stanford-crypto-ccm Cycles:10 Average:120.00 Median:123.00 stddev:5.83 (4.7%) stddev-sans-first:6.08 07:28:41 INFO - PROCESS | 18524 | Values: 117.0 113.0 123.0 125.0 126.0 129.0 123.0 114.0 114.0 116.0 07:28:41 INFO - PROCESS | 18524 | 07:28:41 INFO - PROCESS | 18524 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.90 Median:144.00 stddev:5.99 (4.2%) stddev-sans-first:5.37 07:28:41 INFO - PROCESS | 18524 | Values: 152.0 135.0 142.0 142.0 144.0 132.0 150.0 143.0 144.0 145.0 07:28:41 INFO - PROCESS | 18524 | 07:28:41 INFO - PROCESS | 18524 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.14 (1.7%) stddev-sans-first:1.00 07:28:41 INFO - PROCESS | 18524 | Values: 70.0 67.0 68.0 67.0 69.0 68.0 70.0 68.0 67.0 68.0 07:28:41 INFO - PROCESS | 18524 | -------- Summary: end -------- 07:28:41 INFO - PROCESS | 18524 | 07:28:42 INFO - TEST-INFO | 18524: exit 0 07:28:42 INFO - TEST-OK | kraken | took 58389ms 07:28:42 INFO - TEST-START | v8_7 07:28:42 INFO - operating with platform_type : linux_ 07:28:42 INFO - Initialising browser for v8_7 test... 07:28:42 INFO - TEST-INFO | started process 18773 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwsJ6Dy/profile http://localhost:45064/getInfo.html) 07:28:46 INFO - PROCESS | 18773 | __metrics Screen width/height:1600/1200 07:28:46 INFO - PROCESS | 18773 | colorDepth:24 07:28:46 INFO - PROCESS | 18773 | Browser inner width/height: 1024/697 07:28:46 INFO - PROCESS | 18773 | __metrics 07:28:46 INFO - PROCESS | 18773 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:28:46 INFO - PROCESS | 18773 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:28:47 INFO - TEST-INFO | 18773: exit 0 07:28:47 INFO - Browser initialized. 07:28:47 INFO - Running cycle 1/1 for v8_7 test... 07:28:47 INFO - TEST-INFO | started process 18859 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwsJ6Dy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:28:59 INFO - PROCESS | 18859 | RSS: Main: 147755008 07:28:59 INFO - PROCESS | 18859 | 07:29:21 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:45064/tests/v8_7/run.html (next: http://localhost:45064/tests/v8_7/run.html) 07:29:21 INFO - PROCESS | 18859 | RSS: Main: 557760512 07:29:21 INFO - PROCESS | 18859 | 07:29:21 INFO - PROCESS | 18859 | __start_tp_report 07:29:21 INFO - PROCESS | 18859 | _x_x_mozilla_page_load 07:29:21 INFO - PROCESS | 18859 | _x_x_mozilla_page_load_details 07:29:21 INFO - PROCESS | 18859 | |i|pagename|runs| 07:29:21 INFO - PROCESS | 18859 | |0;Richards;167.53224995811695 07:29:21 INFO - PROCESS | 18859 | |1;DeltaBlue;191.27773527161438 07:29:21 INFO - PROCESS | 18859 | |2;Encrypt;280.74115665356544 07:29:21 INFO - PROCESS | 18859 | |3;Decrypt;5324.468085106383 07:29:21 INFO - PROCESS | 18859 | |4;RayTrace;1974.3589743589744 07:29:21 INFO - PROCESS | 18859 | |5;Earley;789.8894154818325 07:29:21 INFO - PROCESS | 18859 | |6;Boyer;12192.77108433735 07:29:21 INFO - PROCESS | 18859 | |7;RegExp;42729.166666666664 07:29:21 INFO - PROCESS | 18859 | |8;Splay;579.2824074074074 07:29:21 INFO - PROCESS | 18859 | |9;NavierStokes;4854.368932038835 07:29:21 INFO - PROCESS | 18859 | __end_tp_report 07:29:21 INFO - PROCESS | 18859 | __startTimestamp1453735761808__endTimestamp 07:29:21 INFO - PROCESS | 18859 | 07:29:21 INFO - PROCESS | 18859 | ------- Summary: start ------- 07:29:21 INFO - PROCESS | 18859 | Number of tests: 10 07:29:21 INFO - PROCESS | 18859 | 07:29:21 INFO - PROCESS | 18859 | [#0] Richards Cycles:1 Average:167.53 Median:167.53 stddev:0.00 (0.0%) 07:29:21 INFO - PROCESS | 18859 | Values: 167.5 07:29:21 INFO - PROCESS | 18859 | 07:29:21 INFO - PROCESS | 18859 | [#1] DeltaBlue Cycles:1 Average:191.28 Median:191.28 stddev:0.00 (0.0%) 07:29:21 INFO - PROCESS | 18859 | Values: 191.3 07:29:21 INFO - PROCESS | 18859 | 07:29:21 INFO - PROCESS | 18859 | [#2] Encrypt Cycles:1 Average:280.74 Median:280.74 stddev:0.00 (0.0%) 07:29:21 INFO - PROCESS | 18859 | Values: 280.7 07:29:21 INFO - PROCESS | 18859 | 07:29:21 INFO - PROCESS | 18859 | [#3] Decrypt Cycles:1 Average:5324.47 Median:5324.47 stddev:0.00 (0.0%) 07:29:21 INFO - PROCESS | 18859 | Values: 5324.5 07:29:21 INFO - PROCESS | 18859 | 07:29:21 INFO - PROCESS | 18859 | [#4] RayTrace Cycles:1 Average:1974.36 Median:1974.36 stddev:0.00 (0.0%) 07:29:21 INFO - PROCESS | 18859 | Values: 1974.4 07:29:21 INFO - PROCESS | 18859 | 07:29:21 INFO - PROCESS | 18859 | [#5] Earley Cycles:1 Average:789.89 Median:789.89 stddev:0.00 (0.0%) 07:29:21 INFO - PROCESS | 18859 | Values: 789.9 07:29:21 INFO - PROCESS | 18859 | 07:29:21 INFO - PROCESS | 18859 | [#6] Boyer Cycles:1 Average:12192.77 Median:12192.77 stddev:0.00 (0.0%) 07:29:21 INFO - PROCESS | 18859 | Values: 12192.8 07:29:21 INFO - PROCESS | 18859 | 07:29:21 INFO - PROCESS | 18859 | [#7] RegExp Cycles:1 Average:42729.17 Median:42729.17 stddev:0.00 (0.0%) 07:29:21 INFO - PROCESS | 18859 | Values: 42729.2 07:29:21 INFO - PROCESS | 18859 | 07:29:21 INFO - PROCESS | 18859 | [#8] Splay Cycles:1 Average:579.28 Median:579.28 stddev:0.00 (0.0%) 07:29:21 INFO - PROCESS | 18859 | Values: 579.3 07:29:21 INFO - PROCESS | 18859 | 07:29:21 INFO - PROCESS | 18859 | [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 07:29:21 INFO - PROCESS | 18859 | Values: 4854.4 07:29:21 INFO - PROCESS | 18859 | -------- Summary: end -------- 07:29:21 INFO - PROCESS | 18859 | 07:29:22 INFO - TEST-INFO | 18859: exit 0 07:29:22 INFO - TEST-OK | v8_7 | took 40009ms 07:29:22 INFO - SUITE-END | took 1209s 07:29:22 INFO - Completed test suite (00:20:10) 07:29:22 INFO - Working with test: dromaeo_css 07:29:22 INFO - Generating results file: dromaeo_css 07:29:22 INFO - Working with test: kraken 07:29:22 INFO - Generating results file: kraken 07:29:22 INFO - javascript benchmark 07:29:22 INFO - Working with test: v8_7 07:29:22 INFO - Generating results file: v8_7 07:29:22 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:29:22 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 07:29:22 INFO - process_Request line: dromaeo_css 6635.87 graph.html#tests=[[72,63,35]] 07:29:22 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:29:22 INFO - process_Request line: kraken 1501.90 graph.html#tests=[[232,63,35]] 07:29:22 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:29:22 INFO - process_Request line: v8_7 18886.44 graph.html#tests=[[230,63,35]] 07:29:22 INFO - RETURN: dromaeo_css: 6635.87 07:29:22 INFO - RETURN: kraken: 1501.90 07:29:22 INFO - RETURN: v8_7: 18886.44 07:29:22 INFO - javascript benchmark 07:29:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3110.533419987002, 3127.2025633463463, 3171.381580591784, 3179.2687681833177, 3207.791493552919, 4984.25236214568, 5035.647504674675, 5062.493750624935, 5080.542751152396, 5090.440051594326, 5041.798328066873, 5072.644914855961, 5080.593552515799, 5081.136206844836, 5153.1239689252825, 4532.161550113239, 4546.749928753918, 4557.430321209848, 4571.0, 4700.623950084002, 4655.324977878206, 4660.277656963159, 4705.670603057787, 4713.952860471386, 4718.882027949295, 4599.448066232074, 4636.2581986882105, 4704.506026867198, 4719.693219940693, 4721.787519561628, 4676.7427791471455, 4691.319758634979, 4697.929531057037, 4711.057788442291, 4742.0, 4673.182193116225, 4674.976625116887, 4677.111348843709, 4682.531746825324, 4719.433667959866, 4854.247591623304, 4913.975430122862, 4935.851924442272, 5006.849794506171, 5015.699058056528, 5455.536279416255, 5471.316085489314, 5471.644343117685, 5479.0, 5481.479259470344, 5417.4311697272005, 5496.0931446311315, 5500.791894200899, 5508.421615730371, 5509.586780991402, 5073.594112471031, 5074.594032477393, 5108.846734597968, 5165.070287348276, 5177.068127736969, 5572.58205634579, 5582.720863956786, 5585.0, 5585.888282234332, 5587.357453892854, 5243.973780131075, 5280.234366016906, 5360.383555891122, 5371.355437347544, 5375.596830237748, 5418.485243901823, 5453.727313634382, 5472.261244731911, 5472.50747432733, 5518.91721624176, 5337.332833395825, 5387.353517577837, 5399.082156033483, 5399.37907140676, 5445.9652665993335, 5349.866253343697, 5399.568034557226, 5406.026915155231, 5406.972965135149, 5432.185172224198, 4252.787360631956, 4262.87211383659, 4266.0, 4292.12011537634, 4309.202797482476, 3838.692904567628, 3852.5954774748807, 3856.672182864488, 3888.8444462221196, 3893.610638936084, 5000.574951129195, 5056.924146137811, 5115.897682046412, 5135.306733590992, 5144.768485418165, 5339.172428273624, 5349.545288650431, 5357.330333708286, 5362.0, 5386.407495175527, 5064.265681476165, 5067.949320506821, 5070.2141168119, 5077.060743762416, 5110.948890511122, 4604.355390245369, 4687.1328804171335, 4696.436427628706, 4769.284607308862, 4777.355057067251, 5708.543316534668, 5709.514691251207, 5711.228984087178, 5715.828525144252, 5718.79984200551, 5429.809956651498, 5435.157550579666, 5438.646487978427, 5439.48324909133, 5442.673439593637, 5540.944590554042, 5644.266245388073, 5662.263905692398, 5689.784115271444, 5783.595148339744, 5369.812056578001, 5376.650517716336, 5382.892342153214, 5403.189521571796, 5406.702631355313, 5446.264754258124, 5478.839436115894, 5479.945200548103, 5480.835574932758, 5528.530074943675, 5236.136037553913, 5278.155495120763, 5299.0, 5382.946170538245, 5417.972910135424, 5302.496262855023, 5309.2301616266195, 5325.946740532545, 5332.093544097435, 5344.0, 5143.819966301162, 5247.55395791362, 5248.291480650063, 5251.343582052244, 5280.313559237275, 5276.261323414648, 5295.973520132375, 5376.7580458878665, 5426.647267927572, 5444.8094316698725, 5228.189630607262, 5247.790088396421, 5256.658317209369, 5262.500062494057, 5264.842054738364], "unit": "score", "name": "dojo.html", "value": 5039.995667481884}, {"lowerIsBetter": false, "replicates": [490.6246721258237, 496.6275293529853, 516.5144763921913, 526.2001757328861, 552.5220684108245, 33976.320473590546, 34333.31333373331, 34357.1410714732, 34391.0, 34429.31141377171, 37168.81415592918, 37707.43438848413, 37716.62283377165, 37718.24563508728, 37723.81138094312, 8249.25756681897, 8490.617922193485, 8494.150584941519, 8495.575221238912, 8497.66009359628, 8207.835843283161, 8301.83396332073, 8316.002079750438, 8338.374621903382, 8340.541270230135, 8499.61751721171, 8588.312934965219, 8614.612342444574, 8621.827563448727, 8630.611622477003, 8453.239208471236, 8531.146885311482, 8537.74386768401, 8558.614862331178, 8561.914380856175, 8365.539895305756, 8497.36269779769, 8497.702580409656, 8503.617337219777, 8504.957475212646, 36132.0, 36372.09069773251, 36618.63381366179, 36652.450213246826, 36669.63330366689, 2808.4804311202492, 2883.408901175275, 2890.089621769136, 3021.214484234093, 3240.7731458797894, 28158.577621335695, 28308.575371369447, 28439.857800710863, 28848.711512884813, 29271.41457170866, 3852.84588616455, 3859.7684138951754, 3934.8426062957446, 3947.921041579181, 4053.067794407273, 197250.0, 197903.0, 198575.0, 198774.0, 198889.0, 49053.509464905605, 50150.74924625354, 54179.45820541823, 55829.7208513963, 55839.0, 59934.400655993755, 60603.0, 60906.69546652238, 60916.39083609107, 60931.0, 12428.440720167615, 12669.303188324546, 12671.683207919692, 12687.429065692066, 12693.682657933625, 8327.916720832834, 8584.184502472255, 9312.394694344846, 9320.161185493338, 9323.72028839136, 18106.63786724258, 18373.26506939734, 18496.537586560175, 18552.907235464005, 18610.720839187154, 6641.302663220389, 6801.625910574966, 6823.69293381799, 6959.19969203548, 6984.720611175496, 682.2018238660779, 787.22851605427, 788.9566073865992, 792.1128336263422, 819.971301004462, 24516.877415613166, 24841.378965526008, 25020.0, 25108.0, 25126.623100653505, 891.9241864441466, 901.0, 908.6047569307373, 973.3673112476805, 1029.1869423155624, 12813.679658008625, 13515.729685406237, 15526.146061966474, 15622.375104995901, 15895.284712187979, 371317.0, 377694.0, 380668.0, 381187.0, 381734.0, 51660.22509662358, 52084.0, 52398.0, 52444.475555244724, 52535.47464525306, 1153.976920461603, 1158.901493373056, 1177.8998785103363, 1181.9822702659467, 1191.5233906437495, 27260.727392725817, 28314.43371132607, 28400.57399139056, 28595.0, 28663.283417914718, 41523.37714934218, 42130.157396852504, 42156.36765448582, 42201.36697949472, 42211.0, 286073.0, 287945.0, 289500.0, 290028.0, 290605.0, 26313.4737305249, 29472.263193420335, 29504.852475737483, 30118.94583689648, 30144.0, 33955.66044339525, 35251.47122793109, 35495.290094198484, 35565.288694225455, 35571.46642800412, 31370.843145784125, 32120.67879321177, 35933.460998085575, 36708.26583468369, 37173.814130929175, 31366.65801609051, 33318.83340583282, 33967.83016084904, 33991.66008339885, 34151.829240853636, 33834.66165338315, 36355.27289454249, 36781.44827827531, 36876.0, 37063.25873482569, 27847.72152278451, 30869.228269293446, 31484.0, 31595.0, 31622.367552648357, 23943.450744358517, 24337.0, 24971.250862474153, 25148.371290717147, 25872.611910820975], "unit": "score", "name": "ext.html", "value": 17058.391545010654}, {"lowerIsBetter": false, "replicates": [335.43479237484826, 342.42814499785374, 344.5916588842222, 345.25252827628185, 345.4265918575166, 13531.59405217845, 13948.79076813846, 14736.852631473683, 14787.33456994435, 16072.276747546344, 12862.93568532156, 13781.793273100911, 15817.762733559006, 15862.286197121128, 15899.28453219605, 4726.38556987592, 4916.164252077156, 4920.065187614342, 4925.70445773253, 4926.876828079308, 3607.7113830893463, 3738.1402277476195, 4878.512148785128, 4913.557779799818, 6566.376194261537, 6591.274959754423, 6811.829704257384, 6855.1088358513325, 6857.485688573352, 6870.690818913161, 6818.863622727543, 6833.453323734139, 6849.0, 6879.828004299908, 6882.827929301758, 6350.523710721714, 6587.0, 6590.868182636368, 6594.0, 6597.274299827015, 19167.904160479247, 20081.29715459952, 20630.690539641917, 20648.896755516125, 21137.260195893225, 2131.5843410534953, 2242.439390152462, 2251.6509940959177, 2289.7252329720372, 2291.51878105598, 13437.529686460926, 14048.157110573398, 14202.147871127661, 14545.0, 14601.342939567745, 1905.1712505060204, 1963.4993076765334, 1964.7052942058806, 1996.610660921121, 2011.4770159758568, 60915.39084609142, 61175.0, 63292.36707632911, 63439.68280158616, 64860.67569662121, 14181.85818141826, 14578.927105364406, 14581.85418145805, 14601.415943362359, 14611.561653150422, 22707.318780436613, 22996.0, 23061.423464413525, 23158.305250842503, 23252.53494930092, 7662.4253181011645, 7677.808054798675, 7866.646000929972, 7983.401244906655, 8010.279074883289, 6516.609003459807, 6539.738410463623, 6581.670916454158, 6590.967045164839, 6671.366220209073, 6573.704183311763, 7420.814479637944, 7440.218777028443, 7555.697772089165, 7617.362267112598, 2386.773256540626, 2749.3676454415595, 2803.6074949507083, 2804.340979869729, 2805.5370863807652, 779.6140910249463, 803.325206826257, 842.3934766967774, 873.0047745570055, 886.6674996876171, 13129.934350328187, 14680.926595366955, 14942.327595258239, 15078.396864125312, 16242.75635865463, 807.4993504027541, 833.3874602167402, 840.9117042710427, 872.7207293665966, 906.1980147569449, 8384.916150838413, 8854.822903541894, 8858.766550209128, 8859.512726800089, 9046.909530904739, 461712.0, 465096.0, 512881.0, 518158.0, 520204.0, 68528.31471685319, 72632.27367726361, 72682.0, 73352.0, 75449.6227518859, 899.1278459893892, 920.7237828651512, 931.9627214911328, 1026.8305729554688, 1045.7333379988054, 10878.619248326271, 13847.79228311556, 13918.0, 14066.0, 14105.435782568582, 32963.835180823946, 33026.33947321088, 33553.32893342071, 33884.32231355408, 33920.491192631634, 42733.97426357497, 42910.141797163255, 44220.0, 44506.55493445024, 44753.77623111864, 6461.515386345949, 6493.350664933658, 6515.087887695631, 6570.342965703391, 6840.828979275558, 8742.0, 10564.366138031743, 10834.837477438003, 10867.782644347228, 11101.888981110085, 9229.261659067393, 9315.906840931504, 9330.580123894306, 9466.0, 9549.61801527959, 6908.721886451022, 8878.245349145136, 9339.439633621732, 9532.809343813224, 9728.416295022322, 4903.779329930233, 6352.920003599307, 8923.33075019389, 9415.529223538659, 9947.403155810674, 7093.680784364819, 7129.607871567114, 7154.678039488132, 7155.606441645759, 7164.176119746296, 7905.920940790518, 8844.690435834715, 9256.907430925605, 9436.433813971184, 9520.476373799507], "unit": "score", "name": "jquery.html", "value": 8479.430231671531}, {"lowerIsBetter": false, "replicates": [1093.436880006797, 1292.3279894454884, 1299.6425982854714, 1337.0, 1524.4359586952828, 6938.479614028949, 7630.9236907630975, 7799.4930329528615, 7802.765917022484, 7803.219678032194, 7648.349890259321, 7840.0, 7840.4511684182135, 7841.098273698526, 7848.175941526129, 1972.260402349119, 2034.1659919433037, 2200.6588978708246, 2244.394013616327, 2265.694131292279, 2225.2434172381386, 2236.1279101150562, 2236.709227800392, 2237.9776202238013, 2247.2359397804744, 2187.103287652063, 2235.765244649313, 2237.1387015998876, 2238.4292005538564, 2239.4177513846435, 2215.091812356926, 2216.9556608867815, 2222.144474377368, 2258.8757618330983, 2264.637657974716, 2189.0477642225524, 2190.868547887132, 2210.9889450552646, 2212.5906707259046, 2251.043306594691, 7785.766427007142, 7850.450468467209, 7853.96073019637, 7856.096548896836, 7874.803129921741, 4608.539146085398, 4694.108119457293, 4706.435227772655, 4741.57325840676, 4741.691790033637, 2966.1249931270327, 3035.1501579557757, 3079.1532328609587, 3081.383723255358, 3106.7980581262145, 949.8955114937352, 950.1543626172712, 973.3429934793986, 995.6415690351467, 1005.8038682456923, 10537.315074520131, 10588.470576471145, 10607.416592087433, 10608.840867386996, 10613.46932653372, 4006.2187873364996, 4087.754734715867, 4109.054917368962, 4132.214879172948, 4190.643795277436, 8305.46014509055, 8458.788530286793, 8480.830383392298, 8489.4481858679, 8494.320454363637, 4590.908181836345, 4605.447346318463, 4612.76936153191, 4615.169269531517, 4616.446026476777, 4240.957590424056, 4259.339802330644, 4261.531231564525, 4261.680373971964, 4263.722858014219, 3270.149761062141, 3283.474644056987, 3319.751018673561, 3511.5610548681416, 3590.6893983695763, 1031.4327120083924, 1077.5258886090096, 1086.9891301087046, 1090.0625462102585, 1096.8354746788045, 971.820213260549, 993.5677980078689, 1267.7781388257017, 1274.9107562470724, 1308.7971364438527, 7425.777226683208, 7452.403807695371, 7465.70137194517, 7467.775966720898, 7469.0, 1004.1966426858484, 1013.4578000769553, 1026.1329176845554, 1035.3942943378208, 1045.9633912813167, 5589.301337332833, 5662.660240385508, 5670.716464176775, 5674.574406919498, 5683.573731970118, 9308.906910930804, 9332.533373331305, 9346.906530934604, 9622.0, 9915.603375865028, 9424.90575094254, 9591.616335346647, 9707.611695532241, 9708.6116555337, 9711.27165462579, 7148.892766608505, 7278.8180295491975, 7284.6721897514735, 7385.409167266605, 7480.0, 7151.53515021522, 7257.564546127249, 7258.818529536804, 7270.89093663606, 7273.418126549969, 8506.829863402574, 8679.609417576097, 8700.60847261862, 8725.563721814011, 8864.601092950703, 8876.556172191495, 8955.59699813523, 9034.27725781949, 9130.726078217664, 9134.497602631653, 6831.760888368884, 6956.060931774348, 6960.930390696029, 6983.790486285419, 6985.301469852974, 6704.128463299739, 6865.485088618274, 7248.710051598088, 7443.627818609156, 7460.776176714708, 6871.381575658214, 6934.479914006369, 7003.894941575779, 7012.719491220294, 7113.0, 6892.0, 6914.0666010088, 6922.653867306513, 6924.203716572457, 7004.229534751072, 6961.164660240804, 6979.092717946634, 6981.301869812978, 6985.895211571932, 6995.510314278155, 6201.844953876189, 6351.07909353132, 6377.553571249968, 6452.064450654722, 6459.9031014533875, 6602.735890564323, 6604.5046621502615, 6614.0, 6618.536702430783, 6625.0], "unit": "score", "name": "mootools.html", "value": 4411.577132408229}, {"lowerIsBetter": false, "replicates": [311.1257366799294, 319.49832809104714, 319.571773823077, 320.0781748564134, 321.48080849428163, 5620.606557540974, 5683.318001839774, 5731.598788084836, 5793.59444838861, 5794.5943783935145, 5619.943800561993, 5647.774089036434, 5740.167675687023, 5748.109043098327, 5760.395158508359, 4168.228877657643, 4410.904820210399, 4425.867223983286, 4426.269665505204, 4437.755923424211, 4225.767582782945, 4349.108432771274, 4443.666724995638, 4454.599086082252, 4465.843695470659, 4392.8023238954165, 4403.361512580674, 4409.360642706805, 4410.31640095784, 4425.048614547872, 4422.402975598286, 4423.783459548617, 4427.712198707074, 4427.778611069466, 4428.202923473774, 3880.1463677990796, 3885.164689591723, 3888.2612303662213, 3890.396988466792, 3890.7665540067687, 5348.732563371816, 5445.809396671137, 5497.065498865202, 5505.944940550583, 5515.779368825242, 5010.123228435009, 5014.323066386064, 5017.222330538772, 5027.120253955543, 5035.521625445577, 5751.223584816038, 5849.795257166022, 6080.908786368208, 6092.51259899207, 6097.390260973912, 4044.4539987101657, 4072.0837811492474, 4134.813933372975, 4147.605977432139, 4158.459400277945, 6240.251169859601, 6335.144755458046, 6348.904766428507, 6352.174217351715, 6356.2054743157105, 4185.24665560196, 4186.476690413699, 4188.078622703, 4189.811458484375, 4192.161567686475, 4135.60711732385, 4210.6841986851105, 4230.746155230696, 4243.236217480821, 4243.639290660329, 4919.77860996256, 4923.040007198633, 4928.433230178503, 4930.926036109461, 4936.8398426370495, 6055.182550355646, 6138.1099740537375, 6175.69121543921, 6176.8764624707255, 6193.349698281706, 1488.1666266890577, 1535.0405996252343, 1537.907725536449, 1537.9231038448033, 1538.2001359293329, 1017.4200705597739, 1022.085233715835, 1024.2676486312173, 1025.8461230815437, 1045.8431235314763, 5886.941130588725, 5892.5285977122585, 5894.970525147347, 5895.793647222326, 5904.586678932434, 6280.152179455807, 6290.370962903673, 6290.55966082379, 6294.961331380363, 6299.874002519924, 5890.293164820163, 5891.646501209942, 5895.4399332063385, 5899.941000590025, 5907.527397808251, 3238.158078899503, 3372.8819491317686, 3375.8987230383127, 3376.4260075787174, 3378.408778463808, 6505.4795616350575, 6517.543771936013, 6540.6729663516635, 6549.672516374258, 6550.312217217219, 6407.967960160169, 6414.807555773335, 6421.197350331208, 6422.58253213549, 6423.646699431482, 6379.457746091634, 6513.381228783258, 6549.6070235786, 6556.180477440224, 6559.442447392025, 6049.667268300285, 6101.908471372844, 6128.0, 6261.4364707174755, 6264.279607844974, 6200.3179650237535, 6202.41077097675, 6211.3478084802255, 6263.342349053284, 6266.655333956676, 6562.77030303937, 6571.638559879252, 6581.868362632625, 6592.604443733391, 6596.670166491752, 4188.141431006576, 4295.205387003414, 4296.505901821206, 4307.763073031013, 4328.350747387917, 6285.308616052139, 6300.086487459384, 6303.306636270098, 6306.9684651576445, 6310.242770867525, 6122.510199184144, 6128.571000029955, 6133.233345831771, 6137.048757442603, 6142.078688196806, 5978.581499295182, 6101.877962440815, 6109.991851344478, 6117.1741814856205, 6119.265688117454, 5976.850578735566, 6002.609830361012, 6006.15913772081, 6010.398960103955, 6015.669138197266, 6132.264128304632, 6132.509399247961, 6133.0, 6134.141220229082, 6138.57030007913, 5876.814085222711, 5995.940040599538, 6002.309734380602, 6005.309389420273, 6009.639421634716], "unit": "score", "name": "prototype.html", "value": 4577.704997345093}, {"lowerIsBetter": false, "replicates": [711.2318695808526, 720.8738470767614, 729.2525161709244, 732.7655150351886, 743.7657138001529, 12268.0, 12424.937875310634, 12430.93784531076, 12489.0, 12496.187747796386, 11149.108071354292, 11192.328460292389, 11219.943900280508, 11230.438478076105, 11235.943820280887, 500.31207090250905, 508.5626361329254, 636.2714691678026, 645.2901808011185, 655.6131882189508, 566.5043087298614, 573.2662192393743, 575.821495336447, 576.1357963055417, 576.1645613859899, 611.10778263735, 612.1368869893452, 612.3325575123115, 612.6599737145882, 614.4193736918613, 526.463007732113, 532.1193424881847, 613.5705006495449, 614.9815505534841, 626.4299487466384, 447.52562283979086, 447.8499702599633, 447.8544473046273, 448.206674186691, 449.3888311895819, 11069.446527673585, 11092.667219983414, 11102.222844400896, 11109.666709998713, 11156.944215278952, 11772.882271177265, 12114.575989840314, 12291.631251062483, 12415.255084694947, 12448.564300249447, 10112.848307275397, 10123.088921997056, 10243.436610986393, 10326.793464130751, 10388.896111038868, 3519.419295816187, 3576.5886923003927, 3592.6227746086547, 3595.514605528246, 3599.6760291573883, 44024.339634905504, 44390.112197755865, 46193.5380646196, 46962.53037469616, 47253.76373118113, 9618.615255389846, 9638.710838674851, 9650.179734722627, 9939.155171810333, 10130.240231982483, 15887.602809929613, 16013.039217646978, 16022.599435014217, 16054.0, 16065.0, 7447.404207663374, 7457.7016919323705, 7754.302112809874, 7763.534187948741, 7910.564918929399, 4381.0, 4442.933355999663, 4466.642668586505, 4505.324201369755, 4535.25168347219, 2917.0957003329036, 2932.4428358611794, 2936.0751363320487, 2952.320966177791, 2955.3350496138196, 538.9380221274525, 540.8080131553321, 543.2250517947278, 550.5540512185142, 560.7476635514035, 505.03286206914083, 539.323149447441, 614.5483069943588, 622.6150823306958, 632.5445679111033, 8803.823923521622, 9092.181703646704, 9112.95443522778, 9252.491112988715, 9620.422774633404, 462.28807636239816, 494.49314452686286, 515.0497332421676, 578.3435800366614, 647.8749700980791, 3869.4195870619633, 3871.322518559241, 4000.3599424092004, 4006.318925782624, 4097.467329247179, 56384.0, 56735.43264567384, 57101.0, 57101.428985710445, 57279.14081288784, 48404.75797620989, 48589.514104859205, 49177.0, 49331.0, 49421.752891235315, 43438.13123737508, 43882.12235755267, 44377.0, 44644.330335045, 44820.3276950846, 8331.12523185081, 8382.911565709679, 8458.027326857244, 8709.825803484022, 8824.249938755022, 33145.33709325752, 33431.16422089467, 33459.83270083634, 34915.82542087273, 35086.0, 41414.58585414107, 42323.57676423196, 42764.0, 44052.0, 44080.559194407644, 10373.896261037293, 10529.420881851265, 10580.470976450993, 10692.786144276915, 10753.408562529135, 11925.284482931052, 11971.820422693492, 12024.579139730067, 12126.696832579257, 12661.810072849099, 11278.266912650652, 11507.654770356903, 11561.710957226136, 11642.41787910618, 11943.343116128697, 10866.185036122164, 11330.716732081764, 11381.0, 11446.542138314375, 11742.941285293518, 10762.784744305227, 11141.554337826396, 11164.385958772345, 11420.31478111316, 11465.828012579652, 8881.42270752399, 8895.154960278764, 9160.816783664422, 9233.861492077758, 9255.629774809202, 8632.093630168742, 9031.774205644911, 9309.813803724022, 9419.529023548932, 9632.855507167258], "unit": "score", "name": "yui.html", "value": 5799.26897862327}], "name": "dromaeo_css", "value": 6635.8725166166205}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 105.0, 109.0, 109.0, 110.0, 111.0, 112.0, 104.0, 112.0], "unit": "score", "name": "ai-astar", "value": 109.3}, {"lowerIsBetter": true, "replicates": [151.0, 127.0, 157.0, 168.0, 124.0, 156.0, 154.0, 131.0, 174.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 147.0}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 161.0, 160.0, 161.0, 161.0, 160.0, 162.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 92.0, 97.0, 73.0, 74.0, 76.0, 117.0, 101.0, 74.0], "unit": "score", "name": "audio-fft", "value": 85.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 140.0, 96.0, 97.0, 97.0, 148.0, 96.0, 96.0, 149.0], "unit": "score", "name": "audio-oscillator", "value": 111.1}, {"lowerIsBetter": true, "replicates": [109.0, 117.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 147.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 56.0, 55.0, 55.0, 55.0, 55.0, 55.0, 73.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.0}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.0}, {"lowerIsBetter": true, "replicates": [81.0, 80.0, 80.0, 81.0, 82.0, 82.0, 83.0, 83.0, 81.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.5}, {"lowerIsBetter": true, "replicates": [117.0, 113.0, 123.0, 125.0, 126.0, 129.0, 123.0, 114.0, 114.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.0}, {"lowerIsBetter": true, "replicates": [152.0, 135.0, 142.0, 142.0, 144.0, 132.0, 150.0, 143.0, 144.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.9}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 68.0, 67.0, 69.0, 68.0, 70.0, 68.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1501.9000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.53224995811695], "unit": "score", "name": "Richards", "value": 210.71763800000005}, {"lowerIsBetter": false, "replicates": [191.27773527161438], "unit": "score", "name": "DeltaBlue", "value": 345.66490400000004}, {"lowerIsBetter": false, "replicates": [280.74115665356544], "unit": "score", "name": "Encrypt", "value": 948.136722}, {"lowerIsBetter": false, "replicates": [5324.468085106383], "unit": "score", "name": "Decrypt", "value": 49.99203596403597}, {"lowerIsBetter": false, "replicates": [1974.3589743589744], "unit": "score", "name": "RayTrace", "value": 374.7996233766234}, {"lowerIsBetter": false, "replicates": [789.8894154818325], "unit": "score", "name": "Earley", "value": 843.7421580000001}, {"lowerIsBetter": false, "replicates": [12192.77108433735], "unit": "score", "name": "Boyer", "value": 54.66050296442688}, {"lowerIsBetter": false, "replicates": [42729.166666666664], "unit": "score", "name": "RegExp", "value": 21.319980497318397}, {"lowerIsBetter": false, "replicates": [579.2824074074074], "unit": "score", "name": "Splay", "value": 140.67577222777226}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 18886.43610364698}]} 07:29:22 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "18886.44"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1501.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6635.87"}}} 07:29:22 INFO - Return code: 0 07:29:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:29:23 INFO - # TBPL SUCCESS # 07:29:23 INFO - Running post-action listener: _resource_record_post_action 07:29:23 INFO - Running post-run listener: _resource_record_post_run 07:29:24 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 551133184; Read time: 0; Write time: 431464 07:29:24 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248786944; Read time: 0; Write time: 254052 07:29:24 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 302346240; Read time: 0; Write time: 177412 07:29:24 INFO - Running post-run listener: _upload_blobber_files 07:29:24 INFO - Blob upload gear active. 07:29:24 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:29:24 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 07:29:24 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', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 07:29:24 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 Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 07:29:24 INFO - (blobuploader) - INFO - Open directory for files ... 07:29:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:29:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:29:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:25 INFO - (blobuploader) - INFO - Done attempting. 07:29:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 07:29:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:29:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:26 INFO - (blobuploader) - INFO - Done attempting. 07:29:26 INFO - (blobuploader) - INFO - Iteration through files over. 07:29:26 INFO - Return code: 0 07:29:26 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:29:26 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:29:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d8a143063ec3f48cda3c51f4ade8205e8ca863c1310a54ac801ffa8814e30bef6349f8a7a601bcace1ac51c30a04c6bb206746214d20b79a94e230907b193478", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0b395dc6028b9d012e046319d7109bc94a8af47d985099735ec0aa42ee084626eaf3c4278f8f23d868b88fc1cb3548c7ad6f642a67f28b174714986433fa063c"} 07:29:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:29:26 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:29:26 INFO - Contents: 07:29:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d8a143063ec3f48cda3c51f4ade8205e8ca863c1310a54ac801ffa8814e30bef6349f8a7a601bcace1ac51c30a04c6bb206746214d20b79a94e230907b193478", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0b395dc6028b9d012e046319d7109bc94a8af47d985099735ec0aa42ee084626eaf3c4278f8f23d868b88fc1cb3548c7ad6f642a67f28b174714986433fa063c"} 07:29:26 INFO - Running post-run listener: copy_logs_to_upload_dir 07:29:26 INFO - Copying logs to upload dir... 07:29:26 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 07:29:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.461275 ========= master_lag: -0.46 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-01-25 07:29:25.367154) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 07:29:25.370354) ========= 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=0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d8a143063ec3f48cda3c51f4ade8205e8ca863c1310a54ac801ffa8814e30bef6349f8a7a601bcace1ac51c30a04c6bb206746214d20b79a94e230907b193478", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0b395dc6028b9d012e046319d7109bc94a8af47d985099735ec0aa42ee084626eaf3c4278f8f23d868b88fc1cb3548c7ad6f642a67f28b174714986433fa063c"} build_url:https://queue.taskcluster.net/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/NzCWse9kQFaYHtsGDAkbtw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d8a143063ec3f48cda3c51f4ade8205e8ca863c1310a54ac801ffa8814e30bef6349f8a7a601bcace1ac51c30a04c6bb206746214d20b79a94e230907b193478", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0b395dc6028b9d012e046319d7109bc94a8af47d985099735ec0aa42ee084626eaf3c4278f8f23d868b88fc1cb3548c7ad6f642a67f28b174714986433fa063c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 07:29:25.395115) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 07:29:25.395432) ========= 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=0333a256a5e4f052382dd180000001b1-1453731582.998875-356166506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 07:29:25.482143) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 07:29:25.482716) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 07:29:25.483232) ========= ========= Total master_lag: -0.20 =========