builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1454953812.66 results: success (0) buildid: 20160208071710 builduid: db04a2e5974441ad9294c12d7da03079 revision: 0b891e31fc10a2c3c8dab1836f34b85366cf9e4b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-08 09:50:12.657723) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-08 09:50:12.658263) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-08 09:50:12.658626) ========= 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=df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005757 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-08 09:50:12.680601) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-08 09:50:12.680962) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-08 09:50:12.694189) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:50:12.694530) ========= 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=df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:50:12.744507) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-08 09:50:12.744849) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-08 09:50:12.745279) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:50:12.745610) ========= 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=df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-08 09:50:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 55.3M=0s 2016-02-08 09:50:12 (55.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100744 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:50:12.859443) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:50:12.859802) ========= 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=df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022410 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:50:12.912276) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:50:12.912664) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0b891e31fc10a2c3c8dab1836f34b85366cf9e4b --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0b891e31fc10a2c3c8dab1836f34b85366cf9e4b --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=df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-08 09:50:12,994 truncating revision to first 12 chars 2016-02-08 09:50:12,994 Setting DEBUG logging. 2016-02-08 09:50:12,994 attempt 1/10 2016-02-08 09:50:12,995 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0b891e31fc10?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-08 09:50:13,253 unpacking tar archive at: mozilla-aurora-0b891e31fc10/testing/mozharness/ program finished with exit code 0 elapsedTime=0.560655 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:50:13.486354) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-08 09:50:13.486738) ========= echo 0b891e31fc10a2c3c8dab1836f34b85366cf9e4b in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0b891e31fc10a2c3c8dab1836f34b85366cf9e4b'] 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=df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 0b891e31fc10a2c3c8dab1836f34b85366cf9e4b program finished with exit code 0 elapsedTime=0.004685 script_repo_revision: '0b891e31fc10a2c3c8dab1836f34b85366cf9e4b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-08 09:50:13.537966) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-08 09:50:13.538296) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-08 09:50:13.548412) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-02-08 09:50:13.548812) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:50:13 INFO - MultiFileLogger online at 20160208 09:50:13 in /builds/slave/test-pgo 09:50:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:50:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:50:13 INFO - {'append_to_log': False, 09:50:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:50:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:50:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:50:13 INFO - 'branch': 'Mozilla-Aurora', 09:50:13 INFO - 'buildbot_json_path': 'buildprops.json', 09:50:13 INFO - 'config_files': ('talos/linux_config.py',), 09:50:13 INFO - 'default_actions': ('clobber', 09:50:13 INFO - 'read-buildbot-config', 09:50:13 INFO - 'download-and-extract', 09:50:13 INFO - 'populate-webroot', 09:50:13 INFO - 'create-virtualenv', 09:50:13 INFO - 'install', 09:50:13 INFO - 'run-tests'), 09:50:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:50:13 INFO - 'download_minidump_stackwalk': True, 09:50:13 INFO - 'download_symbols': 'ondemand', 09:50:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:50:13 INFO - 'tooltool.py': '/tools/tooltool.py', 09:50:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:50:13 INFO - '/tools/misc-python/virtualenv.py')}, 09:50:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:50:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:50:13 INFO - 'installer_path': 'installer.exe', 09:50:13 INFO - 'log_level': 'info', 09:50:13 INFO - 'log_name': 'talos', 09:50:13 INFO - 'log_to_console': True, 09:50:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:50:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:50:13 INFO - 'opt_config_files': (), 09:50:13 INFO - 'pip_index': False, 09:50:13 INFO - 'sps_profile': False, 09:50:13 INFO - 'sps_profile_interval': 0, 09:50:13 INFO - 'suite': 'dromaeojs-e10s', 09:50:13 INFO - 'system_bits': '32', 09:50:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:50:13 INFO - 'title': 'talos-linux64-ix-021', 09:50:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:50:13 INFO - 'use_talos_json': True, 09:50:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:50:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:50:13 INFO - 'work_dir': 'build'} 09:50:13 INFO - ##### 09:50:13 INFO - ##### Running clobber step. 09:50:13 INFO - ##### 09:50:13 INFO - Running pre-action listener: _resource_record_pre_action 09:50:13 INFO - Running main action method: clobber 09:50:13 INFO - rmtree: /builds/slave/test-pgo/build 09:50:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:50:14 INFO - Running post-action listener: _resource_record_post_action 09:50:14 INFO - ##### 09:50:14 INFO - ##### Running read-buildbot-config step. 09:50:14 INFO - ##### 09:50:14 INFO - Running pre-action listener: _resource_record_pre_action 09:50:14 INFO - Running main action method: read_buildbot_config 09:50:14 INFO - Using buildbot properties: 09:50:14 INFO - { 09:50:14 INFO - "project": "", 09:50:14 INFO - "product": "firefox", 09:50:14 INFO - "script_repo_revision": "production", 09:50:14 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:50:14 INFO - "repository": "", 09:50:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:50:14 INFO - "buildid": "20160208071710", 09:50:14 INFO - "pgo_build": "True", 09:50:14 INFO - "basedir": "/builds/slave/test-pgo", 09:50:14 INFO - "buildnumber": 130, 09:50:14 INFO - "slavename": "talos-linux64-ix-021", 09:50:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:50:14 INFO - "platform": "ubuntu64_hw", 09:50:14 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:50:14 INFO - "branch": "mozilla-aurora", 09:50:14 INFO - "repo_path": "releases/mozilla-aurora", 09:50:14 INFO - "revision": "0b891e31fc10a2c3c8dab1836f34b85366cf9e4b", 09:50:14 INFO - "stage_platform": "linux64-pgo", 09:50:14 INFO - "builduid": "db04a2e5974441ad9294c12d7da03079", 09:50:14 INFO - "slavebuilddir": "test" 09:50:14 INFO - } 09:50:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 09:50:14 INFO - Running post-action listener: _resource_record_post_action 09:50:14 INFO - ##### 09:50:14 INFO - ##### Running download-and-extract step. 09:50:14 INFO - ##### 09:50:14 INFO - Running pre-action listener: _resource_record_pre_action 09:50:14 INFO - Running main action method: download_and_extract 09:50:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:50:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:14 INFO - https://queue.taskcluster.net/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:50:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/test_packages.json 09:50:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/test_packages.json 09:50:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:50:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:50:15 INFO - Downloaded 1448 bytes. 09:50:15 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:50:15 INFO - Using the following test package requirements: 09:50:15 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 09:50:15 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:50:15 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:50:15 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:50:15 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:50:15 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:50:15 INFO - u'jsshell-linux-x86_64.zip'], 09:50:15 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:50:15 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:50:15 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 09:50:15 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:50:15 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:50:15 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:50:15 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:50:15 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:50:15 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:50:15 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 09:50:15 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:50:15 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:50:15 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:15 INFO - https://queue.taskcluster.net/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:50:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:50:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:50:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:50:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:50:16 INFO - Downloaded 22398865 bytes. 09:50:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:50:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 09:50:18 INFO - Return code: 0 09:50:18 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:50:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:18 INFO - https://queue.taskcluster.net/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:50:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:50:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:50:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:50:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:50:19 INFO - Downloaded 22398865 bytes. 09:50:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:50:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 09:50:20 INFO - Return code: 0 09:50:20 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')]} 09:50:20 INFO - https://queue.taskcluster.net/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:50:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 09:50:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 09:50:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 09:50:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:50:21 INFO - Downloaded 10706572 bytes. 09:50:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:50:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 09:50:21 INFO - Return code: 0 09:50: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')]} 09:50:21 INFO - https://queue.taskcluster.net/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:50:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:50:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:50:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:50:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:50:26 INFO - Downloaded 59580872 bytes. 09:50:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:50:26 INFO - mkdir: /builds/slave/test-pgo/properties 09:50:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:50:26 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:50:26 INFO - Contents: 09:50:26 INFO - build_url:https://queue.taskcluster.net/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:50:26 INFO - Running post-action listener: _resource_record_post_action 09:50:26 INFO - Running post-action listener: set_extra_try_arguments 09:50:26 INFO - ##### 09:50:26 INFO - ##### Running populate-webroot step. 09:50:26 INFO - ##### 09:50:26 INFO - Running pre-action listener: _resource_record_pre_action 09:50:26 INFO - Running main action method: populate_webroot 09:50:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:50:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:50:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:50:26 INFO - '--tppagecycles', 09:50:26 INFO - '7'], 09:50:26 INFO - 'tests': ['tsvgm']}}, 09:50:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:50:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:50:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:50:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:50:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:50:26 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:50:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:50:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:26 INFO - 'talos_options': ['--e10s'], 09:50:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:50:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:26 INFO - 'tests': ['damp', 'tps']}, 09:50:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:26 INFO - 'talos_options': ['--e10s'], 09:50:26 INFO - 'tests': ['damp', 'tps']}, 09:50:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:50:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:50:26 INFO - 'other': {'tests': ['a11yr', 09:50:26 INFO - 'ts_paint', 09:50:26 INFO - 'tpaint', 09:50:26 INFO - 'sessionrestore', 09:50:26 INFO - 'sessionrestore_no_auto_restore']}, 09:50:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:50:26 INFO - 'tests': ['a11yr', 09:50:26 INFO - 'ts_paint', 09:50:26 INFO - 'tpaint', 09:50:26 INFO - 'sessionrestore', 09:50:26 INFO - 'sessionrestore_no_auto_restore']}, 09:50:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:50:26 INFO - 'tests': ['a11yr', 09:50:26 INFO - 'ts_paint', 09:50:26 INFO - 'tpaint', 09:50:26 INFO - 'sessionrestore', 09:50:26 INFO - 'sessionrestore_no_auto_restore']}, 09:50:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:50:26 INFO - 'tests': ['a11yr', 09:50:26 INFO - 'ts_paint', 09:50:26 INFO - 'tpaint', 09:50:26 INFO - 'sessionrestore', 09:50:26 INFO - 'sessionrestore_no_auto_restore']}, 09:50:26 INFO - 'other_l64': {'tests': ['a11yr', 09:50:26 INFO - 'ts_paint', 09:50:26 INFO - 'tpaint', 09:50:26 INFO - 'sessionrestore', 09:50:26 INFO - 'sessionrestore_no_auto_restore']}, 09:50:26 INFO - 'other_nol64': {'tests': ['a11yr', 09:50:26 INFO - 'ts_paint', 09:50:26 INFO - 'tpaint', 09:50:26 INFO - 'sessionrestore', 09:50:26 INFO - 'sessionrestore_no_auto_restore']}, 09:50:26 INFO - 'svgr': {'tests': ['tsvgx', 09:50:26 INFO - 'tsvgr_opacity', 09:50:26 INFO - 'tart', 09:50:26 INFO - 'tscrollx', 09:50:26 INFO - 'cart']}, 09:50:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:50:26 INFO - 'tests': ['tsvgx', 09:50:26 INFO - 'tsvgr_opacity', 09:50:26 INFO - 'tart', 09:50:26 INFO - 'tscrollx', 09:50:26 INFO - 'cart']}, 09:50:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:26 INFO - 'tests': ['tp5o']}, 09:50:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:26 INFO - 'talos_options': ['--e10s'], 09:50:26 INFO - 'tests': ['tp5o']}, 09:50:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:26 INFO - 'talos_options': ['--xperf_path', 09:50:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:50:26 INFO - 'tests': ['tp5n']}, 09:50:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:26 INFO - 'talos_options': ['--e10s', 09:50:26 INFO - '--xperf_path', 09:50:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:50:26 INFO - 'tests': ['tp5n']}}, 09:50:26 INFO - 'talos.zip': {'path': '', 09:50:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:50:26 INFO - Running post-action listener: _resource_record_post_action 09:50:26 INFO - ##### 09:50:26 INFO - ##### Running create-virtualenv step. 09:50:26 INFO - ##### 09:50:26 INFO - Running pre-action listener: _resource_record_pre_action 09:50:26 INFO - Running main action method: create_virtualenv 09:50:26 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:50:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 09:50:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:50:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:50:26 INFO - Using real prefix '/usr' 09:50:26 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:50:27 INFO - Installing distribute.............................................................................................................................................................................................done. 09:50:29 INFO - Installing pip.................done. 09:50:29 INFO - Return code: 0 09:50:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:50: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')]} 09:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50: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')]} 09:50:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:29 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 0x7f61a9130f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24fd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258f7f0>, '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 0x24fb2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fb760>, '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': 'df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259', '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 09:50:29 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 09:50:29 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 09:50:29 INFO - Using env: {'DISPLAY': ':0', 09:50:29 INFO - 'HOME': '/home/cltbld', 09:50:29 INFO - 'LANG': 'en_US.UTF-8', 09:50:29 INFO - 'LANGUAGE': 'en_US:en', 09:50:29 INFO - 'LOGNAME': 'cltbld', 09:50:29 INFO - 'MAIL': '/var/mail/cltbld', 09:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:29 INFO - 'MOZ_NO_REMOTE': '1', 09:50:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:29 INFO - 'NO_EM_RESTART': '1', 09:50:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:50:29 INFO - 'PWD': '/builds/slave/test-pgo', 09:50:29 INFO - 'SHELL': '/bin/bash', 09:50:29 INFO - 'SHLVL': '1', 09:50:29 INFO - 'TERM': 'linux', 09:50:29 INFO - 'TMOUT': '86400', 09:50:29 INFO - 'USER': 'cltbld', 09:50:29 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259', 09:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:29 INFO - '_': '/tools/buildbot/bin/python'} 09:50:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:29 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 09:50:29 INFO - Cleaning up... 09:50:29 INFO - Return code: 0 09:50:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:50: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')]} 09:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50: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')]} 09:50:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:29 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 0x7f61a9130f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24fd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258f7f0>, '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 0x24fb2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fb760>, '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': 'df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259', '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 09:50:29 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 09:50:29 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 09:50:29 INFO - Using env: {'DISPLAY': ':0', 09:50:29 INFO - 'HOME': '/home/cltbld', 09:50:29 INFO - 'LANG': 'en_US.UTF-8', 09:50:29 INFO - 'LANGUAGE': 'en_US:en', 09:50:29 INFO - 'LOGNAME': 'cltbld', 09:50:29 INFO - 'MAIL': '/var/mail/cltbld', 09:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:29 INFO - 'MOZ_NO_REMOTE': '1', 09:50:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:29 INFO - 'NO_EM_RESTART': '1', 09:50:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:50:29 INFO - 'PWD': '/builds/slave/test-pgo', 09:50:29 INFO - 'SHELL': '/bin/bash', 09:50:29 INFO - 'SHLVL': '1', 09:50:29 INFO - 'TERM': 'linux', 09:50:29 INFO - 'TMOUT': '86400', 09:50:29 INFO - 'USER': 'cltbld', 09:50:29 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259', 09:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:29 INFO - '_': '/tools/buildbot/bin/python'} 09:50:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:29 INFO - Downloading/unpacking psutil>=0.7.1 09:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:50:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:50:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:50:31 INFO - Installing collected packages: psutil 09:50:31 INFO - Running setup.py install for psutil 09:50:31 INFO - building 'psutil._psutil_linux' extension 09:50:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:50:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:50:31 INFO - building 'psutil._psutil_posix' extension 09:50:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:50:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:50:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:50:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:50:32 INFO - Successfully installed psutil 09:50:32 INFO - Cleaning up... 09:50:32 INFO - Return code: 0 09:50:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:50:32 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')]} 09:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:32 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')]} 09:50:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:32 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 0x7f61a9130f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24fd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258f7f0>, '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 0x24fb2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fb760>, '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': 'df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259', '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 09:50:32 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 09:50:32 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 09:50:32 INFO - Using env: {'DISPLAY': ':0', 09:50:32 INFO - 'HOME': '/home/cltbld', 09:50:32 INFO - 'LANG': 'en_US.UTF-8', 09:50:32 INFO - 'LANGUAGE': 'en_US:en', 09:50:32 INFO - 'LOGNAME': 'cltbld', 09:50:32 INFO - 'MAIL': '/var/mail/cltbld', 09:50:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:32 INFO - 'MOZ_NO_REMOTE': '1', 09:50:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:32 INFO - 'NO_EM_RESTART': '1', 09:50:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:50:32 INFO - 'PWD': '/builds/slave/test-pgo', 09:50:32 INFO - 'SHELL': '/bin/bash', 09:50:32 INFO - 'SHLVL': '1', 09:50:32 INFO - 'TERM': 'linux', 09:50:32 INFO - 'TMOUT': '86400', 09:50:32 INFO - 'USER': 'cltbld', 09:50:32 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259', 09:50:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:32 INFO - '_': '/tools/buildbot/bin/python'} 09:50:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:50:32 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 09:50:32 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 09:50:32 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 09:50:32 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 09:50:32 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 09:50:32 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 09:50:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:50:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:50:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:50:34 INFO - Installing collected packages: mozsystemmonitor 09:50:34 INFO - Running setup.py install for mozsystemmonitor 09:50:34 INFO - Successfully installed mozsystemmonitor 09:50:34 INFO - Cleaning up... 09:50:34 INFO - Return code: 0 09:50:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:50: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')]} 09:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50: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')]} 09:50:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50: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', '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 0x7f61a9130f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24fd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258f7f0>, '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 0x24fb2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fb760>, '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': 'df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259', '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 09:50: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 09:50: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 blobuploader==1.2.4 09:50:34 INFO - Using env: {'DISPLAY': ':0', 09:50:34 INFO - 'HOME': '/home/cltbld', 09:50:34 INFO - 'LANG': 'en_US.UTF-8', 09:50:34 INFO - 'LANGUAGE': 'en_US:en', 09:50:34 INFO - 'LOGNAME': 'cltbld', 09:50:34 INFO - 'MAIL': '/var/mail/cltbld', 09:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:34 INFO - 'MOZ_NO_REMOTE': '1', 09:50:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:34 INFO - 'NO_EM_RESTART': '1', 09:50:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:50:34 INFO - 'PWD': '/builds/slave/test-pgo', 09:50:34 INFO - 'SHELL': '/bin/bash', 09:50:34 INFO - 'SHLVL': '1', 09:50:34 INFO - 'TERM': 'linux', 09:50:34 INFO - 'TMOUT': '86400', 09:50:34 INFO - 'USER': 'cltbld', 09:50:34 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259', 09:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:34 INFO - '_': '/tools/buildbot/bin/python'} 09:50:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:34 INFO - Downloading/unpacking blobuploader==1.2.4 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50:36 INFO - Downloading blobuploader-1.2.4.tar.gz 09:50:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:50:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:50:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50:36 INFO - Downloading docopt-0.6.1.tar.gz 09:50:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:50:37 INFO - Installing collected packages: blobuploader, requests, docopt 09:50:37 INFO - Running setup.py install for blobuploader 09:50:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:50:37 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:50:37 INFO - Running setup.py install for requests 09:50:37 INFO - Running setup.py install for docopt 09:50:37 INFO - Successfully installed blobuploader requests docopt 09:50:37 INFO - Cleaning up... 09:50:37 INFO - Return code: 0 09:50:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:50:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:37 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f61a9130f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24fd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258f7f0>, '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 0x24fb2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fb760>, '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': 'df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259', '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 09:50:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 09:50:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:50:37 INFO - Using env: {'DISPLAY': ':0', 09:50:37 INFO - 'HOME': '/home/cltbld', 09:50:37 INFO - 'LANG': 'en_US.UTF-8', 09:50:37 INFO - 'LANGUAGE': 'en_US:en', 09:50:37 INFO - 'LOGNAME': 'cltbld', 09:50:37 INFO - 'MAIL': '/var/mail/cltbld', 09:50:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:37 INFO - 'MOZ_NO_REMOTE': '1', 09:50:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:37 INFO - 'NO_EM_RESTART': '1', 09:50:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:50:37 INFO - 'PWD': '/builds/slave/test-pgo', 09:50:37 INFO - 'SHELL': '/bin/bash', 09:50:37 INFO - 'SHLVL': '1', 09:50:37 INFO - 'TERM': 'linux', 09:50:37 INFO - 'TMOUT': '86400', 09:50:37 INFO - 'USER': 'cltbld', 09:50:37 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259', 09:50:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:37 INFO - '_': '/tools/buildbot/bin/python'} 09:50:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:50:37 INFO - Running setup.py (path:/tmp/pip-sKU__S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:50:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:50:37 INFO - Running setup.py (path:/tmp/pip-QhbZ59-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:50:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:50:38 INFO - Running setup.py (path:/tmp/pip-Pe7WRA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:50:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:50:38 INFO - Running setup.py (path:/tmp/pip-EnxiaB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:50:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:50:38 INFO - Running setup.py (path:/tmp/pip-7vOd1X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:50:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:50:38 INFO - Running setup.py (path:/tmp/pip-0XCDq_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:50:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:50:38 INFO - Running setup.py (path:/tmp/pip-rRJWdH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:50:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:50:38 INFO - Running setup.py (path:/tmp/pip-1lV6X1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:50:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:50:38 INFO - Running setup.py (path:/tmp/pip-K304Ht-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:50:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:50:38 INFO - Running setup.py (path:/tmp/pip-Hwq8ig-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:50:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:50:38 INFO - Running setup.py (path:/tmp/pip-xWTDU_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:50:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:50:38 INFO - Running setup.py (path:/tmp/pip-jzMYp0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:50:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:50:38 INFO - Running setup.py (path:/tmp/pip-r3z1Jp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:50:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:50:38 INFO - Running setup.py (path:/tmp/pip-sYfWhM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:50:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:50:38 INFO - Running setup.py (path:/tmp/pip-VpGGUE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:50:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:50:38 INFO - Running setup.py (path:/tmp/pip-1sLSHN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:50:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:50:39 INFO - Running setup.py (path:/tmp/pip-xFluPu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:50:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:50:39 INFO - Running setup.py install for manifestparser 09:50:39 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:50:39 INFO - Running setup.py install for mozcrash 09:50:39 INFO - Running setup.py install for mozdebug 09:50:39 INFO - Running setup.py install for mozdevice 09:50:39 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:50:39 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:50:39 INFO - Running setup.py install for mozfile 09:50:39 INFO - Running setup.py install for mozhttpd 09:50:39 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:50:39 INFO - Running setup.py install for mozinfo 09:50:39 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:50:39 INFO - Running setup.py install for mozInstall 09:50:39 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:50:39 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:50:39 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:50:39 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:50:39 INFO - Running setup.py install for mozleak 09:50:39 INFO - Running setup.py install for mozlog 09:50:40 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:50:40 INFO - Running setup.py install for moznetwork 09:50:40 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:50:40 INFO - Running setup.py install for mozprocess 09:50:40 INFO - Running setup.py install for mozprofile 09:50:40 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:50:40 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:50:40 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:50:40 INFO - Running setup.py install for mozrunner 09:50:40 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:50:40 INFO - Running setup.py install for mozscreenshot 09:50:40 INFO - Running setup.py install for moztest 09:50:40 INFO - Running setup.py install for mozversion 09:50:40 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:50:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:50:40 INFO - Cleaning up... 09:50:40 INFO - Return code: 0 09:50:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:50:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f61a9130f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24fd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258f7f0>, '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 0x24fb2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fb760>, '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': 'df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259', '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 09:50:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 09:50:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:50:40 INFO - Using env: {'DISPLAY': ':0', 09:50:40 INFO - 'HOME': '/home/cltbld', 09:50:40 INFO - 'LANG': 'en_US.UTF-8', 09:50:40 INFO - 'LANGUAGE': 'en_US:en', 09:50:40 INFO - 'LOGNAME': 'cltbld', 09:50:40 INFO - 'MAIL': '/var/mail/cltbld', 09:50:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:40 INFO - 'MOZ_NO_REMOTE': '1', 09:50:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:40 INFO - 'NO_EM_RESTART': '1', 09:50:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:50:40 INFO - 'PWD': '/builds/slave/test-pgo', 09:50:40 INFO - 'SHELL': '/bin/bash', 09:50:40 INFO - 'SHLVL': '1', 09:50:40 INFO - 'TERM': 'linux', 09:50:40 INFO - 'TMOUT': '86400', 09:50:40 INFO - 'USER': 'cltbld', 09:50:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259', 09:50:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:40 INFO - '_': '/tools/buildbot/bin/python'} 09:50:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:50:41 INFO - Running setup.py (path:/tmp/pip-OKtZj5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:50:41 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)) 09:50:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:50:41 INFO - Running setup.py (path:/tmp/pip-JILg6Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:50:41 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)) 09:50:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:50:41 INFO - Running setup.py (path:/tmp/pip-PeLSnW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:50:41 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)) 09:50:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:50:41 INFO - Running setup.py (path:/tmp/pip-WMuRKQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:50:41 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)) 09:50:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:50:41 INFO - Running setup.py (path:/tmp/pip-iW9Fmc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:50:41 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)) 09:50:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:50:41 INFO - Running setup.py (path:/tmp/pip-RcR8hH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:50:41 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)) 09:50:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:50:41 INFO - Running setup.py (path:/tmp/pip-eZs3F4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:50:41 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)) 09:50:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:50:41 INFO - Running setup.py (path:/tmp/pip-SBQ8bV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:50:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 09:50:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:50:41 INFO - Running setup.py (path:/tmp/pip-qN7mDj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:50:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 09:50:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:50:41 INFO - Running setup.py (path:/tmp/pip-r5i58W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:50:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:50:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:50:41 INFO - Running setup.py (path:/tmp/pip-dfVlKN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:50:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 09:50:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:50:41 INFO - Running setup.py (path:/tmp/pip-TFYYjh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:50:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 09:50:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:50:41 INFO - Running setup.py (path:/tmp/pip-yus9Ho-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:50:42 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)) 09:50:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:50:42 INFO - Running setup.py (path:/tmp/pip-FdgnVd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:50:42 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)) 09:50:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:50:42 INFO - Running setup.py (path:/tmp/pip-uiGVUl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:50:42 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)) 09:50:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:50:42 INFO - Running setup.py (path:/tmp/pip-ighnpw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:50:42 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)) 09:50:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:50:42 INFO - Running setup.py (path:/tmp/pip-Yi4Uz3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:50:42 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)) 09:50:42 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)) 09:50:42 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)) 09:50:42 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)) 09:50:42 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)) 09:50:42 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)) 09:50:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:50:42 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 09:50:42 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 09:50:42 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 09:50:42 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 09:50:42 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 09:50:42 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 09:50:44 INFO - Downloading blessings-1.6.tar.gz 09:50:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:50:44 INFO - Installing collected packages: blessings 09:50:44 INFO - Running setup.py install for blessings 09:50:44 INFO - Successfully installed blessings 09:50:44 INFO - Cleaning up... 09:50:44 INFO - Return code: 0 09:50:44 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:50:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:50:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:50:44 INFO - Reading from file tmpfile_stdout 09:50:44 INFO - Current package versions: 09:50:44 INFO - argparse == 1.2.1 09:50:44 INFO - blessings == 1.6 09:50:44 INFO - blobuploader == 1.2.4 09:50:44 INFO - docopt == 0.6.1 09:50:44 INFO - manifestparser == 1.1 09:50:44 INFO - mozInstall == 1.12 09:50:44 INFO - mozcrash == 0.16 09:50:44 INFO - mozdebug == 0.1 09:50:44 INFO - mozdevice == 0.48 09:50:44 INFO - mozfile == 1.2 09:50:44 INFO - mozhttpd == 0.7 09:50:44 INFO - mozinfo == 0.9 09:50:44 INFO - mozleak == 0.1 09:50:44 INFO - mozlog == 3.1 09:50:44 INFO - moznetwork == 0.27 09:50:44 INFO - mozprocess == 0.22 09:50:44 INFO - mozprofile == 0.28 09:50:44 INFO - mozrunner == 6.11 09:50:44 INFO - mozscreenshot == 0.1 09:50:44 INFO - mozsystemmonitor == 0.0 09:50:44 INFO - moztest == 0.7 09:50:44 INFO - mozversion == 1.4 09:50:44 INFO - psutil == 3.1.1 09:50:44 INFO - requests == 1.2.3 09:50:44 INFO - wsgiref == 0.1.2 09:50:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:44 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 0x7f61a9130f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24fd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258f7f0>, '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 0x24fb2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fb760>, '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': 'df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259', '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 09:50:44 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 09:50:44 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 09:50:44 INFO - Using env: {'DISPLAY': ':0', 09:50:44 INFO - 'HOME': '/home/cltbld', 09:50:44 INFO - 'LANG': 'en_US.UTF-8', 09:50:44 INFO - 'LANGUAGE': 'en_US:en', 09:50:44 INFO - 'LOGNAME': 'cltbld', 09:50:44 INFO - 'MAIL': '/var/mail/cltbld', 09:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:44 INFO - 'MOZ_NO_REMOTE': '1', 09:50:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:44 INFO - 'NO_EM_RESTART': '1', 09:50:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:50:44 INFO - 'PWD': '/builds/slave/test-pgo', 09:50:44 INFO - 'SHELL': '/bin/bash', 09:50:44 INFO - 'SHLVL': '1', 09:50:44 INFO - 'TERM': 'linux', 09:50:44 INFO - 'TMOUT': '86400', 09:50:44 INFO - 'USER': 'cltbld', 09:50:44 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259', 09:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:44 INFO - '_': '/tools/buildbot/bin/python'} 09:50:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 09:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 09:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 09:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 09:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 09:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 09:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 09:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 09:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 09:50:44 INFO - Cleaning up... 09:50:44 INFO - Return code: 0 09:50:44 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f61a9130f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24fd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258f7f0>, '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 0x24fb2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fb760>, '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': 'df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259', '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 09:50:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 09:50:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:50:44 INFO - Using env: {'DISPLAY': ':0', 09:50:44 INFO - 'HOME': '/home/cltbld', 09:50:44 INFO - 'LANG': 'en_US.UTF-8', 09:50:44 INFO - 'LANGUAGE': 'en_US:en', 09:50:44 INFO - 'LOGNAME': 'cltbld', 09:50:44 INFO - 'MAIL': '/var/mail/cltbld', 09:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:44 INFO - 'MOZ_NO_REMOTE': '1', 09:50:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:44 INFO - 'NO_EM_RESTART': '1', 09:50:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:50:44 INFO - 'PWD': '/builds/slave/test-pgo', 09:50:44 INFO - 'SHELL': '/bin/bash', 09:50:44 INFO - 'SHLVL': '1', 09:50:44 INFO - 'TERM': 'linux', 09:50:44 INFO - 'TMOUT': '86400', 09:50:44 INFO - 'USER': 'cltbld', 09:50:44 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259', 09:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:44 INFO - '_': '/tools/buildbot/bin/python'} 09:50:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:44 INFO - Downloading/unpacking jsonschema 09:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:50:46 INFO - Downloading/unpacking functools32 (from jsonschema) 09:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:46 INFO - Downloading functools32-3.2.3-2.tar.gz 09:50:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:50:47 INFO - warning: no files found matching '*.txt' 09:50:47 INFO - no previously-included directories found matching 'build' 09:50:47 INFO - no previously-included directories found matching 'dist' 09:50:47 INFO - no previously-included directories found matching '.git*' 09:50:47 INFO - Installing collected packages: jsonschema, functools32 09:50:47 INFO - Running setup.py install for functools32 09:50:47 INFO - warning: no files found matching '*.txt' 09:50:47 INFO - no previously-included directories found matching 'build' 09:50:47 INFO - no previously-included directories found matching 'dist' 09:50:47 INFO - no previously-included directories found matching '.git*' 09:50:47 INFO - Successfully installed jsonschema functools32 09:50:47 INFO - Cleaning up... 09:50:47 INFO - Return code: 0 09:50:47 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:50:47 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')]} 09:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:47 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')]} 09:50:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:47 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 0x7f61a9130f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24fd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258f7f0>, '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 0x24fb2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fb760>, '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': 'df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259', '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 09:50:47 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 09:50:47 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 09:50:47 INFO - Using env: {'DISPLAY': ':0', 09:50:47 INFO - 'HOME': '/home/cltbld', 09:50:47 INFO - 'LANG': 'en_US.UTF-8', 09:50:47 INFO - 'LANGUAGE': 'en_US:en', 09:50:47 INFO - 'LOGNAME': 'cltbld', 09:50:47 INFO - 'MAIL': '/var/mail/cltbld', 09:50:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:47 INFO - 'MOZ_NO_REMOTE': '1', 09:50:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:47 INFO - 'NO_EM_RESTART': '1', 09:50:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:50:47 INFO - 'PWD': '/builds/slave/test-pgo', 09:50:47 INFO - 'SHELL': '/bin/bash', 09:50:47 INFO - 'SHLVL': '1', 09:50:47 INFO - 'TERM': 'linux', 09:50:47 INFO - 'TMOUT': '86400', 09:50:47 INFO - 'USER': 'cltbld', 09:50:47 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259', 09:50:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:47 INFO - '_': '/tools/buildbot/bin/python'} 09:50:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:47 INFO - Downloading/unpacking flake8 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:50:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:50:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:50:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:50:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:50:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:50:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:50:49 INFO - no previously-included directories found matching 'docs/_build' 09:50:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:50:49 INFO - Running setup.py install for pep8 09:50:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:50:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:50:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:50:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:50:50 INFO - no previously-included directories found matching 'docs/_build' 09:50:50 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:50:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:50:50 INFO - Cleaning up... 09:50:50 INFO - Return code: 0 09:50:50 INFO - Running post-action listener: _resource_record_post_action 09:50:50 INFO - Running post-action listener: _start_resource_monitoring 09:50:50 INFO - Starting resource monitoring. 09:50:50 INFO - ##### 09:50:50 INFO - ##### Running install step. 09:50:50 INFO - ##### 09:50:50 INFO - Running pre-action listener: _resource_record_pre_action 09:50:50 INFO - Running main action method: install 09:50:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:50:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:50:50 INFO - Reading from file tmpfile_stdout 09:50:50 INFO - Detecting whether we're running mozinstall >=1.0... 09:50:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:50:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:50:50 INFO - Reading from file tmpfile_stdout 09:50:50 INFO - Output received: 09:50:50 INFO - Usage: mozinstall [options] installer 09:50:50 INFO - Options: 09:50:50 INFO - -h, --help show this help message and exit 09:50:50 INFO - -d DEST, --destination=DEST 09:50:50 INFO - Directory to install application into. [default: 09:50:50 INFO - "/builds/slave/test-pgo"] 09:50:50 INFO - --app=APP Application being installed. [default: firefox] 09:50:50 INFO - mkdir: /builds/slave/test-pgo/build/application 09:50:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 09:50:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 09:51:07 INFO - Reading from file tmpfile_stdout 09:51:07 INFO - Output received: 09:51:07 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:51:07 INFO - Running post-action listener: _resource_record_post_action 09:51:07 INFO - ##### 09:51:07 INFO - ##### Running run-tests step. 09:51:07 INFO - ##### 09:51:07 INFO - Running pre-action listener: _resource_record_pre_action 09:51:07 INFO - Running main action method: run_tests 09:51:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:51:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:51:07 INFO - Python 2.7.3 09:51:07 INFO - Return code: 0 09:51:07 INFO - grabbing minidump binary from tooltool 09:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:07 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 0x258f7f0>, '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 0x24fb2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fb760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:51:07 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 09:51:07 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 09:51:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:51:07 INFO - Return code: 0 09:51:07 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:51:07 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:51:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:51:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:51:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:51:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:51:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:51:08 INFO - Return code: 0 09:51:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 09:51:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:51:08 INFO - Using env: {'DISPLAY': ':0', 09:51:08 INFO - 'HOME': '/home/cltbld', 09:51:08 INFO - 'LANG': 'en_US.UTF-8', 09:51:08 INFO - 'LANGUAGE': 'en_US:en', 09:51:08 INFO - 'LOGNAME': 'cltbld', 09:51:08 INFO - 'MAIL': '/var/mail/cltbld', 09:51:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:51:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:08 INFO - 'MOZ_NO_REMOTE': '1', 09:51:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:51:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:08 INFO - 'NO_EM_RESTART': '1', 09:51:08 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:08 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:08 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:51:08 INFO - 'SHELL': '/bin/bash', 09:51:08 INFO - 'SHLVL': '1', 09:51:08 INFO - 'TERM': 'linux', 09:51:08 INFO - 'TMOUT': '86400', 09:51:08 INFO - 'USER': 'cltbld', 09:51:08 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259', 09:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:08 INFO - '_': '/tools/buildbot/bin/python'} 09:51:08 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:51:09 INFO - mozversion application_buildid: 20160208071710 09:51:09 INFO - mozversion application_changeset: 0b891e31fc10a2c3c8dab1836f34b85366cf9e4b 09:51:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:51:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:51:09 INFO - mozversion application_name: Firefox 09:51:09 INFO - mozversion application_remotingname: firefox-dev 09:51:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:51:09 INFO - mozversion application_vendor: Mozilla 09:51:09 INFO - mozversion application_version: 46.0a2 09:51:09 INFO - mozversion platform_buildid: 20160208071710 09:51:09 INFO - mozversion platform_changeset: 0b891e31fc10a2c3c8dab1836f34b85366cf9e4b 09:51:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:51:09 INFO - mozversion platform_version: 46.0a2 09:51:09 INFO - using testdate: 1454953869 09:51:09 INFO - actual date: 1454953869 09:51:09 INFO - starting webserver on 'localhost:50163' 09:51:09 INFO - SUITE-START | Running 3 tests 09:51:09 INFO - TEST-START | dromaeo_css 09:51:09 INFO - operating with platform_type : linux_ 09:51:09 INFO - Initialising browser for dromaeo_css test... 09:51:09 INFO - TEST-INFO | started process 12048 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXr5nTH/profile http://localhost:50163/getInfo.html) 09:51:13 INFO - PROCESS | 12048 | 09:51:13 INFO - PROCESS | 12048 | (process:12125): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:51:15 INFO - PROCESS | 12048 | __metrics Screen width/height:1600/1200 09:51:15 INFO - PROCESS | 12048 | colorDepth:24 09:51:15 INFO - PROCESS | 12048 | Browser inner width/height: 1024/697 09:51:15 INFO - PROCESS | 12048 | __metrics 09:51:15 INFO - PROCESS | 12048 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 09:51:16 INFO - TEST-INFO | 12048: exit 0 09:51:16 INFO - Browser initialized. 09:51:16 INFO - Running cycle 1/1 for dromaeo_css test... 09:51:16 INFO - TEST-INFO | started process 12174 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXr5nTH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:51:17 INFO - PROCESS | 12174 | 09:51:17 INFO - PROCESS | 12174 | (process:12239): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:51:27 INFO - PROCESS | 12174 | RSS: Main: 140877824 09:51:27 INFO - PROCESS | 12174 | 09:52:17 INFO - PROCESS | 12174 | 1454953937484 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] 09:54:25 INFO - PROCESS | 12174 | Cycle 1(1): loaded http://localhost:50163/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50163/tests/dromaeo/cssquery-ext.html) 09:54:26 INFO - PROCESS | 12174 | RSS: Main: 144904192 09:54:26 INFO - PROCESS | 12174 | 09:57:28 INFO - PROCESS | 12174 | Cycle 1(1): loaded http://localhost:50163/tests/dromaeo/cssquery-ext.html (next: http://localhost:50163/tests/dromaeo/cssquery-jquery.html) 09:57:29 INFO - PROCESS | 12174 | RSS: Main: 143945728 09:57:29 INFO - PROCESS | 12174 | 10:00:31 INFO - PROCESS | 12174 | Cycle 1(1): loaded http://localhost:50163/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50163/tests/dromaeo/cssquery-mootools.html) 10:00:31 INFO - PROCESS | 12174 | RSS: Main: 141922304 10:00:31 INFO - PROCESS | 12174 | 10:03:33 INFO - PROCESS | 12174 | Cycle 1(1): loaded http://localhost:50163/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50163/tests/dromaeo/cssquery-prototype.html) 10:03:33 INFO - PROCESS | 12174 | RSS: Main: 142974976 10:03:33 INFO - PROCESS | 12174 | 10:06:36 INFO - PROCESS | 12174 | Cycle 1(1): loaded http://localhost:50163/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50163/tests/dromaeo/cssquery-yui.html) 10:06:36 INFO - PROCESS | 12174 | RSS: Main: 143048704 10:06:36 INFO - PROCESS | 12174 | 10:09:38 INFO - PROCESS | 12174 | Cycle 1(1): loaded http://localhost:50163/tests/dromaeo/cssquery-yui.html (next: http://localhost:50163/tests/dromaeo/cssquery-dojo.html) 10:09:39 INFO - PROCESS | 12174 | RSS: Main: 145776640 10:09:39 INFO - PROCESS | 12174 | 10:09:39 INFO - PROCESS | 12174 | __start_tp_report 10:09:39 INFO - PROCESS | 12174 | _x_x_mozilla_page_load 10:09:39 INFO - PROCESS | 12174 | _x_x_mozilla_page_load_details 10:09:39 INFO - PROCESS | 12174 | |i|pagename|runs| 10:09:39 INFO - PROCESS | 12174 | |0;dojo.html;3344.615369232539;3353.0611428799943;3388.322335532894;3392.932141357173;3404.744644151689;5403.405625381215;5453.2092846537225;5483;5491.643043202189;5495.450454954503;5388.245645609618;5450.509454149126;5479.424660410659;5490.094134467808;5492.203630473579;4981.701097934127;5010.599152067844;5032.396112466509;5061.721605311706;5102.36220472441;4878.121938051149;4952.950470495285;5013.373328333958;5055.241713742931;5063.392392912856;5030.57240134589;5090.516400941905;5097;5105.030044291572;5127.666701664399;5015.84952451427;5024;5048.747562621873;5063.569596584295;5102.770375333119;4857.975710121462;4926.132910951049;4934.062528119682;4954.455009948902;4997.42529609096;5215.843524694265;5274.05067087924;5278.392984806758;5315.973420132913;5337.3061502004875;5727.112297593838;5783.826485205451;5787.536997040269;5797.942020579824;5811.302643682743;5833.7083145842535;5852.239208902815;5860.70696465175;5866.1494083357675;5940.851478713023;5538.363088244863;5601.29983752031;5601.80393686219;5605.439456054402;5638.4925356718095;5919.230500034968;5920.319163296276;5944.464998150101;5974.970125149346;5982.49148822355;5741.110127930177;5774.960507108761;5791.362950075489;5806.390329015477;5855.882882342329;5899.085641725539;5900.468957793819;5905.350411454737;5918.053111502139;5922.230110085661;5804.912926306109;5818.359980402152;5848.1227815827115;5861.384554621789;5866.941330586725;5703;5813.128030795415;5825.7378417971295;5827.562932780059;5871.295444546682;4505.7296562206375;4524.343970124313;4525.162844873643;4531.864044078683;4555.339475775994;4041.81811818463;4052.675785937118;4069.5116586009867;4097.037196258877;4099.815508302074;5474.644148130359;5505.476979686923;5554.91667624986;5573.219749235111;5593.580481463825;5867.325257595346;5872.324682661463;5886.264216972879;5916.852078698067;5938.732757025944;5390.946090539044;5606.271184746039;5608.6073974821375;5610.551155907518;5612.410696876851;5000.474950130184;5020.196768517019;5071.822486213038;5096.286519887219;5112.156494178419;5996.370381110008;6022.427869352405;6030.246219222598;6036.909446358308;6037.0642550404755;5851.882962340815;5916.112583112482;5925.466707996301;5929.673867937132;5946;5836.182934389104;5906.793262235801;5920.792772253123;5927.31835838884;6049.425304596057;5814.505767009851;5829.883402332014;5844.386339434298;5859.853503662443;5876.970615146897;5909.23179986599;5936.643801371932;5947.464728174312;5957.880842383215;5965.224520812267;5723.170140329546;5751.568632352507;5760.654360738369;5789.797357092481;5824.039033559416;5741.966446039586;5750.194972703908;5774.422557744192;5797.942020579909;5803.9419605803405;5651.378348381757;5652.943470565242;5695.231143795535;5699.202111704281;5710.2576665033275;5614.550835933034;5700.686462244616;5720.74256658443;5737.942620573741;5798.94201057984;5567.387587365468;5602.887942241214;5670.858228544154;5684.204211410489;5716.5426765859465 10:09:39 INFO - PROCESS | 12174 | |1;ext.html;564.4722184757252;573.2261447046487;582.7989343676436;623.510544222785;635.4344633276385;38437.615623843754;38477.42283865744;38896;38923.41614875772;39121;42525.574744252546;43055;43253.35119973203;43378;43420.782896085555;8804.943406791179;8985.505797181153;8988.460692358447;8989.190972812445;9010.774730631721;8601.440906341099;8784.429012114224;8788.69239576615;8917.77705557363;8962.283017358628;8892.59983300753;8922.241609463203;8939.73180804577;8951.95524022379;9014.323925705598;8917.375783695144;8944.508052057166;8953.820923581558;8980.236679882153;8988.685396011108;8835.293176545925;8934.195922367018;8964.462132272085;9003.324750643727;9037.05110963346;42395.576044239475;42704.78647606773;42758;42767;43205.13589728219;3640.690541303992;3641.2353405784816;3681.4661874028384;3715.4241092630687;3723.720720945913;31991.84004079965;32182.517262241086;32500.83749581237;32543.349133017444;32666.510002349984;3696.7597106188014;3701.796401197933;3821.2166505866508;3832.4442955771256;3893.8229717593113;295817.0418295811;297144;297721;299608;300221.49889250635;64245;64537.677311613144;64624;64846.675766620865;64989.67505162444;69579.65210174018;69798.30201698019;69939;70035;70055.64972175106;15784.131872746879;16177.838221617869;16349.754753678704;16350.34598616042;16356;11785.351805650771;11790.94104529472;11814.173007889365;11816.05471562273;11845.644630661094;21525.461863453227;21540;21553.78446215549;21711.805850678047;21782.78217217839;8442.197991190827;8450.577471126418;8561.443506172203;8619.224269815746;8653.26447251978;1098.4946924414699;1122.2069405409663;1126.5381193710703;1144.6165534545853;1196.2403873540366;31083.378332433676;31127.221819454695;31510.36979260402;33109.337813244085;35611;1143.5082914346744;1161.7850697620797;1204.8373469581495;1230.267990545624;1274.8151518029833;15313.387464501295;15431.305591248421;15914.283857226452;16129;16199.190040498164;542493;543815;544422;548560;796453;58475.70762146162;58691.70654146702;58877.41122588719;59636.70181649064;59818.40181598216;1449.7173051254904;1471.1834931612843;1480.9333579988927;1494.1632685696045;1497.2962707527445;31764;32235.939643347385;32285.838570807937;32408.513872292406;32953.83523082369;50448;50797;50880;50941.745291273306;50988.74505627448;327390;331892;334797;335258;335557;34358.31283374268;34951.65048349484;35097.29805403826;35105.29789404147;35240.471392928615;45322.09355812931;45410.77294613638;45682.314765277886;46447.980881243966;52593.7370313146;39849;40309.596904030586;40955.38566921558;41552.79223603863;41798.1640367197;41290;42575.574244257165;44561.77719111383;44745.552544474136;45467.54532454633;41088.1782364357;41650.791746041075;41900.37149442822;45409.77295113503;46318.30522542232;37193;37755.81122094372;38069.238615228096;39049;39057;29563.85218073896;29937.700622993492;30133;30534.84732576323;30638.693613063584 10:09:39 INFO - PROCESS | 12174 | |2;jquery.html;395.9643632073113;398.9980050099749;399.4826699424247;403.36067333276753;404.61561516559277;14184;14666.706665866703;17841.375551855686;18018.639627207463;18576;16133.596660083474;16242.350305987746;16351.182440877938;16961.151942402863;17072.914635426805;5459.563234941205;5636.0982242841155;5651.519620832214;5655.208270842086;5655.4061823508355;5209.7134657593815;5364.383095943957;5365.490278423544;5392.0294347017525;5471.835844924659;5363.865903352408;5372.489613486712;5466.289382380285;5636.802711905084;5640.435956404368;5536.833894983117;5623.859403514924;5637.379888212314;5649.23735295734;5662.263905692254;5481.232627432163;5489.231507588941;5501.394846566875;5507.03626865297;5575.080111781551;13696.863031369758;13715.451381944711;13716.314184290746;13758.518451854237;13985.650358741012;2154.192177933275;2194.8902554872193;2261.807746341563;2410.866714501334;2425.9150929717553;10129.797404051951;10280.640177593823;10325.638602648947;10413.53139108742;10427.895721042769;1869.6447674941853;1883.896385698786;1894.1760334254643;1895.6966885298286;1908.1222637586727;60459.39540604582;60483.39516604822;60597.394026059614;61853;61923;10457.320274182153;10681.198910081775;10799.352038877692;10922.508487118099;10991.945040274748;14253.358598863077;14260.572182834532;14284.785728214085;14360.712785744436;14505.419783208554;7935.166807485246;7944.285014348737;8013.998250218722;8127.431079824356;8161.714339998071;7696.769096927102;7756.069271687321;7777.9110924470615;7790;7846.293833555007;4327.632151267115;4551.112533056023;4555.088982203572;4661.720296782204;4811.735354555533;1902.172554938606;2003.5191554026928;2003.719479272903;2012.5773587546487;2014.2043892662316;1023.8873723890366;1064.6539874540806;1102.063246240705;1154.278575890052;1186.549111337686;16804.6639067218;17266.65466690684;17468.388606398716;17830.821691782916;18378.172982215834;986.3243678080538;1003.3277703938379;1022.7698767777191;1051.148569658579;1059.8781140168978;9328.580213890391;9692;9798.706038818847;9966.2525310602;9998.500074996222;635458;646551;654858;661188;663119;65671;65963;68082.31917680858;74332.25667743254;76237;1115.1803424482998;1152.1358980764426;1165.1669056624385;1165.854268216473;1170.6136974798296;15122.243887805345;15795.131267780382;16186.919065404598;16423.91788041052;16465.753013704565;30791.53812692856;31576.36847263088;32735.34529309448;32767.508487373187;33221.66778332186;37591.24817503689;38421.807890960365;39090.60909390869;39448.605513944494;44190.55809441993;7585.544867307979;7588.544687318778;7590.278923502258;7640.274173953688;7706.460547761603;10788;11282.379469129277;11371.404336002663;11579.594714184963;12027.75944481123;3286.359159963784;4703.882402939954;7437.851242975002;10142.594296228068;10289.43408112561;9678.95160524193;10035.09684128432;10283;10365.170786336925;10809.513571889127;9619.759506012406;10168.135708464863;10281.74295642585;10599.993000664925;10705.19711021661;7901.841963160819;8012.599370031358;8013.719519816778;8059;8110;9649.565769540248;10184.490775461345;10232;10493.003164699341;10528.210384221062 10:09:39 INFO - PROCESS | 12174 | |3;mootools.html;1485.762278035514;1500.9249537523121;1703.3442124781955;1827.232562323824;1857.127150239388;8235.794105147374;8236.17638236176;8447.577621118935;8488.066312705605;8516.276116530087;8538.743837684864;8554.52950087745;8650.697225597105;8676.783080422992;8681.696140635078;2457.299669594166;2505.9373515662164;2505.962410563843;2509.2221411362443;2511.3972646564785;2463.556559819232;2513.158092039169;2515.2705715342527;2515.735847735989;2517.697876254852;2398.6162214045758;2398.8080953523763;2419.1895714935517;2472.1223965492263;2482.726900040994;2476.0838489758726;2478.529079474894;2488.35302821266;2491.426971796497;2504.6243063540433;2448.4735781807;2451.350392146083;2464.9137280195287;2469.7283298837115;2475.443025319307;8299.502029878227;8327.750167494985;8410.537420441935;8418.83162336756;8457.873131903027;5192.7403629818355;5265.552428043621;5284;5288.444713305124;5332.520073193431;3150.558921750957;3182.80903145812;3232.4504834178247;3297.7196938260277;3320.734341252694;1057.1754031855164;1843.6957901946162;1850.5281153305955;1867.8318951294314;1884.3404808317116;11850.288982660983;11922.853886300463;12021.759564808743;12075.215111017756;12184.756304873941;4717.669763116549;4738.526147385234;4806.158922188603;4895.6083513318845;4899.926501102486;10395.116415104801;10424.374537527772;10487.737806554744;10523.263371563917;10550.736231594272;5354.41101478837;5392.299001129828;5397.649152805055;5418.431064738224;5445.618806683573;4792.496787837227;4848.10310092634;4856.271559266138;4904.6321525885705;4913.238448040559;3836.0601652594733;3887.727859049896;3888.747231429948;3917.353636649978;4008.238434697398;1193.8985186259092;1202.2786328203008;1202.5971299614553;1229.7970834812156;1238.8637249902504;1433.9067960582738;1450.9492167774076;1464.3337281536876;1472.021105964543;1488.1963739580722;7882;7955.681772729142;7987.400944929153;8008.279254866973;8013.2387423194705;1202.6211743300832;1212.8969037631723;1225.9754804903853;1240.1257113734796;1245.993770031144;6149.661768602769;6150.108234306001;6263.843403914848;6279.529035322278;6403.583767055126;10173.287869849188;10527.894721052844;10548.47257637115;10598.947005264925;10657.520411581498;10079.445630490394;10337.17302615804;10453.529591168415;10506.317089389166;10529.526171322308;8062.7581172564915;8094.433389662785;8113.391495637851;8120.269175774209;8191.672333106728;7682.961585192262;7749.7287594933905;7791.415643826623;7791.805204869697;7801.609919504115;9124.863127052966;9130.863037054316;9304.209142222986;9358.017408172043;9440.433573985309;9306.441613503212;9458.574364153492;9588.328816983023;9694.46680432583;9794.559244833858;7172.462065345016;7201.3518783309755;7286.417086633162;7321.597312147883;7332.120145582351;7913.802154945942;7922.207779222032;7936.880946785918;7944.761657150295;8046;7282.308180722823;7359.227281135403;7413.703451861865;7502.662380193014;7571.432142589438;7023.438124950094;7131.0729605151;7186.96406517985;7201.747938822116;7277.672504737406;7225.24134965842;7296.19741828409;7338.522996005243;7374.373178279906;7452.962735186289;6615.4046135848;6621.073049772939;6678.298778628368;6688.598684078971;6710.530262881552;6945.687444064928;6955.200151982587;6990.720371185095;7024.754133605299;7092.290770922867 10:09:39 INFO - PROCESS | 12174 | |4;prototype.html;373.48832100022963;373.5312183210071;377.29822530094003;379.45927053948117;380.6783268138422;6341.270753863307;6369.140166077578;6386.808395748129;6456.385164008572;6620.569662971903;6389.795520545416;6428.100065990765;6443.355664433554;6463.353664633534;6466.676666166684;4926.45808961014;4932.038252540738;4933.876653083675;4935.3090567320605;4941.925871111936;4870.975645121787;4952.405711314629;4956.776945037482;4958.6281028922795;4961.305417241589;4867.245576935581;4872.65891387603;4881.292212629167;4887.7311747853855;4894.77973491192;4879.365682461275;4880.536349046853;4882.292067650171;4889.095517329305;4890.193118135503;4238.427812245338;4260.21186080573;4264.1471705659;4271.060366719316;4275.636570891478;5946.940530594682;6068.605540639845;6099.57302988791;6108.633481991094;6133.938660613381;5651.858703532444;5656.490915817555;5658.151277308396;5667.801626943078;5720.456556627114;6789.728410863609;6791.252962174206;6792.626405547742;6807.693653785542;6818.318168183142;4737.976310118462;4744;4746.715197088151;4752.097101550694;4752.857414277577;6824.385805277549;6934.375906168419;7055.541389809646;7058.964705176441;7076.540024898417;4853.247746599212;4868.659193856467;4870.342503761947;4871.0014447038275;4876.4879687633;4937.629677774181;4939.629527785431;4944.159492886218;4954.9009019819405;4958.528939750718;5627.32472103342;5697.914531282034;5700.287464066992;5707.942920570824;5712;6768.932310676929;6822.351876571718;6858.451323894076;6862.622555759481;6871.4502839772695;1698.7961444626724;1723.310675729693;1730.6884760742935;1733.9566510837078;1734.1242672450333;1148.1561052626314;1158.3108050709814;1164.249059356727;1175.4651633506735;1180.0264781555252;6523.445507131852;6546.8363290918105;6561.14705088345;6562.704678289489;6570.080188773575;6947.965260173667;6956.339147780953;6958.65206739661;6966;6971.51199416036;6373;6420.261669907927;6464.806055818333;6479.5788273762055;6488.870222595616;3733.309337772521;3778.3199024175365;3783.6027217142355;3784.3188226119564;3784.7918364489665;7107.502474826816;7118.145822501229;7124.608146551989;7127.10911136108;7131.358177764027;7033.507654464241;7092.148942126874;7118.430525557943;7126.2873712628325;7307.5980821055355;7313.48805583604;7328.083989501312;7337.449691273176;7340.926590734024;7353.154387245429;7119.964400177966;7125.216226215009;7140.428765698628;7146.821329466597;7167.247439018828;6864.347886950732;6935.965320173569;6962.617056061965;6985.685644146127;7029.61337126463;7273.927260727325;7294.197638259893;7310.817229569303;7319.74380896666;7322.96338518304;4788.329633851334;4858.17411040117;4870.707757534417;4878.585320247818;4879.463259041574;6805.183377994672;6959.408450281783;6969.16370035599;7090.716371345295;7110.075690160246;6746.898796518154;6855.143107111611;6884.65576721172;6890.793276201722;6890.827729306607;6843.315668433117;6855.211650660238;6855.314468553105;6858.3141685831015;6861.588304701734;6574.079628851869;6718.563293385914;6731.52879298464;6741.764038258638;6742;6796.388325050769;6874.725010999504;6887.345702158287;6911.239763626098;6957.373836354753;6601.702923368364;6700.43046341047;6720.327967203436;6720.966395167993;6722.361375669304 10:09:39 INFO - PROCESS | 12174 | |5;yui.html;777.0170734021464;811.387402511104;831.8419500294943;902.7833320003201;973.8101070291292;15930.123843188634;16261.18694065295;16287.1042092685;16356.509304720863;16467.58831029225;15861.92069039656;15899.920500397511;15909.204539772994;15979;15984.84015159851;868.3617541107282;888.1562515610163;892.7187935800234;896.672714459221;901.184428092574;891.4829398948594;892.6697122064812;894.6197865906996;897.1297841094129;899.4468401932829;921.8202450522117;925.9675911343104;927.2998885841181;930.3115694386139;931.0224264522259;915.7619019055027;919.9816003679922;922.082527884759;923.6628630549834;924.3806649544821;680.1939701453794;681.3084719010209;681.9079424277709;682.6245564939313;684.0594182998377;14959.775603365959;14961.40154393823;14985.400583976629;15006;15042.247887605576;12988.675283117998;13076.476940922352;13093.86906130936;13315.53395631158;13391.330433478288;10953;10994.065504432132;11016.394098324588;11165.72085697856;11210.439478026066;3858.421236814472;3945.9802700986597;3951.229510245503;3968.305546529346;3992.181602771425;51690.22464663033;53150;53291.46708532904;53393.466065339235;53471.46528534704;11088.722781930517;11173.441327933733;11192.216544841946;11245.100391968623;11391.943040284912;19158.329458469165;19170.233190672498;19228.230870765292;19286.132124054453;19400.417987460398;8082.110967793656;8154.918450815535;8376.706815261437;8483.278921291636;8573;4448.110377924363;4511.729296242236;4521.3896124023495;4525.570070843265;4627.028324051919;3202.743780497555;3265.804051756902;3270.8855190068234;3273.083536609753;3274.6070471543567;613.8557439001831;614.4562062574654;615.4030590327375;616.9598976066542;619.6251267982806;491.7393781295919;591.5711109445617;621.4251817069284;634.8317695810614;676.0602762160601;8605.827883442296;8895.777605559913;8919.152680495343;9116.49859257734;9164.221041211571;504.5585113026102;518.9221616757441;597.1818608506287;611.6146827498736;689.5138927056413;3848.5381754189116;3901.221004269747;3969.960300397017;4077.4903137107863;4101.487314085739;62723;62748.372516275165;63083.68458157772;63425;63475;54499;55029.174562381595;55153.72423137939;55843.44156558464;55975.720121399136;47623.28565071527;47747.28379074317;48325.275120873215;48517.514824852005;49083;8641.827163456821;8873.64505419776;9043.638254469748;9109.726708198765;9166;35387.646123538434;36051.459228111074;36318.818405907805;36433.453498198076;36559.45160822537;44728.77635611801;47241.52758472371;47793.28310075421;48561.757191215234;49115;10812.513436895515;10876.891231087904;11260.9436952818;11488.255872063968;11636.767264654829;12043.217190882564;12226.877731222574;12393.380330983595;12426.254424734545;12658.620241392773;11895.643130706092;12083.214591051554;12113.454894529592;12269.263844169378;12271.509139634314;11158.386288754196;11181.608643697757;11627.6511704649;11826.408679566159;12004.75990480203;10992.890071099187;11460.598879039193;11485.253458525169;11887.702807429883;12169.574064907685;9263.583138758637;9443.575039123394;9772.9022709772;9889.258305626963;10016.899831001596;9583.856242156513;9622.47076410804;9940.353876997971;9961.900380996098;9990.500474976077 10:09:39 INFO - PROCESS | 12174 | __end_tp_report 10:09:39 INFO - PROCESS | 12174 | __start_cc_report 10:09:39 INFO - PROCESS | 12174 | _x_x_mozilla_cycle_collect,292 10:09:39 INFO - PROCESS | 12174 | __end_cc_report 10:09:39 INFO - PROCESS | 12174 | __startTimestamp1454954979176__endTimestamp 10:09:39 INFO - PROCESS | 12174 | 10:09:39 INFO - PROCESS | 12174 | ------- Summary: start ------- 10:09:39 INFO - PROCESS | 12174 | Number of tests: 6 10:09:39 INFO - PROCESS | 12174 | 10:09:39 INFO - PROCESS | 12174 | [#0] dojo.html Cycles:165 Average:5459.01 Median:5695.23 stddev:582.81 (10.2%) stddev-sans-first:560.50 10:09:39 INFO - PROCESS | 12174 | Values: 3344.6 3353.1 3388.3 3392.9 3404.7 5403.4 5453.2 5483.0 5491.6 5495.5 5388.2 5450.5 5479.4 5490.1 5492.2 4981.7 5010.6 5032.4 5061.7 5102.4 4878.1 4953.0 5013.4 5055.2 5063.4 5030.6 5090.5 5097.0 5105.0 5127.7 5015.8 5024.0 5048.7 5063.6 5102.8 4858.0 4926.1 4934.1 4954.5 4997.4 5215.8 5274.1 5278.4 5316.0 5337.3 5727.1 5783.8 5787.5 5797.9 5811.3 5833.7 5852.2 5860.7 5866.1 5940.9 5538.4 5601.3 5601.8 5605.4 5638.5 5919.2 5920.3 5944.5 5975.0 5982.5 5741.1 5775.0 5791.4 5806.4 5855.9 5899.1 5900.5 5905.4 5918.1 5922.2 5804.9 5818.4 5848.1 5861.4 5866.9 5703.0 5813.1 5825.7 5827.6 5871.3 4505.7 4524.3 4525.2 4531.9 4555.3 4041.8 4052.7 4069.5 4097.0 4099.8 5474.6 5505.5 5554.9 5573.2 5593.6 5867.3 5872.3 5886.3 5916.9 5938.7 5390.9 5606.3 5608.6 5610.6 5612.4 5000.5 5020.2 5071.8 5096.3 5112.2 5996.4 6022.4 6030.2 6036.9 6037.1 5851.9 5916.1 5925.5 5929.7 5946.0 5836.2 5906.8 5920.8 5927.3 6049.4 5814.5 5829.9 5844.4 5859.9 5877.0 5909.2 5936.6 5947.5 5957.9 5965.2 5723.2 5751.6 5760.7 5789.8 5824.0 5742.0 5750.2 5774.4 5797.9 5803.9 5651.4 5652.9 5695.2 5699.2 5710.3 5614.6 5700.7 5720.7 5737.9 5798.9 5567.4 5602.9 5670.9 5684.2 5716.5 10:09:39 INFO - PROCESS | 12174 | 10:09:39 INFO - PROCESS | 12174 | [#1] ext.html Cycles:180 Average:58370.55 Median:40079.30 stddev:115529.11 (288.3%) stddev-sans-first:115771.67 10:09:39 INFO - PROCESS | 12174 | Values: 564.5 573.2 582.8 623.5 635.4 38437.6 38477.4 38896.0 38923.4 39121.0 42525.6 43055.0 43253.4 43378.0 43420.8 8804.9 8985.5 8988.5 8989.2 9010.8 8601.4 8784.4 8788.7 8917.8 8962.3 8892.6 8922.2 8939.7 8952.0 9014.3 8917.4 8944.5 8953.8 8980.2 8988.7 8835.3 8934.2 8964.5 9003.3 9037.1 42395.6 42704.8 42758.0 42767.0 43205.1 3640.7 3641.2 3681.5 3715.4 3723.7 31991.8 32182.5 32500.8 32543.3 32666.5 3696.8 3701.8 3821.2 3832.4 3893.8 295817.0 297144.0 297721.0 299608.0 300221.5 64245.0 64537.7 64624.0 64846.7 64989.7 69579.7 69798.3 69939.0 70035.0 70055.6 15784.1 16177.8 16349.8 16350.3 16356.0 11785.4 11790.9 11814.2 11816.1 11845.6 21525.5 21540.0 21553.8 21711.8 21782.8 8442.2 8450.6 8561.4 8619.2 8653.3 1098.5 1122.2 1126.5 1144.6 1196.2 31083.4 31127.2 31510.4 33109.3 35611.0 1143.5 1161.8 1204.8 1230.3 1274.8 15313.4 15431.3 15914.3 16129.0 16199.2 542493.0 543815.0 544422.0 548560.0 796453.0 58475.7 58691.7 58877.4 59636.7 59818.4 1449.7 1471.2 1480.9 1494.2 1497.3 31764.0 32235.9 32285.8 32408.5 32953.8 50448.0 50797.0 50880.0 50941.7 50988.7 327390.0 331892.0 334797.0 335258.0 335557.0 34358.3 34951.7 35097.3 35105.3 35240.5 45322.1 45410.8 45682.3 46448.0 52593.7 39849.0 40309.6 40955.4 41552.8 41798.2 41290.0 42575.6 44561.8 44745.6 45467.5 41088.2 41650.8 41900.4 45409.8 46318.3 37193.0 37755.8 38069.2 39049.0 39057.0 29563.9 29937.7 30133.0 30534.8 30638.7 10:09:39 INFO - PROCESS | 12174 | 10:09:39 INFO - PROCESS | 12174 | [#2] jquery.html Cycles:180 Average:30661.82 Median:32751.43 stddev:106456.91 (325.0%) stddev-sans-first:106731.29 10:09:39 INFO - PROCESS | 12174 | Values: 396.0 399.0 399.5 403.4 404.6 14184.0 14666.7 17841.4 18018.6 18576.0 16133.6 16242.4 16351.2 16961.2 17072.9 5459.6 5636.1 5651.5 5655.2 5655.4 5209.7 5364.4 5365.5 5392.0 5471.8 5363.9 5372.5 5466.3 5636.8 5640.4 5536.8 5623.9 5637.4 5649.2 5662.3 5481.2 5489.2 5501.4 5507.0 5575.1 13696.9 13715.5 13716.3 13758.5 13985.7 2154.2 2194.9 2261.8 2410.9 2425.9 10129.8 10280.6 10325.6 10413.5 10427.9 1869.6 1883.9 1894.2 1895.7 1908.1 60459.4 60483.4 60597.4 61853.0 61923.0 10457.3 10681.2 10799.4 10922.5 10991.9 14253.4 14260.6 14284.8 14360.7 14505.4 7935.2 7944.3 8014.0 8127.4 8161.7 7696.8 7756.1 7777.9 7790.0 7846.3 4327.6 4551.1 4555.1 4661.7 4811.7 1902.2 2003.5 2003.7 2012.6 2014.2 1023.9 1064.7 1102.1 1154.3 1186.5 16804.7 17266.7 17468.4 17830.8 18378.2 986.3 1003.3 1022.8 1051.1 1059.9 9328.6 9692.0 9798.7 9966.3 9998.5 635458.0 646551.0 654858.0 661188.0 663119.0 65671.0 65963.0 68082.3 74332.3 76237.0 1115.2 1152.1 1165.2 1165.9 1170.6 15122.2 15795.1 16186.9 16423.9 16465.8 30791.5 31576.4 32735.3 32767.5 33221.7 37591.2 38421.8 39090.6 39448.6 44190.6 7585.5 7588.5 7590.3 7640.3 7706.5 10788.0 11282.4 11371.4 11579.6 12027.8 3286.4 4703.9 7437.9 10142.6 10289.4 9679.0 10035.1 10283.0 10365.2 10809.5 9619.8 10168.1 10281.7 10600.0 10705.2 7901.8 8012.6 8013.7 8059.0 8110.0 9649.6 10184.5 10232.0 10493.0 10528.2 10:09:39 INFO - PROCESS | 12174 | 10:09:39 INFO - PROCESS | 12174 | [#3] mootools.html Cycles:180 Average:5990.59 Median:5229.15 stddev:3092.30 (59.1%) stddev-sans-first:3082.44 10:09:39 INFO - PROCESS | 12174 | Values: 1485.8 1500.9 1703.3 1827.2 1857.1 8235.8 8236.2 8447.6 8488.1 8516.3 8538.7 8554.5 8650.7 8676.8 8681.7 2457.3 2505.9 2506.0 2509.2 2511.4 2463.6 2513.2 2515.3 2515.7 2517.7 2398.6 2398.8 2419.2 2472.1 2482.7 2476.1 2478.5 2488.4 2491.4 2504.6 2448.5 2451.4 2464.9 2469.7 2475.4 8299.5 8327.8 8410.5 8418.8 8457.9 5192.7 5265.6 5284.0 5288.4 5332.5 3150.6 3182.8 3232.5 3297.7 3320.7 1057.2 1843.7 1850.5 1867.8 1884.3 11850.3 11922.9 12021.8 12075.2 12184.8 4717.7 4738.5 4806.2 4895.6 4899.9 10395.1 10424.4 10487.7 10523.3 10550.7 5354.4 5392.3 5397.6 5418.4 5445.6 4792.5 4848.1 4856.3 4904.6 4913.2 3836.1 3887.7 3888.7 3917.4 4008.2 1193.9 1202.3 1202.6 1229.8 1238.9 1433.9 1450.9 1464.3 1472.0 1488.2 7882.0 7955.7 7987.4 8008.3 8013.2 1202.6 1212.9 1226.0 1240.1 1246.0 6149.7 6150.1 6263.8 6279.5 6403.6 10173.3 10527.9 10548.5 10598.9 10657.5 10079.4 10337.2 10453.5 10506.3 10529.5 8062.8 8094.4 8113.4 8120.3 8191.7 7683.0 7749.7 7791.4 7791.8 7801.6 9124.9 9130.9 9304.2 9358.0 9440.4 9306.4 9458.6 9588.3 9694.5 9794.6 7172.5 7201.4 7286.4 7321.6 7332.1 7913.8 7922.2 7936.9 7944.8 8046.0 7282.3 7359.2 7413.7 7502.7 7571.4 7023.4 7131.1 7187.0 7201.7 7277.7 7225.2 7296.2 7338.5 7374.4 7453.0 6615.4 6621.1 6678.3 6688.6 6710.5 6945.7 6955.2 6990.7 7024.8 7092.3 10:09:39 INFO - PROCESS | 12174 | 10:09:39 INFO - PROCESS | 12174 | [#4] prototype.html Cycles:180 Average:5700.38 Median:6465.74 stddev:1711.74 (26.5%) stddev-sans-first:1669.19 10:09:39 INFO - PROCESS | 12174 | Values: 373.5 373.5 377.3 379.5 380.7 6341.3 6369.1 6386.8 6456.4 6620.6 6389.8 6428.1 6443.4 6463.4 6466.7 4926.5 4932.0 4933.9 4935.3 4941.9 4871.0 4952.4 4956.8 4958.6 4961.3 4867.2 4872.7 4881.3 4887.7 4894.8 4879.4 4880.5 4882.3 4889.1 4890.2 4238.4 4260.2 4264.1 4271.1 4275.6 5946.9 6068.6 6099.6 6108.6 6133.9 5651.9 5656.5 5658.2 5667.8 5720.5 6789.7 6791.3 6792.6 6807.7 6818.3 4738.0 4744.0 4746.7 4752.1 4752.9 6824.4 6934.4 7055.5 7059.0 7076.5 4853.2 4868.7 4870.3 4871.0 4876.5 4937.6 4939.6 4944.2 4954.9 4958.5 5627.3 5697.9 5700.3 5707.9 5712.0 6768.9 6822.4 6858.5 6862.6 6871.5 1698.8 1723.3 1730.7 1734.0 1734.1 1148.2 1158.3 1164.2 1175.5 1180.0 6523.4 6546.8 6561.1 6562.7 6570.1 6948.0 6956.3 6958.7 6966.0 6971.5 6373.0 6420.3 6464.8 6479.6 6488.9 3733.3 3778.3 3783.6 3784.3 3784.8 7107.5 7118.1 7124.6 7127.1 7131.4 7033.5 7092.1 7118.4 7126.3 7307.6 7313.5 7328.1 7337.4 7340.9 7353.2 7120.0 7125.2 7140.4 7146.8 7167.2 6864.3 6936.0 6962.6 6985.7 7029.6 7273.9 7294.2 7310.8 7319.7 7323.0 4788.3 4858.2 4870.7 4878.6 4879.5 6805.2 6959.4 6969.2 7090.7 7110.1 6746.9 6855.1 6884.7 6890.8 6890.8 6843.3 6855.2 6855.3 6858.3 6861.6 6574.1 6718.6 6731.5 6741.8 6742.0 6796.4 6874.7 6887.3 6911.2 6957.4 6601.7 6700.4 6720.3 6721.0 6722.4 10:09:39 INFO - PROCESS | 12174 | 10:09:39 INFO - PROCESS | 12174 | [#5] yui.html Cycles:180 Average:14790.23 Median:48059.28 stddev:17194.62 (35.8%) stddev-sans-first:17210.65 10:09:39 INFO - PROCESS | 12174 | Values: 777.0 811.4 831.8 902.8 973.8 15930.1 16261.2 16287.1 16356.5 16467.6 15861.9 15899.9 15909.2 15979.0 15984.8 868.4 888.2 892.7 896.7 901.2 891.5 892.7 894.6 897.1 899.4 921.8 926.0 927.3 930.3 931.0 915.8 920.0 922.1 923.7 924.4 680.2 681.3 681.9 682.6 684.1 14959.8 14961.4 14985.4 15006.0 15042.2 12988.7 13076.5 13093.9 13315.5 13391.3 10953.0 10994.1 11016.4 11165.7 11210.4 3858.4 3946.0 3951.2 3968.3 3992.2 51690.2 53150.0 53291.5 53393.5 53471.5 11088.7 11173.4 11192.2 11245.1 11391.9 19158.3 19170.2 19228.2 19286.1 19400.4 8082.1 8154.9 8376.7 8483.3 8573.0 4448.1 4511.7 4521.4 4525.6 4627.0 3202.7 3265.8 3270.9 3273.1 3274.6 613.9 614.5 615.4 617.0 619.6 491.7 591.6 621.4 634.8 676.1 8605.8 8895.8 8919.2 9116.5 9164.2 504.6 518.9 597.2 611.6 689.5 3848.5 3901.2 3970.0 4077.5 4101.5 62723.0 62748.4 63083.7 63425.0 63475.0 54499.0 55029.2 55153.7 55843.4 55975.7 47623.3 47747.3 48325.3 48517.5 49083.0 8641.8 8873.6 9043.6 9109.7 9166.0 35387.6 36051.5 36318.8 36433.5 36559.5 44728.8 47241.5 47793.3 48561.8 49115.0 10812.5 10876.9 11260.9 11488.3 11636.8 12043.2 12226.9 12393.4 12426.3 12658.6 11895.6 12083.2 12113.5 12269.3 12271.5 11158.4 11181.6 11627.7 11826.4 12004.8 10992.9 11460.6 11485.3 11887.7 12169.6 9263.6 9443.6 9772.9 9889.3 10016.9 9583.9 9622.5 9940.4 9961.9 9990.5 10:09:39 INFO - PROCESS | 12174 | -------- Summary: end -------- 10:09:39 INFO - PROCESS | 12174 | 10:09:39 INFO - TEST-INFO | 12174: exit 0 10:09:39 INFO - TEST-OK | dromaeo_css | took 1110792ms 10:09:39 INFO - TEST-START | kraken 10:09:39 INFO - operating with platform_type : linux_ 10:09:39 INFO - Initialising browser for kraken test... 10:09:39 INFO - TEST-INFO | started process 12425 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpu3LwYs/profile http://localhost:50163/getInfo.html) 10:09:44 INFO - PROCESS | 12425 | 10:09:44 INFO - PROCESS | 12425 | (process:12506): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:09:45 INFO - PROCESS | 12425 | __metrics Screen width/height:1600/1200 10:09:45 INFO - PROCESS | 12425 | colorDepth:24 10:09:45 INFO - PROCESS | 12425 | Browser inner width/height: 1024/697 10:09:45 INFO - PROCESS | 12425 | __metrics 10:09:46 INFO - TEST-INFO | 12425: exit 0 10:09:46 INFO - Browser initialized. 10:09:46 INFO - Running cycle 1/1 for kraken test... 10:09:46 INFO - TEST-INFO | started process 12555 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpu3LwYs/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:09:47 INFO - PROCESS | 12555 | 10:09:47 INFO - PROCESS | 12555 | (process:12617): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:09:58 INFO - PROCESS | 12555 | RSS: Main: 140091392 10:09:58 INFO - PROCESS | 12555 | 10:10:00 INFO - PROCESS | 12555 | Cycle 1(1): loaded http://localhost:50163/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50163/tests/kraken/driver.html?testName=audio-beat-detection) 10:10:01 INFO - PROCESS | 12555 | RSS: Main: 145317888 10:10:01 INFO - PROCESS | 12555 | 10:10:04 INFO - PROCESS | 12555 | Cycle 1(1): loaded http://localhost:50163/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50163/tests/kraken/driver.html?testName=audio-dft) 10:10:04 INFO - PROCESS | 12555 | RSS: Main: 143646720 10:10:04 INFO - PROCESS | 12555 | 10:10:07 INFO - PROCESS | 12555 | Cycle 1(1): loaded http://localhost:50163/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50163/tests/kraken/driver.html?testName=audio-fft) 10:10:08 INFO - PROCESS | 12555 | RSS: Main: 145940480 10:10:08 INFO - PROCESS | 12555 | 10:10:10 INFO - PROCESS | 12555 | Cycle 1(1): loaded http://localhost:50163/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50163/tests/kraken/driver.html?testName=audio-oscillator) 10:10:10 INFO - PROCESS | 12555 | RSS: Main: 145784832 10:10:10 INFO - PROCESS | 12555 | 10:10:12 INFO - PROCESS | 12555 | Cycle 1(1): loaded http://localhost:50163/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50163/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:10:13 INFO - PROCESS | 12555 | RSS: Main: 145694720 10:10:13 INFO - PROCESS | 12555 | 10:10:16 INFO - PROCESS | 12555 | Cycle 1(1): loaded http://localhost:50163/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50163/tests/kraken/driver.html?testName=imaging-darkroom) 10:10:16 INFO - PROCESS | 12555 | RSS: Main: 144846848 10:10:16 INFO - PROCESS | 12555 | 10:10:20 INFO - PROCESS | 12555 | Cycle 1(1): loaded http://localhost:50163/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50163/tests/kraken/driver.html?testName=imaging-desaturate) 10:10:20 INFO - PROCESS | 12555 | RSS: Main: 144793600 10:10:20 INFO - PROCESS | 12555 | 10:10:23 INFO - PROCESS | 12555 | Cycle 1(1): loaded http://localhost:50163/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50163/tests/kraken/driver.html?testName=json-parse-financial) 10:10:24 INFO - PROCESS | 12555 | RSS: Main: 143679488 10:10:24 INFO - PROCESS | 12555 | 10:10:25 INFO - PROCESS | 12555 | Cycle 1(1): loaded http://localhost:50163/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50163/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:10:26 INFO - PROCESS | 12555 | RSS: Main: 144646144 10:10:26 INFO - PROCESS | 12555 | 10:10:28 INFO - PROCESS | 12555 | Cycle 1(1): loaded http://localhost:50163/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50163/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:10:28 INFO - PROCESS | 12555 | RSS: Main: 143708160 10:10:28 INFO - PROCESS | 12555 | 10:10:30 INFO - PROCESS | 12555 | Cycle 1(1): loaded http://localhost:50163/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50163/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:10:31 INFO - PROCESS | 12555 | RSS: Main: 144441344 10:10:31 INFO - PROCESS | 12555 | 10:10:33 INFO - PROCESS | 12555 | Cycle 1(1): loaded http://localhost:50163/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50163/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:10:34 INFO - PROCESS | 12555 | RSS: Main: 146456576 10:10:34 INFO - PROCESS | 12555 | 10:10:36 INFO - PROCESS | 12555 | Cycle 1(1): loaded http://localhost:50163/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50163/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:10:37 INFO - PROCESS | 12555 | RSS: Main: 146026496 10:10:37 INFO - PROCESS | 12555 | 10:10:39 INFO - PROCESS | 12555 | Cycle 1(1): loaded http://localhost:50163/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50163/tests/kraken/driver.html?testName=ai-astar) 10:10:39 INFO - PROCESS | 12555 | RSS: Main: 146800640 10:10:39 INFO - PROCESS | 12555 | 10:10:39 INFO - PROCESS | 12555 | __start_tp_report 10:10:39 INFO - PROCESS | 12555 | _x_x_mozilla_page_load 10:10:39 INFO - PROCESS | 12555 | _x_x_mozilla_page_load_details 10:10:39 INFO - PROCESS | 12555 | |i|pagename|runs| 10:10:39 INFO - PROCESS | 12555 | |0;ai-astar;112;106;114;111;111;122;111;110;109;110 10:10:39 INFO - PROCESS | 12555 | |1;audio-beat-detection;162;138;151;155;124;154;158;127;167;127 10:10:39 INFO - PROCESS | 12555 | |2;audio-dft;163;166;161;164;161;163;161;160;164;161 10:10:39 INFO - PROCESS | 12555 | |3;audio-fft;73;73;73;153;73;75;74;74;166;72 10:10:39 INFO - PROCESS | 12555 | |4;audio-oscillator;95;94;137;94;95;95;140;94;95;143 10:10:39 INFO - PROCESS | 12555 | |5;imaging-gaussian-blur;112;110;109;109;110;110;110;109;109;110 10:10:39 INFO - PROCESS | 12555 | |6;imaging-darkroom;147;147;147;146;147;147;146;148;147;148 10:10:39 INFO - PROCESS | 12555 | |7;imaging-desaturate;96;98;96;97;97;97;98;96;97;96 10:10:39 INFO - PROCESS | 12555 | |8;json-parse-financial;55;56;55;55;57;66;55;68;53;55 10:10:39 INFO - PROCESS | 12555 | |9;json-stringify-tinderbox;64;63;64;64;64;63;64;64;63;64 10:10:39 INFO - PROCESS | 12555 | |10;stanford-crypto-aes;82;89;89;83;82;83;82;83;82;81 10:10:39 INFO - PROCESS | 12555 | |11;stanford-crypto-ccm;116;112;118;109;110;126;118;120;111;118 10:10:39 INFO - PROCESS | 12555 | |12;stanford-crypto-pbkdf2;140;139;134;130;137;135;135;145;135;136 10:10:39 INFO - PROCESS | 12555 | |13;stanford-crypto-sha256-iterative;66;68;65;68;66;68;65;67;67;68 10:10:39 INFO - PROCESS | 12555 | __end_tp_report 10:10:39 INFO - PROCESS | 12555 | __start_cc_report 10:10:39 INFO - PROCESS | 12555 | _x_x_mozilla_cycle_collect,736 10:10:39 INFO - PROCESS | 12555 | __end_cc_report 10:10:39 INFO - PROCESS | 12555 | __startTimestamp1454955039261__endTimestamp 10:10:39 INFO - PROCESS | 12555 | 10:10:39 INFO - PROCESS | 12555 | ------- Summary: start ------- 10:10:39 INFO - PROCESS | 12555 | Number of tests: 14 10:10:39 INFO - PROCESS | 12555 | 10:10:39 INFO - PROCESS | 12555 | [#0] ai-astar Cycles:10 Average:111.60 Median:111.00 stddev:4.20 (3.8%) stddev-sans-first:4.45 10:10:39 INFO - PROCESS | 12555 | Values: 112.0 106.0 114.0 111.0 111.0 122.0 111.0 110.0 109.0 110.0 10:10:39 INFO - PROCESS | 12555 | 10:10:39 INFO - PROCESS | 12555 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:154.50 stddev:15.92 (10.3%) stddev-sans-first:15.84 10:10:39 INFO - PROCESS | 12555 | Values: 162.0 138.0 151.0 155.0 124.0 154.0 158.0 127.0 167.0 127.0 10:10:39 INFO - PROCESS | 12555 | 10:10:39 INFO - PROCESS | 12555 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.90 (1.2%) stddev-sans-first:2.00 10:10:39 INFO - PROCESS | 12555 | Values: 163.0 166.0 161.0 164.0 161.0 163.0 161.0 160.0 164.0 161.0 10:10:39 INFO - PROCESS | 12555 | 10:10:39 INFO - PROCESS | 12555 | [#3] audio-fft Cycles:10 Average:90.60 Median:73.00 stddev:36.45 (49.9%) stddev-sans-first:38.10 10:10:39 INFO - PROCESS | 12555 | Values: 73.0 73.0 73.0 153.0 73.0 75.0 74.0 74.0 166.0 72.0 10:10:39 INFO - PROCESS | 12555 | 10:10:39 INFO - PROCESS | 12555 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:94.50 stddev:21.99 (23.3%) stddev-sans-first:22.80 10:10:39 INFO - PROCESS | 12555 | Values: 95.0 94.0 137.0 94.0 95.0 95.0 140.0 94.0 95.0 143.0 10:10:39 INFO - PROCESS | 12555 | 10:10:39 INFO - PROCESS | 12555 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.92 (0.8%) stddev-sans-first:0.53 10:10:39 INFO - PROCESS | 12555 | Values: 112.0 110.0 109.0 109.0 110.0 110.0 110.0 109.0 109.0 110.0 10:10:39 INFO - PROCESS | 12555 | 10:10:39 INFO - PROCESS | 12555 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 10:10:39 INFO - PROCESS | 12555 | Values: 147.0 147.0 147.0 146.0 147.0 147.0 146.0 148.0 147.0 148.0 10:10:39 INFO - PROCESS | 12555 | 10:10:39 INFO - PROCESS | 12555 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:97.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 10:10:39 INFO - PROCESS | 12555 | Values: 96.0 98.0 96.0 97.0 97.0 97.0 98.0 96.0 97.0 96.0 10:10:39 INFO - PROCESS | 12555 | 10:10:39 INFO - PROCESS | 12555 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:55.50 stddev:5.13 (9.2%) stddev-sans-first:5.36 10:10:39 INFO - PROCESS | 12555 | Values: 55.0 56.0 55.0 55.0 57.0 66.0 55.0 68.0 53.0 55.0 10:10:39 INFO - PROCESS | 12555 | 10:10:39 INFO - PROCESS | 12555 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 10:10:39 INFO - PROCESS | 12555 | Values: 64.0 63.0 64.0 64.0 64.0 63.0 64.0 64.0 63.0 64.0 10:10:39 INFO - PROCESS | 12555 | 10:10:39 INFO - PROCESS | 12555 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.00 stddev:2.91 (3.5%) stddev-sans-first:3.03 10:10:39 INFO - PROCESS | 12555 | Values: 82.0 89.0 89.0 83.0 82.0 83.0 82.0 83.0 82.0 81.0 10:10:39 INFO - PROCESS | 12555 | 10:10:39 INFO - PROCESS | 12555 | [#11] stanford-crypto-ccm Cycles:10 Average:115.80 Median:118.00 stddev:5.31 (4.5%) stddev-sans-first:5.63 10:10:39 INFO - PROCESS | 12555 | Values: 116.0 112.0 118.0 109.0 110.0 126.0 118.0 120.0 111.0 118.0 10:10:39 INFO - PROCESS | 12555 | 10:10:39 INFO - PROCESS | 12555 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.60 Median:136.50 stddev:4.03 (3.0%) stddev-sans-first:4.09 10:10:39 INFO - PROCESS | 12555 | Values: 140.0 139.0 134.0 130.0 137.0 135.0 135.0 145.0 135.0 136.0 10:10:39 INFO - PROCESS | 12555 | 10:10:39 INFO - PROCESS | 12555 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.50 stddev:1.23 (1.8%) stddev-sans-first:1.27 10:10:39 INFO - PROCESS | 12555 | Values: 66.0 68.0 65.0 68.0 66.0 68.0 65.0 67.0 67.0 68.0 10:10:39 INFO - PROCESS | 12555 | -------- Summary: end -------- 10:10:39 INFO - PROCESS | 12555 | 10:10:40 INFO - TEST-INFO | 12555: exit 0 10:10:40 INFO - TEST-OK | kraken | took 60410ms 10:10:40 INFO - TEST-START | v8_7 10:10:40 INFO - operating with platform_type : linux_ 10:10:40 INFO - Initialising browser for v8_7 test... 10:10:40 INFO - TEST-INFO | started process 12845 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTjmzfK/profile http://localhost:50163/getInfo.html) 10:10:44 INFO - PROCESS | 12845 | 10:10:44 INFO - PROCESS | 12845 | (process:12923): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:10:45 INFO - PROCESS | 12845 | __metrics Screen width/height:1600/1200 10:10:45 INFO - PROCESS | 12845 | colorDepth:24 10:10:45 INFO - PROCESS | 12845 | Browser inner width/height: 1024/697 10:10:45 INFO - PROCESS | 12845 | __metrics 10:10:46 INFO - TEST-INFO | 12845: exit 0 10:10:46 INFO - Browser initialized. 10:10:46 INFO - Running cycle 1/1 for v8_7 test... 10:10:46 INFO - TEST-INFO | started process 12972 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTjmzfK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:48 INFO - PROCESS | 12972 | 10:10:48 INFO - PROCESS | 12972 | (process:13037): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:10:58 INFO - PROCESS | 12972 | RSS: Main: 140107776 10:10:58 INFO - PROCESS | 12972 | 10:11:20 INFO - PROCESS | 12972 | Cycle 1(1): loaded http://localhost:50163/tests/v8_7/run.html (next: http://localhost:50163/tests/v8_7/run.html) 10:11:21 INFO - PROCESS | 12972 | RSS: Main: 144203776 10:11:21 INFO - PROCESS | 12972 | 10:11:21 INFO - PROCESS | 12972 | __start_tp_report 10:11:21 INFO - PROCESS | 12972 | _x_x_mozilla_page_load 10:11:21 INFO - PROCESS | 12972 | _x_x_mozilla_page_load_details 10:11:21 INFO - PROCESS | 12972 | |i|pagename|runs| 10:11:21 INFO - PROCESS | 12972 | |0;Richards;166.05778811026238 10:11:21 INFO - PROCESS | 12972 | |1;DeltaBlue;170.67759003242875 10:11:21 INFO - PROCESS | 12972 | |2;Encrypt;278.39643652561244 10:11:21 INFO - PROCESS | 12972 | |3;Decrypt;5186.5284974093265 10:11:21 INFO - PROCESS | 12972 | |4;RayTrace;934.5794392523364 10:11:21 INFO - PROCESS | 12972 | |5;Earley;560.2240896358544 10:11:21 INFO - PROCESS | 12972 | |6;Boyer;11131.868131868132 10:11:21 INFO - PROCESS | 12972 | |7;RegExp;38923.07692307692 10:11:21 INFO - PROCESS | 12972 | |8;Splay;521.6484089723526 10:11:21 INFO - PROCESS | 12972 | |9;NavierStokes;4822.115384615385 10:11:21 INFO - PROCESS | 12972 | __end_tp_report 10:11:21 INFO - PROCESS | 12972 | __startTimestamp1454955081177__endTimestamp 10:11:21 INFO - PROCESS | 12972 | 10:11:21 INFO - PROCESS | 12972 | ------- Summary: start ------- 10:11:21 INFO - PROCESS | 12972 | Number of tests: 10 10:11:21 INFO - PROCESS | 12972 | 10:11:21 INFO - PROCESS | 12972 | [#0] Richards Cycles:1 Average:166.06 Median:166.06 stddev:0.00 (0.0%) 10:11:21 INFO - PROCESS | 12972 | Values: 166.1 10:11:21 INFO - PROCESS | 12972 | 10:11:21 INFO - PROCESS | 12972 | [#1] DeltaBlue Cycles:1 Average:170.68 Median:170.68 stddev:0.00 (0.0%) 10:11:21 INFO - PROCESS | 12972 | Values: 170.7 10:11:21 INFO - PROCESS | 12972 | 10:11:21 INFO - PROCESS | 12972 | [#2] Encrypt Cycles:1 Average:278.40 Median:278.40 stddev:0.00 (0.0%) 10:11:21 INFO - PROCESS | 12972 | Values: 278.4 10:11:21 INFO - PROCESS | 12972 | 10:11:21 INFO - PROCESS | 12972 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 10:11:21 INFO - PROCESS | 12972 | Values: 5186.5 10:11:21 INFO - PROCESS | 12972 | 10:11:21 INFO - PROCESS | 12972 | [#4] RayTrace Cycles:1 Average:934.58 Median:934.58 stddev:0.00 (0.0%) 10:11:21 INFO - PROCESS | 12972 | Values: 934.6 10:11:21 INFO - PROCESS | 12972 | 10:11:21 INFO - PROCESS | 12972 | [#5] Earley Cycles:1 Average:560.22 Median:560.22 stddev:0.00 (0.0%) 10:11:21 INFO - PROCESS | 12972 | Values: 560.2 10:11:21 INFO - PROCESS | 12972 | 10:11:21 INFO - PROCESS | 12972 | [#6] Boyer Cycles:1 Average:11131.87 Median:11131.87 stddev:0.00 (0.0%) 10:11:21 INFO - PROCESS | 12972 | Values: 11131.9 10:11:21 INFO - PROCESS | 12972 | 10:11:21 INFO - PROCESS | 12972 | [#7] RegExp Cycles:1 Average:38923.08 Median:38923.08 stddev:0.00 (0.0%) 10:11:21 INFO - PROCESS | 12972 | Values: 38923.1 10:11:21 INFO - PROCESS | 12972 | 10:11:21 INFO - PROCESS | 12972 | [#8] Splay Cycles:1 Average:521.65 Median:521.65 stddev:0.00 (0.0%) 10:11:21 INFO - PROCESS | 12972 | Values: 521.6 10:11:21 INFO - PROCESS | 12972 | 10:11:21 INFO - PROCESS | 12972 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 10:11:21 INFO - PROCESS | 12972 | Values: 4822.1 10:11:21 INFO - PROCESS | 12972 | -------- Summary: end -------- 10:11:21 INFO - PROCESS | 12972 | 10:11:22 INFO - TEST-INFO | 12972: exit 0 10:11:22 INFO - TEST-OK | v8_7 | took 41849ms 10:11:22 INFO - SUITE-END | took 1213s 10:11:22 INFO - Completed test suite (00:20:13) 10:11:22 INFO - Working with test: dromaeo_css 10:11:22 INFO - Generating results file: dromaeo_css 10:11:22 INFO - Working with test: kraken 10:11:22 INFO - Generating results file: kraken 10:11:22 INFO - javascript benchmark 10:11:22 INFO - Working with test: v8_7 10:11:22 INFO - Generating results file: v8_7 10:11:22 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:11:22 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 10:11:22 INFO - process_Request line: dromaeo_css 7369.92 graph.html#tests=[[72,52,43]] 10:11:22 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:11:22 INFO - process_Request line: kraken 1496.70 graph.html#tests=[[232,52,43]] 10:11:22 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:11:22 INFO - process_Request line: v8_7 22038.14 graph.html#tests=[[230,52,43]] 10:11:22 INFO - RETURN: dromaeo_css: 7369.92 10:11:22 INFO - RETURN: kraken: 1496.70 10:11:22 INFO - RETURN: v8_7: 22038.14 10:11:22 INFO - javascript benchmark 10:11:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3344.615369232539, 3353.0611428799943, 3388.322335532894, 3392.932141357173, 3404.744644151689, 5403.405625381215, 5453.2092846537225, 5483.0, 5491.643043202189, 5495.450454954503, 5388.245645609618, 5450.509454149126, 5479.424660410659, 5490.094134467808, 5492.203630473579, 4981.701097934127, 5010.599152067844, 5032.396112466509, 5061.721605311706, 5102.36220472441, 4878.121938051149, 4952.950470495285, 5013.373328333958, 5055.241713742931, 5063.392392912856, 5030.57240134589, 5090.516400941905, 5097.0, 5105.030044291572, 5127.666701664399, 5015.84952451427, 5024.0, 5048.747562621873, 5063.569596584295, 5102.770375333119, 4857.975710121462, 4926.132910951049, 4934.062528119682, 4954.455009948902, 4997.42529609096, 5215.843524694265, 5274.05067087924, 5278.392984806758, 5315.973420132913, 5337.3061502004875, 5727.112297593838, 5783.826485205451, 5787.536997040269, 5797.942020579824, 5811.302643682743, 5833.7083145842535, 5852.239208902815, 5860.70696465175, 5866.1494083357675, 5940.851478713023, 5538.363088244863, 5601.29983752031, 5601.80393686219, 5605.439456054402, 5638.4925356718095, 5919.230500034968, 5920.319163296276, 5944.464998150101, 5974.970125149346, 5982.49148822355, 5741.110127930177, 5774.960507108761, 5791.362950075489, 5806.390329015477, 5855.882882342329, 5899.085641725539, 5900.468957793819, 5905.350411454737, 5918.053111502139, 5922.230110085661, 5804.912926306109, 5818.359980402152, 5848.1227815827115, 5861.384554621789, 5866.941330586725, 5703.0, 5813.128030795415, 5825.7378417971295, 5827.562932780059, 5871.295444546682, 4505.7296562206375, 4524.343970124313, 4525.162844873643, 4531.864044078683, 4555.339475775994, 4041.81811818463, 4052.675785937118, 4069.5116586009867, 4097.037196258877, 4099.815508302074, 5474.644148130359, 5505.476979686923, 5554.91667624986, 5573.219749235111, 5593.580481463825, 5867.325257595346, 5872.324682661463, 5886.264216972879, 5916.852078698067, 5938.732757025944, 5390.946090539044, 5606.271184746039, 5608.6073974821375, 5610.551155907518, 5612.410696876851, 5000.474950130184, 5020.196768517019, 5071.822486213038, 5096.286519887219, 5112.156494178419, 5996.370381110008, 6022.427869352405, 6030.246219222598, 6036.909446358308, 6037.0642550404755, 5851.882962340815, 5916.112583112482, 5925.466707996301, 5929.673867937132, 5946.0, 5836.182934389104, 5906.793262235801, 5920.792772253123, 5927.31835838884, 6049.425304596057, 5814.505767009851, 5829.883402332014, 5844.386339434298, 5859.853503662443, 5876.970615146897, 5909.23179986599, 5936.643801371932, 5947.464728174312, 5957.880842383215, 5965.224520812267, 5723.170140329546, 5751.568632352507, 5760.654360738369, 5789.797357092481, 5824.039033559416, 5741.966446039586, 5750.194972703908, 5774.422557744192, 5797.942020579909, 5803.9419605803405, 5651.378348381757, 5652.943470565242, 5695.231143795535, 5699.202111704281, 5710.2576665033275, 5614.550835933034, 5700.686462244616, 5720.74256658443, 5737.942620573741, 5798.94201057984, 5567.387587365468, 5602.887942241214, 5670.858228544154, 5684.204211410489, 5716.5426765859465], "unit": "score", "name": "dojo.html", "value": 5422.791911880479}, {"lowerIsBetter": false, "replicates": [564.4722184757252, 573.2261447046487, 582.7989343676436, 623.510544222785, 635.4344633276385, 38437.615623843754, 38477.42283865744, 38896.0, 38923.41614875772, 39121.0, 42525.574744252546, 43055.0, 43253.35119973203, 43378.0, 43420.782896085555, 8804.943406791179, 8985.505797181153, 8988.460692358447, 8989.190972812445, 9010.774730631721, 8601.440906341099, 8784.429012114224, 8788.69239576615, 8917.77705557363, 8962.283017358628, 8892.59983300753, 8922.241609463203, 8939.73180804577, 8951.95524022379, 9014.323925705598, 8917.375783695144, 8944.508052057166, 8953.820923581558, 8980.236679882153, 8988.685396011108, 8835.293176545925, 8934.195922367018, 8964.462132272085, 9003.324750643727, 9037.05110963346, 42395.576044239475, 42704.78647606773, 42758.0, 42767.0, 43205.13589728219, 3640.690541303992, 3641.2353405784816, 3681.4661874028384, 3715.4241092630687, 3723.720720945913, 31991.84004079965, 32182.517262241086, 32500.83749581237, 32543.349133017444, 32666.510002349984, 3696.7597106188014, 3701.796401197933, 3821.2166505866508, 3832.4442955771256, 3893.8229717593113, 295817.0418295811, 297144.0, 297721.0, 299608.0, 300221.49889250635, 64245.0, 64537.677311613144, 64624.0, 64846.675766620865, 64989.67505162444, 69579.65210174018, 69798.30201698019, 69939.0, 70035.0, 70055.64972175106, 15784.131872746879, 16177.838221617869, 16349.754753678704, 16350.34598616042, 16356.0, 11785.351805650771, 11790.94104529472, 11814.173007889365, 11816.05471562273, 11845.644630661094, 21525.461863453227, 21540.0, 21553.78446215549, 21711.805850678047, 21782.78217217839, 8442.197991190827, 8450.577471126418, 8561.443506172203, 8619.224269815746, 8653.26447251978, 1098.4946924414699, 1122.2069405409663, 1126.5381193710703, 1144.6165534545853, 1196.2403873540366, 31083.378332433676, 31127.221819454695, 31510.36979260402, 33109.337813244085, 35611.0, 1143.5082914346744, 1161.7850697620797, 1204.8373469581495, 1230.267990545624, 1274.8151518029833, 15313.387464501295, 15431.305591248421, 15914.283857226452, 16129.0, 16199.190040498164, 542493.0, 543815.0, 544422.0, 548560.0, 796453.0, 58475.70762146162, 58691.70654146702, 58877.41122588719, 59636.70181649064, 59818.40181598216, 1449.7173051254904, 1471.1834931612843, 1480.9333579988927, 1494.1632685696045, 1497.2962707527445, 31764.0, 32235.939643347385, 32285.838570807937, 32408.513872292406, 32953.83523082369, 50448.0, 50797.0, 50880.0, 50941.745291273306, 50988.74505627448, 327390.0, 331892.0, 334797.0, 335258.0, 335557.0, 34358.31283374268, 34951.65048349484, 35097.29805403826, 35105.29789404147, 35240.471392928615, 45322.09355812931, 45410.77294613638, 45682.314765277886, 46447.980881243966, 52593.7370313146, 39849.0, 40309.596904030586, 40955.38566921558, 41552.79223603863, 41798.1640367197, 41290.0, 42575.574244257165, 44561.77719111383, 44745.552544474136, 45467.54532454633, 41088.1782364357, 41650.791746041075, 41900.37149442822, 45409.77295113503, 46318.30522542232, 37193.0, 37755.81122094372, 38069.238615228096, 39049.0, 39057.0, 29563.85218073896, 29937.700622993492, 30133.0, 30534.84732576323, 30638.693613063584], "unit": "score", "name": "ext.html", "value": 20448.997295070953}, {"lowerIsBetter": false, "replicates": [395.9643632073113, 398.9980050099749, 399.4826699424247, 403.36067333276753, 404.61561516559277, 14184.0, 14666.706665866703, 17841.375551855686, 18018.639627207463, 18576.0, 16133.596660083474, 16242.350305987746, 16351.182440877938, 16961.151942402863, 17072.914635426805, 5459.563234941205, 5636.0982242841155, 5651.519620832214, 5655.208270842086, 5655.4061823508355, 5209.7134657593815, 5364.383095943957, 5365.490278423544, 5392.0294347017525, 5471.835844924659, 5363.865903352408, 5372.489613486712, 5466.289382380285, 5636.802711905084, 5640.435956404368, 5536.833894983117, 5623.859403514924, 5637.379888212314, 5649.23735295734, 5662.263905692254, 5481.232627432163, 5489.231507588941, 5501.394846566875, 5507.03626865297, 5575.080111781551, 13696.863031369758, 13715.451381944711, 13716.314184290746, 13758.518451854237, 13985.650358741012, 2154.192177933275, 2194.8902554872193, 2261.807746341563, 2410.866714501334, 2425.9150929717553, 10129.797404051951, 10280.640177593823, 10325.638602648947, 10413.53139108742, 10427.895721042769, 1869.6447674941853, 1883.896385698786, 1894.1760334254643, 1895.6966885298286, 1908.1222637586727, 60459.39540604582, 60483.39516604822, 60597.394026059614, 61853.0, 61923.0, 10457.320274182153, 10681.198910081775, 10799.352038877692, 10922.508487118099, 10991.945040274748, 14253.358598863077, 14260.572182834532, 14284.785728214085, 14360.712785744436, 14505.419783208554, 7935.166807485246, 7944.285014348737, 8013.998250218722, 8127.431079824356, 8161.714339998071, 7696.769096927102, 7756.069271687321, 7777.9110924470615, 7790.0, 7846.293833555007, 4327.632151267115, 4551.112533056023, 4555.088982203572, 4661.720296782204, 4811.735354555533, 1902.172554938606, 2003.5191554026928, 2003.719479272903, 2012.5773587546487, 2014.2043892662316, 1023.8873723890366, 1064.6539874540806, 1102.063246240705, 1154.278575890052, 1186.549111337686, 16804.6639067218, 17266.65466690684, 17468.388606398716, 17830.821691782916, 18378.172982215834, 986.3243678080538, 1003.3277703938379, 1022.7698767777191, 1051.148569658579, 1059.8781140168978, 9328.580213890391, 9692.0, 9798.706038818847, 9966.2525310602, 9998.500074996222, 635458.0, 646551.0, 654858.0, 661188.0, 663119.0, 65671.0, 65963.0, 68082.31917680858, 74332.25667743254, 76237.0, 1115.1803424482998, 1152.1358980764426, 1165.1669056624385, 1165.854268216473, 1170.6136974798296, 15122.243887805345, 15795.131267780382, 16186.919065404598, 16423.91788041052, 16465.753013704565, 30791.53812692856, 31576.36847263088, 32735.34529309448, 32767.508487373187, 33221.66778332186, 37591.24817503689, 38421.807890960365, 39090.60909390869, 39448.605513944494, 44190.55809441993, 7585.544867307979, 7588.544687318778, 7590.278923502258, 7640.274173953688, 7706.460547761603, 10788.0, 11282.379469129277, 11371.404336002663, 11579.594714184963, 12027.75944481123, 3286.359159963784, 4703.882402939954, 7437.851242975002, 10142.594296228068, 10289.43408112561, 9678.95160524193, 10035.09684128432, 10283.0, 10365.170786336925, 10809.513571889127, 9619.759506012406, 10168.135708464863, 10281.74295642585, 10599.993000664925, 10705.19711021661, 7901.841963160819, 8012.599370031358, 8013.719519816778, 8059.0, 8110.0, 9649.565769540248, 10184.490775461345, 10232.0, 10493.003164699341, 10528.210384221062], "unit": "score", "name": "jquery.html", "value": 8427.31695122152}, {"lowerIsBetter": false, "replicates": [1485.762278035514, 1500.9249537523121, 1703.3442124781955, 1827.232562323824, 1857.127150239388, 8235.794105147374, 8236.17638236176, 8447.577621118935, 8488.066312705605, 8516.276116530087, 8538.743837684864, 8554.52950087745, 8650.697225597105, 8676.783080422992, 8681.696140635078, 2457.299669594166, 2505.9373515662164, 2505.962410563843, 2509.2221411362443, 2511.3972646564785, 2463.556559819232, 2513.158092039169, 2515.2705715342527, 2515.735847735989, 2517.697876254852, 2398.6162214045758, 2398.8080953523763, 2419.1895714935517, 2472.1223965492263, 2482.726900040994, 2476.0838489758726, 2478.529079474894, 2488.35302821266, 2491.426971796497, 2504.6243063540433, 2448.4735781807, 2451.350392146083, 2464.9137280195287, 2469.7283298837115, 2475.443025319307, 8299.502029878227, 8327.750167494985, 8410.537420441935, 8418.83162336756, 8457.873131903027, 5192.7403629818355, 5265.552428043621, 5284.0, 5288.444713305124, 5332.520073193431, 3150.558921750957, 3182.80903145812, 3232.4504834178247, 3297.7196938260277, 3320.734341252694, 1057.1754031855164, 1843.6957901946162, 1850.5281153305955, 1867.8318951294314, 1884.3404808317116, 11850.288982660983, 11922.853886300463, 12021.759564808743, 12075.215111017756, 12184.756304873941, 4717.669763116549, 4738.526147385234, 4806.158922188603, 4895.6083513318845, 4899.926501102486, 10395.116415104801, 10424.374537527772, 10487.737806554744, 10523.263371563917, 10550.736231594272, 5354.41101478837, 5392.299001129828, 5397.649152805055, 5418.431064738224, 5445.618806683573, 4792.496787837227, 4848.10310092634, 4856.271559266138, 4904.6321525885705, 4913.238448040559, 3836.0601652594733, 3887.727859049896, 3888.747231429948, 3917.353636649978, 4008.238434697398, 1193.8985186259092, 1202.2786328203008, 1202.5971299614553, 1229.7970834812156, 1238.8637249902504, 1433.9067960582738, 1450.9492167774076, 1464.3337281536876, 1472.021105964543, 1488.1963739580722, 7882.0, 7955.681772729142, 7987.400944929153, 8008.279254866973, 8013.2387423194705, 1202.6211743300832, 1212.8969037631723, 1225.9754804903853, 1240.1257113734796, 1245.993770031144, 6149.661768602769, 6150.108234306001, 6263.843403914848, 6279.529035322278, 6403.583767055126, 10173.287869849188, 10527.894721052844, 10548.47257637115, 10598.947005264925, 10657.520411581498, 10079.445630490394, 10337.17302615804, 10453.529591168415, 10506.317089389166, 10529.526171322308, 8062.7581172564915, 8094.433389662785, 8113.391495637851, 8120.269175774209, 8191.672333106728, 7682.961585192262, 7749.7287594933905, 7791.415643826623, 7791.805204869697, 7801.609919504115, 9124.863127052966, 9130.863037054316, 9304.209142222986, 9358.017408172043, 9440.433573985309, 9306.441613503212, 9458.574364153492, 9588.328816983023, 9694.46680432583, 9794.559244833858, 7172.462065345016, 7201.3518783309755, 7286.417086633162, 7321.597312147883, 7332.120145582351, 7913.802154945942, 7922.207779222032, 7936.880946785918, 7944.761657150295, 8046.0, 7282.308180722823, 7359.227281135403, 7413.703451861865, 7502.662380193014, 7571.432142589438, 7023.438124950094, 7131.0729605151, 7186.96406517985, 7201.747938822116, 7277.672504737406, 7225.24134965842, 7296.19741828409, 7338.522996005243, 7374.373178279906, 7452.962735186289, 6615.4046135848, 6621.073049772939, 6678.298778628368, 6688.598684078971, 6710.530262881552, 6945.687444064928, 6955.200151982587, 6990.720371185095, 7024.754133605299, 7092.290770922867], "unit": "score", "name": "mootools.html", "value": 4971.886325699139}, {"lowerIsBetter": false, "replicates": [373.48832100022963, 373.5312183210071, 377.29822530094003, 379.45927053948117, 380.6783268138422, 6341.270753863307, 6369.140166077578, 6386.808395748129, 6456.385164008572, 6620.569662971903, 6389.795520545416, 6428.100065990765, 6443.355664433554, 6463.353664633534, 6466.676666166684, 4926.45808961014, 4932.038252540738, 4933.876653083675, 4935.3090567320605, 4941.925871111936, 4870.975645121787, 4952.405711314629, 4956.776945037482, 4958.6281028922795, 4961.305417241589, 4867.245576935581, 4872.65891387603, 4881.292212629167, 4887.7311747853855, 4894.77973491192, 4879.365682461275, 4880.536349046853, 4882.292067650171, 4889.095517329305, 4890.193118135503, 4238.427812245338, 4260.21186080573, 4264.1471705659, 4271.060366719316, 4275.636570891478, 5946.940530594682, 6068.605540639845, 6099.57302988791, 6108.633481991094, 6133.938660613381, 5651.858703532444, 5656.490915817555, 5658.151277308396, 5667.801626943078, 5720.456556627114, 6789.728410863609, 6791.252962174206, 6792.626405547742, 6807.693653785542, 6818.318168183142, 4737.976310118462, 4744.0, 4746.715197088151, 4752.097101550694, 4752.857414277577, 6824.385805277549, 6934.375906168419, 7055.541389809646, 7058.964705176441, 7076.540024898417, 4853.247746599212, 4868.659193856467, 4870.342503761947, 4871.0014447038275, 4876.4879687633, 4937.629677774181, 4939.629527785431, 4944.159492886218, 4954.9009019819405, 4958.528939750718, 5627.32472103342, 5697.914531282034, 5700.287464066992, 5707.942920570824, 5712.0, 6768.932310676929, 6822.351876571718, 6858.451323894076, 6862.622555759481, 6871.4502839772695, 1698.7961444626724, 1723.310675729693, 1730.6884760742935, 1733.9566510837078, 1734.1242672450333, 1148.1561052626314, 1158.3108050709814, 1164.249059356727, 1175.4651633506735, 1180.0264781555252, 6523.445507131852, 6546.8363290918105, 6561.14705088345, 6562.704678289489, 6570.080188773575, 6947.965260173667, 6956.339147780953, 6958.65206739661, 6966.0, 6971.51199416036, 6373.0, 6420.261669907927, 6464.806055818333, 6479.5788273762055, 6488.870222595616, 3733.309337772521, 3778.3199024175365, 3783.6027217142355, 3784.3188226119564, 3784.7918364489665, 7107.502474826816, 7118.145822501229, 7124.608146551989, 7127.10911136108, 7131.358177764027, 7033.507654464241, 7092.148942126874, 7118.430525557943, 7126.2873712628325, 7307.5980821055355, 7313.48805583604, 7328.083989501312, 7337.449691273176, 7340.926590734024, 7353.154387245429, 7119.964400177966, 7125.216226215009, 7140.428765698628, 7146.821329466597, 7167.247439018828, 6864.347886950732, 6935.965320173569, 6962.617056061965, 6985.685644146127, 7029.61337126463, 7273.927260727325, 7294.197638259893, 7310.817229569303, 7319.74380896666, 7322.96338518304, 4788.329633851334, 4858.17411040117, 4870.707757534417, 4878.585320247818, 4879.463259041574, 6805.183377994672, 6959.408450281783, 6969.16370035599, 7090.716371345295, 7110.075690160246, 6746.898796518154, 6855.143107111611, 6884.65576721172, 6890.793276201722, 6890.827729306607, 6843.315668433117, 6855.211650660238, 6855.314468553105, 6858.3141685831015, 6861.588304701734, 6574.079628851869, 6718.563293385914, 6731.52879298464, 6741.764038258638, 6742.0, 6796.388325050769, 6874.725010999504, 6887.345702158287, 6911.239763626098, 6957.373836354753, 6601.702923368364, 6700.43046341047, 6720.327967203436, 6720.966395167993, 6722.361375669304], "unit": "score", "name": "prototype.html", "value": 5148.825226236345}, {"lowerIsBetter": false, "replicates": [777.0170734021464, 811.387402511104, 831.8419500294943, 902.7833320003201, 973.8101070291292, 15930.123843188634, 16261.18694065295, 16287.1042092685, 16356.509304720863, 16467.58831029225, 15861.92069039656, 15899.920500397511, 15909.204539772994, 15979.0, 15984.84015159851, 868.3617541107282, 888.1562515610163, 892.7187935800234, 896.672714459221, 901.184428092574, 891.4829398948594, 892.6697122064812, 894.6197865906996, 897.1297841094129, 899.4468401932829, 921.8202450522117, 925.9675911343104, 927.2998885841181, 930.3115694386139, 931.0224264522259, 915.7619019055027, 919.9816003679922, 922.082527884759, 923.6628630549834, 924.3806649544821, 680.1939701453794, 681.3084719010209, 681.9079424277709, 682.6245564939313, 684.0594182998377, 14959.775603365959, 14961.40154393823, 14985.400583976629, 15006.0, 15042.247887605576, 12988.675283117998, 13076.476940922352, 13093.86906130936, 13315.53395631158, 13391.330433478288, 10953.0, 10994.065504432132, 11016.394098324588, 11165.72085697856, 11210.439478026066, 3858.421236814472, 3945.9802700986597, 3951.229510245503, 3968.305546529346, 3992.181602771425, 51690.22464663033, 53150.0, 53291.46708532904, 53393.466065339235, 53471.46528534704, 11088.722781930517, 11173.441327933733, 11192.216544841946, 11245.100391968623, 11391.943040284912, 19158.329458469165, 19170.233190672498, 19228.230870765292, 19286.132124054453, 19400.417987460398, 8082.110967793656, 8154.918450815535, 8376.706815261437, 8483.278921291636, 8573.0, 4448.110377924363, 4511.729296242236, 4521.3896124023495, 4525.570070843265, 4627.028324051919, 3202.743780497555, 3265.804051756902, 3270.8855190068234, 3273.083536609753, 3274.6070471543567, 613.8557439001831, 614.4562062574654, 615.4030590327375, 616.9598976066542, 619.6251267982806, 491.7393781295919, 591.5711109445617, 621.4251817069284, 634.8317695810614, 676.0602762160601, 8605.827883442296, 8895.777605559913, 8919.152680495343, 9116.49859257734, 9164.221041211571, 504.5585113026102, 518.9221616757441, 597.1818608506287, 611.6146827498736, 689.5138927056413, 3848.5381754189116, 3901.221004269747, 3969.960300397017, 4077.4903137107863, 4101.487314085739, 62723.0, 62748.372516275165, 63083.68458157772, 63425.0, 63475.0, 54499.0, 55029.174562381595, 55153.72423137939, 55843.44156558464, 55975.720121399136, 47623.28565071527, 47747.28379074317, 48325.275120873215, 48517.514824852005, 49083.0, 8641.827163456821, 8873.64505419776, 9043.638254469748, 9109.726708198765, 9166.0, 35387.646123538434, 36051.459228111074, 36318.818405907805, 36433.453498198076, 36559.45160822537, 44728.77635611801, 47241.52758472371, 47793.28310075421, 48561.757191215234, 49115.0, 10812.513436895515, 10876.891231087904, 11260.9436952818, 11488.255872063968, 11636.767264654829, 12043.217190882564, 12226.877731222574, 12393.380330983595, 12426.254424734545, 12658.620241392773, 11895.643130706092, 12083.214591051554, 12113.454894529592, 12269.263844169378, 12271.509139634314, 11158.386288754196, 11181.608643697757, 11627.6511704649, 11826.408679566159, 12004.75990480203, 10992.890071099187, 11460.598879039193, 11485.253458525169, 11887.702807429883, 12169.574064907685, 9263.583138758637, 9443.575039123394, 9772.9022709772, 9889.258305626963, 10016.899831001596, 9583.856242156513, 9622.47076410804, 9940.353876997971, 9961.900380996098, 9990.500474976077], "unit": "score", "name": "yui.html", "value": 6697.689293023062}], "name": "dromaeo_css", "value": 7369.913787679873}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 114.0, 111.0, 111.0, 122.0, 111.0, 110.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [162.0, 138.0, 151.0, 155.0, 124.0, 154.0, 158.0, 127.0, 167.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.3}, {"lowerIsBetter": true, "replicates": [163.0, 166.0, 161.0, 164.0, 161.0, 163.0, 161.0, 160.0, 164.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 73.0, 153.0, 73.0, 75.0, 74.0, 74.0, 166.0, 72.0], "unit": "score", "name": "audio-fft", "value": 90.6}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 137.0, 94.0, 95.0, 95.0, 140.0, 94.0, 95.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 108.2}, {"lowerIsBetter": true, "replicates": [112.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 148.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 96.0, 97.0, 97.0, 97.0, 98.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 55.0, 55.0, 57.0, 66.0, 55.0, 68.0, 53.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 63.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.7}, {"lowerIsBetter": true, "replicates": [82.0, 89.0, 89.0, 83.0, 82.0, 83.0, 82.0, 83.0, 82.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [116.0, 112.0, 118.0, 109.0, 110.0, 126.0, 118.0, 120.0, 111.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.8}, {"lowerIsBetter": true, "replicates": [140.0, 139.0, 134.0, 130.0, 137.0, 135.0, 135.0, 145.0, 135.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.6}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 65.0, 68.0, 66.0, 68.0, 65.0, 67.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1496.6999999999996}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.05778811026238], "unit": "score", "name": "Richards", "value": 212.58864400000002}, {"lowerIsBetter": false, "replicates": [170.67759003242875], "unit": "score", "name": "DeltaBlue", "value": 387.3853620000001}, {"lowerIsBetter": false, "replicates": [278.39643652561244], "unit": "score", "name": "Encrypt", "value": 956.1221520000003}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [934.5794392523364], "unit": "score", "name": "RayTrace", "value": 791.7882300000002}, {"lowerIsBetter": false, "replicates": [560.2240896358544], "unit": "score", "name": "Earley", "value": 1189.6364549999998}, {"lowerIsBetter": false, "replicates": [11131.868131868132], "unit": "score", "name": "Boyer", "value": 59.869825271470894}, {"lowerIsBetter": false, "replicates": [38923.07692307692], "unit": "score", "name": "RegExp", "value": 23.404752964426894}, {"lowerIsBetter": false, "replicates": [521.6484089723526], "unit": "score", "name": "Splay", "value": 156.21824700000005}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 22038.135912402577}]} 10:11:22 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "22038.14"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1496.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7369.92"}}} 10:11:22 INFO - Return code: 0 10:11:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:11:22 INFO - # TBPL SUCCESS # 10:11:22 INFO - Running post-action listener: _resource_record_post_action 10:11:22 INFO - Running post-run listener: _resource_record_post_run 10:11:23 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 405504; Write bytes: 511340544; Read time: 988; Write time: 1745228 10:11:23 INFO - install - Wall time: 18s; CPU: 21.0%; Read bytes: 53248; Write bytes: 250523648; Read time: 728; Write time: 1384680 10:11:23 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 352256; Write bytes: 260816896; Read time: 260; Write time: 360548 10:11:23 INFO - Running post-run listener: _upload_blobber_files 10:11:23 INFO - Blob upload gear active. 10:11:23 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 10:11:23 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 10:11:23 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-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 10:11:23 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-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 10:11:24 INFO - (blobuploader) - INFO - Open directory for files ... 10:11:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:11:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:11:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:24 INFO - (blobuploader) - INFO - Done attempting. 10:11:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:11:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:11:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:25 INFO - (blobuploader) - INFO - Done attempting. 10:11:25 INFO - (blobuploader) - INFO - Iteration through files over. 10:11:25 INFO - Return code: 0 10:11:25 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 10:11:25 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 10:11:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14445196d445ff0906f4d37ac012c4eac312abdaa8981ab1ca3f3a19208ca816457a88f4d99da00ae88eb21d9993f91be7db78bce5e26e67546b65808cdbdf8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8470f28935aaf09a5872025136834d66bc10bc2d804b986ae3df421ee86651c9daf455f0a15259ee00e0f0a6352bdd3da1a59725dbd9599a6c97499f5606f862"} 10:11:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 10:11:25 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 10:11:25 INFO - Contents: 10:11:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14445196d445ff0906f4d37ac012c4eac312abdaa8981ab1ca3f3a19208ca816457a88f4d99da00ae88eb21d9993f91be7db78bce5e26e67546b65808cdbdf8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8470f28935aaf09a5872025136834d66bc10bc2d804b986ae3df421ee86651c9daf455f0a15259ee00e0f0a6352bdd3da1a59725dbd9599a6c97499f5606f862"} 10:11:25 INFO - Running post-run listener: copy_logs_to_upload_dir 10:11:25 INFO - Copying logs to upload dir... 10:11:25 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 10:11:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.179268 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-02-08 10:11:25.758145) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-08 10:11:25.762788) ========= 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=df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14445196d445ff0906f4d37ac012c4eac312abdaa8981ab1ca3f3a19208ca816457a88f4d99da00ae88eb21d9993f91be7db78bce5e26e67546b65808cdbdf8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8470f28935aaf09a5872025136834d66bc10bc2d804b986ae3df421ee86651c9daf455f0a15259ee00e0f0a6352bdd3da1a59725dbd9599a6c97499f5606f862"} build_url:https://queue.taskcluster.net/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011514 build_url: 'https://queue.taskcluster.net/v1/task/NzgZOX-rQ4W3cIA2qbVLug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14445196d445ff0906f4d37ac012c4eac312abdaa8981ab1ca3f3a19208ca816457a88f4d99da00ae88eb21d9993f91be7db78bce5e26e67546b65808cdbdf8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8470f28935aaf09a5872025136834d66bc10bc2d804b986ae3df421ee86651c9daf455f0a15259ee00e0f0a6352bdd3da1a59725dbd9599a6c97499f5606f862"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-08 10:11:25.787424) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 10:11:25.787750) ========= 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=df17445c3590ff7897617a0e00000225-1454953809.685675-1356970259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004608 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 10:11:25.872144) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-08 10:11:25.875498) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-08 10:11:25.875804) ========= ========= Total master_lag: 0.29 =========