builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-026 starttime: 1453369871.47 results: success (0) buildid: 20160120233054 builduid: c43f9e4ef8ae425ab8f060b929ccbafc revision: 63e4b33812a91c3cfc18b05a1993009a611f8572 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 01:51:11.469956) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 01:51:11.470392) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 01:51:11.470715) ========= 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=41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006419 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 01:51:11.538509) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 01:51:11.538821) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 01:51:11.563140) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 01:51:11.563472) ========= 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=41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 01:51:11.620675) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 01:51:11.620976) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 01:51:11.621359) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 01:51:11.621665) ========= 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=41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-21 01:51: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% 95.5M=0s 2016-01-21 01:51:12 (95.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170287 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 01:51:11.805989) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 01:51:11.806568) ========= 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=41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021057 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 01:51:11.855811) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 01:51:11.856185) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 63e4b33812a91c3cfc18b05a1993009a611f8572 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 63e4b33812a91c3cfc18b05a1993009a611f8572 --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=41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-21 01:51:12,363 truncating revision to first 12 chars 2016-01-21 01:51:12,363 Setting DEBUG logging. 2016-01-21 01:51:12,363 attempt 1/10 2016-01-21 01:51:12,363 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/63e4b33812a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-21 01:51:12,617 unpacking tar archive at: fx-team-63e4b33812a9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.573408 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 01:51:12.442963) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 01:51:12.446360) ========= echo 63e4b33812a91c3cfc18b05a1993009a611f8572 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'63e4b33812a91c3cfc18b05a1993009a611f8572'] 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=41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 63e4b33812a91c3cfc18b05a1993009a611f8572 program finished with exit code 0 elapsedTime=0.004411 script_repo_revision: '63e4b33812a91c3cfc18b05a1993009a611f8572' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 01:51:12.495773) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 01:51:12.496278) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 01:51:12.506841) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-21 01:51:12.507150) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/63e4b33812a91c3cfc18b05a1993009a611f8572 ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-21 01:51:12.507583) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-01-21 01:51:12.508013) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:51:13 INFO - MultiFileLogger online at 20160121 01:51:13 in /builds/slave/test-pgo 01:51:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 01:51:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:51:13 INFO - {'append_to_log': False, 01:51:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:51:13 INFO - 'blob_upload_branch': 'Fx-Team', 01:51:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:51:13 INFO - 'branch': 'Fx-Team', 01:51:13 INFO - 'buildbot_json_path': 'buildprops.json', 01:51:13 INFO - 'config_files': ('talos/linux_config.py',), 01:51:13 INFO - 'default_actions': ('clobber', 01:51:13 INFO - 'read-buildbot-config', 01:51:13 INFO - 'download-and-extract', 01:51:13 INFO - 'populate-webroot', 01:51:13 INFO - 'create-virtualenv', 01:51:13 INFO - 'install', 01:51:13 INFO - 'run-tests'), 01:51:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:51:13 INFO - 'download_minidump_stackwalk': True, 01:51:13 INFO - 'download_symbols': 'ondemand', 01:51:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:51:13 INFO - 'tooltool.py': '/tools/tooltool.py', 01:51:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:51:13 INFO - '/tools/misc-python/virtualenv.py')}, 01:51:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:51:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:51:13 INFO - 'installer_path': 'installer.exe', 01:51:13 INFO - 'log_level': 'info', 01:51:13 INFO - 'log_name': 'talos', 01:51:13 INFO - 'log_to_console': True, 01:51:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:51:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:51:13 INFO - 'opt_config_files': (), 01:51:13 INFO - 'pip_index': False, 01:51:13 INFO - 'sps_profile': False, 01:51:13 INFO - 'sps_profile_interval': 0, 01:51:13 INFO - 'suite': 'dromaeojs-e10s', 01:51:13 INFO - 'system_bits': '32', 01:51:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:51:13 INFO - 'title': 'talos-linux64-ix-026', 01:51:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:51:13 INFO - 'use_talos_json': True, 01:51:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:51:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:51:13 INFO - 'work_dir': 'build'} 01:51:13 INFO - ##### 01:51:13 INFO - ##### Running clobber step. 01:51:13 INFO - ##### 01:51:13 INFO - Running pre-action listener: _resource_record_pre_action 01:51:13 INFO - Running main action method: clobber 01:51:13 INFO - rmtree: /builds/slave/test-pgo/build 01:51:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:51:13 INFO - Running post-action listener: _resource_record_post_action 01:51:13 INFO - ##### 01:51:13 INFO - ##### Running read-buildbot-config step. 01:51:13 INFO - ##### 01:51:13 INFO - Running pre-action listener: _resource_record_pre_action 01:51:13 INFO - Running main action method: read_buildbot_config 01:51:13 INFO - Using buildbot properties: 01:51:13 INFO - { 01:51:13 INFO - "project": "", 01:51:13 INFO - "product": "firefox", 01:51:13 INFO - "script_repo_revision": "production", 01:51:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:51:13 INFO - "repository": "", 01:51:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 01:51:13 INFO - "buildid": "20160120233054", 01:51:13 INFO - "pgo_build": "True", 01:51:13 INFO - "basedir": "/builds/slave/test-pgo", 01:51:13 INFO - "buildnumber": 455, 01:51:13 INFO - "slavename": "talos-linux64-ix-026", 01:51:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:51:13 INFO - "platform": "ubuntu64_hw", 01:51:13 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 01:51:13 INFO - "branch": "fx-team", 01:51:13 INFO - "repo_path": "integration/fx-team", 01:51:13 INFO - "revision": "63e4b33812a91c3cfc18b05a1993009a611f8572", 01:51:13 INFO - "stage_platform": "linux64-pgo", 01:51:13 INFO - "builduid": "c43f9e4ef8ae425ab8f060b929ccbafc", 01:51:13 INFO - "slavebuilddir": "test" 01:51:13 INFO - } 01:51:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 01:51:13 INFO - Running post-action listener: _resource_record_post_action 01:51:13 INFO - ##### 01:51:13 INFO - ##### Running download-and-extract step. 01:51:13 INFO - ##### 01:51:13 INFO - Running pre-action listener: _resource_record_pre_action 01:51:13 INFO - Running main action method: download_and_extract 01:51:13 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:13 INFO - https://queue.taskcluster.net/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:51:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/test_packages.json 01:51:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/test_packages.json 01:51:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:51:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:51:14 INFO - Downloaded 1448 bytes. 01:51:14 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:51:14 INFO - Using the following test package requirements: 01:51:14 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:51:14 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:51:14 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:51:14 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:51:14 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:51:14 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:51:14 INFO - u'jsshell-linux-x86_64.zip'], 01:51:14 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:51:14 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:51:14 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:51:14 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:51:14 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:51:14 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:51:14 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:51:14 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:51:14 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:51:14 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:51:14 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:51:14 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:51:14 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:51: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')]} 01:51:14 INFO - https://queue.taskcluster.net/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:51:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:51:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:51:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:51:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:51:15 INFO - Downloaded 22485658 bytes. 01:51:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:51:15 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 01:51:17 INFO - Return code: 0 01:51:17 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:51:17 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')]} 01:51:17 INFO - https://queue.taskcluster.net/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:51:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:51:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:51:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:51:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:51:20 INFO - Downloaded 22485658 bytes. 01:51:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:51:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 01:51:22 INFO - Return code: 0 01:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:22 INFO - https://queue.taskcluster.net/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:51:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:51:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:51:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:51:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:51:23 INFO - Downloaded 11133201 bytes. 01:51:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:51:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 01:51:23 INFO - Return code: 0 01:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:23 INFO - https://queue.taskcluster.net/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:51:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:51:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:51:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:51:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:51:24 INFO - Downloaded 55954300 bytes. 01:51:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:51:24 INFO - mkdir: /builds/slave/test-pgo/properties 01:51:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:51:24 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:51:24 INFO - Contents: 01:51:24 INFO - build_url:https://queue.taskcluster.net/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:51:24 INFO - Running post-action listener: _resource_record_post_action 01:51:24 INFO - Running post-action listener: set_extra_try_arguments 01:51:24 INFO - ##### 01:51:24 INFO - ##### Running populate-webroot step. 01:51:24 INFO - ##### 01:51:24 INFO - Running pre-action listener: _resource_record_pre_action 01:51:24 INFO - Running main action method: populate_webroot 01:51:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:51:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:51:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:51:24 INFO - '--tppagecycles', 01:51:24 INFO - '7'], 01:51:24 INFO - 'tests': ['tsvgm']}}, 01:51:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:51:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:51:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:51:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:51:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:51:24 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:51:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:51:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:24 INFO - 'talos_options': ['--e10s'], 01:51:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:51:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:24 INFO - 'tests': ['damp', 'tps']}, 01:51:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:24 INFO - 'talos_options': ['--e10s'], 01:51:24 INFO - 'tests': ['damp', 'tps']}, 01:51:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:51:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:51:24 INFO - 'other': {'tests': ['a11yr', 01:51:24 INFO - 'ts_paint', 01:51:24 INFO - 'tpaint', 01:51:24 INFO - 'sessionrestore', 01:51:24 INFO - 'sessionrestore_no_auto_restore']}, 01:51:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:51:24 INFO - 'tests': ['a11yr', 01:51:24 INFO - 'ts_paint', 01:51:24 INFO - 'tpaint', 01:51:24 INFO - 'sessionrestore', 01:51:24 INFO - 'sessionrestore_no_auto_restore']}, 01:51:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:51:24 INFO - 'tests': ['a11yr', 01:51:24 INFO - 'ts_paint', 01:51:24 INFO - 'tpaint', 01:51:24 INFO - 'sessionrestore', 01:51:24 INFO - 'sessionrestore_no_auto_restore']}, 01:51:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:51:24 INFO - 'tests': ['a11yr', 01:51:24 INFO - 'ts_paint', 01:51:24 INFO - 'tpaint', 01:51:24 INFO - 'sessionrestore', 01:51:24 INFO - 'sessionrestore_no_auto_restore']}, 01:51:24 INFO - 'other_l64': {'tests': ['a11yr', 01:51:24 INFO - 'ts_paint', 01:51:24 INFO - 'tpaint', 01:51:24 INFO - 'sessionrestore', 01:51:24 INFO - 'sessionrestore_no_auto_restore']}, 01:51:24 INFO - 'other_nol64': {'tests': ['a11yr', 01:51:24 INFO - 'ts_paint', 01:51:24 INFO - 'tpaint', 01:51:24 INFO - 'sessionrestore', 01:51:24 INFO - 'sessionrestore_no_auto_restore']}, 01:51:24 INFO - 'svgr': {'tests': ['tsvgx', 01:51:24 INFO - 'tsvgr_opacity', 01:51:24 INFO - 'tart', 01:51:24 INFO - 'tscrollx', 01:51:24 INFO - 'cart']}, 01:51:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:51:24 INFO - 'tests': ['tsvgx', 01:51:24 INFO - 'tsvgr_opacity', 01:51:24 INFO - 'tart', 01:51:24 INFO - 'tscrollx', 01:51:24 INFO - 'cart']}, 01:51:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:24 INFO - 'tests': ['tp5o']}, 01:51:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:24 INFO - 'talos_options': ['--e10s'], 01:51:24 INFO - 'tests': ['tp5o']}, 01:51:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:24 INFO - 'talos_options': ['--xperf_path', 01:51:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:51:24 INFO - 'tests': ['tp5n']}, 01:51:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:24 INFO - 'talos_options': ['--e10s', 01:51:24 INFO - '--xperf_path', 01:51:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:51:24 INFO - 'tests': ['tp5n']}}, 01:51:24 INFO - 'talos.zip': {'path': '', 01:51:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:51:24 INFO - Running post-action listener: _resource_record_post_action 01:51:24 INFO - ##### 01:51:24 INFO - ##### Running create-virtualenv step. 01:51:24 INFO - ##### 01:51:24 INFO - Running pre-action listener: _resource_record_pre_action 01:51:24 INFO - Running main action method: create_virtualenv 01:51:24 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:51:24 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 01:51:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:51:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:51:24 INFO - Using real prefix '/usr' 01:51:24 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:51:25 INFO - Installing distribute.............................................................................................................................................................................................done. 01:51:27 INFO - Installing pip.................done. 01:51:27 INFO - Return code: 0 01:51:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:27 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 0x7f960fb3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b69840>, '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 0x2ad66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad6b60>, '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': '41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880', '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 01:51:27 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 01:51:27 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 01:51:27 INFO - Using env: {'DISPLAY': ':0', 01:51:27 INFO - 'HOME': '/home/cltbld', 01:51:27 INFO - 'LANG': 'en_US.UTF-8', 01:51:27 INFO - 'LANGUAGE': 'en_US:en', 01:51:27 INFO - 'LOGNAME': 'cltbld', 01:51:27 INFO - 'MAIL': '/var/mail/cltbld', 01:51:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:27 INFO - 'MOZ_NO_REMOTE': '1', 01:51:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:27 INFO - 'NO_EM_RESTART': '1', 01:51:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:51:27 INFO - 'PWD': '/builds/slave/test-pgo', 01:51:27 INFO - 'SHELL': '/bin/bash', 01:51:27 INFO - 'SHLVL': '1', 01:51:27 INFO - 'TERM': 'linux', 01:51:27 INFO - 'TMOUT': '86400', 01:51:27 INFO - 'USER': 'cltbld', 01:51:27 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880', 01:51:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:27 INFO - '_': '/tools/buildbot/bin/python'} 01:51:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:27 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 01:51:27 INFO - Cleaning up... 01:51:27 INFO - Return code: 0 01:51:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:27 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 0x7f960fb3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b69840>, '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 0x2ad66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad6b60>, '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': '41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880', '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 01:51:27 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 01:51:27 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 01:51:27 INFO - Using env: {'DISPLAY': ':0', 01:51:27 INFO - 'HOME': '/home/cltbld', 01:51:27 INFO - 'LANG': 'en_US.UTF-8', 01:51:27 INFO - 'LANGUAGE': 'en_US:en', 01:51:27 INFO - 'LOGNAME': 'cltbld', 01:51:27 INFO - 'MAIL': '/var/mail/cltbld', 01:51:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:27 INFO - 'MOZ_NO_REMOTE': '1', 01:51:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:27 INFO - 'NO_EM_RESTART': '1', 01:51:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:51:27 INFO - 'PWD': '/builds/slave/test-pgo', 01:51:27 INFO - 'SHELL': '/bin/bash', 01:51:27 INFO - 'SHLVL': '1', 01:51:27 INFO - 'TERM': 'linux', 01:51:27 INFO - 'TMOUT': '86400', 01:51:27 INFO - 'USER': 'cltbld', 01:51:27 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880', 01:51:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:27 INFO - '_': '/tools/buildbot/bin/python'} 01:51:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:27 INFO - Downloading/unpacking psutil>=0.7.1 01:51:27 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 01:51:27 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 01:51:27 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 01:51:27 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 01:51:27 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 01:51:27 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 01:51:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:51:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:51:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:51:29 INFO - Installing collected packages: psutil 01:51:29 INFO - Running setup.py install for psutil 01:51:29 INFO - building 'psutil._psutil_linux' extension 01:51:29 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 01:51:29 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 01:51:29 INFO - building 'psutil._psutil_posix' extension 01:51:29 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 01:51:30 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 01:51:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:51:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:51:30 INFO - Successfully installed psutil 01:51:30 INFO - Cleaning up... 01:51:30 INFO - Return code: 0 01:51:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:30 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 0x7f960fb3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b69840>, '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 0x2ad66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad6b60>, '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': '41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880', '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 01:51:30 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 01:51:30 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 01:51:30 INFO - Using env: {'DISPLAY': ':0', 01:51:30 INFO - 'HOME': '/home/cltbld', 01:51:30 INFO - 'LANG': 'en_US.UTF-8', 01:51:30 INFO - 'LANGUAGE': 'en_US:en', 01:51:30 INFO - 'LOGNAME': 'cltbld', 01:51:30 INFO - 'MAIL': '/var/mail/cltbld', 01:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:30 INFO - 'MOZ_NO_REMOTE': '1', 01:51:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:30 INFO - 'NO_EM_RESTART': '1', 01:51:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:51:30 INFO - 'PWD': '/builds/slave/test-pgo', 01:51:30 INFO - 'SHELL': '/bin/bash', 01:51:30 INFO - 'SHLVL': '1', 01:51:30 INFO - 'TERM': 'linux', 01:51:30 INFO - 'TMOUT': '86400', 01:51:30 INFO - 'USER': 'cltbld', 01:51:30 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880', 01:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:30 INFO - '_': '/tools/buildbot/bin/python'} 01:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:51:30 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 01:51:30 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 01:51:30 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 01:51:30 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 01:51:30 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 01:51:30 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 01:51:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:51:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:51:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:51:32 INFO - Installing collected packages: mozsystemmonitor 01:51:32 INFO - Running setup.py install for mozsystemmonitor 01:51:32 INFO - Successfully installed mozsystemmonitor 01:51:32 INFO - Cleaning up... 01:51:32 INFO - Return code: 0 01:51:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:51: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')]} 01:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51: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')]} 01:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51: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', '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 0x7f960fb3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b69840>, '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 0x2ad66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad6b60>, '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': '41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880', '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 01:51: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 01:51: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 blobuploader==1.2.4 01:51:32 INFO - Using env: {'DISPLAY': ':0', 01:51:32 INFO - 'HOME': '/home/cltbld', 01:51:32 INFO - 'LANG': 'en_US.UTF-8', 01:51:32 INFO - 'LANGUAGE': 'en_US:en', 01:51:32 INFO - 'LOGNAME': 'cltbld', 01:51:32 INFO - 'MAIL': '/var/mail/cltbld', 01:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:32 INFO - 'MOZ_NO_REMOTE': '1', 01:51:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:32 INFO - 'NO_EM_RESTART': '1', 01:51:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:51:32 INFO - 'PWD': '/builds/slave/test-pgo', 01:51:32 INFO - 'SHELL': '/bin/bash', 01:51:32 INFO - 'SHLVL': '1', 01:51:32 INFO - 'TERM': 'linux', 01:51:32 INFO - 'TMOUT': '86400', 01:51:32 INFO - 'USER': 'cltbld', 01:51:32 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880', 01:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:32 INFO - '_': '/tools/buildbot/bin/python'} 01:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:32 INFO - Downloading/unpacking blobuploader==1.2.4 01:51: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 01:51: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 01:51: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 01:51: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 01:51: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 01:51: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 01:51:34 INFO - Downloading blobuploader-1.2.4.tar.gz 01:51:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:51:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:51: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 01:51: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 01:51: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 01:51: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 01:51: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 01:51: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 01:51:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:51:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:51: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 01:51: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 01:51: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 01:51: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 01:51: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 01:51: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 01:51:35 INFO - Downloading docopt-0.6.1.tar.gz 01:51:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:51:35 INFO - Installing collected packages: blobuploader, requests, docopt 01:51:35 INFO - Running setup.py install for blobuploader 01:51:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:51:35 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:51:35 INFO - Running setup.py install for requests 01:51:35 INFO - Running setup.py install for docopt 01:51:35 INFO - Successfully installed blobuploader requests docopt 01:51:35 INFO - Cleaning up... 01:51:35 INFO - Return code: 0 01:51:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:51:35 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')]} 01:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:35 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')]} 01:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:35 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 0x7f960fb3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b69840>, '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 0x2ad66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad6b60>, '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': '41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880', '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 01:51:35 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 01:51:35 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 01:51:35 INFO - Using env: {'DISPLAY': ':0', 01:51:35 INFO - 'HOME': '/home/cltbld', 01:51:35 INFO - 'LANG': 'en_US.UTF-8', 01:51:35 INFO - 'LANGUAGE': 'en_US:en', 01:51:35 INFO - 'LOGNAME': 'cltbld', 01:51:35 INFO - 'MAIL': '/var/mail/cltbld', 01:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:35 INFO - 'MOZ_NO_REMOTE': '1', 01:51:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:35 INFO - 'NO_EM_RESTART': '1', 01:51:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:51:35 INFO - 'PWD': '/builds/slave/test-pgo', 01:51:35 INFO - 'SHELL': '/bin/bash', 01:51:35 INFO - 'SHLVL': '1', 01:51:35 INFO - 'TERM': 'linux', 01:51:35 INFO - 'TMOUT': '86400', 01:51:35 INFO - 'USER': 'cltbld', 01:51:35 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880', 01:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:35 INFO - '_': '/tools/buildbot/bin/python'} 01:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:51:35 INFO - Running setup.py (path:/tmp/pip-2uuNgI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:51:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:51:35 INFO - Running setup.py (path:/tmp/pip-f3qkM3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:51:36 INFO - Running setup.py (path:/tmp/pip-i35YtH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:51:36 INFO - Running setup.py (path:/tmp/pip-jbRbuW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:51:36 INFO - Running setup.py (path:/tmp/pip-pb0aBr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:51:36 INFO - Running setup.py (path:/tmp/pip-PD3EIf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:51:36 INFO - Running setup.py (path:/tmp/pip-sAgl1p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:51:36 INFO - Running setup.py (path:/tmp/pip-bcrsEq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:51:36 INFO - Running setup.py (path:/tmp/pip-jAk1nx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:51:36 INFO - Running setup.py (path:/tmp/pip-hH4_TW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:51:36 INFO - Running setup.py (path:/tmp/pip-Dhkp3p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:51:36 INFO - Running setup.py (path:/tmp/pip-rpffjK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:51:36 INFO - Running setup.py (path:/tmp/pip-wailAt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:51:36 INFO - Running setup.py (path:/tmp/pip-sjjgbS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:51:36 INFO - Running setup.py (path:/tmp/pip-FasvkG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:51:36 INFO - Running setup.py (path:/tmp/pip-UiiMoG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:51:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:51:37 INFO - Running setup.py (path:/tmp/pip-E0ALNT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:51:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:51:37 INFO - Running setup.py install for manifestparser 01:51:37 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:51:37 INFO - Running setup.py install for mozcrash 01:51:37 INFO - Running setup.py install for mozdebug 01:51:37 INFO - Running setup.py install for mozdevice 01:51:37 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:51:37 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:51:37 INFO - Running setup.py install for mozfile 01:51:37 INFO - Running setup.py install for mozhttpd 01:51:37 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:51:37 INFO - Running setup.py install for mozinfo 01:51:37 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:51:37 INFO - Running setup.py install for mozInstall 01:51:37 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:51:37 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:51:37 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:51:37 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:51:37 INFO - Running setup.py install for mozleak 01:51:38 INFO - Running setup.py install for mozlog 01:51:38 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:51:38 INFO - Running setup.py install for moznetwork 01:51:38 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:51:38 INFO - Running setup.py install for mozprocess 01:51:38 INFO - Running setup.py install for mozprofile 01:51:38 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:51:38 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:51:38 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:51:38 INFO - Running setup.py install for mozrunner 01:51:38 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:51:38 INFO - Running setup.py install for mozscreenshot 01:51:38 INFO - Running setup.py install for moztest 01:51:38 INFO - Running setup.py install for mozversion 01:51:38 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:51:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:51:38 INFO - Cleaning up... 01:51:38 INFO - Return code: 0 01:51:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:38 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 0x7f960fb3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b69840>, '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 0x2ad66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad6b60>, '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': '41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880', '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 01:51:38 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 01:51:38 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 01:51:38 INFO - Using env: {'DISPLAY': ':0', 01:51:38 INFO - 'HOME': '/home/cltbld', 01:51:38 INFO - 'LANG': 'en_US.UTF-8', 01:51:38 INFO - 'LANGUAGE': 'en_US:en', 01:51:38 INFO - 'LOGNAME': 'cltbld', 01:51:38 INFO - 'MAIL': '/var/mail/cltbld', 01:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:38 INFO - 'MOZ_NO_REMOTE': '1', 01:51:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:38 INFO - 'NO_EM_RESTART': '1', 01:51:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:51:38 INFO - 'PWD': '/builds/slave/test-pgo', 01:51:38 INFO - 'SHELL': '/bin/bash', 01:51:38 INFO - 'SHLVL': '1', 01:51:38 INFO - 'TERM': 'linux', 01:51:38 INFO - 'TMOUT': '86400', 01:51:38 INFO - 'USER': 'cltbld', 01:51:38 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880', 01:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:38 INFO - '_': '/tools/buildbot/bin/python'} 01:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:51:39 INFO - Running setup.py (path:/tmp/pip-VehYfm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:51:39 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)) 01:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:51:39 INFO - Running setup.py (path:/tmp/pip-G8chEt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:51:39 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)) 01:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:51:39 INFO - Running setup.py (path:/tmp/pip-vf_2Lb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:51:39 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)) 01:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:51:39 INFO - Running setup.py (path:/tmp/pip-Cto2yW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:51:39 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)) 01:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:51:39 INFO - Running setup.py (path:/tmp/pip-sDPmUi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:51:39 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)) 01:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:51:39 INFO - Running setup.py (path:/tmp/pip-uIlHFP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:51:39 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)) 01:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:51:39 INFO - Running setup.py (path:/tmp/pip-Rfp3DG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:51:39 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)) 01:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:51:39 INFO - Running setup.py (path:/tmp/pip-8H75qU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:51:39 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)) 01:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:51:39 INFO - Running setup.py (path:/tmp/pip-CltHoi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:51:39 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)) 01:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:51:39 INFO - Running setup.py (path:/tmp/pip-hnzPAS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:51:39 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)) 01:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:51:39 INFO - Running setup.py (path:/tmp/pip-zS5iG0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:51:39 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)) 01:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:51:39 INFO - Running setup.py (path:/tmp/pip-32muLe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:51:39 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)) 01:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:51:39 INFO - Running setup.py (path:/tmp/pip-_m2m8N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:51:40 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)) 01:51:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:51:40 INFO - Running setup.py (path:/tmp/pip-Yb4bnt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:51:40 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)) 01:51:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:51:40 INFO - Running setup.py (path:/tmp/pip-aM9UtQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:51:40 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)) 01:51:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:51:40 INFO - Running setup.py (path:/tmp/pip-V5TvR4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:51:40 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)) 01:51:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:51:40 INFO - Running setup.py (path:/tmp/pip-tEc1Rh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:51:40 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)) 01:51:40 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)) 01:51:40 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)) 01:51:40 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)) 01:51:40 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)) 01:51:40 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)) 01:51:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:51:40 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 01:51:40 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 01:51:40 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 01:51:40 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 01:51:40 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 01:51:40 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 01:51:42 INFO - Downloading blessings-1.6.tar.gz 01:51:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:51:42 INFO - Installing collected packages: blessings 01:51:42 INFO - Running setup.py install for blessings 01:51:42 INFO - Successfully installed blessings 01:51:42 INFO - Cleaning up... 01:51:42 INFO - Return code: 0 01:51:42 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:51:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:51:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:51:42 INFO - Reading from file tmpfile_stdout 01:51:42 INFO - Current package versions: 01:51:42 INFO - argparse == 1.2.1 01:51:42 INFO - blessings == 1.6 01:51:42 INFO - blobuploader == 1.2.4 01:51:42 INFO - docopt == 0.6.1 01:51:42 INFO - manifestparser == 1.1 01:51:42 INFO - mozInstall == 1.12 01:51:42 INFO - mozcrash == 0.16 01:51:42 INFO - mozdebug == 0.1 01:51:42 INFO - mozdevice == 0.48 01:51:42 INFO - mozfile == 1.2 01:51:42 INFO - mozhttpd == 0.7 01:51:42 INFO - mozinfo == 0.9 01:51:42 INFO - mozleak == 0.1 01:51:42 INFO - mozlog == 3.1 01:51:42 INFO - moznetwork == 0.27 01:51:42 INFO - mozprocess == 0.22 01:51:42 INFO - mozprofile == 0.28 01:51:42 INFO - mozrunner == 6.11 01:51:42 INFO - mozscreenshot == 0.1 01:51:42 INFO - mozsystemmonitor == 0.0 01:51:42 INFO - moztest == 0.7 01:51:42 INFO - mozversion == 1.4 01:51:42 INFO - psutil == 3.1.1 01:51:42 INFO - requests == 1.2.3 01:51:42 INFO - wsgiref == 0.1.2 01:51:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:42 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 0x7f960fb3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b69840>, '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 0x2ad66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad6b60>, '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': '41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880', '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 01:51:42 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 01:51:42 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 01:51:42 INFO - Using env: {'DISPLAY': ':0', 01:51:42 INFO - 'HOME': '/home/cltbld', 01:51:42 INFO - 'LANG': 'en_US.UTF-8', 01:51:42 INFO - 'LANGUAGE': 'en_US:en', 01:51:42 INFO - 'LOGNAME': 'cltbld', 01:51:42 INFO - 'MAIL': '/var/mail/cltbld', 01:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:42 INFO - 'MOZ_NO_REMOTE': '1', 01:51:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:42 INFO - 'NO_EM_RESTART': '1', 01:51:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:51:42 INFO - 'PWD': '/builds/slave/test-pgo', 01:51:42 INFO - 'SHELL': '/bin/bash', 01:51:42 INFO - 'SHLVL': '1', 01:51:42 INFO - 'TERM': 'linux', 01:51:42 INFO - 'TMOUT': '86400', 01:51:42 INFO - 'USER': 'cltbld', 01:51:42 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880', 01:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:42 INFO - '_': '/tools/buildbot/bin/python'} 01:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:42 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)) 01:51:42 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)) 01:51:42 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)) 01:51:42 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)) 01:51:42 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)) 01:51:42 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)) 01:51:42 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)) 01:51:42 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)) 01:51:42 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)) 01:51:42 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)) 01:51: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 mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 01:51:42 INFO - Cleaning up... 01:51:42 INFO - Return code: 0 01:51:42 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 01:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:42 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 0x7f960fb3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b69840>, '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 0x2ad66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad6b60>, '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': '41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880', '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 01:51:42 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 01:51:42 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 01:51:42 INFO - Using env: {'DISPLAY': ':0', 01:51:42 INFO - 'HOME': '/home/cltbld', 01:51:42 INFO - 'LANG': 'en_US.UTF-8', 01:51:42 INFO - 'LANGUAGE': 'en_US:en', 01:51:42 INFO - 'LOGNAME': 'cltbld', 01:51:42 INFO - 'MAIL': '/var/mail/cltbld', 01:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:42 INFO - 'MOZ_NO_REMOTE': '1', 01:51:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:42 INFO - 'NO_EM_RESTART': '1', 01:51:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:51:42 INFO - 'PWD': '/builds/slave/test-pgo', 01:51:42 INFO - 'SHELL': '/bin/bash', 01:51:42 INFO - 'SHLVL': '1', 01:51:42 INFO - 'TERM': 'linux', 01:51:42 INFO - 'TMOUT': '86400', 01:51:42 INFO - 'USER': 'cltbld', 01:51:42 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880', 01:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:42 INFO - '_': '/tools/buildbot/bin/python'} 01:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:42 INFO - Downloading/unpacking jsonschema 01:51: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 01:51: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 01:51: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 01:51: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 01:51: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 01:51: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 01:51:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:51:44 INFO - Downloading/unpacking functools32 (from jsonschema) 01:51: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 01:51: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 01:51: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 01:51: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 01:51: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 01:51: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 01:51:44 INFO - Downloading functools32-3.2.3-2.tar.gz 01:51:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:51:44 INFO - warning: no files found matching '*.txt' 01:51:44 INFO - no previously-included directories found matching 'build' 01:51:44 INFO - no previously-included directories found matching 'dist' 01:51:44 INFO - no previously-included directories found matching '.git*' 01:51:44 INFO - Installing collected packages: jsonschema, functools32 01:51:45 INFO - Running setup.py install for functools32 01:51:45 INFO - warning: no files found matching '*.txt' 01:51:45 INFO - no previously-included directories found matching 'build' 01:51:45 INFO - no previously-included directories found matching 'dist' 01:51:45 INFO - no previously-included directories found matching '.git*' 01:51:45 INFO - Successfully installed jsonschema functools32 01:51:45 INFO - Cleaning up... 01:51:45 INFO - Return code: 0 01:51:45 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 01:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:45 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 0x7f960fb3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b69840>, '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 0x2ad66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad6b60>, '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': '41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880', '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 01:51:45 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 01:51:45 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 01:51:45 INFO - Using env: {'DISPLAY': ':0', 01:51:45 INFO - 'HOME': '/home/cltbld', 01:51:45 INFO - 'LANG': 'en_US.UTF-8', 01:51:45 INFO - 'LANGUAGE': 'en_US:en', 01:51:45 INFO - 'LOGNAME': 'cltbld', 01:51:45 INFO - 'MAIL': '/var/mail/cltbld', 01:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:45 INFO - 'MOZ_NO_REMOTE': '1', 01:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:45 INFO - 'NO_EM_RESTART': '1', 01:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:51:45 INFO - 'PWD': '/builds/slave/test-pgo', 01:51:45 INFO - 'SHELL': '/bin/bash', 01:51:45 INFO - 'SHLVL': '1', 01:51:45 INFO - 'TERM': 'linux', 01:51:45 INFO - 'TMOUT': '86400', 01:51:45 INFO - 'USER': 'cltbld', 01:51:45 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880', 01:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:45 INFO - '_': '/tools/buildbot/bin/python'} 01:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:45 INFO - Downloading/unpacking flake8 01:51:45 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 01:51:45 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 01:51:45 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 01:51:45 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 01:51:45 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 01:51:45 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 01:51:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:51:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:51: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 01:51: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 01:51: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 01:51: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 01:51: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 01:51: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 01:51:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:51:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:51: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 01:51: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 01:51: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 01:51: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 01:51: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 01:51: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 01:51:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:51: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 01:51: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 01:51: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 01:51: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 01:51: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 01:51: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 01:51:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 01:51:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:51:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:51:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:51:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:51:47 INFO - no previously-included directories found matching 'docs/_build' 01:51:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:51:47 INFO - Running setup.py install for pep8 01:51:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:51:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:51:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:51:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:51:47 INFO - no previously-included directories found matching 'docs/_build' 01:51:48 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 01:51:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:51:48 INFO - Cleaning up... 01:51:48 INFO - Return code: 0 01:51:48 INFO - Running post-action listener: _resource_record_post_action 01:51:48 INFO - Running post-action listener: _start_resource_monitoring 01:51:48 INFO - Starting resource monitoring. 01:51:48 INFO - ##### 01:51:48 INFO - ##### Running install step. 01:51:48 INFO - ##### 01:51:48 INFO - Running pre-action listener: _resource_record_pre_action 01:51:48 INFO - Running main action method: install 01:51:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:51:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:51:48 INFO - Reading from file tmpfile_stdout 01:51:48 INFO - Detecting whether we're running mozinstall >=1.0... 01:51:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:51:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:51:48 INFO - Reading from file tmpfile_stdout 01:51:48 INFO - Output received: 01:51:48 INFO - Usage: mozinstall [options] installer 01:51:48 INFO - Options: 01:51:48 INFO - -h, --help show this help message and exit 01:51:48 INFO - -d DEST, --destination=DEST 01:51:48 INFO - Directory to install application into. [default: 01:51:48 INFO - "/builds/slave/test-pgo"] 01:51:48 INFO - --app=APP Application being installed. [default: firefox] 01:51:48 INFO - mkdir: /builds/slave/test-pgo/build/application 01:51:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 01:51:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 01:52:04 INFO - Reading from file tmpfile_stdout 01:52:04 INFO - Output received: 01:52:04 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:52:04 INFO - Running post-action listener: _resource_record_post_action 01:52:04 INFO - ##### 01:52:04 INFO - ##### Running run-tests step. 01:52:04 INFO - ##### 01:52:04 INFO - Running pre-action listener: _resource_record_pre_action 01:52:04 INFO - Running main action method: run_tests 01:52:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:52:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:52:04 INFO - Python 2.7.3 01:52:04 INFO - Return code: 0 01:52:04 INFO - grabbing minidump binary from tooltool 01:52:04 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')]} 01:52:04 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 0x2b69840>, '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 0x2ad66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad6b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:52:04 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 01:52:04 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 01:52:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:52:04 INFO - Return code: 0 01:52:04 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:52:04 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:52:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:52:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:52:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:52:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 01:52:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 01:52:05 INFO - Return code: 0 01:52:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 01:52:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 01:52:05 INFO - Using env: {'DISPLAY': ':0', 01:52:05 INFO - 'HOME': '/home/cltbld', 01:52:05 INFO - 'LANG': 'en_US.UTF-8', 01:52:05 INFO - 'LANGUAGE': 'en_US:en', 01:52:05 INFO - 'LOGNAME': 'cltbld', 01:52:05 INFO - 'MAIL': '/var/mail/cltbld', 01:52:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:52:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:05 INFO - 'MOZ_NO_REMOTE': '1', 01:52:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:52:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:05 INFO - 'NO_EM_RESTART': '1', 01:52:05 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:52:05 INFO - 'PWD': '/builds/slave/test-pgo', 01:52:05 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:52:05 INFO - 'SHELL': '/bin/bash', 01:52:05 INFO - 'SHLVL': '1', 01:52:05 INFO - 'TERM': 'linux', 01:52:05 INFO - 'TMOUT': '86400', 01:52:05 INFO - 'USER': 'cltbld', 01:52:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880', 01:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:05 INFO - '_': '/tools/buildbot/bin/python'} 01:52:05 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 01:52:05 INFO - mozversion application_buildid: 20160120233054 01:52:05 INFO - mozversion application_changeset: 63e4b33812a91c3cfc18b05a1993009a611f8572 01:52:05 INFO - mozversion application_display_name: Nightly 01:52:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:52:05 INFO - mozversion application_name: Firefox 01:52:05 INFO - mozversion application_remotingname: firefox 01:52:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:52:05 INFO - mozversion application_vendor: Mozilla 01:52:05 INFO - mozversion application_version: 46.0a1 01:52:05 INFO - mozversion platform_buildid: 20160120233054 01:52:05 INFO - mozversion platform_changeset: 63e4b33812a91c3cfc18b05a1993009a611f8572 01:52:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:52:05 INFO - mozversion platform_version: 46.0a1 01:52:05 INFO - using testdate: 1453369925 01:52:05 INFO - actual date: 1453369925 01:52:05 INFO - starting webserver on 'localhost:60093' 01:52:05 INFO - SUITE-START | Running 3 tests 01:52:05 INFO - TEST-START | dromaeo_css 01:52:05 INFO - operating with platform_type : linux_ 01:52:05 INFO - Initialising browser for dromaeo_css test... 01:52:05 INFO - TEST-INFO | started process 6357 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPuAr6K/profile http://localhost:60093/getInfo.html) 01:52:09 INFO - PROCESS | 6357 | 01:52:09 INFO - PROCESS | 6357 | (process:6438): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:52:10 INFO - PROCESS | 6357 | __metrics Screen width/height:1600/1200 01:52:10 INFO - PROCESS | 6357 | colorDepth:24 01:52:10 INFO - PROCESS | 6357 | Browser inner width/height: 1024/697 01:52:10 INFO - PROCESS | 6357 | __metrics 01:52:10 INFO - PROCESS | 6357 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:52:11 INFO - TEST-INFO | 6357: exit 0 01:52:11 INFO - Browser initialized. 01:52:11 INFO - Running cycle 1/1 for dromaeo_css test... 01:52:11 INFO - TEST-INFO | started process 6487 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPuAr6K/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:52:11 INFO - PROCESS | 6487 | -- checkerboarding starts below -- 01:52:11 INFO - PROCESS | 6487 | RENDERTRACE 0.045475 rect red 0 0 10 10 // viewport 01:52:11 INFO - PROCESS | 6487 | RENDERTRACE 1.31805 rect red 0 0 10 10 // viewport 01:52:11 INFO - PROCESS | 6487 | RENDERTRACE 19.8716 rect brown 0 0 10 10 // page 01:52:11 INFO - PROCESS | 6487 | RENDERTRACE 19.8963 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 01:52:11 INFO - PROCESS | 6487 | Checkerboarded for 2 frames (22.6933 ms), 100 peak, 131 severity. 01:52:12 INFO - PROCESS | 6487 | 01:52:12 INFO - PROCESS | 6487 | (process:6550): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:52:22 INFO - PROCESS | 6487 | RSS: Main: 150368256 01:52:22 INFO - PROCESS | 6487 | 01:53:12 INFO - PROCESS | 6487 | 1453369992571 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] 01:55:21 INFO - PROCESS | 6487 | Cycle 1(1): loaded http://localhost:60093/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60093/tests/dromaeo/cssquery-ext.html) 01:55:22 INFO - PROCESS | 6487 | RSS: Main: 155787264 01:55:22 INFO - PROCESS | 6487 | 01:58:24 INFO - PROCESS | 6487 | Cycle 1(1): loaded http://localhost:60093/tests/dromaeo/cssquery-ext.html (next: http://localhost:60093/tests/dromaeo/cssquery-jquery.html) 01:58:25 INFO - PROCESS | 6487 | RSS: Main: 153174016 01:58:25 INFO - PROCESS | 6487 | 02:01:27 INFO - PROCESS | 6487 | Cycle 1(1): loaded http://localhost:60093/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60093/tests/dromaeo/cssquery-mootools.html) 02:01:27 INFO - PROCESS | 6487 | RSS: Main: 152621056 02:01:27 INFO - PROCESS | 6487 | 02:04:29 INFO - PROCESS | 6487 | Cycle 1(1): loaded http://localhost:60093/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60093/tests/dromaeo/cssquery-prototype.html) 02:04:30 INFO - PROCESS | 6487 | RSS: Main: 150749184 02:04:30 INFO - PROCESS | 6487 | 02:07:32 INFO - PROCESS | 6487 | Cycle 1(1): loaded http://localhost:60093/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60093/tests/dromaeo/cssquery-yui.html) 02:07:33 INFO - PROCESS | 6487 | RSS: Main: 150396928 02:07:33 INFO - PROCESS | 6487 | 02:10:35 INFO - PROCESS | 6487 | Cycle 1(1): loaded http://localhost:60093/tests/dromaeo/cssquery-yui.html (next: http://localhost:60093/tests/dromaeo/cssquery-dojo.html) 02:10:35 INFO - PROCESS | 6487 | RSS: Main: 152473600 02:10:35 INFO - PROCESS | 6487 | 02:10:35 INFO - PROCESS | 6487 | __start_tp_report 02:10:35 INFO - PROCESS | 6487 | _x_x_mozilla_page_load 02:10:35 INFO - PROCESS | 6487 | _x_x_mozilla_page_load_details 02:10:35 INFO - PROCESS | 6487 | |i|pagename|runs| 02:10:35 INFO - PROCESS | 6487 | |0;dojo.html;3217.4369485340058;3236.692514211149;3265.0368141398285;3275.8198299093556;3292.9012129636103;5371.650842695222;5404.756785944632;5415.810446634368;5417.539509141723;5421.728913554326;5344.973275133629;5357.919631205526;5409.756560954756;5476.863078423042;5491.258680078188;4860.027994401125;4889.486603906592;4946.975265123688;4967.403911530603;4971.37857767779;4971.403431588196;5004.449510553836;5006.524380183877;5059.038782631288;5128.333316668828;4884.169691152512;4896.46138924718;4952.628552858532;4958.578520825734;4966;4935.161022626162;4945.332380128672;4946.925796113062;4972.502749725035;4973.3286006389035;4916.385451818523;4934.062528119646;4952.603791696655;4956.355673762388;4975.651704380694;5161.561267292284;5224.791008359661;5257.894842103136;5360;5373.785048598052;5813.447722466359;5863.8534036649;5865.120231965239;5866.266716660418;5867.471927526501;5881.176635271066;5897.823065308047;5903.79336723217;5906.3207731110615;5916.556258280603;5463.016657001738;5468.48049435307;5537.169424586304;5551.333839939192;5565.471280228372;5941.138534912414;5966;5968.492678122321;5971.970140149271;5981.700914954322;5728.541716662657;5737;5741.339745929188;5744.253247077853;5752.28096487939;5745.2818397700285;5783.971080144656;5809.88380232393;5854.531637468992;5913.408659134052;5796.449337312949;5814.04068328721;5826.038703613856;5836.824895253149;5838.737256823453;5739.827805165852;5781.913271300934;5828.737706803204;5837.211976383219;5845.503132233723;4462.553744625511;4464.9107017860115;4478.283474644041;4493.865184044484;4545.272756358967;3973.5231772186944;3981.7411868228473;3989.601039895987;4006.859759908389;4030.133521292936;5347.25138480613;5393;5417.729113544307;5430.456954304538;5449.373322068013;5822.039363504974;5830.737616807254;5865.67738774363;5878.647281163144;5932.495737862244;5425.538829199483;5431.375391829911;5439.673619582838;5450.31871016123;5451.3458384994055;4942.40691117061;4978.303037574742;4979.925301120486;5024.42219144803;5042;5991.101334799815;6036.909446358308;6037.9396206038255;6043.667598282137;6086.117512960596;5863.648181109147;5874.500667443144;5903.616264942765;5904.439078287556;5906.438888305604;5915.053591425351;5941.435563621622;6067.120267561268;6069.180660610761;6077.118817771487;5755.798547050833;5803.187553742564;5803.216565763737;5814.244148260699;5821.912671310019;5806.303243610793;5859.736311866061;5865.618734782225;5876.3536011039605;5891.204687367151;5543.362513311021;5626.606137570331;5685.914711279417;5686.60193786431;5705.315362156568;5666.518345940642;5736.110902810071;5761.827145185651;5784.21913041734;5806.564507662027;5549.361823390201;5574.386817450159;5578.135389014709;5581.553475722014;5582.8325150245555;5570.470805273492;5665.66006039639;5684.857878553069;5726.341470730919;5761.308642962871;5470.945290547203;5536.501714845684;5567.805126820542;5579.302587176603;5623.325200975909 02:10:35 INFO - PROCESS | 6487 | |1;ext.html;537.5377175628959;550.4330539544266;561.7752898840464;567.3277166557627;589.2869627750422;35543.82228088859;36306.8184659077;36329.636703632954;36373.81813090938;36381.45427818582;42183.3672494912;43039;43141.56858431423;43202;43288.56711432885;8611.095834937336;8779.78050548735;8813.38306318558;8829.161229683203;8859.069797671249;8553.95723021384;8668.739937801876;8676.479411235347;8697.695580654678;8740.956295218515;8710;8751.256143227833;8819.250363719091;8828.514431706253;8830.426022308562;8689.739307820775;8722.345824063188;8763.474191548528;8775.078616745277;8785.692500762507;8512.276456501204;8665.39342246043;8678.045415004344;8695.043545210021;8724.738257852274;39197.60802391968;39353;39627.20745585072;39798.801005995076;39955.80022099871;3340.6492318306714;3344.4314466540745;3395.7792743471596;3409.6419875913166;3616.1682812952904;29291.267718307212;29726.702732972608;29834.70165298341;30228.546571801442;30585.541216881764;3503.982480087583;3533.9293214135832;3536.2397084626928;3636.2182130841998;3656.981715091434;262853;263010;263963;264269;264584.9999999981;51991.740041300305;52653.7367313161;58585.414145858;59402;59552.106718399256;58498.41501585015;58569.41430585725;58695;58790.706046469495;58911.70544147337;13284.667883302995;13327.73344533104;13358.799618005738;13366.131201471873;13406.597802065953;11611.709707257387;11674.883251167379;11717;11784.116191285688;11836.467358968866;19451.152140546626;19617.607647846962;19764.40706778799;19801.702974455395;19867.900660496893;7652.125229318853;7896.763097107096;7944.761657150295;8002.1997800219515;8066;988.4168340679034;1030.443560477334;1044.6343779677204;1058.3173852865013;1071.737424331044;28834.42331153365;28919;28958.42083158325;28960.262384257014;29184.708152918625;1040.9895901041043;1064.8668916385452;1075.134516714037;1115.2806439846415;1157.3287493253893;14968.775468367983;15283.923580382027;16220.270087846075;16538.50384488467;16606.833931660527;304504;308835;309541;309677;310805;51758.22362664563;52056;52126.73936630293;52235.2988231061;52518.21222681663;1350.3180893648644;1366.863313668625;1370.8560601136737;1385.411200239894;1393.2197969137314;28471.43057138887;29118.854405727834;29393.412131757672;29510.081844680026;29761.255968600093;45963.31055034244;46221.53778462307;46294.53705462902;46308.7684561575;46536.767316163205;295446;295738.08523829834;295923.3668969803;296116;296266;30926.22684432907;32486.187845304055;32960.1759956003;32967.83516082404;33031.17422064468;37166.628333717395;38150.80924595359;38454;38528.614713853625;39016.219675606895;32353.029409117764;32566;32631.673683262863;34195;35895.820520898276;34871;35488;36325.273494529436;36484.45273320955;36503.817480912425;32184.19539511531;32906.341873162884;33217.667823321455;33250.833745831114;33259.50110748389;29028.27429314284;29964.850175748983;32394.83802580972;33230;33325.66674333226;23288.301350959497;23438.76561234434;23458.296251112493;23565.882170589037;23632.881835590713 02:10:35 INFO - PROCESS | 6487 | |2;jquery.html;365.296803652968;366.5619584596408;367.0859559696357;367.9245754620303;372.61992767377257;15255.542333729978;16775.74836377454;17529.82470175298;17850;18425.44723658289;10178.389296642206;10622.893771062287;16630.50108496744;16685.49943501697;16697.83302166978;4882.267659851015;5501.449855014506;5506.174073888928;5506.64206826557;5507.807226747064;5044;5050.116229659813;5369.489898459659;5444.020076386269;5456.236126942231;3743.719221058418;3829.6936245100324;5008.499150084999;5008.774605142778;5028.6982781033075;5275.261463395128;5441.428649991753;5443.945560544423;5492.917606235909;5493.478119578654;4807.78364973577;5072.746362681888;5085.720285384303;5087.923681144785;5220.92168617471;12257.14200006;13565.728685426237;18962.81037189624;19810.801891981184;19983.100760465815;2127.7872212778752;2129.127057906251;2135.850490465668;2210.6131427000373;2252;9225.07749225072;9386.20217281525;9427.528623568864;11377.488013039432;12543.498260069586;1800.1449311577028;1817.1913498493175;1855.5824939388665;1867.495776140448;1892.4228110426313;54943.17585236225;55730.44269557293;57142.7142864283;58053.7097314515;58445;9824.164945979528;9843.655472058443;9851.014898510091;9883;9950.950245248727;12678.049146314062;12742.36288185587;12759.170653907466;12778.488860445477;12854.871451285555;7080.822979425556;7150.070490836262;7188.640567971581;7214.96392518034;7223.386012188917;6873.621950792654;6961.408280296231;7001.754938577125;7015.964920175366;7030.859382812418;4215.156968606291;4221.852235171754;4258.701890867609;4261.509926358446;4277.636400905895;1720.5010546941496;1761.1018380625974;1770.8140645232065;1785.8482029027678;1809.556658618647;424;425.58292872984646;440.0802323144643;444.3024451611004;944.0606596436589;10349.844752328721;10544.841827372595;10560.2079844012;10770.623028193975;10935.070519005974;454.3956537804712;458.8233530090939;460.80646128626057;465.51586350196095;471.5025647941386;5712.971435142797;5877.676727780014;5925.466707996215;5928.110783382527;6043;527019;542495;563325;563891;575930;67128.66435667791;71527;72339.63830180815;72808.63595681988;73070.63464682642;1148.0585919545892;1171.8945294923499;1177.9057675385948;1185.9288442693467;1191.2614179208772;14523.564293071226;14629.341679624655;14783.334749936494;15216.239188040332;15423.305951231998;22301.776982230618;29230.976915808697;30182.547261790653;30381.392372152874;31932.840335798173;41544.37683434811;41796.19343775505;42138.1572368557;42341.36487952745;42689;6873.1064961554675;6957.478189135733;7013.894791578028;7289.125304963438;7380.298871607189;10406.271560990657;10523;10598.735031623963;10664.466776661291;10914.72713182145;9186.494742789211;9409.341346105706;9435.811283774423;9443.150116489549;9563.904360956301;9680.128788409076;9830.705078847646;9914.702558923243;9929.503524823585;10163.54264058134;9269.953650231706;9790.510474476105;9793;9844.753881153028;9967.700968970943;7428.1086269647985;7539.509931854412;7542.622868856425;7552.471327007057;7562.130355009244;8295.95852020736;10052.11694048736;10073.69778906634;10155.289129760846;10191.337563058378 02:10:35 INFO - PROCESS | 6487 | |3;mootools.html;1511.5465360391881;1541.1446647110852;1706.2236682309551;1804.6751584714746;1831.633673265348;7728.381729461644;7758.185390533983;7918.524888506694;7943.007124109494;7973.840523189533;7779.494332868359;7785.3771698264145;7843.333316668076;7886.842263154734;7905.960470197641;2318.049599664134;2343.496148328109;2346.577616029114;2350.682657841195;2352.4118970257437;2350.15394457995;2359.398353419884;2373.703287089114;2378.988105059472;2381.1784934197763;2301.9539609207804;2341.7892389684926;2344.308429013445;2357.905683772647;2409.5662780699467;2369.2536850891915;2381.666566680666;2389.247387073075;2389.6535002424553;2391.1391898916377;2341.4263505441277;2352.741198468167;2362.492064206204;2366.219147681261;2376.1802178248477;7826.060872695256;7839.098503672094;7860.410469214775;7867.095284042294;7871.134175240776;4709.764511774398;4798.0643774464;4838.443578988426;4849.612031037544;4855.927161092586;3217.3404452087266;3225.2743132794935;3319.71782398494;3335.216224187314;3338.8998330050135;1006.3106771861299;1056.3292309383519;1071.4267866691362;1080.3679847289345;1104.9834252486219;10633.627823026234;10717.46412679363;10738.677839664822;10768.192385571036;10786.676399708022;4101.26177288085;4155.91688166235;4222.767747773841;4238.109996900624;4240.406343111967;8751.474911505331;8771.210591046836;8806.031336552975;8816.162464565856;8832.514211718417;4674.95325046752;4695.2252878275385;4743.02767932573;4752.168370535212;4753.31076993834;4320.827166913288;4321.308590625485;4343.087951530151;4369.3664418659755;4370.344448332776;3518.20840310928;3520.7887526748477;3542.769719968194;3578.570571531433;3582.462630605378;1069.8662667166604;1077.789830982951;1089.3082892363407;1089.7765957978595;1095.1512577752305;996.5216695985822;1013.2603199664286;1136.4374634555782;1223.7368965672424;1361.3873756809278;7103.680334384965;7111.075560177143;7113.466490013269;7142.28577142292;7212.891806622905;1105.690406686129;1118.2619471149003;1136.5510623303749;1146.140394703972;1152.3240861651304;5580.1629755537;5725.427457254241;5729.541636669056;5756.395578464285;5776.480116789509;8902.910970890338;9188.90811091894;9324.90675093254;9450.291228157916;9500.762480938032;8998.055204203596;9123.270138388913;9133.497657628894;9170.95414522923;9205.401648892934;7254.274572542704;7363.521371110861;7398.223186565441;7444.925550744531;7484.101907771103;7179.210286868336;7267.6366181691765;7285.417166626763;7298.489105762758;7306.086739157606;8374.53940033304;8464;8754.34342424308;8759.518226497348;8790.252828509649;8555.657773688983;8811.383203175716;8902.42134261271;8930.285577153682;8935;7057.682404291717;7061.293870612898;7152.24901385347;7221.67502462401;7223.952526883678;7554.206808285271;7623.733169339046;7633.618319083913;7667.11828139771;7697.461177717506;6942.305769423017;6964.09466769337;7111.182214045451;7182.102237220348;7246.565206087652;6938.5836849789175;7004.4396448283;7037.577745335091;7160.140783106061;7172.677229524579;6920.065791118134;7009.509334346547;7015.438764898694;7018.684159212746;7023;6487.22153341602;6487.253965793994;6512.804615861532;6513.706883190173;6542.149520562297;6350.555461117862;6641;6673.065770791996;6684.16447944007;6701.832454188684 02:10:35 INFO - PROCESS | 6487 | |4;prototype.html;335.4984298473782;341.0705826622454;342.58376073071213;344.4695169439064;352.04068912214217;6099.420555047274;6237.906431403532;6245.718942647581;6321.241451025878;6340.873182536352;6045.879082418349;6071.3018002929675;6148;6244.750209991595;6259.99840025596;4723.952760472403;4748.833790817322;4765.21373973294;4771.785269662873;4780.78486468108;4744.786484608201;4763.951930575268;4769.546893045155;4770.61835053195;4782.210935195706;4731.9763401182945;4732.668713190061;4736.597389221903;4739.31279964405;4746.430428348603;4639.350490931272;4698.882527936812;4710.387649605529;4717.103750287469;4733.337332773414;4106.630403263721;4110.301248787713;4114.855980040684;4120.031792528754;4140.23405669952;5950.375210602911;5950.9107363389585;5963.4931030862;5965.194698715662;5969.8806023879715;5534.861628459281;5535;5544.77820887168;5547.583931205136;5549.139883318092;6466.353364663496;6619.933800662028;6622.668866556653;6630.83422914431;6646.435053020499;4594.793234304464;4600.815967361302;4602.953970460286;4603.194440972849;4606.101810147023;6897.724091036353;6970.79087627372;6975.441964642816;6976.232614412411;6991.126109236346;4550.47669518003;4699.835505757282;4719.811207551659;4720.669553131248;4722.079194557028;4758.619310455155;4767.594754445911;4773.474917759044;4783.282507623884;4792.448868380181;5438.129899216186;5499.752511137009;5508.724563771795;5514.696691681996;5518.751656175482;6592.373724496165;6683.064370988066;6685.5654382465955;6687.899681504781;6688.765893193715;1666.4584010196734;1689.6536210076904;1692.1370101248451;1694.1021258732892;1695.0338307165043;1099.769048499808;1100.372787511127;1103.8289065194908;1121.9831702524468;1123.5730422439422;6147.600405973598;6173.47525460332;6174.5060395168275;6177.135201071854;6208;6737.393634572912;6746.392824645805;6812.046313516112;6813.1142951415995;6825;6189.6286222826775;6235.127082208494;6236.314005459396;6243.25080990275;6254.718537665816;3729.216864458494;3744.8689295874515;3757.530308711411;3762.8682996095554;3768.3782175940664;7240.1311842579225;7270.054892864;7278.272172782786;7287.526310789782;7290.781276561712;6884.414824739853;7056.188538318056;7107.502474826712;7109.786706398816;7138.821529461805;7209.963950180216;7210.71157153708;7234.782956511313;7258.963705181546;7263;6878.7248510059035;6897.48268879826;6904.965475172592;6907.6891539879825;6925.445964322943;6653.600783952978;6754.5609535380045;6760.729570817112;6808.489363297872;6813.965930170516;7192.244814294633;7199.49603527769;7227.7831665050135;7243.7464688735645;7263.6005019724425;4704.835330763407;4737.976310118427;4746.288056791371;4748.952510474851;4759.9524004759505;6829.590224586541;6954.061201737701;6963.199232088375;6995.195552511323;6997.4052205561065;6711.295313991961;6718.664066796739;6729.495287853332;6734;6739.865202696017;6667.36660017317;6720.563163394364;6728.158980127484;6736.898946515904;6749.797506074826;6267.811965641038;6338.904916426165;6493.512986526124;6494.447971922251;6497.122888410193;6609.1408116944485;6686.933130668631;6711.228208756055;6791.286914873867;6792.456603471809;6522.315156908457;6534.1178940844275;6569.408753212234;6579.111819904251;6585.967070164618 02:10:35 INFO - PROCESS | 6487 | |5;yui.html;717.8636059148762;720.8630360231556;722.1983598205994;738.2764890407399;746.7498388040007;15691.293891774869;16038.59903502413;16040.278187481563;16041.037537747728;16085.678286434264;13358.799618005738;13471.124376915493;13503.189808611465;13566.389512471938;13576.389062492186;814.2020819596798;819.4141189049814;831.5260301628074;831.9833603327929;837.3134030095324;820.827626198499;825.8513467575834;827.8634025385804;828.3911325175991;830.5515021888173;850.1413572291999;851.085083535199;851.1658574596898;853.6372041882206;854.090393730678;838.3083955736481;840.5503055865113;845.2308399356587;845.995770021149;846.0989046665343;629.2449061126621;629.2511910826148;629.3894921925724;629.6285191736852;630.1839118341759;13851.51519696816;13859.099158554662;13939.442422303096;13952.511662091778;13985.510507132201;12597.181183223061;12629.43167557462;12767.23396596198;12772.425240864091;12778.808317875239;10455.19416361443;10537.894621053769;10547.156227501782;10631.255812093157;10774.946125269324;3496.125968507873;3606.314800187982;3634.164142247298;3689.4465830125696;3695.334839728848;45804;47319.52680473185;47534.286985695246;47609.285860712116;47759.52240477585;9367.953160234156;9415.293852961055;9636.662716804878;9804.36271642341;10481.475926203659;17868.46394608164;17874.821251787576;17912.910435448;17938.730919036225;17984.550386240448;7250.891236631349;7275.563466192046;7276.745313913988;7472.364848987788;7473.962630186814;4000.4199391088127;4069.8575549855614;4079.286124928126;4157.230912281238;4174.874753757392;3145.433821912032;3169.1126484583892;3175.4442972479724;3181.5704879841387;3190.952135717966;547.5701574264264;558.8519042453753;564.2777245126244;564.2889958652128;580.0371383503364;580.1500801326077;583.7398131435893;607.9270487541523;621.4220774679592;647.792706333978;8386.958065209636;8412.957935210285;8430.494170349799;8484.40609157353;8493.575321233913;614.1034090228317;620.0760866309167;624.2010226909563;652.3150691773714;665.6704931059156;3677.558692956862;3848.807559622008;3905.1213476967455;3987.0829709167056;4052.0581053594456;51553.48446515487;51629.48370516322;51976.740116299174;52055.73972130115;52112.739436302574;47228.7638561805;47826.760866195444;47846.5215347849;47874.76062619664;48460.757696211294;42578.78710606427;43120;43188.352174718035;43231.567684322756;43430.7828460862;7589.6205189739185;7619.834875359805;7857.449978501679;7880;7906.920930790849;31015.844920775253;31109.68890311068;31514.68485315209;31568;32092.358152836347;38380.42429363506;43218.35172472353;43598;43684.56315436932;45254.54745452503;10522.684319470429;10622.681319560426;10700.441450508615;10823.783524329312;11119.16606254518;11425.60010399632;11428;11653.88346116528;11851.822222666839;12237.816432753694;10771.246012779031;10881.619143330263;10927.235093543375;10947.178961578073;10970.506327215135;10578.788424231627;10606.893931060898;10693.465326733787;10918.617848375268;11045.33727976324;10731.463426828783;11050.944745276543;11100.056495197998;11264.436778160894;11418.200725949437;8870.77823054403;8922.598483068406;8990.910090899008;9357.953210234178;9480.905190948002;8712.168173410022;9015.684451044182;9298.349115562116;9508.809823803624;9782.9021709782 02:10:35 INFO - PROCESS | 6487 | __end_tp_report 02:10:35 INFO - PROCESS | 6487 | __start_cc_report 02:10:35 INFO - PROCESS | 6487 | _x_x_mozilla_cycle_collect,305 02:10:35 INFO - PROCESS | 6487 | __end_cc_report 02:10:35 INFO - PROCESS | 6487 | __startTimestamp1453371035986__endTimestamp 02:10:35 INFO - PROCESS | 6487 | 02:10:35 INFO - PROCESS | 6487 | ------- Summary: start ------- 02:10:35 INFO - PROCESS | 6487 | Number of tests: 6 02:10:35 INFO - PROCESS | 6487 | 02:10:35 INFO - PROCESS | 6487 | [#0] dojo.html Cycles:165 Average:5411.71 Median:5578.14 stddev:603.95 (10.8%) stddev-sans-first:580.75 02:10:35 INFO - PROCESS | 6487 | Values: 3217.4 3236.7 3265.0 3275.8 3292.9 5371.7 5404.8 5415.8 5417.5 5421.7 5345.0 5357.9 5409.8 5476.9 5491.3 4860.0 4889.5 4947.0 4967.4 4971.4 4971.4 5004.4 5006.5 5059.0 5128.3 4884.2 4896.5 4952.6 4958.6 4966.0 4935.2 4945.3 4946.9 4972.5 4973.3 4916.4 4934.1 4952.6 4956.4 4975.7 5161.6 5224.8 5257.9 5360.0 5373.8 5813.4 5863.9 5865.1 5866.3 5867.5 5881.2 5897.8 5903.8 5906.3 5916.6 5463.0 5468.5 5537.2 5551.3 5565.5 5941.1 5966.0 5968.5 5972.0 5981.7 5728.5 5737.0 5741.3 5744.3 5752.3 5745.3 5784.0 5809.9 5854.5 5913.4 5796.4 5814.0 5826.0 5836.8 5838.7 5739.8 5781.9 5828.7 5837.2 5845.5 4462.6 4464.9 4478.3 4493.9 4545.3 3973.5 3981.7 3989.6 4006.9 4030.1 5347.3 5393.0 5417.7 5430.5 5449.4 5822.0 5830.7 5865.7 5878.6 5932.5 5425.5 5431.4 5439.7 5450.3 5451.3 4942.4 4978.3 4979.9 5024.4 5042.0 5991.1 6036.9 6037.9 6043.7 6086.1 5863.6 5874.5 5903.6 5904.4 5906.4 5915.1 5941.4 6067.1 6069.2 6077.1 5755.8 5803.2 5803.2 5814.2 5821.9 5806.3 5859.7 5865.6 5876.4 5891.2 5543.4 5626.6 5685.9 5686.6 5705.3 5666.5 5736.1 5761.8 5784.2 5806.6 5549.4 5574.4 5578.1 5581.6 5582.8 5570.5 5665.7 5684.9 5726.3 5761.3 5470.9 5536.5 5567.8 5579.3 5623.3 02:10:35 INFO - PROCESS | 6487 | 02:10:35 INFO - PROCESS | 6487 | [#1] ext.html Cycles:180 Average:45563.21 Median:18802.32 stddev:75760.91 (402.9%) stddev-sans-first:75898.01 02:10:35 INFO - PROCESS | 6487 | Values: 537.5 550.4 561.8 567.3 589.3 35543.8 36306.8 36329.6 36373.8 36381.5 42183.4 43039.0 43141.6 43202.0 43288.6 8611.1 8779.8 8813.4 8829.2 8859.1 8554.0 8668.7 8676.5 8697.7 8741.0 8710.0 8751.3 8819.3 8828.5 8830.4 8689.7 8722.3 8763.5 8775.1 8785.7 8512.3 8665.4 8678.0 8695.0 8724.7 39197.6 39353.0 39627.2 39798.8 39955.8 3340.6 3344.4 3395.8 3409.6 3616.2 29291.3 29726.7 29834.7 30228.5 30585.5 3504.0 3533.9 3536.2 3636.2 3657.0 262853.0 263010.0 263963.0 264269.0 264585.0 51991.7 52653.7 58585.4 59402.0 59552.1 58498.4 58569.4 58695.0 58790.7 58911.7 13284.7 13327.7 13358.8 13366.1 13406.6 11611.7 11674.9 11717.0 11784.1 11836.5 19451.2 19617.6 19764.4 19801.7 19867.9 7652.1 7896.8 7944.8 8002.2 8066.0 988.4 1030.4 1044.6 1058.3 1071.7 28834.4 28919.0 28958.4 28960.3 29184.7 1041.0 1064.9 1075.1 1115.3 1157.3 14968.8 15283.9 16220.3 16538.5 16606.8 304504.0 308835.0 309541.0 309677.0 310805.0 51758.2 52056.0 52126.7 52235.3 52518.2 1350.3 1366.9 1370.9 1385.4 1393.2 28471.4 29118.9 29393.4 29510.1 29761.3 45963.3 46221.5 46294.5 46308.8 46536.8 295446.0 295738.1 295923.4 296116.0 296266.0 30926.2 32486.2 32960.2 32967.8 33031.2 37166.6 38150.8 38454.0 38528.6 39016.2 32353.0 32566.0 32631.7 34195.0 35895.8 34871.0 35488.0 36325.3 36484.5 36503.8 32184.2 32906.3 33217.7 33250.8 33259.5 29028.3 29964.9 32394.8 33230.0 33325.7 23288.3 23438.8 23458.3 23565.9 23632.9 02:10:35 INFO - PROCESS | 6487 | 02:10:35 INFO - PROCESS | 6487 | [#2] jquery.html Cycles:180 Average:27300.73 Median:463.16 stddev:90672.82 (19576.9%) stddev-sans-first:90904.62 02:10:35 INFO - PROCESS | 6487 | Values: 365.3 366.6 367.1 367.9 372.6 15255.5 16775.7 17529.8 17850.0 18425.4 10178.4 10622.9 16630.5 16685.5 16697.8 4882.3 5501.4 5506.2 5506.6 5507.8 5044.0 5050.1 5369.5 5444.0 5456.2 3743.7 3829.7 5008.5 5008.8 5028.7 5275.3 5441.4 5443.9 5492.9 5493.5 4807.8 5072.7 5085.7 5087.9 5220.9 12257.1 13565.7 18962.8 19810.8 19983.1 2127.8 2129.1 2135.9 2210.6 2252.0 9225.1 9386.2 9427.5 11377.5 12543.5 1800.1 1817.2 1855.6 1867.5 1892.4 54943.2 55730.4 57142.7 58053.7 58445.0 9824.2 9843.7 9851.0 9883.0 9951.0 12678.0 12742.4 12759.2 12778.5 12854.9 7080.8 7150.1 7188.6 7215.0 7223.4 6873.6 6961.4 7001.8 7016.0 7030.9 4215.2 4221.9 4258.7 4261.5 4277.6 1720.5 1761.1 1770.8 1785.8 1809.6 424.0 425.6 440.1 444.3 944.1 10349.8 10544.8 10560.2 10770.6 10935.1 454.4 458.8 460.8 465.5 471.5 5713.0 5877.7 5925.5 5928.1 6043.0 527019.0 542495.0 563325.0 563891.0 575930.0 67128.7 71527.0 72339.6 72808.6 73070.6 1148.1 1171.9 1177.9 1185.9 1191.3 14523.6 14629.3 14783.3 15216.2 15423.3 22301.8 29231.0 30182.5 30381.4 31932.8 41544.4 41796.2 42138.2 42341.4 42689.0 6873.1 6957.5 7013.9 7289.1 7380.3 10406.3 10523.0 10598.7 10664.5 10914.7 9186.5 9409.3 9435.8 9443.2 9563.9 9680.1 9830.7 9914.7 9929.5 10163.5 9270.0 9790.5 9793.0 9844.8 9967.7 7428.1 7539.5 7542.6 7552.5 7562.1 8296.0 10052.1 10073.7 10155.3 10191.3 02:10:35 INFO - PROCESS | 6487 | 02:10:35 INFO - PROCESS | 6487 | [#3] mootools.html Cycles:180 Average:5508.57 Median:6487.24 stddev:2813.16 (43.4%) stddev-sans-first:2805.01 02:10:36 INFO - PROCESS | 6487 | Values: 1511.5 1541.1 1706.2 1804.7 1831.6 7728.4 7758.2 7918.5 7943.0 7973.8 7779.5 7785.4 7843.3 7886.8 7906.0 2318.0 2343.5 2346.6 2350.7 2352.4 2350.2 2359.4 2373.7 2379.0 2381.2 2302.0 2341.8 2344.3 2357.9 2409.6 2369.3 2381.7 2389.2 2389.7 2391.1 2341.4 2352.7 2362.5 2366.2 2376.2 7826.1 7839.1 7860.4 7867.1 7871.1 4709.8 4798.1 4838.4 4849.6 4855.9 3217.3 3225.3 3319.7 3335.2 3338.9 1006.3 1056.3 1071.4 1080.4 1105.0 10633.6 10717.5 10738.7 10768.2 10786.7 4101.3 4155.9 4222.8 4238.1 4240.4 8751.5 8771.2 8806.0 8816.2 8832.5 4675.0 4695.2 4743.0 4752.2 4753.3 4320.8 4321.3 4343.1 4369.4 4370.3 3518.2 3520.8 3542.8 3578.6 3582.5 1069.9 1077.8 1089.3 1089.8 1095.2 996.5 1013.3 1136.4 1223.7 1361.4 7103.7 7111.1 7113.5 7142.3 7212.9 1105.7 1118.3 1136.6 1146.1 1152.3 5580.2 5725.4 5729.5 5756.4 5776.5 8902.9 9188.9 9324.9 9450.3 9500.8 8998.1 9123.3 9133.5 9171.0 9205.4 7254.3 7363.5 7398.2 7444.9 7484.1 7179.2 7267.6 7285.4 7298.5 7306.1 8374.5 8464.0 8754.3 8759.5 8790.3 8555.7 8811.4 8902.4 8930.3 8935.0 7057.7 7061.3 7152.2 7221.7 7224.0 7554.2 7623.7 7633.6 7667.1 7697.5 6942.3 6964.1 7111.2 7182.1 7246.6 6938.6 7004.4 7037.6 7160.1 7172.7 6920.1 7009.5 7015.4 7018.7 7023.0 6487.2 6487.3 6512.8 6513.7 6542.1 6350.6 6641.0 6673.1 6684.2 6701.8 02:10:36 INFO - PROCESS | 6487 | 02:10:36 INFO - PROCESS | 6487 | [#4] prototype.html Cycles:180 Average:5559.43 Median:6235.72 stddev:1691.27 (27.1%) stddev-sans-first:1649.94 02:10:36 INFO - PROCESS | 6487 | Values: 335.5 341.1 342.6 344.5 352.0 6099.4 6237.9 6245.7 6321.2 6340.9 6045.9 6071.3 6148.0 6244.8 6260.0 4724.0 4748.8 4765.2 4771.8 4780.8 4744.8 4764.0 4769.5 4770.6 4782.2 4732.0 4732.7 4736.6 4739.3 4746.4 4639.4 4698.9 4710.4 4717.1 4733.3 4106.6 4110.3 4114.9 4120.0 4140.2 5950.4 5950.9 5963.5 5965.2 5969.9 5534.9 5535.0 5544.8 5547.6 5549.1 6466.4 6619.9 6622.7 6630.8 6646.4 4594.8 4600.8 4603.0 4603.2 4606.1 6897.7 6970.8 6975.4 6976.2 6991.1 4550.5 4699.8 4719.8 4720.7 4722.1 4758.6 4767.6 4773.5 4783.3 4792.4 5438.1 5499.8 5508.7 5514.7 5518.8 6592.4 6683.1 6685.6 6687.9 6688.8 1666.5 1689.7 1692.1 1694.1 1695.0 1099.8 1100.4 1103.8 1122.0 1123.6 6147.6 6173.5 6174.5 6177.1 6208.0 6737.4 6746.4 6812.0 6813.1 6825.0 6189.6 6235.1 6236.3 6243.3 6254.7 3729.2 3744.9 3757.5 3762.9 3768.4 7240.1 7270.1 7278.3 7287.5 7290.8 6884.4 7056.2 7107.5 7109.8 7138.8 7210.0 7210.7 7234.8 7259.0 7263.0 6878.7 6897.5 6905.0 6907.7 6925.4 6653.6 6754.6 6760.7 6808.5 6814.0 7192.2 7199.5 7227.8 7243.7 7263.6 4704.8 4738.0 4746.3 4749.0 4760.0 6829.6 6954.1 6963.2 6995.2 6997.4 6711.3 6718.7 6729.5 6734.0 6739.9 6667.4 6720.6 6728.2 6736.9 6749.8 6267.8 6338.9 6493.5 6494.4 6497.1 6609.1 6686.9 6711.2 6791.3 6792.5 6522.3 6534.1 6569.4 6579.1 6586.0 02:10:36 INFO - PROCESS | 6487 | 02:10:36 INFO - PROCESS | 6487 | [#5] yui.html Cycles:180 Average:13254.82 Median:45529.27 stddev:14872.92 (32.7%) stddev-sans-first:14884.84 02:10:36 INFO - PROCESS | 6487 | Values: 717.9 720.9 722.2 738.3 746.7 15691.3 16038.6 16040.3 16041.0 16085.7 13358.8 13471.1 13503.2 13566.4 13576.4 814.2 819.4 831.5 832.0 837.3 820.8 825.9 827.9 828.4 830.6 850.1 851.1 851.2 853.6 854.1 838.3 840.6 845.2 846.0 846.1 629.2 629.3 629.4 629.6 630.2 13851.5 13859.1 13939.4 13952.5 13985.5 12597.2 12629.4 12767.2 12772.4 12778.8 10455.2 10537.9 10547.2 10631.3 10774.9 3496.1 3606.3 3634.2 3689.4 3695.3 45804.0 47319.5 47534.3 47609.3 47759.5 9368.0 9415.3 9636.7 9804.4 10481.5 17868.5 17874.8 17912.9 17938.7 17984.6 7250.9 7275.6 7276.7 7472.4 7474.0 4000.4 4069.9 4079.3 4157.2 4174.9 3145.4 3169.1 3175.4 3181.6 3191.0 547.6 558.9 564.3 564.3 580.0 580.2 583.7 607.9 621.4 647.8 8387.0 8413.0 8430.5 8484.4 8493.6 614.1 620.1 624.2 652.3 665.7 3677.6 3848.8 3905.1 3987.1 4052.1 51553.5 51629.5 51976.7 52055.7 52112.7 47228.8 47826.8 47846.5 47874.8 48460.8 42578.8 43120.0 43188.4 43231.6 43430.8 7589.6 7619.8 7857.4 7880.0 7906.9 31015.8 31109.7 31514.7 31568.0 32092.4 38380.4 43218.4 43598.0 43684.6 45254.5 10522.7 10622.7 10700.4 10823.8 11119.2 11425.6 11428.0 11653.9 11851.8 12237.8 10771.2 10881.6 10927.2 10947.2 10970.5 10578.8 10606.9 10693.5 10918.6 11045.3 10731.5 11050.9 11100.1 11264.4 11418.2 8870.8 8922.6 8990.9 9358.0 9480.9 8712.2 9015.7 9298.3 9508.8 9782.9 02:10:36 INFO - PROCESS | 6487 | -------- Summary: end -------- 02:10:36 INFO - PROCESS | 6487 | 02:10:36 INFO - TEST-INFO | 6487: exit 0 02:10:36 INFO - TEST-OK | dromaeo_css | took 1110809ms 02:10:36 INFO - TEST-START | kraken 02:10:36 INFO - operating with platform_type : linux_ 02:10:36 INFO - Initialising browser for kraken test... 02:10:36 INFO - TEST-INFO | started process 6733 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKrQ6he/profile http://localhost:60093/getInfo.html) 02:10:40 INFO - PROCESS | 6733 | 02:10:40 INFO - PROCESS | 6733 | (process:6805): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:10:40 INFO - PROCESS | 6733 | __metrics Screen width/height:1600/1200 02:10:40 INFO - PROCESS | 6733 | colorDepth:24 02:10:40 INFO - PROCESS | 6733 | Browser inner width/height: 1024/697 02:10:40 INFO - PROCESS | 6733 | __metrics 02:10:40 INFO - PROCESS | 6733 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:10:41 INFO - TEST-INFO | 6733: exit 0 02:10:41 INFO - Browser initialized. 02:10:41 INFO - Running cycle 1/1 for kraken test... 02:10:41 INFO - TEST-INFO | started process 6854 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKrQ6he/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:10:42 INFO - PROCESS | 6854 | -- checkerboarding starts below -- 02:10:42 INFO - PROCESS | 6854 | RENDERTRACE 0.051971 rect red 0 0 10 10 // viewport 02:10:42 INFO - PROCESS | 6854 | RENDERTRACE 27.172 rect brown 0 0 10 10 // page 02:10:42 INFO - PROCESS | 6854 | RENDERTRACE 27.2143 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 02:10:42 INFO - PROCESS | 6854 | Checkerboarded for 1 frames (27.2822 ms), 100 peak, 1 severity. 02:10:43 INFO - PROCESS | 6854 | 02:10:43 INFO - PROCESS | 6854 | (process:6916): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:10:53 INFO - PROCESS | 6854 | RSS: Main: 150282240 02:10:53 INFO - PROCESS | 6854 | 02:10:56 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:60093/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60093/tests/kraken/driver.html?testName=audio-beat-detection) 02:10:56 INFO - PROCESS | 6854 | RSS: Main: 151707648 02:10:56 INFO - PROCESS | 6854 | 02:10:59 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:60093/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60093/tests/kraken/driver.html?testName=audio-dft) 02:11:00 INFO - PROCESS | 6854 | RSS: Main: 154157056 02:11:00 INFO - PROCESS | 6854 | 02:11:02 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:60093/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60093/tests/kraken/driver.html?testName=audio-fft) 02:11:03 INFO - PROCESS | 6854 | RSS: Main: 145915904 02:11:03 INFO - PROCESS | 6854 | 02:11:05 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:60093/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60093/tests/kraken/driver.html?testName=audio-oscillator) 02:11:06 INFO - PROCESS | 6854 | RSS: Main: 146771968 02:11:06 INFO - PROCESS | 6854 | 02:11:08 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:60093/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60093/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:11:09 INFO - PROCESS | 6854 | RSS: Main: 146526208 02:11:09 INFO - PROCESS | 6854 | 02:11:12 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:60093/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60093/tests/kraken/driver.html?testName=imaging-darkroom) 02:11:12 INFO - PROCESS | 6854 | RSS: Main: 148635648 02:11:12 INFO - PROCESS | 6854 | 02:11:16 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:60093/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60093/tests/kraken/driver.html?testName=imaging-desaturate) 02:11:16 INFO - PROCESS | 6854 | RSS: Main: 147980288 02:11:16 INFO - PROCESS | 6854 | 02:11:19 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:60093/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60093/tests/kraken/driver.html?testName=json-parse-financial) 02:11:20 INFO - PROCESS | 6854 | RSS: Main: 150282240 02:11:20 INFO - PROCESS | 6854 | 02:11:21 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:60093/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60093/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:11:22 INFO - PROCESS | 6854 | RSS: Main: 150994944 02:11:22 INFO - PROCESS | 6854 | 02:11:24 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:60093/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60093/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:11:24 INFO - PROCESS | 6854 | RSS: Main: 150020096 02:11:24 INFO - PROCESS | 6854 | 02:11:26 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:60093/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60093/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:11:27 INFO - PROCESS | 6854 | RSS: Main: 150708224 02:11:27 INFO - PROCESS | 6854 | 02:11:29 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:60093/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60093/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:11:30 INFO - PROCESS | 6854 | RSS: Main: 151293952 02:11:30 INFO - PROCESS | 6854 | 02:11:32 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:60093/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60093/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:11:33 INFO - PROCESS | 6854 | RSS: Main: 150847488 02:11:33 INFO - PROCESS | 6854 | 02:11:35 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:60093/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60093/tests/kraken/driver.html?testName=ai-astar) 02:11:35 INFO - PROCESS | 6854 | RSS: Main: 151580672 02:11:35 INFO - PROCESS | 6854 | 02:11:35 INFO - PROCESS | 6854 | __start_tp_report 02:11:35 INFO - PROCESS | 6854 | _x_x_mozilla_page_load 02:11:35 INFO - PROCESS | 6854 | _x_x_mozilla_page_load_details 02:11:35 INFO - PROCESS | 6854 | |i|pagename|runs| 02:11:35 INFO - PROCESS | 6854 | |0;ai-astar;111;104;111;111;111;123;108;110;111;109 02:11:35 INFO - PROCESS | 6854 | |1;audio-beat-detection;163;125;155;173;130;149;151;137;169;138 02:11:35 INFO - PROCESS | 6854 | |2;audio-dft;163;165;162;163;162;161;169;168;166;164 02:11:35 INFO - PROCESS | 6854 | |3;audio-fft;73;77;74;74;73;129;73;76;74;77 02:11:35 INFO - PROCESS | 6854 | |4;audio-oscillator;95;96;138;96;98;98;142;97;97;134 02:11:35 INFO - PROCESS | 6854 | |5;imaging-gaussian-blur;110;110;110;112;109;110;110;121;109;110 02:11:35 INFO - PROCESS | 6854 | |6;imaging-darkroom;146;147;147;147;146;146;146;146;146;147 02:11:35 INFO - PROCESS | 6854 | |7;imaging-desaturate;97;97;96;98;97;96;97;97;96;97 02:11:35 INFO - PROCESS | 6854 | |8;json-parse-financial;60;60;61;60;60;61;64;61;76;64 02:11:35 INFO - PROCESS | 6854 | |9;json-stringify-tinderbox;68;68;68;68;69;68;69;69;71;69 02:11:35 INFO - PROCESS | 6854 | |10;stanford-crypto-aes;81;80;84;82;83;81;82;82;81;82 02:11:35 INFO - PROCESS | 6854 | |11;stanford-crypto-ccm;119;114;123;124;116;122;121;134;120;120 02:11:35 INFO - PROCESS | 6854 | |12;stanford-crypto-pbkdf2;132;144;145;141;142;143;142;140;147;131 02:11:35 INFO - PROCESS | 6854 | |13;stanford-crypto-sha256-iterative;66;67;68;66;67;69;66;68;68;68 02:11:35 INFO - PROCESS | 6854 | __end_tp_report 02:11:35 INFO - PROCESS | 6854 | __start_cc_report 02:11:35 INFO - PROCESS | 6854 | _x_x_mozilla_cycle_collect,722 02:11:35 INFO - PROCESS | 6854 | __end_cc_report 02:11:35 INFO - PROCESS | 6854 | __startTimestamp1453371095447__endTimestamp 02:11:35 INFO - PROCESS | 6854 | 02:11:35 INFO - PROCESS | 6854 | ------- Summary: start ------- 02:11:35 INFO - PROCESS | 6854 | Number of tests: 14 02:11:35 INFO - PROCESS | 6854 | 02:11:35 INFO - PROCESS | 6854 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:4.79 (4.3%) stddev-sans-first:5.09 02:11:35 INFO - PROCESS | 6854 | Values: 111.0 104.0 111.0 111.0 111.0 123.0 108.0 110.0 111.0 109.0 02:11:35 INFO - PROCESS | 6854 | 02:11:35 INFO - PROCESS | 6854 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:153.00 stddev:16.38 (10.7%) stddev-sans-first:16.57 02:11:35 INFO - PROCESS | 6854 | Values: 163.0 125.0 155.0 173.0 130.0 149.0 151.0 137.0 169.0 138.0 02:11:35 INFO - PROCESS | 6854 | 02:11:35 INFO - PROCESS | 6854 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.50 stddev:2.67 (1.6%) stddev-sans-first:2.79 02:11:35 INFO - PROCESS | 6854 | Values: 163.0 165.0 162.0 163.0 162.0 161.0 169.0 168.0 166.0 164.0 02:11:35 INFO - PROCESS | 6854 | 02:11:35 INFO - PROCESS | 6854 | [#3] audio-fft Cycles:10 Average:80.00 Median:74.00 stddev:17.29 (23.4%) stddev-sans-first:18.15 02:11:35 INFO - PROCESS | 6854 | Values: 73.0 77.0 74.0 74.0 73.0 129.0 73.0 76.0 74.0 77.0 02:11:35 INFO - PROCESS | 6854 | 02:11:35 INFO - PROCESS | 6854 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:96.50 stddev:20.05 (20.8%) stddev-sans-first:20.61 02:11:35 INFO - PROCESS | 6854 | Values: 95.0 96.0 138.0 96.0 98.0 98.0 142.0 97.0 97.0 134.0 02:11:35 INFO - PROCESS | 6854 | 02:11:35 INFO - PROCESS | 6854 | [#5] imaging-gaussian-blur Cycles:10 Average:111.10 Median:110.00 stddev:3.57 (3.2%) stddev-sans-first:3.77 02:11:35 INFO - PROCESS | 6854 | Values: 110.0 110.0 110.0 112.0 109.0 110.0 110.0 121.0 109.0 110.0 02:11:35 INFO - PROCESS | 6854 | 02:11:35 INFO - PROCESS | 6854 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:11:35 INFO - PROCESS | 6854 | Values: 146.0 147.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 147.0 02:11:35 INFO - PROCESS | 6854 | 02:11:35 INFO - PROCESS | 6854 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:97.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 02:11:35 INFO - PROCESS | 6854 | Values: 97.0 97.0 96.0 98.0 97.0 96.0 97.0 97.0 96.0 97.0 02:11:35 INFO - PROCESS | 6854 | 02:11:35 INFO - PROCESS | 6854 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:61.00 stddev:4.92 (8.1%) stddev-sans-first:5.12 02:11:35 INFO - PROCESS | 6854 | Values: 60.0 60.0 61.0 60.0 60.0 61.0 64.0 61.0 76.0 64.0 02:11:35 INFO - PROCESS | 6854 | 02:11:35 INFO - PROCESS | 6854 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.95 (1.4%) stddev-sans-first:0.97 02:11:35 INFO - PROCESS | 6854 | Values: 68.0 68.0 68.0 68.0 69.0 68.0 69.0 69.0 71.0 69.0 02:11:35 INFO - PROCESS | 6854 | 02:11:35 INFO - PROCESS | 6854 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.00 stddev:1.14 (1.4%) stddev-sans-first:1.17 02:11:35 INFO - PROCESS | 6854 | Values: 81.0 80.0 84.0 82.0 83.0 81.0 82.0 82.0 81.0 82.0 02:11:35 INFO - PROCESS | 6854 | 02:11:35 INFO - PROCESS | 6854 | [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:121.50 stddev:5.40 (4.4%) stddev-sans-first:5.66 02:11:35 INFO - PROCESS | 6854 | Values: 119.0 114.0 123.0 124.0 116.0 122.0 121.0 134.0 120.0 120.0 02:11:35 INFO - PROCESS | 6854 | 02:11:35 INFO - PROCESS | 6854 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.70 Median:142.50 stddev:5.25 (3.7%) stddev-sans-first:4.53 02:11:35 INFO - PROCESS | 6854 | Values: 132.0 144.0 145.0 141.0 142.0 143.0 142.0 140.0 147.0 131.0 02:11:35 INFO - PROCESS | 6854 | 02:11:35 INFO - PROCESS | 6854 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:1.06 (1.6%) stddev-sans-first:1.01 02:11:35 INFO - PROCESS | 6854 | Values: 66.0 67.0 68.0 66.0 67.0 69.0 66.0 68.0 68.0 68.0 02:11:35 INFO - PROCESS | 6854 | -------- Summary: end -------- 02:11:35 INFO - PROCESS | 6854 | 02:11:36 INFO - TEST-INFO | 6854: exit 0 02:11:36 INFO - TEST-OK | kraken | took 59844ms 02:11:36 INFO - TEST-START | v8_7 02:11:36 INFO - operating with platform_type : linux_ 02:11:36 INFO - Initialising browser for v8_7 test... 02:11:36 INFO - TEST-INFO | started process 7145 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpF0d393/profile http://localhost:60093/getInfo.html) 02:11:39 INFO - PROCESS | 7145 | 02:11:39 INFO - PROCESS | 7145 | (process:7218): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:11:40 INFO - PROCESS | 7145 | __metrics Screen width/height:1600/1200 02:11:40 INFO - PROCESS | 7145 | colorDepth:24 02:11:40 INFO - PROCESS | 7145 | Browser inner width/height: 1024/697 02:11:40 INFO - PROCESS | 7145 | __metrics 02:11:40 INFO - PROCESS | 7145 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:11:41 INFO - TEST-INFO | 7145: exit 0 02:11:41 INFO - Browser initialized. 02:11:41 INFO - Running cycle 1/1 for v8_7 test... 02:11:41 INFO - TEST-INFO | started process 7267 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpF0d393/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:11:42 INFO - PROCESS | 7267 | -- checkerboarding starts below -- 02:11:42 INFO - PROCESS | 7267 | RENDERTRACE 0.046332 rect red 0 0 10 10 // viewport 02:11:42 INFO - PROCESS | 7267 | RENDERTRACE 53.7102 rect brown 0 0 10 10 // page 02:11:42 INFO - PROCESS | 7267 | RENDERTRACE 53.7327 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 02:11:42 INFO - PROCESS | 7267 | Checkerboarded for 1 frames (66.7014 ms), 100 peak, 1 severity. 02:11:42 INFO - PROCESS | 7267 | 02:11:42 INFO - PROCESS | 7267 | (process:7326): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:11:53 INFO - PROCESS | 7267 | RSS: Main: 149188608 02:11:53 INFO - PROCESS | 7267 | 02:12:15 INFO - PROCESS | 7267 | Cycle 1(1): loaded http://localhost:60093/tests/v8_7/run.html (next: http://localhost:60093/tests/v8_7/run.html) 02:12:16 INFO - PROCESS | 7267 | RSS: Main: 144740352 02:12:16 INFO - PROCESS | 7267 | 02:12:16 INFO - PROCESS | 7267 | __start_tp_report 02:12:16 INFO - PROCESS | 7267 | _x_x_mozilla_page_load 02:12:16 INFO - PROCESS | 7267 | _x_x_mozilla_page_load_details 02:12:16 INFO - PROCESS | 7267 | |i|pagename|runs| 02:12:16 INFO - PROCESS | 7267 | |0;Richards;166.00265604249668 02:12:16 INFO - PROCESS | 7267 | |1;DeltaBlue;187.72292096865027 02:12:16 INFO - PROCESS | 7267 | |2;Encrypt;281.0567734682406 02:12:16 INFO - PROCESS | 7267 | |3;Decrypt;5208.333333333333 02:12:16 INFO - PROCESS | 7267 | |4;RayTrace;1068.3760683760684 02:12:16 INFO - PROCESS | 7267 | |5;Earley;707.7140835102618 02:12:16 INFO - PROCESS | 7267 | |6;Boyer;12525 02:12:16 INFO - PROCESS | 7267 | |7;RegExp;42224.489795918365 02:12:16 INFO - PROCESS | 7267 | |8;Splay;569.8005698005697 02:12:16 INFO - PROCESS | 7267 | |9;NavierStokes;4887.804878048781 02:12:16 INFO - PROCESS | 7267 | __end_tp_report 02:12:16 INFO - PROCESS | 7267 | __startTimestamp1453371136048__endTimestamp 02:12:16 INFO - PROCESS | 7267 | 02:12:16 INFO - PROCESS | 7267 | ------- Summary: start ------- 02:12:16 INFO - PROCESS | 7267 | Number of tests: 10 02:12:16 INFO - PROCESS | 7267 | 02:12:16 INFO - PROCESS | 7267 | [#0] Richards Cycles:1 Average:166.00 Median:166.00 stddev:0.00 (0.0%) 02:12:16 INFO - PROCESS | 7267 | Values: 166.0 02:12:16 INFO - PROCESS | 7267 | 02:12:16 INFO - PROCESS | 7267 | [#1] DeltaBlue Cycles:1 Average:187.72 Median:187.72 stddev:0.00 (0.0%) 02:12:16 INFO - PROCESS | 7267 | Values: 187.7 02:12:16 INFO - PROCESS | 7267 | 02:12:16 INFO - PROCESS | 7267 | [#2] Encrypt Cycles:1 Average:281.06 Median:281.06 stddev:0.00 (0.0%) 02:12:16 INFO - PROCESS | 7267 | Values: 281.1 02:12:16 INFO - PROCESS | 7267 | 02:12:16 INFO - PROCESS | 7267 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 02:12:16 INFO - PROCESS | 7267 | Values: 5208.3 02:12:16 INFO - PROCESS | 7267 | 02:12:16 INFO - PROCESS | 7267 | [#4] RayTrace Cycles:1 Average:1068.38 Median:1068.38 stddev:0.00 (0.0%) 02:12:16 INFO - PROCESS | 7267 | Values: 1068.4 02:12:16 INFO - PROCESS | 7267 | 02:12:16 INFO - PROCESS | 7267 | [#5] Earley Cycles:1 Average:707.71 Median:707.71 stddev:0.00 (0.0%) 02:12:16 INFO - PROCESS | 7267 | Values: 707.7 02:12:16 INFO - PROCESS | 7267 | 02:12:16 INFO - PROCESS | 7267 | [#6] Boyer Cycles:1 Average:12525.00 Median:12525.00 stddev:0.00 (0.0%) 02:12:16 INFO - PROCESS | 7267 | Values: 12525.0 02:12:16 INFO - PROCESS | 7267 | 02:12:16 INFO - PROCESS | 7267 | [#7] RegExp Cycles:1 Average:42224.49 Median:42224.49 stddev:0.00 (0.0%) 02:12:16 INFO - PROCESS | 7267 | Values: 42224.5 02:12:16 INFO - PROCESS | 7267 | 02:12:16 INFO - PROCESS | 7267 | [#8] Splay Cycles:1 Average:569.80 Median:569.80 stddev:0.00 (0.0%) 02:12:16 INFO - PROCESS | 7267 | Values: 569.8 02:12:16 INFO - PROCESS | 7267 | 02:12:16 INFO - PROCESS | 7267 | [#9] NavierStokes Cycles:1 Average:4887.80 Median:4887.80 stddev:0.00 (0.0%) 02:12:16 INFO - PROCESS | 7267 | Values: 4887.8 02:12:16 INFO - PROCESS | 7267 | -------- Summary: end -------- 02:12:16 INFO - PROCESS | 7267 | 02:12:16 INFO - TEST-INFO | 7267: exit 0 02:12:16 INFO - TEST-OK | v8_7 | took 40472ms 02:12:16 INFO - SUITE-END | took 1211s 02:12:17 INFO - Completed test suite (00:20:11) 02:12:17 INFO - Working with test: dromaeo_css 02:12:17 INFO - Generating results file: dromaeo_css 02:12:17 INFO - Working with test: kraken 02:12:17 INFO - Generating results file: kraken 02:12:17 INFO - javascript benchmark 02:12:17 INFO - Working with test: v8_7 02:12:17 INFO - Generating results file: v8_7 02:12:17 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:12:17 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 02:12:17 INFO - process_Request line: dromaeo_css 6854.63 graph.html#tests=[[72,64,43]] 02:12:17 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:12:17 INFO - process_Request line: kraken 1510.10 graph.html#tests=[[232,64,43]] 02:12:17 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:12:17 INFO - process_Request line: v8_7 20396.83 graph.html#tests=[[230,64,43]] 02:12:17 INFO - RETURN: dromaeo_css: 6854.63 02:12:17 INFO - RETURN: kraken: 1510.10 02:12:17 INFO - RETURN: v8_7: 20396.83 02:12:17 INFO - javascript benchmark 02:12:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3217.4369485340058, 3236.692514211149, 3265.0368141398285, 3275.8198299093556, 3292.9012129636103, 5371.650842695222, 5404.756785944632, 5415.810446634368, 5417.539509141723, 5421.728913554326, 5344.973275133629, 5357.919631205526, 5409.756560954756, 5476.863078423042, 5491.258680078188, 4860.027994401125, 4889.486603906592, 4946.975265123688, 4967.403911530603, 4971.37857767779, 4971.403431588196, 5004.449510553836, 5006.524380183877, 5059.038782631288, 5128.333316668828, 4884.169691152512, 4896.46138924718, 4952.628552858532, 4958.578520825734, 4966.0, 4935.161022626162, 4945.332380128672, 4946.925796113062, 4972.502749725035, 4973.3286006389035, 4916.385451818523, 4934.062528119646, 4952.603791696655, 4956.355673762388, 4975.651704380694, 5161.561267292284, 5224.791008359661, 5257.894842103136, 5360.0, 5373.785048598052, 5813.447722466359, 5863.8534036649, 5865.120231965239, 5866.266716660418, 5867.471927526501, 5881.176635271066, 5897.823065308047, 5903.79336723217, 5906.3207731110615, 5916.556258280603, 5463.016657001738, 5468.48049435307, 5537.169424586304, 5551.333839939192, 5565.471280228372, 5941.138534912414, 5966.0, 5968.492678122321, 5971.970140149271, 5981.700914954322, 5728.541716662657, 5737.0, 5741.339745929188, 5744.253247077853, 5752.28096487939, 5745.2818397700285, 5783.971080144656, 5809.88380232393, 5854.531637468992, 5913.408659134052, 5796.449337312949, 5814.04068328721, 5826.038703613856, 5836.824895253149, 5838.737256823453, 5739.827805165852, 5781.913271300934, 5828.737706803204, 5837.211976383219, 5845.503132233723, 4462.553744625511, 4464.9107017860115, 4478.283474644041, 4493.865184044484, 4545.272756358967, 3973.5231772186944, 3981.7411868228473, 3989.601039895987, 4006.859759908389, 4030.133521292936, 5347.25138480613, 5393.0, 5417.729113544307, 5430.456954304538, 5449.373322068013, 5822.039363504974, 5830.737616807254, 5865.67738774363, 5878.647281163144, 5932.495737862244, 5425.538829199483, 5431.375391829911, 5439.673619582838, 5450.31871016123, 5451.3458384994055, 4942.40691117061, 4978.303037574742, 4979.925301120486, 5024.42219144803, 5042.0, 5991.101334799815, 6036.909446358308, 6037.9396206038255, 6043.667598282137, 6086.117512960596, 5863.648181109147, 5874.500667443144, 5903.616264942765, 5904.439078287556, 5906.438888305604, 5915.053591425351, 5941.435563621622, 6067.120267561268, 6069.180660610761, 6077.118817771487, 5755.798547050833, 5803.187553742564, 5803.216565763737, 5814.244148260699, 5821.912671310019, 5806.303243610793, 5859.736311866061, 5865.618734782225, 5876.3536011039605, 5891.204687367151, 5543.362513311021, 5626.606137570331, 5685.914711279417, 5686.60193786431, 5705.315362156568, 5666.518345940642, 5736.110902810071, 5761.827145185651, 5784.21913041734, 5806.564507662027, 5549.361823390201, 5574.386817450159, 5578.135389014709, 5581.553475722014, 5582.8325150245555, 5570.470805273492, 5665.66006039639, 5684.857878553069, 5726.341470730919, 5761.308642962871, 5470.945290547203, 5536.501714845684, 5567.805126820542, 5579.302587176603, 5623.325200975909], "unit": "score", "name": "dojo.html", "value": 5372.297953479806}, {"lowerIsBetter": false, "replicates": [537.5377175628959, 550.4330539544266, 561.7752898840464, 567.3277166557627, 589.2869627750422, 35543.82228088859, 36306.8184659077, 36329.636703632954, 36373.81813090938, 36381.45427818582, 42183.3672494912, 43039.0, 43141.56858431423, 43202.0, 43288.56711432885, 8611.095834937336, 8779.78050548735, 8813.38306318558, 8829.161229683203, 8859.069797671249, 8553.95723021384, 8668.739937801876, 8676.479411235347, 8697.695580654678, 8740.956295218515, 8710.0, 8751.256143227833, 8819.250363719091, 8828.514431706253, 8830.426022308562, 8689.739307820775, 8722.345824063188, 8763.474191548528, 8775.078616745277, 8785.692500762507, 8512.276456501204, 8665.39342246043, 8678.045415004344, 8695.043545210021, 8724.738257852274, 39197.60802391968, 39353.0, 39627.20745585072, 39798.801005995076, 39955.80022099871, 3340.6492318306714, 3344.4314466540745, 3395.7792743471596, 3409.6419875913166, 3616.1682812952904, 29291.267718307212, 29726.702732972608, 29834.70165298341, 30228.546571801442, 30585.541216881764, 3503.982480087583, 3533.9293214135832, 3536.2397084626928, 3636.2182130841998, 3656.981715091434, 262853.0, 263010.0, 263963.0, 264269.0, 264584.9999999981, 51991.740041300305, 52653.7367313161, 58585.414145858, 59402.0, 59552.106718399256, 58498.41501585015, 58569.41430585725, 58695.0, 58790.706046469495, 58911.70544147337, 13284.667883302995, 13327.73344533104, 13358.799618005738, 13366.131201471873, 13406.597802065953, 11611.709707257387, 11674.883251167379, 11717.0, 11784.116191285688, 11836.467358968866, 19451.152140546626, 19617.607647846962, 19764.40706778799, 19801.702974455395, 19867.900660496893, 7652.125229318853, 7896.763097107096, 7944.761657150295, 8002.1997800219515, 8066.0, 988.4168340679034, 1030.443560477334, 1044.6343779677204, 1058.3173852865013, 1071.737424331044, 28834.42331153365, 28919.0, 28958.42083158325, 28960.262384257014, 29184.708152918625, 1040.9895901041043, 1064.8668916385452, 1075.134516714037, 1115.2806439846415, 1157.3287493253893, 14968.775468367983, 15283.923580382027, 16220.270087846075, 16538.50384488467, 16606.833931660527, 304504.0, 308835.0, 309541.0, 309677.0, 310805.0, 51758.22362664563, 52056.0, 52126.73936630293, 52235.2988231061, 52518.21222681663, 1350.3180893648644, 1366.863313668625, 1370.8560601136737, 1385.411200239894, 1393.2197969137314, 28471.43057138887, 29118.854405727834, 29393.412131757672, 29510.081844680026, 29761.255968600093, 45963.31055034244, 46221.53778462307, 46294.53705462902, 46308.7684561575, 46536.767316163205, 295446.0, 295738.08523829834, 295923.3668969803, 296116.0, 296266.0, 30926.22684432907, 32486.187845304055, 32960.1759956003, 32967.83516082404, 33031.17422064468, 37166.628333717395, 38150.80924595359, 38454.0, 38528.614713853625, 39016.219675606895, 32353.029409117764, 32566.0, 32631.673683262863, 34195.0, 35895.820520898276, 34871.0, 35488.0, 36325.273494529436, 36484.45273320955, 36503.817480912425, 32184.19539511531, 32906.341873162884, 33217.667823321455, 33250.833745831114, 33259.50110748389, 29028.27429314284, 29964.850175748983, 32394.83802580972, 33230.0, 33325.66674333226, 23288.301350959497, 23438.76561234434, 23458.296251112493, 23565.882170589037, 23632.881835590713], "unit": "score", "name": "ext.html", "value": 18203.36446273749}, {"lowerIsBetter": false, "replicates": [365.296803652968, 366.5619584596408, 367.0859559696357, 367.9245754620303, 372.61992767377257, 15255.542333729978, 16775.74836377454, 17529.82470175298, 17850.0, 18425.44723658289, 10178.389296642206, 10622.893771062287, 16630.50108496744, 16685.49943501697, 16697.83302166978, 4882.267659851015, 5501.449855014506, 5506.174073888928, 5506.64206826557, 5507.807226747064, 5044.0, 5050.116229659813, 5369.489898459659, 5444.020076386269, 5456.236126942231, 3743.719221058418, 3829.6936245100324, 5008.499150084999, 5008.774605142778, 5028.6982781033075, 5275.261463395128, 5441.428649991753, 5443.945560544423, 5492.917606235909, 5493.478119578654, 4807.78364973577, 5072.746362681888, 5085.720285384303, 5087.923681144785, 5220.92168617471, 12257.14200006, 13565.728685426237, 18962.81037189624, 19810.801891981184, 19983.100760465815, 2127.7872212778752, 2129.127057906251, 2135.850490465668, 2210.6131427000373, 2252.0, 9225.07749225072, 9386.20217281525, 9427.528623568864, 11377.488013039432, 12543.498260069586, 1800.1449311577028, 1817.1913498493175, 1855.5824939388665, 1867.495776140448, 1892.4228110426313, 54943.17585236225, 55730.44269557293, 57142.7142864283, 58053.7097314515, 58445.0, 9824.164945979528, 9843.655472058443, 9851.014898510091, 9883.0, 9950.950245248727, 12678.049146314062, 12742.36288185587, 12759.170653907466, 12778.488860445477, 12854.871451285555, 7080.822979425556, 7150.070490836262, 7188.640567971581, 7214.96392518034, 7223.386012188917, 6873.621950792654, 6961.408280296231, 7001.754938577125, 7015.964920175366, 7030.859382812418, 4215.156968606291, 4221.852235171754, 4258.701890867609, 4261.509926358446, 4277.636400905895, 1720.5010546941496, 1761.1018380625974, 1770.8140645232065, 1785.8482029027678, 1809.556658618647, 424.0, 425.58292872984646, 440.0802323144643, 444.3024451611004, 944.0606596436589, 10349.844752328721, 10544.841827372595, 10560.2079844012, 10770.623028193975, 10935.070519005974, 454.3956537804712, 458.8233530090939, 460.80646128626057, 465.51586350196095, 471.5025647941386, 5712.971435142797, 5877.676727780014, 5925.466707996215, 5928.110783382527, 6043.0, 527019.0, 542495.0, 563325.0, 563891.0, 575930.0, 67128.66435667791, 71527.0, 72339.63830180815, 72808.63595681988, 73070.63464682642, 1148.0585919545892, 1171.8945294923499, 1177.9057675385948, 1185.9288442693467, 1191.2614179208772, 14523.564293071226, 14629.341679624655, 14783.334749936494, 15216.239188040332, 15423.305951231998, 22301.776982230618, 29230.976915808697, 30182.547261790653, 30381.392372152874, 31932.840335798173, 41544.37683434811, 41796.19343775505, 42138.1572368557, 42341.36487952745, 42689.0, 6873.1064961554675, 6957.478189135733, 7013.894791578028, 7289.125304963438, 7380.298871607189, 10406.271560990657, 10523.0, 10598.735031623963, 10664.466776661291, 10914.72713182145, 9186.494742789211, 9409.341346105706, 9435.811283774423, 9443.150116489549, 9563.904360956301, 9680.128788409076, 9830.705078847646, 9914.702558923243, 9929.503524823585, 10163.54264058134, 9269.953650231706, 9790.510474476105, 9793.0, 9844.753881153028, 9967.700968970943, 7428.1086269647985, 7539.509931854412, 7542.622868856425, 7552.471327007057, 7562.130355009244, 8295.95852020736, 10052.11694048736, 10073.69778906634, 10155.289129760846, 10191.337563058378], "unit": "score", "name": "jquery.html", "value": 7545.520573487415}, {"lowerIsBetter": false, "replicates": [1511.5465360391881, 1541.1446647110852, 1706.2236682309551, 1804.6751584714746, 1831.633673265348, 7728.381729461644, 7758.185390533983, 7918.524888506694, 7943.007124109494, 7973.840523189533, 7779.494332868359, 7785.3771698264145, 7843.333316668076, 7886.842263154734, 7905.960470197641, 2318.049599664134, 2343.496148328109, 2346.577616029114, 2350.682657841195, 2352.4118970257437, 2350.15394457995, 2359.398353419884, 2373.703287089114, 2378.988105059472, 2381.1784934197763, 2301.9539609207804, 2341.7892389684926, 2344.308429013445, 2357.905683772647, 2409.5662780699467, 2369.2536850891915, 2381.666566680666, 2389.247387073075, 2389.6535002424553, 2391.1391898916377, 2341.4263505441277, 2352.741198468167, 2362.492064206204, 2366.219147681261, 2376.1802178248477, 7826.060872695256, 7839.098503672094, 7860.410469214775, 7867.095284042294, 7871.134175240776, 4709.764511774398, 4798.0643774464, 4838.443578988426, 4849.612031037544, 4855.927161092586, 3217.3404452087266, 3225.2743132794935, 3319.71782398494, 3335.216224187314, 3338.8998330050135, 1006.3106771861299, 1056.3292309383519, 1071.4267866691362, 1080.3679847289345, 1104.9834252486219, 10633.627823026234, 10717.46412679363, 10738.677839664822, 10768.192385571036, 10786.676399708022, 4101.26177288085, 4155.91688166235, 4222.767747773841, 4238.109996900624, 4240.406343111967, 8751.474911505331, 8771.210591046836, 8806.031336552975, 8816.162464565856, 8832.514211718417, 4674.95325046752, 4695.2252878275385, 4743.02767932573, 4752.168370535212, 4753.31076993834, 4320.827166913288, 4321.308590625485, 4343.087951530151, 4369.3664418659755, 4370.344448332776, 3518.20840310928, 3520.7887526748477, 3542.769719968194, 3578.570571531433, 3582.462630605378, 1069.8662667166604, 1077.789830982951, 1089.3082892363407, 1089.7765957978595, 1095.1512577752305, 996.5216695985822, 1013.2603199664286, 1136.4374634555782, 1223.7368965672424, 1361.3873756809278, 7103.680334384965, 7111.075560177143, 7113.466490013269, 7142.28577142292, 7212.891806622905, 1105.690406686129, 1118.2619471149003, 1136.5510623303749, 1146.140394703972, 1152.3240861651304, 5580.1629755537, 5725.427457254241, 5729.541636669056, 5756.395578464285, 5776.480116789509, 8902.910970890338, 9188.90811091894, 9324.90675093254, 9450.291228157916, 9500.762480938032, 8998.055204203596, 9123.270138388913, 9133.497657628894, 9170.95414522923, 9205.401648892934, 7254.274572542704, 7363.521371110861, 7398.223186565441, 7444.925550744531, 7484.101907771103, 7179.210286868336, 7267.6366181691765, 7285.417166626763, 7298.489105762758, 7306.086739157606, 8374.53940033304, 8464.0, 8754.34342424308, 8759.518226497348, 8790.252828509649, 8555.657773688983, 8811.383203175716, 8902.42134261271, 8930.285577153682, 8935.0, 7057.682404291717, 7061.293870612898, 7152.24901385347, 7221.67502462401, 7223.952526883678, 7554.206808285271, 7623.733169339046, 7633.618319083913, 7667.11828139771, 7697.461177717506, 6942.305769423017, 6964.09466769337, 7111.182214045451, 7182.102237220348, 7246.565206087652, 6938.5836849789175, 7004.4396448283, 7037.577745335091, 7160.140783106061, 7172.677229524579, 6920.065791118134, 7009.509334346547, 7015.438764898694, 7018.684159212746, 7023.0, 6487.22153341602, 6487.253965793994, 6512.804615861532, 6513.706883190173, 6542.149520562297, 6350.555461117862, 6641.0, 6673.065770791996, 6684.16447944007, 6701.832454188684], "unit": "score", "name": "mootools.html", "value": 4546.114957380185}, {"lowerIsBetter": false, "replicates": [335.4984298473782, 341.0705826622454, 342.58376073071213, 344.4695169439064, 352.04068912214217, 6099.420555047274, 6237.906431403532, 6245.718942647581, 6321.241451025878, 6340.873182536352, 6045.879082418349, 6071.3018002929675, 6148.0, 6244.750209991595, 6259.99840025596, 4723.952760472403, 4748.833790817322, 4765.21373973294, 4771.785269662873, 4780.78486468108, 4744.786484608201, 4763.951930575268, 4769.546893045155, 4770.61835053195, 4782.210935195706, 4731.9763401182945, 4732.668713190061, 4736.597389221903, 4739.31279964405, 4746.430428348603, 4639.350490931272, 4698.882527936812, 4710.387649605529, 4717.103750287469, 4733.337332773414, 4106.630403263721, 4110.301248787713, 4114.855980040684, 4120.031792528754, 4140.23405669952, 5950.375210602911, 5950.9107363389585, 5963.4931030862, 5965.194698715662, 5969.8806023879715, 5534.861628459281, 5535.0, 5544.77820887168, 5547.583931205136, 5549.139883318092, 6466.353364663496, 6619.933800662028, 6622.668866556653, 6630.83422914431, 6646.435053020499, 4594.793234304464, 4600.815967361302, 4602.953970460286, 4603.194440972849, 4606.101810147023, 6897.724091036353, 6970.79087627372, 6975.441964642816, 6976.232614412411, 6991.126109236346, 4550.47669518003, 4699.835505757282, 4719.811207551659, 4720.669553131248, 4722.079194557028, 4758.619310455155, 4767.594754445911, 4773.474917759044, 4783.282507623884, 4792.448868380181, 5438.129899216186, 5499.752511137009, 5508.724563771795, 5514.696691681996, 5518.751656175482, 6592.373724496165, 6683.064370988066, 6685.5654382465955, 6687.899681504781, 6688.765893193715, 1666.4584010196734, 1689.6536210076904, 1692.1370101248451, 1694.1021258732892, 1695.0338307165043, 1099.769048499808, 1100.372787511127, 1103.8289065194908, 1121.9831702524468, 1123.5730422439422, 6147.600405973598, 6173.47525460332, 6174.5060395168275, 6177.135201071854, 6208.0, 6737.393634572912, 6746.392824645805, 6812.046313516112, 6813.1142951415995, 6825.0, 6189.6286222826775, 6235.127082208494, 6236.314005459396, 6243.25080990275, 6254.718537665816, 3729.216864458494, 3744.8689295874515, 3757.530308711411, 3762.8682996095554, 3768.3782175940664, 7240.1311842579225, 7270.054892864, 7278.272172782786, 7287.526310789782, 7290.781276561712, 6884.414824739853, 7056.188538318056, 7107.502474826712, 7109.786706398816, 7138.821529461805, 7209.963950180216, 7210.71157153708, 7234.782956511313, 7258.963705181546, 7263.0, 6878.7248510059035, 6897.48268879826, 6904.965475172592, 6907.6891539879825, 6925.445964322943, 6653.600783952978, 6754.5609535380045, 6760.729570817112, 6808.489363297872, 6813.965930170516, 7192.244814294633, 7199.49603527769, 7227.7831665050135, 7243.7464688735645, 7263.6005019724425, 4704.835330763407, 4737.976310118427, 4746.288056791371, 4748.952510474851, 4759.9524004759505, 6829.590224586541, 6954.061201737701, 6963.199232088375, 6995.195552511323, 6997.4052205561065, 6711.295313991961, 6718.664066796739, 6729.495287853332, 6734.0, 6739.865202696017, 6667.36660017317, 6720.563163394364, 6728.158980127484, 6736.898946515904, 6749.797506074826, 6267.811965641038, 6338.904916426165, 6493.512986526124, 6494.447971922251, 6497.122888410193, 6609.1408116944485, 6686.933130668631, 6711.228208756055, 6791.286914873867, 6792.456603471809, 6522.315156908457, 6534.1178940844275, 6569.408753212234, 6579.111819904251, 6585.967070164618], "unit": "score", "name": "prototype.html", "value": 5006.391987163175}, {"lowerIsBetter": false, "replicates": [717.8636059148762, 720.8630360231556, 722.1983598205994, 738.2764890407399, 746.7498388040007, 15691.293891774869, 16038.59903502413, 16040.278187481563, 16041.037537747728, 16085.678286434264, 13358.799618005738, 13471.124376915493, 13503.189808611465, 13566.389512471938, 13576.389062492186, 814.2020819596798, 819.4141189049814, 831.5260301628074, 831.9833603327929, 837.3134030095324, 820.827626198499, 825.8513467575834, 827.8634025385804, 828.3911325175991, 830.5515021888173, 850.1413572291999, 851.085083535199, 851.1658574596898, 853.6372041882206, 854.090393730678, 838.3083955736481, 840.5503055865113, 845.2308399356587, 845.995770021149, 846.0989046665343, 629.2449061126621, 629.2511910826148, 629.3894921925724, 629.6285191736852, 630.1839118341759, 13851.51519696816, 13859.099158554662, 13939.442422303096, 13952.511662091778, 13985.510507132201, 12597.181183223061, 12629.43167557462, 12767.23396596198, 12772.425240864091, 12778.808317875239, 10455.19416361443, 10537.894621053769, 10547.156227501782, 10631.255812093157, 10774.946125269324, 3496.125968507873, 3606.314800187982, 3634.164142247298, 3689.4465830125696, 3695.334839728848, 45804.0, 47319.52680473185, 47534.286985695246, 47609.285860712116, 47759.52240477585, 9367.953160234156, 9415.293852961055, 9636.662716804878, 9804.36271642341, 10481.475926203659, 17868.46394608164, 17874.821251787576, 17912.910435448, 17938.730919036225, 17984.550386240448, 7250.891236631349, 7275.563466192046, 7276.745313913988, 7472.364848987788, 7473.962630186814, 4000.4199391088127, 4069.8575549855614, 4079.286124928126, 4157.230912281238, 4174.874753757392, 3145.433821912032, 3169.1126484583892, 3175.4442972479724, 3181.5704879841387, 3190.952135717966, 547.5701574264264, 558.8519042453753, 564.2777245126244, 564.2889958652128, 580.0371383503364, 580.1500801326077, 583.7398131435893, 607.9270487541523, 621.4220774679592, 647.792706333978, 8386.958065209636, 8412.957935210285, 8430.494170349799, 8484.40609157353, 8493.575321233913, 614.1034090228317, 620.0760866309167, 624.2010226909563, 652.3150691773714, 665.6704931059156, 3677.558692956862, 3848.807559622008, 3905.1213476967455, 3987.0829709167056, 4052.0581053594456, 51553.48446515487, 51629.48370516322, 51976.740116299174, 52055.73972130115, 52112.739436302574, 47228.7638561805, 47826.760866195444, 47846.5215347849, 47874.76062619664, 48460.757696211294, 42578.78710606427, 43120.0, 43188.352174718035, 43231.567684322756, 43430.7828460862, 7589.6205189739185, 7619.834875359805, 7857.449978501679, 7880.0, 7906.920930790849, 31015.844920775253, 31109.68890311068, 31514.68485315209, 31568.0, 32092.358152836347, 38380.42429363506, 43218.35172472353, 43598.0, 43684.56315436932, 45254.54745452503, 10522.684319470429, 10622.681319560426, 10700.441450508615, 10823.783524329312, 11119.16606254518, 11425.60010399632, 11428.0, 11653.88346116528, 11851.822222666839, 12237.816432753694, 10771.246012779031, 10881.619143330263, 10927.235093543375, 10947.178961578073, 10970.506327215135, 10578.788424231627, 10606.893931060898, 10693.465326733787, 10918.617848375268, 11045.33727976324, 10731.463426828783, 11050.944745276543, 11100.056495197998, 11264.436778160894, 11418.200725949437, 8870.77823054403, 8922.598483068406, 8990.910090899008, 9357.953210234178, 9480.905190948002, 8712.168173410022, 9015.684451044182, 9298.349115562116, 9508.809823803624, 9782.9021709782], "unit": "score", "name": "yui.html", "value": 6175.954587778384}], "name": "dromaeo_css", "value": 6854.632405559415}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 104.0, 111.0, 111.0, 111.0, 123.0, 108.0, 110.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [163.0, 125.0, 155.0, 173.0, 130.0, 149.0, 151.0, 137.0, 169.0, 138.0], "unit": "score", "name": "audio-beat-detection", "value": 149.0}, {"lowerIsBetter": true, "replicates": [163.0, 165.0, 162.0, 163.0, 162.0, 161.0, 169.0, 168.0, 166.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.3}, {"lowerIsBetter": true, "replicates": [73.0, 77.0, 74.0, 74.0, 73.0, 129.0, 73.0, 76.0, 74.0, 77.0], "unit": "score", "name": "audio-fft", "value": 80.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 138.0, 96.0, 98.0, 98.0, 142.0, 97.0, 97.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 112.0, 109.0, 110.0, 110.0, 121.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 111.1}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 98.0, 97.0, 96.0, 97.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 61.0, 60.0, 60.0, 61.0, 64.0, 61.0, 76.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 62.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 69.0, 69.0, 71.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [81.0, 80.0, 84.0, 82.0, 83.0, 81.0, 82.0, 82.0, 81.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.8}, {"lowerIsBetter": true, "replicates": [119.0, 114.0, 123.0, 124.0, 116.0, 122.0, 121.0, 134.0, 120.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.3}, {"lowerIsBetter": true, "replicates": [132.0, 144.0, 145.0, 141.0, 142.0, 143.0, 142.0, 140.0, 147.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.7}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 68.0, 66.0, 67.0, 69.0, 66.0, 68.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1510.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.00265604249668], "unit": "score", "name": "Richards", "value": 212.659248}, {"lowerIsBetter": false, "replicates": [187.72292096865027], "unit": "score", "name": "DeltaBlue", "value": 352.210586}, {"lowerIsBetter": false, "replicates": [281.0567734682406], "unit": "score", "name": "Encrypt", "value": 947.0719979999998}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1068.3760683760684], "unit": "score", "name": "RayTrace", "value": 692.6297040000002}, {"lowerIsBetter": false, "replicates": [707.7140835102618], "unit": "score", "name": "Earley", "value": 941.7122190000003}, {"lowerIsBetter": false, "replicates": [12525.0], "unit": "score", "name": "Boyer", "value": 53.21061876247504}, {"lowerIsBetter": false, "replicates": [42224.489795918365], "unit": "score", "name": "RegExp", "value": 21.574801836636038}, {"lowerIsBetter": false, "replicates": [569.8005698005697], "unit": "score", "name": "Splay", "value": 143.016705}, {"lowerIsBetter": false, "replicates": [4887.804878048781], "unit": "score", "name": "NavierStokes", "value": 303.61277445109783}], "name": "v8_7", "value": 20396.829297608052}]} 02:12:17 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20396.83"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1510.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6854.63"}}} 02:12:17 INFO - Return code: 0 02:12:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:12:17 INFO - # TBPL SUCCESS # 02:12:17 INFO - Running post-action listener: _resource_record_post_action 02:12:17 INFO - Running post-run listener: _resource_record_post_run 02:12:18 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 4096; Write bytes: 559439872; Read time: 164; Write time: 500948 02:12:18 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 245882880; Read time: 0; Write time: 292240 02:12:18 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 313556992; Read time: 164; Write time: 208708 02:12:18 INFO - Running post-run listener: _upload_blobber_files 02:12:18 INFO - Blob upload gear active. 02:12:18 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:12:18 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 02:12:18 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 02:12:18 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 02:12:18 INFO - (blobuploader) - INFO - Open directory for files ... 02:12:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:12:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:12:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:12:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:12:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:12:19 INFO - (blobuploader) - INFO - Done attempting. 02:12:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:12:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:12:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:12:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:12:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:12:20 INFO - (blobuploader) - INFO - Done attempting. 02:12:20 INFO - (blobuploader) - INFO - Iteration through files over. 02:12:20 INFO - Return code: 0 02:12:20 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:12:20 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:12:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38741df7b31f20e717b729ce40f087445363793199d06c93ed5704c63d3ecfcc335c4150ead2fc7c5f0a7b839c6f2a73bd865178dcb2dfd4f71d808bf132ea97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8651c22dd99734f8102e4e3a25a920b0afd86a6b9b71eac1b265258ddca962a9b0bf6ca2af80a9c4056239393a56e3e226b44250c1faf35d97b1b5686d45d58b"} 02:12:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:12:20 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:12:20 INFO - Contents: 02:12:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38741df7b31f20e717b729ce40f087445363793199d06c93ed5704c63d3ecfcc335c4150ead2fc7c5f0a7b839c6f2a73bd865178dcb2dfd4f71d808bf132ea97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8651c22dd99734f8102e4e3a25a920b0afd86a6b9b71eac1b265258ddca962a9b0bf6ca2af80a9c4056239393a56e3e226b44250c1faf35d97b1b5686d45d58b"} 02:12:20 INFO - Running post-run listener: copy_logs_to_upload_dir 02:12:20 INFO - Copying logs to upload dir... 02:12:20 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 02:12:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.657481 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-01-21 02:12:20.220741) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 02:12:20.224598) ========= 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=41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880 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/Fx-Team/sha512/38741df7b31f20e717b729ce40f087445363793199d06c93ed5704c63d3ecfcc335c4150ead2fc7c5f0a7b839c6f2a73bd865178dcb2dfd4f71d808bf132ea97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8651c22dd99734f8102e4e3a25a920b0afd86a6b9b71eac1b265258ddca962a9b0bf6ca2af80a9c4056239393a56e3e226b44250c1faf35d97b1b5686d45d58b"} build_url:https://queue.taskcluster.net/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011325 build_url: 'https://queue.taskcluster.net/v1/task/P5MLnCNpRembb80MNzLoAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38741df7b31f20e717b729ce40f087445363793199d06c93ed5704c63d3ecfcc335c4150ead2fc7c5f0a7b839c6f2a73bd865178dcb2dfd4f71d808bf132ea97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8651c22dd99734f8102e4e3a25a920b0afd86a6b9b71eac1b265258ddca962a9b0bf6ca2af80a9c4056239393a56e3e226b44250c1faf35d97b1b5686d45d58b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 02:12:20.249978) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 02:12:20.250360) ========= 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=41bf3e9aed84707956354da8000001c5-1453368819.799728-2077892880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004711 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 02:12:20.336298) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 02:12:20.336665) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 02:12:20.336995) ========= ========= Total master_lag: 0.37 =========