builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-049 starttime: 1453295546.09 results: success (0) buildid: 20160120023022 builduid: 0cd011a8fcd24bc08a030ad62d0d9b99 revision: 329779bbecb2a050e10b66da3425ad0e685af9b3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 05:12:26.089742) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 05:12:26.090331) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 05:12:26.090735) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006305 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 05:12:26.118038) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 05:12:26.118346) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 05:12:26.139752) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:12:26.140082) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004643 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:12:26.192803) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 05:12:26.193119) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 05:12:26.193515) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:12:26.194161) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-20 05:12:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.0M=0s 2016-01-20 05:12:27 (84.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149214 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:12:26.357646) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:12:26.358170) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019384 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:12:26.408577) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:12:26.408985) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 329779bbecb2a050e10b66da3425ad0e685af9b3 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 329779bbecb2a050e10b66da3425ad0e685af9b3 --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=8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-20 05:12:27,205 truncating revision to first 12 chars 2016-01-20 05:12:27,205 Setting DEBUG logging. 2016-01-20 05:12:27,205 attempt 1/10 2016-01-20 05:12:27,205 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/329779bbecb2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-20 05:12:27,465 unpacking tar archive at: b2g-inbound-329779bbecb2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.566308 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:12:26.993198) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 05:12:26.993869) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004921 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 05:12:27.045789) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 05:12:27.046103) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 05:12:27.056913) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 05:12:27.057271) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 05:12:27.057774) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 44 secs) (at 2016-01-20 05:12:27.058120) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:12:27 INFO - MultiFileLogger online at 20160120 05:12:27 in /builds/slave/test-pgo 05:12:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 05:12:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:12:27 INFO - {'append_to_log': False, 05:12:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:12:27 INFO - 'blob_upload_branch': 'B2G-Inbound', 05:12:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:12:27 INFO - 'branch': 'B2G-Inbound', 05:12:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:12:27 INFO - 'config_files': ('talos/linux_config.py',), 05:12:27 INFO - 'default_actions': ('clobber', 05:12:27 INFO - 'read-buildbot-config', 05:12:27 INFO - 'download-and-extract', 05:12:27 INFO - 'populate-webroot', 05:12:27 INFO - 'create-virtualenv', 05:12:27 INFO - 'install', 05:12:27 INFO - 'run-tests'), 05:12:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:12:27 INFO - 'download_minidump_stackwalk': True, 05:12:27 INFO - 'download_symbols': 'ondemand', 05:12:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:12:27 INFO - 'tooltool.py': '/tools/tooltool.py', 05:12:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:12:27 INFO - '/tools/misc-python/virtualenv.py')}, 05:12:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:12:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:12:27 INFO - 'installer_path': 'installer.exe', 05:12:27 INFO - 'log_level': 'info', 05:12:27 INFO - 'log_name': 'talos', 05:12:27 INFO - 'log_to_console': True, 05:12:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:12:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:12:27 INFO - 'opt_config_files': (), 05:12:27 INFO - 'pip_index': False, 05:12:27 INFO - 'sps_profile': False, 05:12:27 INFO - 'sps_profile_interval': 0, 05:12:27 INFO - 'suite': 'dromaeojs', 05:12:27 INFO - 'system_bits': '32', 05:12:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:12:27 INFO - 'title': 'talos-linux64-ix-049', 05:12:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:12:27 INFO - 'use_talos_json': True, 05:12:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:12:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:12:27 INFO - 'work_dir': 'build'} 05:12:27 INFO - ##### 05:12:27 INFO - ##### Running clobber step. 05:12:27 INFO - ##### 05:12:27 INFO - Running pre-action listener: _resource_record_pre_action 05:12:27 INFO - Running main action method: clobber 05:12:27 INFO - rmtree: /builds/slave/test-pgo/build 05:12:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:12:28 INFO - Running post-action listener: _resource_record_post_action 05:12:28 INFO - ##### 05:12:28 INFO - ##### Running read-buildbot-config step. 05:12:28 INFO - ##### 05:12:28 INFO - Running pre-action listener: _resource_record_pre_action 05:12:28 INFO - Running main action method: read_buildbot_config 05:12:28 INFO - Using buildbot properties: 05:12:28 INFO - { 05:12:28 INFO - "project": "", 05:12:28 INFO - "product": "firefox", 05:12:28 INFO - "script_repo_revision": "production", 05:12:28 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 05:12:28 INFO - "repository": "", 05:12:28 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 05:12:28 INFO - "buildid": "20160120023022", 05:12:28 INFO - "pgo_build": "True", 05:12:28 INFO - "basedir": "/builds/slave/test-pgo", 05:12:28 INFO - "buildnumber": 1123, 05:12:28 INFO - "slavename": "talos-linux64-ix-049", 05:12:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:12:28 INFO - "platform": "ubuntu64_hw", 05:12:28 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 05:12:28 INFO - "branch": "b2g-inbound", 05:12:28 INFO - "repo_path": "integration/b2g-inbound", 05:12:28 INFO - "revision": "329779bbecb2a050e10b66da3425ad0e685af9b3", 05:12:28 INFO - "stage_platform": "linux64-pgo", 05:12:28 INFO - "builduid": "0cd011a8fcd24bc08a030ad62d0d9b99", 05:12:28 INFO - "slavebuilddir": "test" 05:12:28 INFO - } 05:12:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:12:28 INFO - Running post-action listener: _resource_record_post_action 05:12:28 INFO - ##### 05:12:28 INFO - ##### Running download-and-extract step. 05:12:28 INFO - ##### 05:12:28 INFO - Running pre-action listener: _resource_record_pre_action 05:12:28 INFO - Running main action method: download_and_extract 05:12:28 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:28 INFO - https://queue.taskcluster.net/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:12:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/test_packages.json 05:12:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/test_packages.json 05:12:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:12:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:12:28 WARNING - URL Error: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/test_packages.json 05:12:28 INFO - Running command: ['nslookup', 'queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com'] 05:12:28 INFO - Copy/paste: nslookup queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com 05:12:28 INFO - Server: 10.26.75.40 05:12:28 INFO - Address: 10.26.75.40#53 05:12:28 INFO - queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com canonical name = proxxy1.srv.releng.scl3.mozilla.com. 05:12:28 INFO - Name: proxxy1.srv.releng.scl3.mozilla.com 05:12:28 INFO - Address: 10.26.48.46 05:12:28 INFO - Return code: 0 05:12:28 INFO - retry: attempt #1 caught exception: 05:12:28 INFO - retry: Failed, sleeping 30 seconds before retrying 05:12:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #2 05:12:59 INFO - Downloaded 1448 bytes. 05:12:59 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:12:59 INFO - Using the following test package requirements: 05:12:59 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:12:59 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:12:59 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:12:59 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:59 INFO - u'jsshell-linux-x86_64.zip'], 05:12:59 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:12:59 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:12:59 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:12:59 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:12:59 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:12:59 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:12:59 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:12:59 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:12:59 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')]} 05:12:59 INFO - https://queue.taskcluster.net/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:12:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:12:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:12:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/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 05:12:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/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 05:13:00 INFO - Downloaded 22483577 bytes. 05:13:00 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'] 05:13:00 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 05:13:01 INFO - Return code: 0 05:13:01 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 05:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:01 INFO - https://queue.taskcluster.net/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:13:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:13:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:13:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/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 05:13:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/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 05:13:03 INFO - Downloaded 22483577 bytes. 05:13:03 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'] 05:13:03 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 05:13:04 INFO - Return code: 0 05:13: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')]} 05:13:04 INFO - https://queue.taskcluster.net/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:13:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:13:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:13:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/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 05:13:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/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 05:13:05 INFO - Downloaded 11132144 bytes. 05:13:05 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'] 05:13:05 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 05:13:05 INFO - Return code: 0 05:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:05 INFO - https://queue.taskcluster.net/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:13:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:13:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:13:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/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 05:13:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/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 05:13:07 INFO - Downloaded 55960246 bytes. 05:13:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:13:07 INFO - mkdir: /builds/slave/test-pgo/properties 05:13:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:13:07 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:13:07 INFO - Contents: 05:13:07 INFO - build_url:https://queue.taskcluster.net/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:13:07 INFO - Running post-action listener: _resource_record_post_action 05:13:07 INFO - Running post-action listener: set_extra_try_arguments 05:13:07 INFO - ##### 05:13:07 INFO - ##### Running populate-webroot step. 05:13:07 INFO - ##### 05:13:07 INFO - Running pre-action listener: _resource_record_pre_action 05:13:07 INFO - Running main action method: populate_webroot 05:13:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:13:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:13:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:13:07 INFO - '--tppagecycles', 05:13:07 INFO - '7'], 05:13:07 INFO - 'tests': ['tsvgm']}}, 05:13:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:13:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:13:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:13:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:13:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:13:07 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:13:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:13:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:07 INFO - 'talos_options': ['--e10s'], 05:13:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:13:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:07 INFO - 'tests': ['damp', 'tps']}, 05:13:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:07 INFO - 'talos_options': ['--e10s'], 05:13:07 INFO - 'tests': ['damp', 'tps']}, 05:13:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:13:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:13:07 INFO - 'other': {'tests': ['a11yr', 05:13:07 INFO - 'ts_paint', 05:13:07 INFO - 'tpaint', 05:13:07 INFO - 'sessionrestore', 05:13:07 INFO - 'sessionrestore_no_auto_restore']}, 05:13:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:13:07 INFO - 'tests': ['a11yr', 05:13:07 INFO - 'ts_paint', 05:13:07 INFO - 'tpaint', 05:13:07 INFO - 'sessionrestore', 05:13:07 INFO - 'sessionrestore_no_auto_restore']}, 05:13:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:13:07 INFO - 'tests': ['a11yr', 05:13:07 INFO - 'ts_paint', 05:13:07 INFO - 'tpaint', 05:13:07 INFO - 'sessionrestore', 05:13:07 INFO - 'sessionrestore_no_auto_restore']}, 05:13:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:13:07 INFO - 'tests': ['a11yr', 05:13:07 INFO - 'ts_paint', 05:13:07 INFO - 'tpaint', 05:13:07 INFO - 'sessionrestore', 05:13:07 INFO - 'sessionrestore_no_auto_restore']}, 05:13:07 INFO - 'other_l64': {'tests': ['a11yr', 05:13:07 INFO - 'ts_paint', 05:13:07 INFO - 'tpaint', 05:13:07 INFO - 'sessionrestore', 05:13:07 INFO - 'sessionrestore_no_auto_restore']}, 05:13:07 INFO - 'other_nol64': {'tests': ['a11yr', 05:13:07 INFO - 'ts_paint', 05:13:07 INFO - 'tpaint', 05:13:07 INFO - 'sessionrestore', 05:13:07 INFO - 'sessionrestore_no_auto_restore']}, 05:13:07 INFO - 'svgr': {'tests': ['tsvgx', 05:13:07 INFO - 'tsvgr_opacity', 05:13:07 INFO - 'tart', 05:13:07 INFO - 'tscrollx', 05:13:07 INFO - 'cart']}, 05:13:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:13:07 INFO - 'tests': ['tsvgx', 05:13:07 INFO - 'tsvgr_opacity', 05:13:07 INFO - 'tart', 05:13:07 INFO - 'tscrollx', 05:13:07 INFO - 'cart']}, 05:13:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:07 INFO - 'tests': ['tp5o']}, 05:13:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:07 INFO - 'talos_options': ['--e10s'], 05:13:07 INFO - 'tests': ['tp5o']}, 05:13:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:07 INFO - 'talos_options': ['--xperf_path', 05:13:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:13:07 INFO - 'tests': ['tp5n']}, 05:13:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:07 INFO - 'talos_options': ['--e10s', 05:13:07 INFO - '--xperf_path', 05:13:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:13:07 INFO - 'tests': ['tp5n']}}, 05:13:07 INFO - 'talos.zip': {'path': '', 05:13:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:13:07 INFO - Running post-action listener: _resource_record_post_action 05:13:07 INFO - ##### 05:13:07 INFO - ##### Running create-virtualenv step. 05:13:07 INFO - ##### 05:13:07 INFO - Running pre-action listener: _resource_record_pre_action 05:13:07 INFO - Running main action method: create_virtualenv 05:13:07 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:13:07 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 05:13:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:13:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:13:07 INFO - Using real prefix '/usr' 05:13:07 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:13:07 INFO - Installing distribute.............................................................................................................................................................................................done. 05:13:09 INFO - Installing pip.................done. 05:13:09 INFO - Return code: 0 05:13:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae45733f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24eb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257c840>, '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 0x24e96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e9b60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423', '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 05:13:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:13:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:13:09 INFO - Using env: {'DISPLAY': ':0', 05:13:09 INFO - 'HOME': '/home/cltbld', 05:13:09 INFO - 'LANG': 'en_US.UTF-8', 05:13:09 INFO - 'LANGUAGE': 'en_US:en', 05:13:09 INFO - 'LOGNAME': 'cltbld', 05:13:09 INFO - 'MAIL': '/var/mail/cltbld', 05:13:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:09 INFO - 'MOZ_NO_REMOTE': '1', 05:13:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:09 INFO - 'NO_EM_RESTART': '1', 05:13:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:13:09 INFO - 'PWD': '/builds/slave/test-pgo', 05:13:09 INFO - 'SHELL': '/bin/bash', 05:13:09 INFO - 'SHLVL': '1', 05:13:09 INFO - 'TERM': 'linux', 05:13:09 INFO - 'TMOUT': '86400', 05:13:09 INFO - 'USER': 'cltbld', 05:13:09 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423', 05:13:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:09 INFO - '_': '/tools/buildbot/bin/python'} 05:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:10 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 05:13:10 INFO - Cleaning up... 05:13:10 INFO - Return code: 0 05:13:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:13:10 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')]} 05:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:10 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')]} 05:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:10 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 0x7fae45733f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24eb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257c840>, '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 0x24e96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e9b60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423', '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 05:13:10 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 05:13:10 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 05:13:10 INFO - Using env: {'DISPLAY': ':0', 05:13:10 INFO - 'HOME': '/home/cltbld', 05:13:10 INFO - 'LANG': 'en_US.UTF-8', 05:13:10 INFO - 'LANGUAGE': 'en_US:en', 05:13:10 INFO - 'LOGNAME': 'cltbld', 05:13:10 INFO - 'MAIL': '/var/mail/cltbld', 05:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:10 INFO - 'MOZ_NO_REMOTE': '1', 05:13:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:10 INFO - 'NO_EM_RESTART': '1', 05:13:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:13:10 INFO - 'PWD': '/builds/slave/test-pgo', 05:13:10 INFO - 'SHELL': '/bin/bash', 05:13:10 INFO - 'SHLVL': '1', 05:13:10 INFO - 'TERM': 'linux', 05:13:10 INFO - 'TMOUT': '86400', 05:13:10 INFO - 'USER': 'cltbld', 05:13:10 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423', 05:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:10 INFO - '_': '/tools/buildbot/bin/python'} 05:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:10 INFO - Downloading/unpacking psutil>=0.7.1 05:13:10 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 05:13:10 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 05:13:10 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 05:13:10 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 05:13:10 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 05:13:10 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 05:13:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:13:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:13:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:13:21 INFO - Installing collected packages: psutil 05:13:21 INFO - Running setup.py install for psutil 05:13:21 INFO - building 'psutil._psutil_linux' extension 05:13:21 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 05:13:21 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 05:13:21 INFO - building 'psutil._psutil_posix' extension 05:13:21 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 05:13:21 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 05:13:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:13:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:13:21 INFO - Successfully installed psutil 05:13:21 INFO - Cleaning up... 05:13:21 INFO - Return code: 0 05:13:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fae45733f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24eb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257c840>, '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 0x24e96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e9b60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423', '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 05:13:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:13:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:13:21 INFO - Using env: {'DISPLAY': ':0', 05:13:21 INFO - 'HOME': '/home/cltbld', 05:13:21 INFO - 'LANG': 'en_US.UTF-8', 05:13:21 INFO - 'LANGUAGE': 'en_US:en', 05:13:21 INFO - 'LOGNAME': 'cltbld', 05:13:21 INFO - 'MAIL': '/var/mail/cltbld', 05:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:21 INFO - 'MOZ_NO_REMOTE': '1', 05:13:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:21 INFO - 'NO_EM_RESTART': '1', 05:13:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:13:21 INFO - 'PWD': '/builds/slave/test-pgo', 05:13:21 INFO - 'SHELL': '/bin/bash', 05:13:21 INFO - 'SHLVL': '1', 05:13:21 INFO - 'TERM': 'linux', 05:13:21 INFO - 'TMOUT': '86400', 05:13:21 INFO - 'USER': 'cltbld', 05:13:21 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423', 05:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:21 INFO - '_': '/tools/buildbot/bin/python'} 05:13:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:13:21 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 05:13:21 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 05:13:21 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 05:13:21 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 05:13:21 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 05:13:21 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 05:13:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:13:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:13:23 INFO - Installing collected packages: mozsystemmonitor 05:13:23 INFO - Running setup.py install for mozsystemmonitor 05:13:23 INFO - Successfully installed mozsystemmonitor 05:13:23 INFO - Cleaning up... 05:13:23 INFO - Return code: 0 05:13:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:13: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')]} 05:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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')]} 05:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:23 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 0x7fae45733f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24eb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257c840>, '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 0x24e96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e9b60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423', '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 05:13:23 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 05:13:23 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 05:13:23 INFO - Using env: {'DISPLAY': ':0', 05:13:23 INFO - 'HOME': '/home/cltbld', 05:13:23 INFO - 'LANG': 'en_US.UTF-8', 05:13:23 INFO - 'LANGUAGE': 'en_US:en', 05:13:23 INFO - 'LOGNAME': 'cltbld', 05:13:23 INFO - 'MAIL': '/var/mail/cltbld', 05:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:23 INFO - 'MOZ_NO_REMOTE': '1', 05:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:23 INFO - 'NO_EM_RESTART': '1', 05:13:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:13:23 INFO - 'PWD': '/builds/slave/test-pgo', 05:13:23 INFO - 'SHELL': '/bin/bash', 05:13:23 INFO - 'SHLVL': '1', 05:13:23 INFO - 'TERM': 'linux', 05:13:23 INFO - 'TMOUT': '86400', 05:13:23 INFO - 'USER': 'cltbld', 05:13:23 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423', 05:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:23 INFO - '_': '/tools/buildbot/bin/python'} 05:13:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:24 INFO - Downloading/unpacking blobuploader==1.2.4 05:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:25 INFO - Downloading blobuploader-1.2.4.tar.gz 05:13:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:13:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:13:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:26 INFO - Downloading docopt-0.6.1.tar.gz 05:13:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:13:26 INFO - Installing collected packages: blobuploader, requests, docopt 05:13:26 INFO - Running setup.py install for blobuploader 05:13:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:13:26 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:13:26 INFO - Running setup.py install for requests 05:13:27 INFO - Running setup.py install for docopt 05:13:27 INFO - Successfully installed blobuploader requests docopt 05:13:27 INFO - Cleaning up... 05:13:27 INFO - Return code: 0 05:13:27 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:13: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')]} 05:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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')]} 05:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:27 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 0x7fae45733f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24eb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257c840>, '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 0x24e96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e9b60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423', '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 05:13:27 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 05:13:27 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 05:13:27 INFO - Using env: {'DISPLAY': ':0', 05:13:27 INFO - 'HOME': '/home/cltbld', 05:13:27 INFO - 'LANG': 'en_US.UTF-8', 05:13:27 INFO - 'LANGUAGE': 'en_US:en', 05:13:27 INFO - 'LOGNAME': 'cltbld', 05:13:27 INFO - 'MAIL': '/var/mail/cltbld', 05:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:27 INFO - 'MOZ_NO_REMOTE': '1', 05:13:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:27 INFO - 'NO_EM_RESTART': '1', 05:13:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:13:27 INFO - 'PWD': '/builds/slave/test-pgo', 05:13:27 INFO - 'SHELL': '/bin/bash', 05:13:27 INFO - 'SHLVL': '1', 05:13:27 INFO - 'TERM': 'linux', 05:13:27 INFO - 'TMOUT': '86400', 05:13:27 INFO - 'USER': 'cltbld', 05:13:27 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423', 05:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:27 INFO - '_': '/tools/buildbot/bin/python'} 05:13:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:13:27 INFO - Running setup.py (path:/tmp/pip-B3UWDa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:13:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:13:27 INFO - Running setup.py (path:/tmp/pip-K_dqYI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:13:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:13:27 INFO - Running setup.py (path:/tmp/pip-Ze3ruK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:13:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:13:27 INFO - Running setup.py (path:/tmp/pip-6VGEZV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:13:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:13:27 INFO - Running setup.py (path:/tmp/pip-gd1YQ8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:13:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:13:27 INFO - Running setup.py (path:/tmp/pip-KYpZIS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:13:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:13:27 INFO - Running setup.py (path:/tmp/pip-vFECyy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:13:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:13:27 INFO - Running setup.py (path:/tmp/pip-4KxUcV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:13:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:13:28 INFO - Running setup.py (path:/tmp/pip-al05wO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:13:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:13:28 INFO - Running setup.py (path:/tmp/pip-7CS9kd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:13:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:13:28 INFO - Running setup.py (path:/tmp/pip-RFsJTT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:13:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:13:28 INFO - Running setup.py (path:/tmp/pip-zDdjwE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:13:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:13:28 INFO - Running setup.py (path:/tmp/pip-sb9xTQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:13:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:13:28 INFO - Running setup.py (path:/tmp/pip-TPC6ph-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:13:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:13:28 INFO - Running setup.py (path:/tmp/pip-MzHSXY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:13:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:13:28 INFO - Running setup.py (path:/tmp/pip-WhmCWU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:13:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:13:28 INFO - Running setup.py (path:/tmp/pip-955WLV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:13:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:13:28 INFO - Running setup.py install for manifestparser 05:13:28 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:13:28 INFO - Running setup.py install for mozcrash 05:13:28 INFO - Running setup.py install for mozdebug 05:13:28 INFO - Running setup.py install for mozdevice 05:13:29 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:13:29 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:13:29 INFO - Running setup.py install for mozfile 05:13:29 INFO - Running setup.py install for mozhttpd 05:13:29 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:13:29 INFO - Running setup.py install for mozinfo 05:13:29 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:13:29 INFO - Running setup.py install for mozInstall 05:13:29 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:13:29 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:13:29 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:13:29 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:13:29 INFO - Running setup.py install for mozleak 05:13:29 INFO - Running setup.py install for mozlog 05:13:29 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:13:29 INFO - Running setup.py install for moznetwork 05:13:29 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:13:29 INFO - Running setup.py install for mozprocess 05:13:29 INFO - Running setup.py install for mozprofile 05:13:29 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:13:29 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:13:29 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:13:30 INFO - Running setup.py install for mozrunner 05:13:30 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:13:30 INFO - Running setup.py install for mozscreenshot 05:13:30 INFO - Running setup.py install for moztest 05:13:30 INFO - Running setup.py install for mozversion 05:13:30 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:13:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:13:30 INFO - Cleaning up... 05:13:30 INFO - Return code: 0 05:13:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:13: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')]} 05:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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')]} 05:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:30 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 0x7fae45733f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24eb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257c840>, '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 0x24e96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e9b60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423', '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 05:13:30 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 05:13:30 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 05:13:30 INFO - Using env: {'DISPLAY': ':0', 05:13:30 INFO - 'HOME': '/home/cltbld', 05:13:30 INFO - 'LANG': 'en_US.UTF-8', 05:13:30 INFO - 'LANGUAGE': 'en_US:en', 05:13:30 INFO - 'LOGNAME': 'cltbld', 05:13:30 INFO - 'MAIL': '/var/mail/cltbld', 05:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:30 INFO - 'MOZ_NO_REMOTE': '1', 05:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:30 INFO - 'NO_EM_RESTART': '1', 05:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:13:30 INFO - 'PWD': '/builds/slave/test-pgo', 05:13:30 INFO - 'SHELL': '/bin/bash', 05:13:30 INFO - 'SHLVL': '1', 05:13:30 INFO - 'TERM': 'linux', 05:13:30 INFO - 'TMOUT': '86400', 05:13:30 INFO - 'USER': 'cltbld', 05:13:30 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423', 05:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:30 INFO - '_': '/tools/buildbot/bin/python'} 05:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:13:30 INFO - Running setup.py (path:/tmp/pip-e0yYmp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:13:30 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)) 05:13:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:13:30 INFO - Running setup.py (path:/tmp/pip-gzLcIN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:13:30 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)) 05:13:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:13:30 INFO - Running setup.py (path:/tmp/pip-24W88J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:13:30 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)) 05:13:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:13:30 INFO - Running setup.py (path:/tmp/pip-CP3Sa0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:13:30 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)) 05:13:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:13:30 INFO - Running setup.py (path:/tmp/pip-r4iItp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:13:31 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)) 05:13:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:13:31 INFO - Running setup.py (path:/tmp/pip-2iuYi8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:13:31 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)) 05:13:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:13:31 INFO - Running setup.py (path:/tmp/pip-IjGjQS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:13:31 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)) 05:13:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:13:31 INFO - Running setup.py (path:/tmp/pip-ACBES5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:13:31 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)) 05:13:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:13:31 INFO - Running setup.py (path:/tmp/pip-j6iWeq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:13:31 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)) 05:13:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:13:31 INFO - Running setup.py (path:/tmp/pip-l6Ci5L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:13:31 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)) 05:13:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:13:31 INFO - Running setup.py (path:/tmp/pip-9nHYZM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:13:31 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)) 05:13:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:13:31 INFO - Running setup.py (path:/tmp/pip-n20v_V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:13:31 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)) 05:13:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:13:31 INFO - Running setup.py (path:/tmp/pip-F4Rmca-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:13:31 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)) 05:13:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:13:31 INFO - Running setup.py (path:/tmp/pip-iskn61-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:13:31 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)) 05:13:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:13:31 INFO - Running setup.py (path:/tmp/pip-YuFVOG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:13:31 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)) 05:13:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:13:31 INFO - Running setup.py (path:/tmp/pip-CqipPl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:13:31 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)) 05:13:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:13:31 INFO - Running setup.py (path:/tmp/pip-aVPuSx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:13:31 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)) 05:13:31 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)) 05:13:31 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)) 05:13:31 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)) 05:13:31 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)) 05:13:31 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)) 05:13:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:33 INFO - Downloading blessings-1.5.1.tar.gz 05:13:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:13:33 INFO - Installing collected packages: blessings 05:13:33 INFO - Running setup.py install for blessings 05:13:33 INFO - Successfully installed blessings 05:13:33 INFO - Cleaning up... 05:13:33 INFO - Return code: 0 05:13:33 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:13:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:13:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:13:34 INFO - Reading from file tmpfile_stdout 05:13:34 INFO - Current package versions: 05:13:34 INFO - argparse == 1.2.1 05:13:34 INFO - blessings == 1.5.1 05:13:34 INFO - blobuploader == 1.2.4 05:13:34 INFO - docopt == 0.6.1 05:13:34 INFO - manifestparser == 1.1 05:13:34 INFO - mozInstall == 1.12 05:13:34 INFO - mozcrash == 0.16 05:13:34 INFO - mozdebug == 0.1 05:13:34 INFO - mozdevice == 0.48 05:13:34 INFO - mozfile == 1.2 05:13:34 INFO - mozhttpd == 0.7 05:13:34 INFO - mozinfo == 0.9 05:13:34 INFO - mozleak == 0.1 05:13:34 INFO - mozlog == 3.1 05:13:34 INFO - moznetwork == 0.27 05:13:34 INFO - mozprocess == 0.22 05:13:34 INFO - mozprofile == 0.28 05:13:34 INFO - mozrunner == 6.11 05:13:34 INFO - mozscreenshot == 0.1 05:13:34 INFO - mozsystemmonitor == 0.0 05:13:34 INFO - moztest == 0.7 05:13:34 INFO - mozversion == 1.4 05:13:34 INFO - psutil == 3.1.1 05:13:34 INFO - requests == 1.2.3 05:13:34 INFO - wsgiref == 0.1.2 05:13:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:34 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 0x7fae45733f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24eb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257c840>, '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 0x24e96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e9b60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423', '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 05:13:34 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 05:13:34 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 05:13:34 INFO - Using env: {'DISPLAY': ':0', 05:13:34 INFO - 'HOME': '/home/cltbld', 05:13:34 INFO - 'LANG': 'en_US.UTF-8', 05:13:34 INFO - 'LANGUAGE': 'en_US:en', 05:13:34 INFO - 'LOGNAME': 'cltbld', 05:13:34 INFO - 'MAIL': '/var/mail/cltbld', 05:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:34 INFO - 'MOZ_NO_REMOTE': '1', 05:13:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:34 INFO - 'NO_EM_RESTART': '1', 05:13:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:13:34 INFO - 'PWD': '/builds/slave/test-pgo', 05:13:34 INFO - 'SHELL': '/bin/bash', 05:13:34 INFO - 'SHLVL': '1', 05:13:34 INFO - 'TERM': 'linux', 05:13:34 INFO - 'TMOUT': '86400', 05:13:34 INFO - 'USER': 'cltbld', 05:13:34 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423', 05:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:34 INFO - '_': '/tools/buildbot/bin/python'} 05:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:34 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)) 05:13:34 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)) 05:13:34 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)) 05:13:34 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)) 05:13:34 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)) 05:13:34 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)) 05:13:34 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)) 05:13:34 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)) 05:13:34 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)) 05:13:34 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)) 05:13:34 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)) 05:13:34 INFO - Cleaning up... 05:13:34 INFO - Return code: 0 05:13:34 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae45733f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24eb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257c840>, '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 0x24e96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e9b60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423', '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 05:13:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:13:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:13:34 INFO - Using env: {'DISPLAY': ':0', 05:13:34 INFO - 'HOME': '/home/cltbld', 05:13:34 INFO - 'LANG': 'en_US.UTF-8', 05:13:34 INFO - 'LANGUAGE': 'en_US:en', 05:13:34 INFO - 'LOGNAME': 'cltbld', 05:13:34 INFO - 'MAIL': '/var/mail/cltbld', 05:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:34 INFO - 'MOZ_NO_REMOTE': '1', 05:13:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:34 INFO - 'NO_EM_RESTART': '1', 05:13:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:13:34 INFO - 'PWD': '/builds/slave/test-pgo', 05:13:34 INFO - 'SHELL': '/bin/bash', 05:13:34 INFO - 'SHLVL': '1', 05:13:34 INFO - 'TERM': 'linux', 05:13:34 INFO - 'TMOUT': '86400', 05:13:34 INFO - 'USER': 'cltbld', 05:13:34 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423', 05:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:34 INFO - '_': '/tools/buildbot/bin/python'} 05:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:34 INFO - Downloading/unpacking jsonschema 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:13:36 INFO - Downloading/unpacking functools32 (from jsonschema) 05:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:36 INFO - Downloading functools32-3.2.3-2.tar.gz 05:13:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:13:36 INFO - warning: no files found matching '*.txt' 05:13:36 INFO - no previously-included directories found matching 'build' 05:13:36 INFO - no previously-included directories found matching 'dist' 05:13:36 INFO - no previously-included directories found matching '.git*' 05:13:36 INFO - Installing collected packages: jsonschema, functools32 05:13:36 INFO - Running setup.py install for functools32 05:13:36 INFO - warning: no files found matching '*.txt' 05:13:36 INFO - no previously-included directories found matching 'build' 05:13:36 INFO - no previously-included directories found matching 'dist' 05:13:36 INFO - no previously-included directories found matching '.git*' 05:13:36 INFO - Successfully installed jsonschema functools32 05:13:36 INFO - Cleaning up... 05:13:36 INFO - Return code: 0 05:13:36 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae45733f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24eb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257c840>, '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 0x24e96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e9b60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423', '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 05:13:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:13:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:13:36 INFO - Using env: {'DISPLAY': ':0', 05:13:36 INFO - 'HOME': '/home/cltbld', 05:13:36 INFO - 'LANG': 'en_US.UTF-8', 05:13:36 INFO - 'LANGUAGE': 'en_US:en', 05:13:36 INFO - 'LOGNAME': 'cltbld', 05:13:36 INFO - 'MAIL': '/var/mail/cltbld', 05:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:36 INFO - 'MOZ_NO_REMOTE': '1', 05:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:36 INFO - 'NO_EM_RESTART': '1', 05:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:13:36 INFO - 'PWD': '/builds/slave/test-pgo', 05:13:36 INFO - 'SHELL': '/bin/bash', 05:13:36 INFO - 'SHLVL': '1', 05:13:36 INFO - 'TERM': 'linux', 05:13:36 INFO - 'TMOUT': '86400', 05:13:36 INFO - 'USER': 'cltbld', 05:13:36 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423', 05:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:36 INFO - '_': '/tools/buildbot/bin/python'} 05:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:36 INFO - Downloading/unpacking flake8 05:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:13:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:13:38 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 05:13:38 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 05:13:38 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 05:13:38 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 05:13:38 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 05:13:38 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 05:13:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:13:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:13:38 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 05:13:38 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 05:13:38 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 05:13:38 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 05:13:38 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 05:13:38 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 05:13:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:13:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:13:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:13:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:13:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:13:39 INFO - no previously-included directories found matching 'docs/_build' 05:13:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:13:39 INFO - Running setup.py install for pep8 05:13:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:13:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:13:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:13:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:13:39 INFO - no previously-included directories found matching 'docs/_build' 05:13:39 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:13:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:13:39 INFO - Cleaning up... 05:13:39 INFO - Return code: 0 05:13:39 INFO - Running post-action listener: _resource_record_post_action 05:13:39 INFO - Running post-action listener: _start_resource_monitoring 05:13:40 INFO - Starting resource monitoring. 05:13:40 INFO - ##### 05:13:40 INFO - ##### Running install step. 05:13:40 INFO - ##### 05:13:40 INFO - Running pre-action listener: _resource_record_pre_action 05:13:40 INFO - Running main action method: install 05:13:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:13:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:13:40 INFO - Reading from file tmpfile_stdout 05:13:40 INFO - Detecting whether we're running mozinstall >=1.0... 05:13:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:13:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:13:40 INFO - Reading from file tmpfile_stdout 05:13:40 INFO - Output received: 05:13:40 INFO - Usage: mozinstall [options] installer 05:13:40 INFO - Options: 05:13:40 INFO - -h, --help show this help message and exit 05:13:40 INFO - -d DEST, --destination=DEST 05:13:40 INFO - Directory to install application into. [default: 05:13:40 INFO - "/builds/slave/test-pgo"] 05:13:40 INFO - --app=APP Application being installed. [default: firefox] 05:13:40 INFO - mkdir: /builds/slave/test-pgo/build/application 05:13:40 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'] 05:13:40 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 05:13:56 INFO - Reading from file tmpfile_stdout 05:13:56 INFO - Output received: 05:13:56 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:13:56 INFO - Running post-action listener: _resource_record_post_action 05:13:56 INFO - ##### 05:13:56 INFO - ##### Running run-tests step. 05:13:56 INFO - ##### 05:13:56 INFO - Running pre-action listener: _resource_record_pre_action 05:13:56 INFO - Running main action method: run_tests 05:13:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:13:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:13:56 INFO - Python 2.7.3 05:13:56 INFO - Return code: 0 05:13:56 INFO - grabbing minidump binary from tooltool 05:13:56 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')]} 05:13:56 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 0x257c840>, '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 0x24e96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e9b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:13:56 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 05:13:56 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 05:13:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:13:56 INFO - Return code: 0 05:13:56 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:13:56 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:13:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:13:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:13:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:13:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:13:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:13:57 INFO - Return code: 0 05:13:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 05:13:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 05:13:57 INFO - Using env: {'DISPLAY': ':0', 05:13:57 INFO - 'HOME': '/home/cltbld', 05:13:57 INFO - 'LANG': 'en_US.UTF-8', 05:13:57 INFO - 'LANGUAGE': 'en_US:en', 05:13:57 INFO - 'LOGNAME': 'cltbld', 05:13:57 INFO - 'MAIL': '/var/mail/cltbld', 05:13:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:13:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:57 INFO - 'MOZ_NO_REMOTE': '1', 05:13:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:13:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:57 INFO - 'NO_EM_RESTART': '1', 05:13:57 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:13:57 INFO - 'PWD': '/builds/slave/test-pgo', 05:13:57 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:13:57 INFO - 'SHELL': '/bin/bash', 05:13:57 INFO - 'SHLVL': '1', 05:13:57 INFO - 'TERM': 'linux', 05:13:57 INFO - 'TMOUT': '86400', 05:13:57 INFO - 'USER': 'cltbld', 05:13:57 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423', 05:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:57 INFO - '_': '/tools/buildbot/bin/python'} 05:13:57 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:13:57 INFO - mozversion application_buildid: 20160120023022 05:13:57 INFO - mozversion application_changeset: 329779bbecb2a050e10b66da3425ad0e685af9b3 05:13:57 INFO - mozversion application_display_name: Nightly 05:13:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:13:57 INFO - mozversion application_name: Firefox 05:13:57 INFO - mozversion application_remotingname: firefox 05:13:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 05:13:57 INFO - mozversion application_vendor: Mozilla 05:13:57 INFO - mozversion application_version: 46.0a1 05:13:57 INFO - mozversion platform_buildid: 20160120023022 05:13:57 INFO - mozversion platform_changeset: 329779bbecb2a050e10b66da3425ad0e685af9b3 05:13:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 05:13:57 INFO - mozversion platform_version: 46.0a1 05:13:57 INFO - using testdate: 1453295637 05:13:57 INFO - actual date: 1453295637 05:13:57 INFO - starting webserver on 'localhost:49694' 05:13:57 INFO - SUITE-START | Running 3 tests 05:13:57 INFO - TEST-START | dromaeo_css 05:13:57 INFO - operating with platform_type : linux_ 05:13:57 INFO - Initialising browser for dromaeo_css test... 05:13:57 INFO - TEST-INFO | started process 3584 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3q1S2n/profile http://localhost:49694/getInfo.html) 05:14:01 INFO - PROCESS | 3584 | __metrics Screen width/height:1600/1200 05:14:01 INFO - PROCESS | 3584 | colorDepth:24 05:14:01 INFO - PROCESS | 3584 | Browser inner width/height: 1024/697 05:14:01 INFO - PROCESS | 3584 | __metrics 05:14:01 INFO - PROCESS | 3584 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:14:01 INFO - PROCESS | 3584 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:14:02 INFO - TEST-INFO | 3584: exit 0 05:14:02 INFO - Browser initialized. 05:14:02 INFO - Running cycle 1/1 for dromaeo_css test... 05:14:02 INFO - TEST-INFO | started process 3676 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3q1S2n/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:14:14 INFO - PROCESS | 3676 | RSS: Main: 148635648 05:14:14 INFO - PROCESS | 3676 | 05:15:05 INFO - PROCESS | 3676 | 1453295705156 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] 05:17:14 INFO - PROCESS | 3676 | Cycle 1(1): loaded http://localhost:49694/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49694/tests/dromaeo/cssquery-ext.html) 05:17:15 INFO - PROCESS | 3676 | RSS: Main: 232615936 05:17:15 INFO - PROCESS | 3676 | 05:20:17 INFO - PROCESS | 3676 | Cycle 1(1): loaded http://localhost:49694/tests/dromaeo/cssquery-ext.html (next: http://localhost:49694/tests/dromaeo/cssquery-jquery.html) 05:20:17 INFO - PROCESS | 3676 | RSS: Main: 228749312 05:20:17 INFO - PROCESS | 3676 | 05:23:19 INFO - PROCESS | 3676 | Cycle 1(1): loaded http://localhost:49694/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49694/tests/dromaeo/cssquery-mootools.html) 05:23:20 INFO - PROCESS | 3676 | RSS: Main: 230359040 05:23:20 INFO - PROCESS | 3676 | 05:26:22 INFO - PROCESS | 3676 | Cycle 1(1): loaded http://localhost:49694/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49694/tests/dromaeo/cssquery-prototype.html) 05:26:22 INFO - PROCESS | 3676 | RSS: Main: 215773184 05:26:22 INFO - PROCESS | 3676 | 05:29:25 INFO - PROCESS | 3676 | Cycle 1(1): loaded http://localhost:49694/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49694/tests/dromaeo/cssquery-yui.html) 05:29:26 INFO - PROCESS | 3676 | RSS: Main: 215056384 05:29:26 INFO - PROCESS | 3676 | 05:32:28 INFO - PROCESS | 3676 | Cycle 1(1): loaded http://localhost:49694/tests/dromaeo/cssquery-yui.html (next: http://localhost:49694/tests/dromaeo/cssquery-dojo.html) 05:32:29 INFO - PROCESS | 3676 | RSS: Main: 276963328 05:32:29 INFO - PROCESS | 3676 | 05:32:29 INFO - PROCESS | 3676 | __start_tp_report 05:32:29 INFO - PROCESS | 3676 | _x_x_mozilla_page_load 05:32:29 INFO - PROCESS | 3676 | _x_x_mozilla_page_load_details 05:32:29 INFO - PROCESS | 3676 | |i|pagename|runs| 05:32:29 INFO - PROCESS | 3676 | |0;dojo.html;3145.795523290986;3188.76084293678;3247.0745837436334;3248.187953011747;3280.1635582926356;5117.641765076446;5195.298634684316;5217.373915130181;5225.608079394042;5287.709175995319;5268.47315268473;5284.4187139414635;5306;5306.442823503535;5321.547668448186;4760.309755085511;4776.665633405663;4780.80876764929;4844.346013288196;4865.659403841715;4845.103655823684;4856.854294371157;4877.780499877514;4908.386451693538;4921.753912304388;4589.449266088074;4683.7892294846815;4755.952440475586;4802.471728109905;4808.543188397097;4687.789049492781;4697.224957881946;4702.929456058162;4709.505501922283;4722;4683.157031734287;4705.1765940960195;4708.411448568929;4709.387779588632;4730.5032971538185;5036.7733451994745;5054.140796064641;5104.310918026056;5138.126518491866;5183.50756678115;5638.182463542805;5640.323161220639;5640.971795141039;5645.633033852787;5652.095664693629;5596.916046259309;5644.491995720405;5686.431356864322;5691.9146212806845;5694.202811606378;5250.921236181461;5257.395399529065;5260.447652996419;5281.471852814688;5304.151335786256;5707.543396528268;5708.029634962067;5710.857228569319;5722.37053924068;5767.250257466587;5466.590005749585;5487.067198576252;5487.176923461513;5488.670679759148;5500.477454641803;5597.076482380362;5612.579056570774;5648.209250704905;5652.886942261214;5684.232628595087;5563.276774019351;5568.49883510486;5573.164025396223;5574.749136288877;5574.832755017356;5498.1752737089755;5498.230247765316;5554.694491802989;5560.332760068818;5567.749451274703;4342.891427714332;4362.0185458271635;4363.040131171138;4401.625861801719;4402.207602631557;3915.5105611798526;3919.8432062717743;3926.862559810393;3932.8820135395986;3956.228535435562;5108.182690769459;5187.118189907725;5189.818356357585;5250.317458730417;5296.364436267672;5621.775128994795;5628.521575666033;5642.492175704207;5643.604947653707;5659.207710920392;5264.763085661154;5270.92093618596;5270.92093618596;5271.262023316739;5282.049231138355;4769.332293478916;4783.186858234039;4836.758162091881;4855.393075865517;4861.756912154378;5802.042662960649;5841.269841269841;5847.444492773095;5852.473277405054;5858.882822343615;5605.1872478491205;5617.382087970402;5619.438056194512;5622.409646987007;5626.465485778845;5733.713314334183;5790.94209057904;5825.76696932118;5828.970855145867;5922.082077278029;5498.835034948958;5509.834704958857;5516.310461192351;5516.420775818481;5523.309586301712;5502.972485137549;5564.38791732901;5568.860778480571;5569.164625306236;5613.298337707786;5371.973140134274;5414;5450.264214331015;5478.780848766005;5507.256520369699;5326.09456392422;5392.838214853561;5394.730263486888;5400.702961337164;5415.241866138665;5239.842804715865;5316.494932981361;5326;5327.840164795062;5362.812301569426;5407.891842163213;5427.755750991294;5488.4785945335125;5544.75048622821;5564.248826408383;5322.387925388475;5324.068288049499;5324.6006549508165;5327.0411325961695;5327.653702509325 05:32:29 INFO - PROCESS | 3676 | |1;ext.html;512.6539585779598;517.6842126302954;518.277003580006;552.4779083765843;561.6237121128842;28403;35792.642073579256;36456.81771591141;36502.45246321307;36503.4524482133;38783.80608096955;39233.41149882747;39356.60643393565;39366;39415.21169576614;8373.371997100227;8578.82842343156;8609.354298427612;8642.092580279075;8649.567521623894;8291.419600627958;8409.201125893062;8415.621297041616;8422.873656895152;8581.613827377752;8541.701040463586;8556.101609331025;8564.657413703444;8581.785455363635;8629.180227878342;8445.704400345989;8531.232189102948;8532.402731808776;8554;8559;8583.742487725378;8637;8702.521361325125;8730.126987301282;8731.519766412845;38886.22227555461;39212.803935980424;39316;39339.60660393417;39385.80307098475;3167.635721891989;3180.6024246969127;3350.983245083759;3376.4597664373828;3379.8648054078053;29069.563956540667;29199.124026279245;29870.402591948256;29940.850295748383;30040.098797036124;3926.607339266079;3979.0848104935735;4006.819693113817;4035.0517628357607;4105.062444468838;187574;188339;188365.11634883613;188408;188574;55963;56159;56358.15462768062;56393.154102688495;56402.71798640981;59188;59454.108188377206;59486;59554.10668839971;59638.70180649069;14246.14523128595;14583.125012499284;14590.854091459161;14607.853921460863;14612.415503379958;10875.401852898167;11055.613053543088;11058;11089.667309980714;11120.610778622871;17893.7315940261;18807.15367808452;18946.810531894782;19078.61842763165;19121;6446.903296450557;7178.102737157856;7610.429217808576;7610.733624323122;7645.655945482466;870.1081391573688;927.8932922713974;991.2565575818137;1005.5977608956476;1028.7068185567227;28381.574276385873;29104.27239319034;29215.707842921725;29929;30088.24779380489;1007.1942446043137;1059.5391004912733;1104.1222228328497;1114.8606424196976;1126.853509043819;13659.009479454631;13801.723965520634;13822.100380007712;13977.86022139786;14050.929745351208;246129;289943;295123;317603;319498;43083.13833723308;43224;43678.56321436745;43795.78102109469;43851;1180.6458062581191;1324.7549203397402;1328.0902581731546;1330.7138965122545;1357.3281225793296;22303;25421.26210324145;27730.722692773623;28177.43645127127;28245.29386765265;47391.52608474009;47799;47804.52195478001;47804.7609761949;47841;192069;193691;193943;194164;194365;28562;28623;28648.856755716923;28896.133116006553;29013.274668133465;38153.427698585096;39301.41047884227;39570;40114.39828402518;42099.57900421079;34037;35450.82274588611;36216.456753148195;36419.45370819387;37033.62966370302;31995.520067198544;32558.83720581382;32814;33936.28509719266;36842.8157859209;33673.831630842666;34312.828435857664;34485.31029379348;34707.65292347044;34739.305213896085;30045.849770751007;31622.683773161974;31971.200719982186;32034.19914502156;32064.679353207102;24664.753352466247;24741.87629061915;25055.74944250534;25107.748922511273;25300.746992530574 05:32:29 INFO - PROCESS | 3676 | |2;jquery.html;366.5528055771958;367.9576848662403;370.3038288018525;371.233403022758;379.93920972644383;13628.591142265723;13728.794068088986;15465.226738663065;16253.512394628166;16979.235934382952;15584.68830623387;15786.763198552031;16036.59908502288;16358.263878125483;16416.343346266163;5172.456892026349;5353.464653534635;5361.51746342829;5362.2224777407255;5368.194770784375;3920.5491368492703;4058.4521089652812;5286.577073834084;5330.840074797762;5559.11054231323;5724.914126288109;5857.502112320458;5864.266966629171;5867.4719275265215;5873.588848780587;5673.290838645169;5766.135079738031;5776.537876969854;5785.942140578582;5788.160716696077;4934.950650493485;5119.6160287978555;5119.897602047976;5141.280220769096;5143.434222235588;19414;19557.511062223417;19663.508412289662;19755.703664445045;19778;2220.0675716199075;2222.833287503444;2376.8930398132125;2405.6992875890514;2545.300042488312;12394.380280986004;12439.129260951737;12615.936920315431;12706;12770.616881493477;1692.9068901210428;1766.7968183658786;1826.8447181989548;1837.6508463391913;1844.815518448158;51912.48087519114;53467.46532534664;53592.73203633957;53874.46125538773;54205;9440.150386465113;9602.66390676323;9794.608215671436;9800.852987205197;9896.950515247378;12887.871121288666;12949.417276222404;12969.935150324189;12978.805317920238;12979.35103244834;7292;7311.780646580611;7375.041244638162;7395.889061664079;7445.627718614048;6743.494237932175;6785;6796.082528858639;6860.862782744317;7065.046218760504;5728.79949201776;5886.381929897385;5890.4993075589055;5918.585699001114;5947.078202878561;1646.415522489523;1729.5589624645886;1740.5474576610172;1776.3693888669336;1801.8108098649716;951.7192428233687;997.486294558303;1004.2977153724513;1032.2206733915996;1067.9679609611724;10887.733679895999;11041.619797525309;11074.889251107386;16290.348386064425;17052.914735426242;444.5376808119584;445.4876891574715;453.90921815637006;460.3715927758652;478.66254290724953;5057.367829021372;5924.407559244041;6004.279486461653;6040.818775436744;6293.496520278367;402618;402744;407564;563588;572747;53338.466615334124;68478.65760671264;71955.64022179856;72632.63683681548;74122.62938685271;469.7064334790756;476.7235003697847;478.72473327836633;479.0323546436249;483.1183090859196;10153.593856245667;13952.16287022782;14775.187364695044;15048.398064077313;15048.699026019638;26664.933402663675;31089;32250;32252.35495290128;33803.66196338005;38533;38628.806855966664;38858.6114138855;39050.2189956205;40370.394444082776;7233;7517.398608111447;7585.658645360862;7615.504992175491;7644.579548124684;10045.949770251102;10916.235863489479;11187.440627968732;11228.326300422;11409.828852567052;9557.90442095598;9732.513374331114;9795.755106122118;9880.950595246977;9904.50477476109;9332.860007099764;9480.762980925532;9658.613655453984;9817.116459518678;9978.600855965971;9564.808703826024;9913.008699130029;10033.09702126812;10169.288149829441;10204.846927296245;7457.440691948234;7491.213422590768;7531;7646.65590048438;7657.923420765721;9412.529373531434;9657.517124143906;9702.6118955241;9702.805943881223;9729.367591106555 05:32:29 INFO - PROCESS | 3676 | |3;mootools.html;1314.231174762765;1465.5530063330684;1477.3351991603777;1629.5518732348603;1790.588164722113;6963.860722785541;7671.0794704635455;7838.490498117619;7850.96074519628;7873.448858579902;7725.768226953186;7915.643796029178;7932.286094251531;7933.682652693886;7934.365250779938;2043.8875861827594;2088.6136064828056;2091.7489901211798;2319.223060274806;2343.8945247463903;2298.609236429811;2348.1898744933055;2351.5179388225374;2353.9176128835493;2357.49313897512;2300.217925905192;2307.3424074138875;2312.1213938703268;2372.738998710149;2374.6438034294906;2288.645259984705;2288.771122887698;2291.5531471363174;2296.8392212545127;2368.7631236876346;2316.073570571768;2324.651302304651;2325.5581439526436;2337.9181728639414;2345.906163753448;7849.372050235967;7893.526388416656;7903.604819758989;7906.090799558067;7912.09010963735;4908.680935739166;4998.200287953946;5000.174971129759;5040.319556859814;5044.747762611854;2914.693957134513;2933.6772954974936;2951.453981013498;2972.390659914712;3073.9538906916414;913.4199783137689;922.4004397141845;924.8474001789697;946.668665966913;948.7817801905601;11007.889921100767;11011.119110471143;11017.338959662366;11038.834417483744;11059.391733454657;4412.4043254160915;4438.423005009328;4509.571590698878;4513.255312873339;4517.390152329459;9286.535673216313;9350.532473376305;9355.345125841262;9389.671361502315;9399.57701903416;4947.727874966839;4980.601551875841;4987.600991920638;4995;4995.0259699359;4495.617872480811;4505.909881802346;4509.323601459741;4510.977445112753;4519.706219095749;3509.578850537952;3630.3465376232;3771.5097037384962;3782.167923056923;3921.686265098785;1178;1180.262336039975;1206.4691535724253;1220.023980815362;1239.3493415956696;1301.9739605207842;1302.3813688498078;1302.5115581656878;1302.8697130286896;1327.2965328375976;7212.891806622905;7353.852922941511;7416.184219735825;7416.888746668804;7429.21993190718;1108.467935391017;1137.5108703257513;1140.766142940695;1148.104478506766;1154.272808130889;5691.203231547586;5792.82621521355;5847.152162936351;5848.181254624356;5854.912176317359;9066.410683305565;9181.954090229507;9345.766355841159;9391.859122113174;9433.952830235805;9328.813423731623;9356.766080848034;9374.85937710935;9378.202852757455;9382.671606493877;7195.640217989079;7218.6390680465765;7454.1800401956825;7461.1419686735635;7466.066741657293;7333.523320984119;7396.593187374746;7412.592307423143;7416;7423.517471364344;8110.5944702763445;8197.098319185005;8412.537310447984;8449.535275559903;8582;8263.00843898736;8422.073571907207;8474.915250847413;8646.654133834827;8660.307175426076;6945.513814032969;7029.402500787491;7070.964645176741;7080.433565314659;7082.5396349237135;6795.694193761194;6961.965190174219;7082.327178917994;7238.203797582157;7370.44721645868;6851.383375496229;7022.894656580258;7052.18899826506;7063.894041589483;7169.247229040876;6771.93228067713;6920.273371295942;6939.618320992394;6949.861002780017;7095.184053833668;6712.194536655633;6745.156855393076;6765.86468270622;6773.356531129535;6785;6369.554131210771;6374.58565193261;6377.87244255103;6385.169927909342;6393.073004414241;6390.169277993831;6422.775202867877;6441.259255185713;6456.7740129095255;6457.6771161442675 05:32:29 INFO - PROCESS | 3676 | |4;prototype.html;332.77372880933757;339.91841957930086;344.72249838879725;344.9620541740408;349.22646338360545;5676.063449530833;5762.740676669549;5800.15897694834;5857.502112320447;5877.970610146948;5581;5665.971670141654;5670.319561652597;5689.061304884699;5709.514691251248;4424.070945101533;4430.822767089328;4445.711028783135;4460.509343972152;4466.464024317086;4238.131183107471;4338.414314067592;4345.261305578059;4347.956520434803;4449.399331090293;4335.6748243881675;4436.401085853417;4439.75581343026;4442.622377097934;4453.955460445386;4417.469903611587;4421.182081314967;4425.712328698656;4426.911461770746;4438.866833994985;3913.256481268578;3937.1928754605237;3938.3107956107565;3944.191440754667;3944.6390995106644;5402.216678581623;5508.504234618864;5520.91718624221;5523.199136125239;5542.168674698827;5163.070647283487;5163.845084647466;5164.122099243138;5172.043172013189;5173.508516690908;6066.757329706807;6071.089336599502;6077.544184186204;6078.513718902477;6082.209312789353;4129.97935010323;4234.703570750049;4269.7224680395675;4350.8912277193;4359.978200109011;6302.527310451688;6325.114483972247;6325.5255855811;6335.524835637391;6345.96827015862;4453.554644535585;4459.063596644676;4459.264221403432;4463.5313292103865;4464.285714285698;4425.977870110629;4450.755208463565;4495.865124046284;4495.9325610115875;4497.257952437811;5142;5151.5106064923775;5152.742362881841;5154.458781827929;5155.381354237516;6099.878002439927;6101.481374083164;6116.571839971249;6120.724567394478;6121.938780612226;1579.3287852662572;1592.2516417283857;1593.4661888267328;1593.8087429508532;1596.0822527046994;1087.1628845788698;1096.2874131814385;1096.6785024046005;1098.2751384086464;1122.2761318949395;5813.12803079533;5830.679312637761;5832.62087964281;5841.2990441146485;5845.357010728816;6256.092866534327;6310.495160387158;6330.39861213184;6333.334999825044;6352.301246862841;5787.88424231513;5806.88386232273;5811.128330750421;5823.4467725566;5856.209411729447;3282.638909719929;3378.847951842173;3380.8478618462227;3386.6782655647676;3393.457046872538;6440.903386449207;6449.806505804833;6450.48396128318;6451.870962580722;6456.063870738717;6391.96804015977;6397.776077837253;6402.9359706403275;6404.327545607644;6405.807825765234;6361;6514.837129071811;6517.8696426072165;6520.0871877937125;6527.445167160749;6088.665123418255;6251.124842521959;6255.843603909757;6261.65560894137;6263.749450021948;6128.66292353907;6175.96912015437;6257.374262573706;6265.592736472115;6270.686465676789;6543.574667646588;6573.04690819838;6582.572132811543;6583.572067815577;6588.374104460068;4425.070735145656;4427.734335939854;4430.158269928703;4431.113777244628;4437.9334309986025;6190.721417536131;6351.523635727432;6375.043743438521;6381.649009304533;6384.106225128393;6115.7247923844425;6139.386061393825;6140.785072522441;6144.969275153596;6154.661493617894;6105.389461053859;6105.504151482737;6114.510839132769;6117;6122.326544080059;5905.173275741486;6040.637561746309;6045.78839740607;6046;6048.667323297261;6123.4488895999575;6155.569110162246;6165.630062196283;6169.660668663267;6173.753049877954;5988.610740301867;5988.730507127103;5989;5991;5991.550633702403 05:32:29 INFO - PROCESS | 3676 | |5;yui.html;718.6550455781224;739.6782399656148;778.3695206882426;795;805.3156807605205;12529.436175372108;12702.301373424458;12707.538633057202;12718.872811271907;12919.160254583458;12330.876691233085;12540.498380064786;12592.811107833368;12653.873461265384;12801.935990320058;798.9520628762293;806.7297455352434;812.3907069697726;812.585581353511;812.6668066092903;800.2597597222575;805.4241217529466;807.0597753617029;807.5558442856405;807.5598798654747;843.2663582683074;843.3337663246028;843.5782108945527;843.7089204224563;844.0167205205928;836.8493671139192;838.8993320801512;838.9496630202208;839.2195258409677;844.8056946902216;618.8638499530097;619.5817822969477;620.9844753881189;622.7384498510592;622.7789134857106;12681.492740290378;12781.297028663419;12792.168509046882;12808.295543745091;12814.615561533168;12146.93472325639;12176.756464870654;12315.876841231562;12361;12675;10086.949565252127;10271.28101032928;10321.019503147189;10333.58665653373;10583.629572964986;3483.094395457174;3569.4824250483794;3598.7300952428673;3652.7077833773233;3660.2313514162056;46249.30626040612;46421;46476.76761616204;46686.5331346689;47077.29384059208;9589.616415343447;9726.465044422624;9764.560594773111;9903.653372131941;9977.600895964226;16991.55571776388;17025.659486810444;17026.404075857285;17037.829621703873;17058.402955896483;7213.508338541813;7351.852962940711;7418.072740907387;7523.435742319348;7603.619819009027;4146.357314616239;4148.647364974011;4152.522459917088;4285.550017248206;4303.053328267776;2982.746466550324;3009.8043627164166;3012.0662594595747;3018.5773991641186;3049.725524702743;550.0950935710733;567.0473604344658;576.0236399303141;576.032265793471;582.2547139661241;540.2706346432285;562.6511562830989;621.4003486635419;637.5760119520467;683.2108914204102;9076.273898088137;9477;9500.382475139093;9738.853917191247;9743.220542356594;577.887311974161;603.7434090511515;677.5629718831326;687.7902239816904;693.8820400531922;4080.8571699990357;4382.496012958551;4385.693001489929;4423.358613001097;4428.68999170055;50936.74531627318;56723;58182;58701.41298587045;58708.706456467444;44204.336934946004;44973.77513112414;45057.098858022655;45597.7720111404;50071.24893126606;40727;40734;40857.59142408597;41689;41765.791171044555;8380.329573633973;8739.475631462132;8793.428427152214;8834.823303533765;9086.772830679285;29831.403371932007;30266.24334391658;35177.120571985906;35964.28071438609;36090;43785.56214437942;44054;44163.11673766571;44586.3312050326;44865.77567112144;11476.655700329004;11543.595974140864;11683.763566737314;11777.175597708421;11871.878339089892;11546.307221566733;11830.645080647595;11867.821982670439;12256.632301030982;12487;11273.323600583992;11598.362090085126;11662.94168529152;11930.940345298219;11938.462769175234;11528.365939873052;11831.171817973003;11858.169928105295;11927.165098443373;12326.137170397986;10366.681304642683;10645.89354106449;10786.191035672198;10796.469813739724;10805.891941080488;9510;9837.057912912305;9871.555779989774;9935.701928942144;10260.692179234635;9123.954380228057;9322.440653560809;9382.906170938477;9589.856152157583;10092.949535252277 05:32:29 INFO - PROCESS | 3676 | __end_tp_report 05:32:29 INFO - PROCESS | 3676 | __start_cc_report 05:32:29 INFO - PROCESS | 3676 | _x_x_mozilla_cycle_collect,726 05:32:29 INFO - PROCESS | 3676 | __end_cc_report 05:32:29 INFO - PROCESS | 3676 | __startTimestamp1453296749007__endTimestamp 05:32:29 INFO - PROCESS | 3676 | 05:32:29 INFO - PROCESS | 3676 | ------- Summary: start ------- 05:32:29 INFO - PROCESS | 3676 | Number of tests: 6 05:32:29 INFO - PROCESS | 3676 | 05:32:29 INFO - PROCESS | 3676 | [#0] dojo.html Cycles:165 Average:5204.42 Median:5327.04 stddev:557.59 (10.5%) stddev-sans-first:535.40 05:32:29 INFO - PROCESS | 3676 | Values: 3145.8 3188.8 3247.1 3248.2 3280.2 5117.6 5195.3 5217.4 5225.6 5287.7 5268.5 5284.4 5306.0 5306.4 5321.5 4760.3 4776.7 4780.8 4844.3 4865.7 4845.1 4856.9 4877.8 4908.4 4921.8 4589.4 4683.8 4756.0 4802.5 4808.5 4687.8 4697.2 4702.9 4709.5 4722.0 4683.2 4705.2 4708.4 4709.4 4730.5 5036.8 5054.1 5104.3 5138.1 5183.5 5638.2 5640.3 5641.0 5645.6 5652.1 5596.9 5644.5 5686.4 5691.9 5694.2 5250.9 5257.4 5260.4 5281.5 5304.2 5707.5 5708.0 5710.9 5722.4 5767.3 5466.6 5487.1 5487.2 5488.7 5500.5 5597.1 5612.6 5648.2 5652.9 5684.2 5563.3 5568.5 5573.2 5574.7 5574.8 5498.2 5498.2 5554.7 5560.3 5567.7 4342.9 4362.0 4363.0 4401.6 4402.2 3915.5 3919.8 3926.9 3932.9 3956.2 5108.2 5187.1 5189.8 5250.3 5296.4 5621.8 5628.5 5642.5 5643.6 5659.2 5264.8 5270.9 5270.9 5271.3 5282.0 4769.3 4783.2 4836.8 4855.4 4861.8 5802.0 5841.3 5847.4 5852.5 5858.9 5605.2 5617.4 5619.4 5622.4 5626.5 5733.7 5790.9 5825.8 5829.0 5922.1 5498.8 5509.8 5516.3 5516.4 5523.3 5503.0 5564.4 5568.9 5569.2 5613.3 5372.0 5414.0 5450.3 5478.8 5507.3 5326.1 5392.8 5394.7 5400.7 5415.2 5239.8 5316.5 5326.0 5327.8 5362.8 5407.9 5427.8 5488.5 5544.8 5564.2 5322.4 5324.1 5324.6 5327.0 5327.7 05:32:29 INFO - PROCESS | 3676 | 05:32:29 INFO - PROCESS | 3676 | [#1] ext.html Cycles:180 Average:39707.88 Median:34596.48 stddev:60187.91 (174.0%) stddev-sans-first:60284.80 05:32:29 INFO - PROCESS | 3676 | Values: 512.7 517.7 518.3 552.5 561.6 28403.0 35792.6 36456.8 36502.5 36503.5 38783.8 39233.4 39356.6 39366.0 39415.2 8373.4 8578.8 8609.4 8642.1 8649.6 8291.4 8409.2 8415.6 8422.9 8581.6 8541.7 8556.1 8564.7 8581.8 8629.2 8445.7 8531.2 8532.4 8554.0 8559.0 8583.7 8637.0 8702.5 8730.1 8731.5 38886.2 39212.8 39316.0 39339.6 39385.8 3167.6 3180.6 3351.0 3376.5 3379.9 29069.6 29199.1 29870.4 29940.9 30040.1 3926.6 3979.1 4006.8 4035.1 4105.1 187574.0 188339.0 188365.1 188408.0 188574.0 55963.0 56159.0 56358.2 56393.2 56402.7 59188.0 59454.1 59486.0 59554.1 59638.7 14246.1 14583.1 14590.9 14607.9 14612.4 10875.4 11055.6 11058.0 11089.7 11120.6 17893.7 18807.2 18946.8 19078.6 19121.0 6446.9 7178.1 7610.4 7610.7 7645.7 870.1 927.9 991.3 1005.6 1028.7 28381.6 29104.3 29215.7 29929.0 30088.2 1007.2 1059.5 1104.1 1114.9 1126.9 13659.0 13801.7 13822.1 13977.9 14050.9 246129.0 289943.0 295123.0 317603.0 319498.0 43083.1 43224.0 43678.6 43795.8 43851.0 1180.6 1324.8 1328.1 1330.7 1357.3 22303.0 25421.3 27730.7 28177.4 28245.3 47391.5 47799.0 47804.5 47804.8 47841.0 192069.0 193691.0 193943.0 194164.0 194365.0 28562.0 28623.0 28648.9 28896.1 29013.3 38153.4 39301.4 39570.0 40114.4 42099.6 34037.0 35450.8 36216.5 36419.5 37033.6 31995.5 32558.8 32814.0 33936.3 36842.8 33673.8 34312.8 34485.3 34707.7 34739.3 30045.8 31622.7 31971.2 32034.2 32064.7 24664.8 24741.9 25055.7 25107.7 25300.7 05:32:29 INFO - PROCESS | 3676 | 05:32:29 INFO - PROCESS | 3676 | [#2] jquery.html Cycles:180 Average:25026.03 Median:2709.03 stddev:77917.40 (2876.2%) stddev-sans-first:78113.97 05:32:29 INFO - PROCESS | 3676 | Values: 366.6 368.0 370.3 371.2 379.9 13628.6 13728.8 15465.2 16253.5 16979.2 15584.7 15786.8 16036.6 16358.3 16416.3 5172.5 5353.5 5361.5 5362.2 5368.2 3920.5 4058.5 5286.6 5330.8 5559.1 5724.9 5857.5 5864.3 5867.5 5873.6 5673.3 5766.1 5776.5 5785.9 5788.2 4935.0 5119.6 5119.9 5141.3 5143.4 19414.0 19557.5 19663.5 19755.7 19778.0 2220.1 2222.8 2376.9 2405.7 2545.3 12394.4 12439.1 12615.9 12706.0 12770.6 1692.9 1766.8 1826.8 1837.7 1844.8 51912.5 53467.5 53592.7 53874.5 54205.0 9440.2 9602.7 9794.6 9800.9 9897.0 12887.9 12949.4 12969.9 12978.8 12979.4 7292.0 7311.8 7375.0 7395.9 7445.6 6743.5 6785.0 6796.1 6860.9 7065.0 5728.8 5886.4 5890.5 5918.6 5947.1 1646.4 1729.6 1740.5 1776.4 1801.8 951.7 997.5 1004.3 1032.2 1068.0 10887.7 11041.6 11074.9 16290.3 17052.9 444.5 445.5 453.9 460.4 478.7 5057.4 5924.4 6004.3 6040.8 6293.5 402618.0 402744.0 407564.0 563588.0 572747.0 53338.5 68478.7 71955.6 72632.6 74122.6 469.7 476.7 478.7 479.0 483.1 10153.6 13952.2 14775.2 15048.4 15048.7 26664.9 31089.0 32250.0 32252.4 33803.7 38533.0 38628.8 38858.6 39050.2 40370.4 7233.0 7517.4 7585.7 7615.5 7644.6 10045.9 10916.2 11187.4 11228.3 11409.8 9557.9 9732.5 9795.8 9881.0 9904.5 9332.9 9480.8 9658.6 9817.1 9978.6 9564.8 9913.0 10033.1 10169.3 10204.8 7457.4 7491.2 7531.0 7646.7 7657.9 9412.5 9657.5 9702.6 9702.8 9729.4 05:32:29 INFO - PROCESS | 3676 | 05:32:29 INFO - PROCESS | 3676 | [#3] mootools.html Cycles:180 Average:5504.39 Median:6407.92 stddev:2828.10 (44.1%) stddev-sans-first:2818.49 05:32:29 INFO - PROCESS | 3676 | Values: 1314.2 1465.6 1477.3 1629.6 1790.6 6963.9 7671.1 7838.5 7851.0 7873.4 7725.8 7915.6 7932.3 7933.7 7934.4 2043.9 2088.6 2091.7 2319.2 2343.9 2298.6 2348.2 2351.5 2353.9 2357.5 2300.2 2307.3 2312.1 2372.7 2374.6 2288.6 2288.8 2291.6 2296.8 2368.8 2316.1 2324.7 2325.6 2337.9 2345.9 7849.4 7893.5 7903.6 7906.1 7912.1 4908.7 4998.2 5000.2 5040.3 5044.7 2914.7 2933.7 2951.5 2972.4 3074.0 913.4 922.4 924.8 946.7 948.8 11007.9 11011.1 11017.3 11038.8 11059.4 4412.4 4438.4 4509.6 4513.3 4517.4 9286.5 9350.5 9355.3 9389.7 9399.6 4947.7 4980.6 4987.6 4995.0 4995.0 4495.6 4505.9 4509.3 4511.0 4519.7 3509.6 3630.3 3771.5 3782.2 3921.7 1178.0 1180.3 1206.5 1220.0 1239.3 1302.0 1302.4 1302.5 1302.9 1327.3 7212.9 7353.9 7416.2 7416.9 7429.2 1108.5 1137.5 1140.8 1148.1 1154.3 5691.2 5792.8 5847.2 5848.2 5854.9 9066.4 9182.0 9345.8 9391.9 9434.0 9328.8 9356.8 9374.9 9378.2 9382.7 7195.6 7218.6 7454.2 7461.1 7466.1 7333.5 7396.6 7412.6 7416.0 7423.5 8110.6 8197.1 8412.5 8449.5 8582.0 8263.0 8422.1 8474.9 8646.7 8660.3 6945.5 7029.4 7071.0 7080.4 7082.5 6795.7 6962.0 7082.3 7238.2 7370.4 6851.4 7022.9 7052.2 7063.9 7169.2 6771.9 6920.3 6939.6 6949.9 7095.2 6712.2 6745.2 6765.9 6773.4 6785.0 6369.6 6374.6 6377.9 6385.2 6393.1 6390.2 6422.8 6441.3 6456.8 6457.7 05:32:29 INFO - PROCESS | 3676 | 05:32:29 INFO - PROCESS | 3676 | [#4] prototype.html Cycles:180 Average:5124.16 Median:5812.13 stddev:1519.86 (26.1%) stddev-sans-first:1480.96 05:32:29 INFO - PROCESS | 3676 | Values: 332.8 339.9 344.7 345.0 349.2 5676.1 5762.7 5800.2 5857.5 5878.0 5581.0 5666.0 5670.3 5689.1 5709.5 4424.1 4430.8 4445.7 4460.5 4466.5 4238.1 4338.4 4345.3 4348.0 4449.4 4335.7 4436.4 4439.8 4442.6 4454.0 4417.5 4421.2 4425.7 4426.9 4438.9 3913.3 3937.2 3938.3 3944.2 3944.6 5402.2 5508.5 5520.9 5523.2 5542.2 5163.1 5163.8 5164.1 5172.0 5173.5 6066.8 6071.1 6077.5 6078.5 6082.2 4130.0 4234.7 4269.7 4350.9 4360.0 6302.5 6325.1 6325.5 6335.5 6346.0 4453.6 4459.1 4459.3 4463.5 4464.3 4426.0 4450.8 4495.9 4495.9 4497.3 5142.0 5151.5 5152.7 5154.5 5155.4 6099.9 6101.5 6116.6 6120.7 6121.9 1579.3 1592.3 1593.5 1593.8 1596.1 1087.2 1096.3 1096.7 1098.3 1122.3 5813.1 5830.7 5832.6 5841.3 5845.4 6256.1 6310.5 6330.4 6333.3 6352.3 5787.9 5806.9 5811.1 5823.4 5856.2 3282.6 3378.8 3380.8 3386.7 3393.5 6440.9 6449.8 6450.5 6451.9 6456.1 6392.0 6397.8 6402.9 6404.3 6405.8 6361.0 6514.8 6517.9 6520.1 6527.4 6088.7 6251.1 6255.8 6261.7 6263.7 6128.7 6176.0 6257.4 6265.6 6270.7 6543.6 6573.0 6582.6 6583.6 6588.4 4425.1 4427.7 4430.2 4431.1 4437.9 6190.7 6351.5 6375.0 6381.6 6384.1 6115.7 6139.4 6140.8 6145.0 6154.7 6105.4 6105.5 6114.5 6117.0 6122.3 5905.2 6040.6 6045.8 6046.0 6048.7 6123.4 6155.6 6165.6 6169.7 6173.8 5988.6 5988.7 5989.0 5991.0 5991.6 05:32:29 INFO - PROCESS | 3676 | 05:32:29 INFO - PROCESS | 3676 | [#5] yui.html Cycles:180 Average:13343.00 Median:24507.51 stddev:15092.96 (61.6%) stddev-sans-first:15105.52 05:32:29 INFO - PROCESS | 3676 | Values: 718.7 739.7 778.4 795.0 805.3 12529.4 12702.3 12707.5 12718.9 12919.2 12330.9 12540.5 12592.8 12653.9 12801.9 799.0 806.7 812.4 812.6 812.7 800.3 805.4 807.1 807.6 807.6 843.3 843.3 843.6 843.7 844.0 836.8 838.9 838.9 839.2 844.8 618.9 619.6 621.0 622.7 622.8 12681.5 12781.3 12792.2 12808.3 12814.6 12146.9 12176.8 12315.9 12361.0 12675.0 10086.9 10271.3 10321.0 10333.6 10583.6 3483.1 3569.5 3598.7 3652.7 3660.2 46249.3 46421.0 46476.8 46686.5 47077.3 9589.6 9726.5 9764.6 9903.7 9977.6 16991.6 17025.7 17026.4 17037.8 17058.4 7213.5 7351.9 7418.1 7523.4 7603.6 4146.4 4148.6 4152.5 4285.6 4303.1 2982.7 3009.8 3012.1 3018.6 3049.7 550.1 567.0 576.0 576.0 582.3 540.3 562.7 621.4 637.6 683.2 9076.3 9477.0 9500.4 9738.9 9743.2 577.9 603.7 677.6 687.8 693.9 4080.9 4382.5 4385.7 4423.4 4428.7 50936.7 56723.0 58182.0 58701.4 58708.7 44204.3 44973.8 45057.1 45597.8 50071.2 40727.0 40734.0 40857.6 41689.0 41765.8 8380.3 8739.5 8793.4 8834.8 9086.8 29831.4 30266.2 35177.1 35964.3 36090.0 43785.6 44054.0 44163.1 44586.3 44865.8 11476.7 11543.6 11683.8 11777.2 11871.9 11546.3 11830.6 11867.8 12256.6 12487.0 11273.3 11598.4 11662.9 11930.9 11938.5 11528.4 11831.2 11858.2 11927.2 12326.1 10366.7 10645.9 10786.2 10796.5 10805.9 9510.0 9837.1 9871.6 9935.7 10260.7 9124.0 9322.4 9382.9 9589.9 10092.9 05:32:29 INFO - PROCESS | 3676 | -------- Summary: end -------- 05:32:29 INFO - PROCESS | 3676 | 05:32:29 INFO - TEST-INFO | 3676: exit 0 05:32:29 INFO - TEST-OK | dromaeo_css | took 1111966ms 05:32:29 INFO - TEST-START | kraken 05:32:29 INFO - operating with platform_type : linux_ 05:32:29 INFO - Initialising browser for kraken test... 05:32:29 INFO - TEST-INFO | started process 3878 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaFoilQ/profile http://localhost:49694/getInfo.html) 05:32:33 INFO - PROCESS | 3878 | __metrics Screen width/height:1600/1200 05:32:33 INFO - PROCESS | 3878 | colorDepth:24 05:32:33 INFO - PROCESS | 3878 | Browser inner width/height: 1024/697 05:32:33 INFO - PROCESS | 3878 | __metrics 05:32:33 INFO - PROCESS | 3878 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:32:33 INFO - PROCESS | 3878 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:32:34 INFO - TEST-INFO | 3878: exit 0 05:32:34 INFO - Browser initialized. 05:32:34 INFO - Running cycle 1/1 for kraken test... 05:32:34 INFO - TEST-INFO | started process 3958 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaFoilQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:32:46 INFO - PROCESS | 3958 | RSS: Main: 149577728 05:32:46 INFO - PROCESS | 3958 | 05:32:48 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:49694/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49694/tests/kraken/driver.html?testName=audio-beat-detection) 05:32:49 INFO - PROCESS | 3958 | RSS: Main: 185888768 05:32:49 INFO - PROCESS | 3958 | 05:32:51 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:49694/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49694/tests/kraken/driver.html?testName=audio-dft) 05:32:52 INFO - PROCESS | 3958 | RSS: Main: 177844224 05:32:52 INFO - PROCESS | 3958 | 05:32:55 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:49694/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49694/tests/kraken/driver.html?testName=audio-fft) 05:32:55 INFO - PROCESS | 3958 | RSS: Main: 161918976 05:32:55 INFO - PROCESS | 3958 | 05:32:58 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:49694/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49694/tests/kraken/driver.html?testName=audio-oscillator) 05:32:58 INFO - PROCESS | 3958 | RSS: Main: 162652160 05:32:58 INFO - PROCESS | 3958 | 05:33:00 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:49694/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49694/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:33:01 INFO - PROCESS | 3958 | RSS: Main: 164376576 05:33:01 INFO - PROCESS | 3958 | 05:33:04 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:49694/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49694/tests/kraken/driver.html?testName=imaging-darkroom) 05:33:04 INFO - PROCESS | 3958 | RSS: Main: 166305792 05:33:04 INFO - PROCESS | 3958 | 05:33:08 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:49694/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49694/tests/kraken/driver.html?testName=imaging-desaturate) 05:33:08 INFO - PROCESS | 3958 | RSS: Main: 165662720 05:33:08 INFO - PROCESS | 3958 | 05:33:11 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:49694/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49694/tests/kraken/driver.html?testName=json-parse-financial) 05:33:12 INFO - PROCESS | 3958 | RSS: Main: 165736448 05:33:12 INFO - PROCESS | 3958 | 05:33:13 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:49694/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49694/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:33:14 INFO - PROCESS | 3958 | RSS: Main: 179720192 05:33:14 INFO - PROCESS | 3958 | 05:33:15 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:49694/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49694/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:33:16 INFO - PROCESS | 3958 | RSS: Main: 177410048 05:33:16 INFO - PROCESS | 3958 | 05:33:18 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:49694/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49694/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:33:19 INFO - PROCESS | 3958 | RSS: Main: 186929152 05:33:19 INFO - PROCESS | 3958 | 05:33:21 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:49694/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49694/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:33:22 INFO - PROCESS | 3958 | RSS: Main: 195457024 05:33:22 INFO - PROCESS | 3958 | 05:33:24 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:49694/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49694/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:33:25 INFO - PROCESS | 3958 | RSS: Main: 192049152 05:33:25 INFO - PROCESS | 3958 | 05:33:26 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:49694/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49694/tests/kraken/driver.html?testName=ai-astar) 05:33:27 INFO - PROCESS | 3958 | RSS: Main: 249397248 05:33:27 INFO - PROCESS | 3958 | 05:33:27 INFO - PROCESS | 3958 | __start_tp_report 05:33:27 INFO - PROCESS | 3958 | _x_x_mozilla_page_load 05:33:27 INFO - PROCESS | 3958 | _x_x_mozilla_page_load_details 05:33:27 INFO - PROCESS | 3958 | |i|pagename|runs| 05:33:27 INFO - PROCESS | 3958 | |0;ai-astar;111;110;108;111;109;112;111;111;106;111 05:33:27 INFO - PROCESS | 3958 | |1;audio-beat-detection;155;125;153;168;126;145;150;134;168;131 05:33:27 INFO - PROCESS | 3958 | |2;audio-dft;162;161;161;161;161;162;160;159;160;161 05:33:27 INFO - PROCESS | 3958 | |3;audio-fft;80;81;96;95;75;73;72;115;102;73 05:33:27 INFO - PROCESS | 3958 | |4;audio-oscillator;96;96;140;101;96;96;148;97;97;135 05:33:27 INFO - PROCESS | 3958 | |5;imaging-gaussian-blur;110;108;109;109;109;109;109;109;110;108 05:33:27 INFO - PROCESS | 3958 | |6;imaging-darkroom;147;146;146;146;146;146;146;147;145;146 05:33:27 INFO - PROCESS | 3958 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;97;97 05:33:27 INFO - PROCESS | 3958 | |8;json-parse-financial;57;56;55;56;55;57;57;57;56;53 05:33:27 INFO - PROCESS | 3958 | |9;json-stringify-tinderbox;67;68;67;67;79;67;69;68;70;69 05:33:27 INFO - PROCESS | 3958 | |10;stanford-crypto-aes;82;84;82;82;81;81;89;85;82;89 05:33:27 INFO - PROCESS | 3958 | |11;stanford-crypto-ccm;123;114;119;114;113;112;119;115;115;123 05:33:27 INFO - PROCESS | 3958 | |12;stanford-crypto-pbkdf2;145;138;145;154;146;134;144;133;145;134 05:33:27 INFO - PROCESS | 3958 | |13;stanford-crypto-sha256-iterative;66;66;67;65;68;65;65;65;66;67 05:33:27 INFO - PROCESS | 3958 | __end_tp_report 05:33:27 INFO - PROCESS | 3958 | __start_cc_report 05:33:27 INFO - PROCESS | 3958 | _x_x_mozilla_cycle_collect,938 05:33:27 INFO - PROCESS | 3958 | __end_cc_report 05:33:27 INFO - PROCESS | 3958 | __startTimestamp1453296807101__endTimestamp 05:33:27 INFO - PROCESS | 3958 | 05:33:27 INFO - PROCESS | 3958 | ------- Summary: start ------- 05:33:27 INFO - PROCESS | 3958 | Number of tests: 14 05:33:27 INFO - PROCESS | 3958 | 05:33:27 INFO - PROCESS | 3958 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:1.83 (1.6%) stddev-sans-first:1.90 05:33:27 INFO - PROCESS | 3958 | Values: 111.0 110.0 108.0 111.0 109.0 112.0 111.0 111.0 106.0 111.0 05:33:27 INFO - PROCESS | 3958 | 05:33:27 INFO - PROCESS | 3958 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:151.50 stddev:16.06 (10.6%) stddev-sans-first:16.67 05:33:27 INFO - PROCESS | 3958 | Values: 155.0 125.0 153.0 168.0 126.0 145.0 150.0 134.0 168.0 131.0 05:33:27 INFO - PROCESS | 3958 | 05:33:27 INFO - PROCESS | 3958 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 05:33:27 INFO - PROCESS | 3958 | Values: 162.0 161.0 161.0 161.0 161.0 162.0 160.0 159.0 160.0 161.0 05:33:27 INFO - PROCESS | 3958 | 05:33:27 INFO - PROCESS | 3958 | [#3] audio-fft Cycles:10 Average:86.20 Median:77.50 stddev:14.88 (19.2%) stddev-sans-first:15.62 05:33:27 INFO - PROCESS | 3958 | Values: 80.0 81.0 96.0 95.0 75.0 73.0 72.0 115.0 102.0 73.0 05:33:27 INFO - PROCESS | 3958 | 05:33:27 INFO - PROCESS | 3958 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:96.00 stddev:21.53 (22.4%) stddev-sans-first:22.21 05:33:27 INFO - PROCESS | 3958 | Values: 96.0 96.0 140.0 101.0 96.0 96.0 148.0 97.0 97.0 135.0 05:33:27 INFO - PROCESS | 3958 | 05:33:27 INFO - PROCESS | 3958 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 05:33:27 INFO - PROCESS | 3958 | Values: 110.0 108.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 108.0 05:33:27 INFO - PROCESS | 3958 | 05:33:27 INFO - PROCESS | 3958 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 05:33:27 INFO - PROCESS | 3958 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 145.0 146.0 05:33:27 INFO - PROCESS | 3958 | 05:33:27 INFO - PROCESS | 3958 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:33:27 INFO - PROCESS | 3958 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 97.0 05:33:27 INFO - PROCESS | 3958 | 05:33:27 INFO - PROCESS | 3958 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.50 stddev:1.29 (2.3%) stddev-sans-first:1.30 05:33:27 INFO - PROCESS | 3958 | Values: 57.0 56.0 55.0 56.0 55.0 57.0 57.0 57.0 56.0 53.0 05:33:27 INFO - PROCESS | 3958 | 05:33:27 INFO - PROCESS | 3958 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:68.50 stddev:3.63 (5.3%) stddev-sans-first:3.77 05:33:27 INFO - PROCESS | 3958 | Values: 67.0 68.0 67.0 67.0 79.0 67.0 69.0 68.0 70.0 69.0 05:33:27 INFO - PROCESS | 3958 | 05:33:27 INFO - PROCESS | 3958 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:3.06 (3.7%) stddev-sans-first:3.18 05:33:27 INFO - PROCESS | 3958 | Values: 82.0 84.0 82.0 82.0 81.0 81.0 89.0 85.0 82.0 89.0 05:33:27 INFO - PROCESS | 3958 | 05:33:27 INFO - PROCESS | 3958 | [#11] stanford-crypto-ccm Cycles:10 Average:116.70 Median:117.00 stddev:4.03 (3.4%) stddev-sans-first:3.57 05:33:27 INFO - PROCESS | 3958 | Values: 123.0 114.0 119.0 114.0 113.0 112.0 119.0 115.0 115.0 123.0 05:33:27 INFO - PROCESS | 3958 | 05:33:27 INFO - PROCESS | 3958 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.80 Median:145.00 stddev:6.80 (4.7%) stddev-sans-first:7.11 05:33:27 INFO - PROCESS | 3958 | Values: 145.0 138.0 145.0 154.0 146.0 134.0 144.0 133.0 145.0 134.0 05:33:27 INFO - PROCESS | 3958 | 05:33:27 INFO - PROCESS | 3958 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.05 (1.6%) stddev-sans-first:1.12 05:33:27 INFO - PROCESS | 3958 | Values: 66.0 66.0 67.0 65.0 68.0 65.0 65.0 65.0 66.0 67.0 05:33:27 INFO - PROCESS | 3958 | -------- Summary: end -------- 05:33:27 INFO - PROCESS | 3958 | 05:33:27 INFO - TEST-INFO | 3958: exit 0 05:33:27 INFO - TEST-OK | kraken | took 58257ms 05:33:27 INFO - TEST-START | v8_7 05:33:27 INFO - operating with platform_type : linux_ 05:33:27 INFO - Initialising browser for v8_7 test... 05:33:27 INFO - TEST-INFO | started process 4205 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2JL3Za/profile http://localhost:49694/getInfo.html) 05:33:31 INFO - PROCESS | 4205 | __metrics Screen width/height:1600/1200 05:33:31 INFO - PROCESS | 4205 | colorDepth:24 05:33:31 INFO - PROCESS | 4205 | Browser inner width/height: 1024/697 05:33:31 INFO - PROCESS | 4205 | __metrics 05:33:31 INFO - PROCESS | 4205 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:33:31 INFO - PROCESS | 4205 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:33:32 INFO - PROCESS | 4205 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 05:33:32 INFO - TEST-INFO | 4205: exit 0 05:33:32 INFO - Browser initialized. 05:33:32 INFO - Running cycle 1/1 for v8_7 test... 05:33:32 INFO - TEST-INFO | started process 4286 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2JL3Za/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:33:44 INFO - PROCESS | 4286 | RSS: Main: 147546112 05:33:44 INFO - PROCESS | 4286 | 05:34:06 INFO - PROCESS | 4286 | Cycle 1(1): loaded http://localhost:49694/tests/v8_7/run.html (next: http://localhost:49694/tests/v8_7/run.html) 05:34:07 INFO - PROCESS | 4286 | RSS: Main: 518529024 05:34:07 INFO - PROCESS | 4286 | 05:34:07 INFO - PROCESS | 4286 | __start_tp_report 05:34:07 INFO - PROCESS | 4286 | _x_x_mozilla_page_load 05:34:07 INFO - PROCESS | 4286 | _x_x_mozilla_page_load_details 05:34:07 INFO - PROCESS | 4286 | |i|pagename|runs| 05:34:07 INFO - PROCESS | 4286 | |0;Richards;167.47613465081227 05:34:07 INFO - PROCESS | 4286 | |1;DeltaBlue;189.2147587511826 05:34:07 INFO - PROCESS | 4286 | |2;Encrypt;279.17364600781684 05:34:07 INFO - PROCESS | 4286 | |3;Decrypt;5251.308900523561 05:34:07 INFO - PROCESS | 4286 | |4;RayTrace;1107.4197120708748 05:34:07 INFO - PROCESS | 4286 | |5;Earley;791.7656373713381 05:34:07 INFO - PROCESS | 4286 | |6;Boyer;12207.317073170732 05:34:07 INFO - PROCESS | 4286 | |7;RegExp;42437.5 05:34:07 INFO - PROCESS | 4286 | |8;Splay;588.9281507656066 05:34:07 INFO - PROCESS | 4286 | |9;NavierStokes;4835.748792270531 05:34:07 INFO - PROCESS | 4286 | __end_tp_report 05:34:07 INFO - PROCESS | 4286 | __startTimestamp1453296847227__endTimestamp 05:34:07 INFO - PROCESS | 4286 | 05:34:07 INFO - PROCESS | 4286 | ------- Summary: start ------- 05:34:07 INFO - PROCESS | 4286 | Number of tests: 10 05:34:07 INFO - PROCESS | 4286 | 05:34:07 INFO - PROCESS | 4286 | [#0] Richards Cycles:1 Average:167.48 Median:167.48 stddev:0.00 (0.0%) 05:34:07 INFO - PROCESS | 4286 | Values: 167.5 05:34:07 INFO - PROCESS | 4286 | 05:34:07 INFO - PROCESS | 4286 | [#1] DeltaBlue Cycles:1 Average:189.21 Median:189.21 stddev:0.00 (0.0%) 05:34:07 INFO - PROCESS | 4286 | Values: 189.2 05:34:07 INFO - PROCESS | 4286 | 05:34:07 INFO - PROCESS | 4286 | [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 05:34:07 INFO - PROCESS | 4286 | Values: 279.2 05:34:07 INFO - PROCESS | 4286 | 05:34:07 INFO - PROCESS | 4286 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 05:34:07 INFO - PROCESS | 4286 | Values: 5251.3 05:34:07 INFO - PROCESS | 4286 | 05:34:07 INFO - PROCESS | 4286 | [#4] RayTrace Cycles:1 Average:1107.42 Median:1107.42 stddev:0.00 (0.0%) 05:34:07 INFO - PROCESS | 4286 | Values: 1107.4 05:34:07 INFO - PROCESS | 4286 | 05:34:07 INFO - PROCESS | 4286 | [#5] Earley Cycles:1 Average:791.77 Median:791.77 stddev:0.00 (0.0%) 05:34:07 INFO - PROCESS | 4286 | Values: 791.8 05:34:07 INFO - PROCESS | 4286 | 05:34:07 INFO - PROCESS | 4286 | [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 05:34:07 INFO - PROCESS | 4286 | Values: 12207.3 05:34:07 INFO - PROCESS | 4286 | 05:34:07 INFO - PROCESS | 4286 | [#7] RegExp Cycles:1 Average:42437.50 Median:42437.50 stddev:0.00 (0.0%) 05:34:07 INFO - PROCESS | 4286 | Values: 42437.5 05:34:07 INFO - PROCESS | 4286 | 05:34:07 INFO - PROCESS | 4286 | [#8] Splay Cycles:1 Average:588.93 Median:588.93 stddev:0.00 (0.0%) 05:34:07 INFO - PROCESS | 4286 | Values: 588.9 05:34:07 INFO - PROCESS | 4286 | 05:34:07 INFO - PROCESS | 4286 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 05:34:07 INFO - PROCESS | 4286 | Values: 4835.7 05:34:07 INFO - PROCESS | 4286 | -------- Summary: end -------- 05:34:07 INFO - PROCESS | 4286 | 05:34:08 INFO - TEST-INFO | 4286: exit 0 05:34:08 INFO - TEST-OK | v8_7 | took 40075ms 05:34:08 INFO - SUITE-END | took 1210s 05:34:08 INFO - Completed test suite (00:20:10) 05:34:08 INFO - Working with test: dromaeo_css 05:34:08 INFO - Generating results file: dromaeo_css 05:34:08 INFO - Working with test: kraken 05:34:08 INFO - Generating results file: kraken 05:34:08 INFO - javascript benchmark 05:34:08 INFO - Working with test: v8_7 05:34:08 INFO - Generating results file: v8_7 05:34:08 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:34:08 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 05:34:08 INFO - process_Request line: dromaeo_css 6700.69 graph.html#tests=[[72,201,35]] 05:34:08 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:34:08 INFO - process_Request line: kraken 1497.20 graph.html#tests=[[232,201,35]] 05:34:08 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:34:08 INFO - process_Request line: v8_7 20056.03 graph.html#tests=[[230,201,35]] 05:34:08 INFO - RETURN: dromaeo_css: 6700.69 05:34:08 INFO - RETURN: kraken: 1497.20 05:34:08 INFO - RETURN: v8_7: 20056.03 05:34:08 INFO - javascript benchmark 05:34:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3145.795523290986, 3188.76084293678, 3247.0745837436334, 3248.187953011747, 3280.1635582926356, 5117.641765076446, 5195.298634684316, 5217.373915130181, 5225.608079394042, 5287.709175995319, 5268.47315268473, 5284.4187139414635, 5306.0, 5306.442823503535, 5321.547668448186, 4760.309755085511, 4776.665633405663, 4780.80876764929, 4844.346013288196, 4865.659403841715, 4845.103655823684, 4856.854294371157, 4877.780499877514, 4908.386451693538, 4921.753912304388, 4589.449266088074, 4683.7892294846815, 4755.952440475586, 4802.471728109905, 4808.543188397097, 4687.789049492781, 4697.224957881946, 4702.929456058162, 4709.505501922283, 4722.0, 4683.157031734287, 4705.1765940960195, 4708.411448568929, 4709.387779588632, 4730.5032971538185, 5036.7733451994745, 5054.140796064641, 5104.310918026056, 5138.126518491866, 5183.50756678115, 5638.182463542805, 5640.323161220639, 5640.971795141039, 5645.633033852787, 5652.095664693629, 5596.916046259309, 5644.491995720405, 5686.431356864322, 5691.9146212806845, 5694.202811606378, 5250.921236181461, 5257.395399529065, 5260.447652996419, 5281.471852814688, 5304.151335786256, 5707.543396528268, 5708.029634962067, 5710.857228569319, 5722.37053924068, 5767.250257466587, 5466.590005749585, 5487.067198576252, 5487.176923461513, 5488.670679759148, 5500.477454641803, 5597.076482380362, 5612.579056570774, 5648.209250704905, 5652.886942261214, 5684.232628595087, 5563.276774019351, 5568.49883510486, 5573.164025396223, 5574.749136288877, 5574.832755017356, 5498.1752737089755, 5498.230247765316, 5554.694491802989, 5560.332760068818, 5567.749451274703, 4342.891427714332, 4362.0185458271635, 4363.040131171138, 4401.625861801719, 4402.207602631557, 3915.5105611798526, 3919.8432062717743, 3926.862559810393, 3932.8820135395986, 3956.228535435562, 5108.182690769459, 5187.118189907725, 5189.818356357585, 5250.317458730417, 5296.364436267672, 5621.775128994795, 5628.521575666033, 5642.492175704207, 5643.604947653707, 5659.207710920392, 5264.763085661154, 5270.92093618596, 5270.92093618596, 5271.262023316739, 5282.049231138355, 4769.332293478916, 4783.186858234039, 4836.758162091881, 4855.393075865517, 4861.756912154378, 5802.042662960649, 5841.269841269841, 5847.444492773095, 5852.473277405054, 5858.882822343615, 5605.1872478491205, 5617.382087970402, 5619.438056194512, 5622.409646987007, 5626.465485778845, 5733.713314334183, 5790.94209057904, 5825.76696932118, 5828.970855145867, 5922.082077278029, 5498.835034948958, 5509.834704958857, 5516.310461192351, 5516.420775818481, 5523.309586301712, 5502.972485137549, 5564.38791732901, 5568.860778480571, 5569.164625306236, 5613.298337707786, 5371.973140134274, 5414.0, 5450.264214331015, 5478.780848766005, 5507.256520369699, 5326.09456392422, 5392.838214853561, 5394.730263486888, 5400.702961337164, 5415.241866138665, 5239.842804715865, 5316.494932981361, 5326.0, 5327.840164795062, 5362.812301569426, 5407.891842163213, 5427.755750991294, 5488.4785945335125, 5544.75048622821, 5564.248826408383, 5322.387925388475, 5324.068288049499, 5324.6006549508165, 5327.0411325961695, 5327.653702509325], "unit": "score", "name": "dojo.html", "value": 5169.927731174427}, {"lowerIsBetter": false, "replicates": [512.6539585779598, 517.6842126302954, 518.277003580006, 552.4779083765843, 561.6237121128842, 28403.0, 35792.642073579256, 36456.81771591141, 36502.45246321307, 36503.4524482133, 38783.80608096955, 39233.41149882747, 39356.60643393565, 39366.0, 39415.21169576614, 8373.371997100227, 8578.82842343156, 8609.354298427612, 8642.092580279075, 8649.567521623894, 8291.419600627958, 8409.201125893062, 8415.621297041616, 8422.873656895152, 8581.613827377752, 8541.701040463586, 8556.101609331025, 8564.657413703444, 8581.785455363635, 8629.180227878342, 8445.704400345989, 8531.232189102948, 8532.402731808776, 8554.0, 8559.0, 8583.742487725378, 8637.0, 8702.521361325125, 8730.126987301282, 8731.519766412845, 38886.22227555461, 39212.803935980424, 39316.0, 39339.60660393417, 39385.80307098475, 3167.635721891989, 3180.6024246969127, 3350.983245083759, 3376.4597664373828, 3379.8648054078053, 29069.563956540667, 29199.124026279245, 29870.402591948256, 29940.850295748383, 30040.098797036124, 3926.607339266079, 3979.0848104935735, 4006.819693113817, 4035.0517628357607, 4105.062444468838, 187574.0, 188339.0, 188365.11634883613, 188408.0, 188574.0, 55963.0, 56159.0, 56358.15462768062, 56393.154102688495, 56402.71798640981, 59188.0, 59454.108188377206, 59486.0, 59554.10668839971, 59638.70180649069, 14246.14523128595, 14583.125012499284, 14590.854091459161, 14607.853921460863, 14612.415503379958, 10875.401852898167, 11055.613053543088, 11058.0, 11089.667309980714, 11120.610778622871, 17893.7315940261, 18807.15367808452, 18946.810531894782, 19078.61842763165, 19121.0, 6446.903296450557, 7178.102737157856, 7610.429217808576, 7610.733624323122, 7645.655945482466, 870.1081391573688, 927.8932922713974, 991.2565575818137, 1005.5977608956476, 1028.7068185567227, 28381.574276385873, 29104.27239319034, 29215.707842921725, 29929.0, 30088.24779380489, 1007.1942446043137, 1059.5391004912733, 1104.1222228328497, 1114.8606424196976, 1126.853509043819, 13659.009479454631, 13801.723965520634, 13822.100380007712, 13977.86022139786, 14050.929745351208, 246129.0, 289943.0, 295123.0, 317603.0, 319498.0, 43083.13833723308, 43224.0, 43678.56321436745, 43795.78102109469, 43851.0, 1180.6458062581191, 1324.7549203397402, 1328.0902581731546, 1330.7138965122545, 1357.3281225793296, 22303.0, 25421.26210324145, 27730.722692773623, 28177.43645127127, 28245.29386765265, 47391.52608474009, 47799.0, 47804.52195478001, 47804.7609761949, 47841.0, 192069.0, 193691.0, 193943.0, 194164.0, 194365.0, 28562.0, 28623.0, 28648.856755716923, 28896.133116006553, 29013.274668133465, 38153.427698585096, 39301.41047884227, 39570.0, 40114.39828402518, 42099.57900421079, 34037.0, 35450.82274588611, 36216.456753148195, 36419.45370819387, 37033.62966370302, 31995.520067198544, 32558.83720581382, 32814.0, 33936.28509719266, 36842.8157859209, 33673.831630842666, 34312.828435857664, 34485.31029379348, 34707.65292347044, 34739.305213896085, 30045.849770751007, 31622.683773161974, 31971.200719982186, 32034.19914502156, 32064.679353207102, 24664.753352466247, 24741.87629061915, 25055.74944250534, 25107.748922511273, 25300.746992530574], "unit": "score", "name": "ext.html", "value": 17400.53419794071}, {"lowerIsBetter": false, "replicates": [366.5528055771958, 367.9576848662403, 370.3038288018525, 371.233403022758, 379.93920972644383, 13628.591142265723, 13728.794068088986, 15465.226738663065, 16253.512394628166, 16979.235934382952, 15584.68830623387, 15786.763198552031, 16036.59908502288, 16358.263878125483, 16416.343346266163, 5172.456892026349, 5353.464653534635, 5361.51746342829, 5362.2224777407255, 5368.194770784375, 3920.5491368492703, 4058.4521089652812, 5286.577073834084, 5330.840074797762, 5559.11054231323, 5724.914126288109, 5857.502112320458, 5864.266966629171, 5867.4719275265215, 5873.588848780587, 5673.290838645169, 5766.135079738031, 5776.537876969854, 5785.942140578582, 5788.160716696077, 4934.950650493485, 5119.6160287978555, 5119.897602047976, 5141.280220769096, 5143.434222235588, 19414.0, 19557.511062223417, 19663.508412289662, 19755.703664445045, 19778.0, 2220.0675716199075, 2222.833287503444, 2376.8930398132125, 2405.6992875890514, 2545.300042488312, 12394.380280986004, 12439.129260951737, 12615.936920315431, 12706.0, 12770.616881493477, 1692.9068901210428, 1766.7968183658786, 1826.8447181989548, 1837.6508463391913, 1844.815518448158, 51912.48087519114, 53467.46532534664, 53592.73203633957, 53874.46125538773, 54205.0, 9440.150386465113, 9602.66390676323, 9794.608215671436, 9800.852987205197, 9896.950515247378, 12887.871121288666, 12949.417276222404, 12969.935150324189, 12978.805317920238, 12979.35103244834, 7292.0, 7311.780646580611, 7375.041244638162, 7395.889061664079, 7445.627718614048, 6743.494237932175, 6785.0, 6796.082528858639, 6860.862782744317, 7065.046218760504, 5728.79949201776, 5886.381929897385, 5890.4993075589055, 5918.585699001114, 5947.078202878561, 1646.415522489523, 1729.5589624645886, 1740.5474576610172, 1776.3693888669336, 1801.8108098649716, 951.7192428233687, 997.486294558303, 1004.2977153724513, 1032.2206733915996, 1067.9679609611724, 10887.733679895999, 11041.619797525309, 11074.889251107386, 16290.348386064425, 17052.914735426242, 444.5376808119584, 445.4876891574715, 453.90921815637006, 460.3715927758652, 478.66254290724953, 5057.367829021372, 5924.407559244041, 6004.279486461653, 6040.818775436744, 6293.496520278367, 402618.0, 402744.0, 407564.0, 563588.0, 572747.0, 53338.466615334124, 68478.65760671264, 71955.64022179856, 72632.63683681548, 74122.62938685271, 469.7064334790756, 476.7235003697847, 478.72473327836633, 479.0323546436249, 483.1183090859196, 10153.593856245667, 13952.16287022782, 14775.187364695044, 15048.398064077313, 15048.699026019638, 26664.933402663675, 31089.0, 32250.0, 32252.35495290128, 33803.66196338005, 38533.0, 38628.806855966664, 38858.6114138855, 39050.2189956205, 40370.394444082776, 7233.0, 7517.398608111447, 7585.658645360862, 7615.504992175491, 7644.579548124684, 10045.949770251102, 10916.235863489479, 11187.440627968732, 11228.326300422, 11409.828852567052, 9557.90442095598, 9732.513374331114, 9795.755106122118, 9880.950595246977, 9904.50477476109, 9332.860007099764, 9480.762980925532, 9658.613655453984, 9817.116459518678, 9978.600855965971, 9564.808703826024, 9913.008699130029, 10033.09702126812, 10169.288149829441, 10204.846927296245, 7457.440691948234, 7491.213422590768, 7531.0, 7646.65590048438, 7657.923420765721, 9412.529373531434, 9657.517124143906, 9702.6118955241, 9702.805943881223, 9729.367591106555], "unit": "score", "name": "jquery.html", "value": 7682.973283213222}, {"lowerIsBetter": false, "replicates": [1314.231174762765, 1465.5530063330684, 1477.3351991603777, 1629.5518732348603, 1790.588164722113, 6963.860722785541, 7671.0794704635455, 7838.490498117619, 7850.96074519628, 7873.448858579902, 7725.768226953186, 7915.643796029178, 7932.286094251531, 7933.682652693886, 7934.365250779938, 2043.8875861827594, 2088.6136064828056, 2091.7489901211798, 2319.223060274806, 2343.8945247463903, 2298.609236429811, 2348.1898744933055, 2351.5179388225374, 2353.9176128835493, 2357.49313897512, 2300.217925905192, 2307.3424074138875, 2312.1213938703268, 2372.738998710149, 2374.6438034294906, 2288.645259984705, 2288.771122887698, 2291.5531471363174, 2296.8392212545127, 2368.7631236876346, 2316.073570571768, 2324.651302304651, 2325.5581439526436, 2337.9181728639414, 2345.906163753448, 7849.372050235967, 7893.526388416656, 7903.604819758989, 7906.090799558067, 7912.09010963735, 4908.680935739166, 4998.200287953946, 5000.174971129759, 5040.319556859814, 5044.747762611854, 2914.693957134513, 2933.6772954974936, 2951.453981013498, 2972.390659914712, 3073.9538906916414, 913.4199783137689, 922.4004397141845, 924.8474001789697, 946.668665966913, 948.7817801905601, 11007.889921100767, 11011.119110471143, 11017.338959662366, 11038.834417483744, 11059.391733454657, 4412.4043254160915, 4438.423005009328, 4509.571590698878, 4513.255312873339, 4517.390152329459, 9286.535673216313, 9350.532473376305, 9355.345125841262, 9389.671361502315, 9399.57701903416, 4947.727874966839, 4980.601551875841, 4987.600991920638, 4995.0, 4995.0259699359, 4495.617872480811, 4505.909881802346, 4509.323601459741, 4510.977445112753, 4519.706219095749, 3509.578850537952, 3630.3465376232, 3771.5097037384962, 3782.167923056923, 3921.686265098785, 1178.0, 1180.262336039975, 1206.4691535724253, 1220.023980815362, 1239.3493415956696, 1301.9739605207842, 1302.3813688498078, 1302.5115581656878, 1302.8697130286896, 1327.2965328375976, 7212.891806622905, 7353.852922941511, 7416.184219735825, 7416.888746668804, 7429.21993190718, 1108.467935391017, 1137.5108703257513, 1140.766142940695, 1148.104478506766, 1154.272808130889, 5691.203231547586, 5792.82621521355, 5847.152162936351, 5848.181254624356, 5854.912176317359, 9066.410683305565, 9181.954090229507, 9345.766355841159, 9391.859122113174, 9433.952830235805, 9328.813423731623, 9356.766080848034, 9374.85937710935, 9378.202852757455, 9382.671606493877, 7195.640217989079, 7218.6390680465765, 7454.1800401956825, 7461.1419686735635, 7466.066741657293, 7333.523320984119, 7396.593187374746, 7412.592307423143, 7416.0, 7423.517471364344, 8110.5944702763445, 8197.098319185005, 8412.537310447984, 8449.535275559903, 8582.0, 8263.00843898736, 8422.073571907207, 8474.915250847413, 8646.654133834827, 8660.307175426076, 6945.513814032969, 7029.402500787491, 7070.964645176741, 7080.433565314659, 7082.5396349237135, 6795.694193761194, 6961.965190174219, 7082.327178917994, 7238.203797582157, 7370.44721645868, 6851.383375496229, 7022.894656580258, 7052.18899826506, 7063.894041589483, 7169.247229040876, 6771.93228067713, 6920.273371295942, 6939.618320992394, 6949.861002780017, 7095.184053833668, 6712.194536655633, 6745.156855393076, 6765.86468270622, 6773.356531129535, 6785.0, 6369.554131210771, 6374.58565193261, 6377.87244255103, 6385.169927909342, 6393.073004414241, 6390.169277993831, 6422.775202867877, 6441.259255185713, 6456.7740129095255, 6457.6771161442675], "unit": "score", "name": "mootools.html", "value": 4535.309531003458}, {"lowerIsBetter": false, "replicates": [332.77372880933757, 339.91841957930086, 344.72249838879725, 344.9620541740408, 349.22646338360545, 5676.063449530833, 5762.740676669549, 5800.15897694834, 5857.502112320447, 5877.970610146948, 5581.0, 5665.971670141654, 5670.319561652597, 5689.061304884699, 5709.514691251248, 4424.070945101533, 4430.822767089328, 4445.711028783135, 4460.509343972152, 4466.464024317086, 4238.131183107471, 4338.414314067592, 4345.261305578059, 4347.956520434803, 4449.399331090293, 4335.6748243881675, 4436.401085853417, 4439.75581343026, 4442.622377097934, 4453.955460445386, 4417.469903611587, 4421.182081314967, 4425.712328698656, 4426.911461770746, 4438.866833994985, 3913.256481268578, 3937.1928754605237, 3938.3107956107565, 3944.191440754667, 3944.6390995106644, 5402.216678581623, 5508.504234618864, 5520.91718624221, 5523.199136125239, 5542.168674698827, 5163.070647283487, 5163.845084647466, 5164.122099243138, 5172.043172013189, 5173.508516690908, 6066.757329706807, 6071.089336599502, 6077.544184186204, 6078.513718902477, 6082.209312789353, 4129.97935010323, 4234.703570750049, 4269.7224680395675, 4350.8912277193, 4359.978200109011, 6302.527310451688, 6325.114483972247, 6325.5255855811, 6335.524835637391, 6345.96827015862, 4453.554644535585, 4459.063596644676, 4459.264221403432, 4463.5313292103865, 4464.285714285698, 4425.977870110629, 4450.755208463565, 4495.865124046284, 4495.9325610115875, 4497.257952437811, 5142.0, 5151.5106064923775, 5152.742362881841, 5154.458781827929, 5155.381354237516, 6099.878002439927, 6101.481374083164, 6116.571839971249, 6120.724567394478, 6121.938780612226, 1579.3287852662572, 1592.2516417283857, 1593.4661888267328, 1593.8087429508532, 1596.0822527046994, 1087.1628845788698, 1096.2874131814385, 1096.6785024046005, 1098.2751384086464, 1122.2761318949395, 5813.12803079533, 5830.679312637761, 5832.62087964281, 5841.2990441146485, 5845.357010728816, 6256.092866534327, 6310.495160387158, 6330.39861213184, 6333.334999825044, 6352.301246862841, 5787.88424231513, 5806.88386232273, 5811.128330750421, 5823.4467725566, 5856.209411729447, 3282.638909719929, 3378.847951842173, 3380.8478618462227, 3386.6782655647676, 3393.457046872538, 6440.903386449207, 6449.806505804833, 6450.48396128318, 6451.870962580722, 6456.063870738717, 6391.96804015977, 6397.776077837253, 6402.9359706403275, 6404.327545607644, 6405.807825765234, 6361.0, 6514.837129071811, 6517.8696426072165, 6520.0871877937125, 6527.445167160749, 6088.665123418255, 6251.124842521959, 6255.843603909757, 6261.65560894137, 6263.749450021948, 6128.66292353907, 6175.96912015437, 6257.374262573706, 6265.592736472115, 6270.686465676789, 6543.574667646588, 6573.04690819838, 6582.572132811543, 6583.572067815577, 6588.374104460068, 4425.070735145656, 4427.734335939854, 4430.158269928703, 4431.113777244628, 4437.9334309986025, 6190.721417536131, 6351.523635727432, 6375.043743438521, 6381.649009304533, 6384.106225128393, 6115.7247923844425, 6139.386061393825, 6140.785072522441, 6144.969275153596, 6154.661493617894, 6105.389461053859, 6105.504151482737, 6114.510839132769, 6117.0, 6122.326544080059, 5905.173275741486, 6040.637561746309, 6045.78839740607, 6046.0, 6048.667323297261, 6123.4488895999575, 6155.569110162246, 6165.630062196283, 6169.660668663267, 6173.753049877954, 5988.610740301867, 5988.730507127103, 5989.0, 5991.0, 5991.550633702403], "unit": "score", "name": "prototype.html", "value": 4639.941785609982}, {"lowerIsBetter": false, "replicates": [718.6550455781224, 739.6782399656148, 778.3695206882426, 795.0, 805.3156807605205, 12529.436175372108, 12702.301373424458, 12707.538633057202, 12718.872811271907, 12919.160254583458, 12330.876691233085, 12540.498380064786, 12592.811107833368, 12653.873461265384, 12801.935990320058, 798.9520628762293, 806.7297455352434, 812.3907069697726, 812.585581353511, 812.6668066092903, 800.2597597222575, 805.4241217529466, 807.0597753617029, 807.5558442856405, 807.5598798654747, 843.2663582683074, 843.3337663246028, 843.5782108945527, 843.7089204224563, 844.0167205205928, 836.8493671139192, 838.8993320801512, 838.9496630202208, 839.2195258409677, 844.8056946902216, 618.8638499530097, 619.5817822969477, 620.9844753881189, 622.7384498510592, 622.7789134857106, 12681.492740290378, 12781.297028663419, 12792.168509046882, 12808.295543745091, 12814.615561533168, 12146.93472325639, 12176.756464870654, 12315.876841231562, 12361.0, 12675.0, 10086.949565252127, 10271.28101032928, 10321.019503147189, 10333.58665653373, 10583.629572964986, 3483.094395457174, 3569.4824250483794, 3598.7300952428673, 3652.7077833773233, 3660.2313514162056, 46249.30626040612, 46421.0, 46476.76761616204, 46686.5331346689, 47077.29384059208, 9589.616415343447, 9726.465044422624, 9764.560594773111, 9903.653372131941, 9977.600895964226, 16991.55571776388, 17025.659486810444, 17026.404075857285, 17037.829621703873, 17058.402955896483, 7213.508338541813, 7351.852962940711, 7418.072740907387, 7523.435742319348, 7603.619819009027, 4146.357314616239, 4148.647364974011, 4152.522459917088, 4285.550017248206, 4303.053328267776, 2982.746466550324, 3009.8043627164166, 3012.0662594595747, 3018.5773991641186, 3049.725524702743, 550.0950935710733, 567.0473604344658, 576.0236399303141, 576.032265793471, 582.2547139661241, 540.2706346432285, 562.6511562830989, 621.4003486635419, 637.5760119520467, 683.2108914204102, 9076.273898088137, 9477.0, 9500.382475139093, 9738.853917191247, 9743.220542356594, 577.887311974161, 603.7434090511515, 677.5629718831326, 687.7902239816904, 693.8820400531922, 4080.8571699990357, 4382.496012958551, 4385.693001489929, 4423.358613001097, 4428.68999170055, 50936.74531627318, 56723.0, 58182.0, 58701.41298587045, 58708.706456467444, 44204.336934946004, 44973.77513112414, 45057.098858022655, 45597.7720111404, 50071.24893126606, 40727.0, 40734.0, 40857.59142408597, 41689.0, 41765.791171044555, 8380.329573633973, 8739.475631462132, 8793.428427152214, 8834.823303533765, 9086.772830679285, 29831.403371932007, 30266.24334391658, 35177.120571985906, 35964.28071438609, 36090.0, 43785.56214437942, 44054.0, 44163.11673766571, 44586.3312050326, 44865.77567112144, 11476.655700329004, 11543.595974140864, 11683.763566737314, 11777.175597708421, 11871.878339089892, 11546.307221566733, 11830.645080647595, 11867.821982670439, 12256.632301030982, 12487.0, 11273.323600583992, 11598.362090085126, 11662.94168529152, 11930.940345298219, 11938.462769175234, 11528.365939873052, 11831.171817973003, 11858.169928105295, 11927.165098443373, 12326.137170397986, 10366.681304642683, 10645.89354106449, 10786.191035672198, 10796.469813739724, 10805.891941080488, 9510.0, 9837.057912912305, 9871.555779989774, 9935.701928942144, 10260.692179234635, 9123.954380228057, 9322.440653560809, 9382.906170938477, 9589.856152157583, 10092.949535252277], "unit": "score", "name": "yui.html", "value": 6222.803542494694}], "name": "dromaeo_css", "value": 6700.69134161309}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 108.0, 111.0, 109.0, 112.0, 111.0, 111.0, 106.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [155.0, 125.0, 153.0, 168.0, 126.0, 145.0, 150.0, 134.0, 168.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 145.5}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 161.0, 161.0, 162.0, 160.0, 159.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 96.0, 95.0, 75.0, 73.0, 72.0, 115.0, 102.0, 73.0], "unit": "score", "name": "audio-fft", "value": 86.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 140.0, 101.0, 96.0, 96.0, 148.0, 97.0, 97.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 110.2}, {"lowerIsBetter": true, "replicates": [110.0, 108.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 108.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 55.0, 56.0, 55.0, 57.0, 57.0, 57.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.9}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 79.0, 67.0, 69.0, 68.0, 70.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 82.0, 82.0, 81.0, 81.0, 89.0, 85.0, 82.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.7}, {"lowerIsBetter": true, "replicates": [123.0, 114.0, 119.0, 114.0, 113.0, 112.0, 119.0, 115.0, 115.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.7}, {"lowerIsBetter": true, "replicates": [145.0, 138.0, 145.0, 154.0, 146.0, 134.0, 144.0, 133.0, 145.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.8}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 67.0, 65.0, 68.0, 65.0, 65.0, 65.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.0}], "name": "kraken", "value": 1497.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.47613465081227], "unit": "score", "name": "Richards", "value": 210.7882419999999}, {"lowerIsBetter": false, "replicates": [189.2147587511826], "unit": "score", "name": "DeltaBlue", "value": 349.43363}, {"lowerIsBetter": false, "replicates": [279.17364600781684], "unit": "score", "name": "Encrypt", "value": 953.4603419999996}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [1107.4197120708748], "unit": "score", "name": "RayTrace", "value": 668.2100670000003}, {"lowerIsBetter": false, "replicates": [791.7656373713381], "unit": "score", "name": "Earley", "value": 841.7427690000002}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [42437.5], "unit": "score", "name": "RegExp", "value": 21.466509572901316}, {"lowerIsBetter": false, "replicates": [588.9281507656066], "unit": "score", "name": "Splay", "value": 138.37171800000004}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20056.025220212832}]} 05:34:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20056.03"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1497.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6700.69"}}} 05:34:08 INFO - Return code: 0 05:34:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:34:08 INFO - # TBPL SUCCESS # 05:34:08 INFO - Running post-action listener: _resource_record_post_action 05:34:08 INFO - Running post-run listener: _resource_record_post_run 05:34:10 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 8192; Write bytes: 308469760; Read time: 196; Write time: 217776 05:34:10 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5996544; Read time: 0; Write time: 380 05:34:10 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 8192; Write bytes: 302473216; Read time: 196; Write time: 217396 05:34:10 INFO - Running post-run listener: _upload_blobber_files 05:34:10 INFO - Blob upload gear active. 05:34:10 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:34:10 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 05:34:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:34:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:34:10 INFO - (blobuploader) - INFO - Open directory for files ... 05:34:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:34:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:34:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:34:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:34:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:34:11 INFO - (blobuploader) - INFO - Done attempting. 05:34:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:34:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:34:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:34:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:34:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:34:12 INFO - (blobuploader) - INFO - Done attempting. 05:34:12 INFO - (blobuploader) - INFO - Iteration through files over. 05:34:12 INFO - Return code: 0 05:34:12 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:34:12 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:34:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/0937234dc59868467f6a29b10cb53de802207f6fa6a0462958ce1c8e31c3ceb76ec3d729ff1be709c199dc9cdbd1a1624614e26eeb3696cacc4a6d9d56002494", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/92a93fab282fbf91d421da93640c69b5d225f66198490289dda4d73e1794b7cc88db392990d700788fddce720cc42a0e43a1686523279f8d74040e1399d8e90b"} 05:34:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:34:12 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:34:12 INFO - Contents: 05:34:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/0937234dc59868467f6a29b10cb53de802207f6fa6a0462958ce1c8e31c3ceb76ec3d729ff1be709c199dc9cdbd1a1624614e26eeb3696cacc4a6d9d56002494", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/92a93fab282fbf91d421da93640c69b5d225f66198490289dda4d73e1794b7cc88db392990d700788fddce720cc42a0e43a1686523279f8d74040e1399d8e90b"} 05:34:12 INFO - Running post-run listener: copy_logs_to_upload_dir 05:34:12 INFO - Copying logs to upload dir... 05:34:12 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:34:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1304.391804 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 44 secs) (at 2016-01-20 05:34:11.460297) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 05:34:11.463907) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/0937234dc59868467f6a29b10cb53de802207f6fa6a0462958ce1c8e31c3ceb76ec3d729ff1be709c199dc9cdbd1a1624614e26eeb3696cacc4a6d9d56002494", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/92a93fab282fbf91d421da93640c69b5d225f66198490289dda4d73e1794b7cc88db392990d700788fddce720cc42a0e43a1686523279f8d74040e1399d8e90b"} build_url:https://queue.taskcluster.net/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011291 build_url: 'https://queue.taskcluster.net/v1/task/J2vEhEZLSFmnw3f-a2pmmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/0937234dc59868467f6a29b10cb53de802207f6fa6a0462958ce1c8e31c3ceb76ec3d729ff1be709c199dc9cdbd1a1624614e26eeb3696cacc4a6d9d56002494", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/92a93fab282fbf91d421da93640c69b5d225f66198490289dda4d73e1794b7cc88db392990d700788fddce720cc42a0e43a1686523279f8d74040e1399d8e90b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 05:34:11.488749) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:34:11.489075) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1453295258.294579-354976423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004399 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:34:11.572213) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 05:34:11.572545) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 05:34:11.572846) ========= ========= Total master_lag: 0.28 =========