builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-045 starttime: 1452778284.94 results: success (0) buildid: 20160114030246 builduid: 17ab2e707d59461cbabc0b1a911d506d revision: 6fa2ab99f52feb1b6ead5581b8f5d398546a55a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 05:31:24.937886) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 05:31:24.938351) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 05:31:24.938637) ========= 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=1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006570 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 05:31:24.963571) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 05:31:24.963853) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 05:31:24.992814) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 05:31:24.993094) ========= 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=1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.027500 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 05:31:25.043587) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 05:31:25.043862) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 05:31:25.044255) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 05:31:25.044529) ========= 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=1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 05:31:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 61.9M=0s 2016-01-14 05:31:25 (61.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104462 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 05:31:25.161012) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 05:31:25.161315) ========= 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=1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.038309 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 05:31:25.211396) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-14 05:31:25.211739) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6fa2ab99f52feb1b6ead5581b8f5d398546a55a5 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 6fa2ab99f52feb1b6ead5581b8f5d398546a55a5 --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=1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 05:31:25,282 truncating revision to first 12 chars 2016-01-14 05:31:25,282 Setting DEBUG logging. 2016-01-14 05:31:25,283 attempt 1/10 2016-01-14 05:31:25,283 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6fa2ab99f52f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-14 05:31:26,334 unpacking tar archive at: mozilla-central-6fa2ab99f52f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.399398 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-14 05:31:26.623336) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 05:31:26.623635) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 05:31:26.634523) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 05:31:26.634829) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 05:31:26.635257) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2016-01-14 05:31:26.635540) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:31:26 INFO - MultiFileLogger online at 20160114 05:31:26 in /builds/slave/test-pgo 05:31:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:31:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:31:26 INFO - {'append_to_log': False, 05:31:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:31:26 INFO - 'blob_upload_branch': 'Firefox', 05:31:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:31:26 INFO - 'branch': 'Firefox', 05:31:26 INFO - 'buildbot_json_path': 'buildprops.json', 05:31:26 INFO - 'config_files': ('talos/linux_config.py',), 05:31:26 INFO - 'default_actions': ('clobber', 05:31:26 INFO - 'read-buildbot-config', 05:31:26 INFO - 'download-and-extract', 05:31:26 INFO - 'populate-webroot', 05:31:26 INFO - 'create-virtualenv', 05:31:26 INFO - 'install', 05:31:26 INFO - 'run-tests'), 05:31:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:31:26 INFO - 'download_minidump_stackwalk': True, 05:31:26 INFO - 'download_symbols': 'ondemand', 05:31:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:31:26 INFO - 'tooltool.py': '/tools/tooltool.py', 05:31:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:31:26 INFO - '/tools/misc-python/virtualenv.py')}, 05:31:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:31:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:31:26 INFO - 'installer_path': 'installer.exe', 05:31:26 INFO - 'log_level': 'info', 05:31:26 INFO - 'log_name': 'talos', 05:31:26 INFO - 'log_to_console': True, 05:31:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:31:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:31:26 INFO - 'opt_config_files': (), 05:31:26 INFO - 'pip_index': False, 05:31:26 INFO - 'sps_profile': False, 05:31:26 INFO - 'sps_profile_interval': 0, 05:31:26 INFO - 'suite': 'dromaeojs-e10s', 05:31:26 INFO - 'system_bits': '32', 05:31:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:31:26 INFO - 'title': 'talos-linux64-ix-045', 05:31:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:31:26 INFO - 'use_talos_json': True, 05:31:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:31:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:31:26 INFO - 'work_dir': 'build'} 05:31:26 INFO - ##### 05:31:26 INFO - ##### Running clobber step. 05:31:26 INFO - ##### 05:31:26 INFO - Running pre-action listener: _resource_record_pre_action 05:31:26 INFO - Running main action method: clobber 05:31:26 INFO - rmtree: /builds/slave/test-pgo/build 05:31:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:31:31 INFO - Running post-action listener: _resource_record_post_action 05:31:31 INFO - ##### 05:31:31 INFO - ##### Running read-buildbot-config step. 05:31:31 INFO - ##### 05:31:31 INFO - Running pre-action listener: _resource_record_pre_action 05:31:31 INFO - Running main action method: read_buildbot_config 05:31:31 INFO - Using buildbot properties: 05:31:31 INFO - { 05:31:31 INFO - "project": "", 05:31:31 INFO - "product": "firefox", 05:31:31 INFO - "script_repo_revision": "production", 05:31:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:31:31 INFO - "repository": "", 05:31:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:31:31 INFO - "buildid": "20160114030246", 05:31:31 INFO - "stage_platform": "linux64-pgo", 05:31:31 INFO - "basedir": "/builds/slave/test-pgo", 05:31:31 INFO - "nightly_build": "True", 05:31:31 INFO - "buildnumber": 618, 05:31:31 INFO - "slavename": "talos-linux64-ix-045", 05:31:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:31:31 INFO - "platform": "ubuntu64_hw", 05:31:31 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:31:31 INFO - "branch": "mozilla-central", 05:31:31 INFO - "repo_path": "mozilla-central", 05:31:31 INFO - "revision": "6fa2ab99f52feb1b6ead5581b8f5d398546a55a5", 05:31:31 INFO - "pgo_build": "True", 05:31:31 INFO - "builduid": "17ab2e707d59461cbabc0b1a911d506d", 05:31:31 INFO - "slavebuilddir": "test" 05:31:31 INFO - } 05:31:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:31:31 INFO - Running post-action listener: _resource_record_post_action 05:31:31 INFO - ##### 05:31:31 INFO - ##### Running download-and-extract step. 05:31:31 INFO - ##### 05:31:31 INFO - Running pre-action listener: _resource_record_pre_action 05:31:31 INFO - Running main action method: download_and_extract 05:31:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:31:31 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:31:31 INFO - https://queue.taskcluster.net/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:31:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/artifacts/public/build/test_packages.json 05:31:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/artifacts/public/build/test_packages.json 05:31:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:31:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:31:32 INFO - Downloaded 1448 bytes. 05:31:32 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:31:32 INFO - Using the following test package requirements: 05:31:32 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:31:32 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:31:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:31:32 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:31:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:31:32 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:31:32 INFO - u'jsshell-linux-x86_64.zip'], 05:31:32 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:31:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:31:32 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:31:32 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:31:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:31:32 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:31:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:31:32 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:31:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:31:32 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:31:32 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:31:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:31:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:33 INFO - https://queue.taskcluster.net/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:31:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:31:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:31:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/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:31:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/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:31:44 INFO - Downloaded 24030700 bytes. 05:31:44 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:31:44 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:31:46 INFO - Return code: 0 05:31:46 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:31:46 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:31:46 INFO - https://queue.taskcluster.net/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:31:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:31:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:31:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/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:31:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/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:31:51 INFO - Downloaded 24030700 bytes. 05:31:51 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:31:51 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:31:52 INFO - Return code: 0 05:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:52 INFO - https://queue.taskcluster.net/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:31:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:31:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:31:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/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:31:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/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:31:55 INFO - Downloaded 11132144 bytes. 05:31:55 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:31:55 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:31:55 INFO - Return code: 0 05:31:55 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:31:55 INFO - https://queue.taskcluster.net/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:31:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:31:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:31:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/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:31:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/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:32:00 INFO - Downloaded 55883159 bytes. 05:32:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:32:00 INFO - mkdir: /builds/slave/test-pgo/properties 05:32:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:32:00 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:32:00 INFO - Contents: 05:32:00 INFO - build_url:https://queue.taskcluster.net/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:32:00 INFO - Running post-action listener: _resource_record_post_action 05:32:00 INFO - Running post-action listener: set_extra_try_arguments 05:32:00 INFO - ##### 05:32:00 INFO - ##### Running populate-webroot step. 05:32:00 INFO - ##### 05:32:00 INFO - Running pre-action listener: _resource_record_pre_action 05:32:00 INFO - Running main action method: populate_webroot 05:32:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:32:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:32:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:32:00 INFO - '--tppagecycles', 05:32:00 INFO - '7'], 05:32:00 INFO - 'tests': ['tsvgm']}}, 05:32:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:32:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:32:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:32:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:32:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:32:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:32:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:00 INFO - 'talos_options': ['--e10s'], 05:32:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:00 INFO - 'tests': ['damp', 'tps']}, 05:32:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:00 INFO - 'talos_options': ['--e10s'], 05:32:00 INFO - 'tests': ['damp', 'tps']}, 05:32:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:32:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:32:00 INFO - 'other': {'tests': ['a11yr', 05:32:00 INFO - 'ts_paint', 05:32:00 INFO - 'tpaint', 05:32:00 INFO - 'sessionrestore', 05:32:00 INFO - 'sessionrestore_no_auto_restore']}, 05:32:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:32:00 INFO - 'tests': ['a11yr', 05:32:00 INFO - 'ts_paint', 05:32:00 INFO - 'tpaint', 05:32:00 INFO - 'sessionrestore', 05:32:00 INFO - 'sessionrestore_no_auto_restore']}, 05:32:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:32:00 INFO - 'tests': ['a11yr', 05:32:00 INFO - 'ts_paint', 05:32:00 INFO - 'tpaint', 05:32:00 INFO - 'sessionrestore', 05:32:00 INFO - 'sessionrestore_no_auto_restore']}, 05:32:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:32:00 INFO - 'tests': ['a11yr', 05:32:00 INFO - 'ts_paint', 05:32:00 INFO - 'tpaint', 05:32:00 INFO - 'sessionrestore', 05:32:00 INFO - 'sessionrestore_no_auto_restore']}, 05:32:00 INFO - 'other_l64': {'tests': ['a11yr', 05:32:00 INFO - 'ts_paint', 05:32:00 INFO - 'tpaint', 05:32:00 INFO - 'sessionrestore', 05:32:00 INFO - 'sessionrestore_no_auto_restore']}, 05:32:00 INFO - 'other_nol64': {'tests': ['a11yr', 05:32:00 INFO - 'ts_paint', 05:32:00 INFO - 'tpaint', 05:32:00 INFO - 'sessionrestore', 05:32:00 INFO - 'sessionrestore_no_auto_restore']}, 05:32:00 INFO - 'svgr': {'tests': ['tsvgx', 05:32:00 INFO - 'tsvgr_opacity', 05:32:00 INFO - 'tart', 05:32:00 INFO - 'tscrollx', 05:32:00 INFO - 'cart']}, 05:32:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:32:00 INFO - 'tests': ['tsvgx', 05:32:00 INFO - 'tsvgr_opacity', 05:32:00 INFO - 'tart', 05:32:00 INFO - 'tscrollx', 05:32:00 INFO - 'cart']}, 05:32:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:00 INFO - 'tests': ['tp5o']}, 05:32:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:00 INFO - 'talos_options': ['--e10s'], 05:32:00 INFO - 'tests': ['tp5o']}, 05:32:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:00 INFO - 'talos_options': ['--xperf_path', 05:32:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:00 INFO - 'tests': ['tp5n']}, 05:32:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:00 INFO - 'talos_options': ['--e10s', 05:32:00 INFO - '--xperf_path', 05:32:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:00 INFO - 'tests': ['tp5n']}}, 05:32:00 INFO - 'talos.zip': {'path': '', 05:32:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:32:00 INFO - Running post-action listener: _resource_record_post_action 05:32:00 INFO - ##### 05:32:00 INFO - ##### Running create-virtualenv step. 05:32:00 INFO - ##### 05:32:00 INFO - Running pre-action listener: _resource_record_pre_action 05:32:00 INFO - Running main action method: create_virtualenv 05:32:00 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:32:00 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:32:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:32:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:32:00 INFO - Using real prefix '/usr' 05:32:00 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:32:00 INFO - Installing distribute.............................................................................................................................................................................................done. 05:32:02 INFO - Installing pip.................done. 05:32:02 INFO - Return code: 0 05:32:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:32:02 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:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:02 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:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f4950d17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0c840>, '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 0xe796b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe79b60>, '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': '1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118', '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:32:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:32:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:32:02 INFO - Using env: {'DISPLAY': ':0', 05:32:02 INFO - 'HOME': '/home/cltbld', 05:32:02 INFO - 'LANG': 'en_US.UTF-8', 05:32:02 INFO - 'LANGUAGE': 'en_US:en', 05:32:02 INFO - 'LOGNAME': 'cltbld', 05:32:02 INFO - 'MAIL': '/var/mail/cltbld', 05:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:02 INFO - 'MOZ_NO_REMOTE': '1', 05:32:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:02 INFO - 'NO_EM_RESTART': '1', 05:32:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:32:02 INFO - 'PWD': '/builds/slave/test-pgo', 05:32:02 INFO - 'SHELL': '/bin/bash', 05:32:02 INFO - 'SHLVL': '1', 05:32:02 INFO - 'TERM': 'linux', 05:32:02 INFO - 'TMOUT': '86400', 05:32:02 INFO - 'USER': 'cltbld', 05:32:02 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118', 05:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:02 INFO - '_': '/tools/buildbot/bin/python'} 05:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:03 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:32:03 INFO - Cleaning up... 05:32:03 INFO - Return code: 0 05:32:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:32:03 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:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:03 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:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f4950d17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0c840>, '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 0xe796b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe79b60>, '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': '1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118', '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:32:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:32:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:32:03 INFO - Using env: {'DISPLAY': ':0', 05:32:03 INFO - 'HOME': '/home/cltbld', 05:32:03 INFO - 'LANG': 'en_US.UTF-8', 05:32:03 INFO - 'LANGUAGE': 'en_US:en', 05:32:03 INFO - 'LOGNAME': 'cltbld', 05:32:03 INFO - 'MAIL': '/var/mail/cltbld', 05:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:03 INFO - 'MOZ_NO_REMOTE': '1', 05:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:03 INFO - 'NO_EM_RESTART': '1', 05:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:32:03 INFO - 'PWD': '/builds/slave/test-pgo', 05:32:03 INFO - 'SHELL': '/bin/bash', 05:32:03 INFO - 'SHLVL': '1', 05:32:03 INFO - 'TERM': 'linux', 05:32:03 INFO - 'TMOUT': '86400', 05:32:03 INFO - 'USER': 'cltbld', 05:32:03 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118', 05:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:03 INFO - '_': '/tools/buildbot/bin/python'} 05:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:03 INFO - Downloading/unpacking psutil>=0.7.1 05:32:03 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:32:03 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:32:03 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:32:03 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:32:03 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:32:03 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:32:05 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:32:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:32:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:32:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:05 INFO - Installing collected packages: psutil 05:32:05 INFO - Running setup.py install for psutil 05:32:05 INFO - building 'psutil._psutil_linux' extension 05:32:05 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:32:05 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:32:05 INFO - building 'psutil._psutil_posix' extension 05:32:05 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:32:05 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:32:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:05 INFO - Successfully installed psutil 05:32:05 INFO - Cleaning up... 05:32:05 INFO - Return code: 0 05:32:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:32: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:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f4950d17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0c840>, '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 0xe796b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe79b60>, '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': '1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118', '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:32:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:32:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:32:05 INFO - Using env: {'DISPLAY': ':0', 05:32:05 INFO - 'HOME': '/home/cltbld', 05:32:05 INFO - 'LANG': 'en_US.UTF-8', 05:32:05 INFO - 'LANGUAGE': 'en_US:en', 05:32:05 INFO - 'LOGNAME': 'cltbld', 05:32:05 INFO - 'MAIL': '/var/mail/cltbld', 05:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:05 INFO - 'MOZ_NO_REMOTE': '1', 05:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:05 INFO - 'NO_EM_RESTART': '1', 05:32:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:32:05 INFO - 'PWD': '/builds/slave/test-pgo', 05:32:05 INFO - 'SHELL': '/bin/bash', 05:32:05 INFO - 'SHLVL': '1', 05:32:05 INFO - 'TERM': 'linux', 05:32:05 INFO - 'TMOUT': '86400', 05:32:05 INFO - 'USER': 'cltbld', 05:32:05 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118', 05:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:05 INFO - '_': '/tools/buildbot/bin/python'} 05:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:32:05 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:32:05 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:32:05 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:32:05 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:32:05 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:32:05 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:32:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:32:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:32:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:32:07 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:32:07 INFO - Installing collected packages: mozsystemmonitor 05:32:07 INFO - Running setup.py install for mozsystemmonitor 05:32:07 INFO - Successfully installed mozsystemmonitor 05:32:07 INFO - Cleaning up... 05:32:07 INFO - Return code: 0 05:32:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f4950d17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0c840>, '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 0xe796b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe79b60>, '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': '1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118', '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:32:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:32:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:32:07 INFO - Using env: {'DISPLAY': ':0', 05:32:07 INFO - 'HOME': '/home/cltbld', 05:32:07 INFO - 'LANG': 'en_US.UTF-8', 05:32:07 INFO - 'LANGUAGE': 'en_US:en', 05:32:07 INFO - 'LOGNAME': 'cltbld', 05:32:07 INFO - 'MAIL': '/var/mail/cltbld', 05:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:07 INFO - 'MOZ_NO_REMOTE': '1', 05:32:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:07 INFO - 'NO_EM_RESTART': '1', 05:32:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:32:07 INFO - 'PWD': '/builds/slave/test-pgo', 05:32:07 INFO - 'SHELL': '/bin/bash', 05:32:07 INFO - 'SHLVL': '1', 05:32:07 INFO - 'TERM': 'linux', 05:32:07 INFO - 'TMOUT': '86400', 05:32:07 INFO - 'USER': 'cltbld', 05:32:07 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118', 05:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:07 INFO - '_': '/tools/buildbot/bin/python'} 05:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:08 INFO - Downloading/unpacking blobuploader==1.2.4 05:32:08 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:32:08 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:32:08 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:32:08 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:32:08 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:32:08 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:32:09 INFO - Downloading blobuploader-1.2.4.tar.gz 05:32:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:32:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:32:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:32:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:32:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:32: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:32: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:32: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:32: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:32: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:32: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:32:10 INFO - Downloading docopt-0.6.1.tar.gz 05:32:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:32:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:32:10 INFO - Installing collected packages: blobuploader, requests, docopt 05:32:10 INFO - Running setup.py install for blobuploader 05:32:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:32:10 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:32:10 INFO - Running setup.py install for requests 05:32:11 INFO - Running setup.py install for docopt 05:32:11 INFO - Successfully installed blobuploader requests docopt 05:32:11 INFO - Cleaning up... 05:32:11 INFO - Return code: 0 05:32:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f4950d17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0c840>, '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 0xe796b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe79b60>, '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': '1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118', '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:32:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:32:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --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:32:11 INFO - Using env: {'DISPLAY': ':0', 05:32:11 INFO - 'HOME': '/home/cltbld', 05:32:11 INFO - 'LANG': 'en_US.UTF-8', 05:32:11 INFO - 'LANGUAGE': 'en_US:en', 05:32:11 INFO - 'LOGNAME': 'cltbld', 05:32:11 INFO - 'MAIL': '/var/mail/cltbld', 05:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:11 INFO - 'MOZ_NO_REMOTE': '1', 05:32:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:11 INFO - 'NO_EM_RESTART': '1', 05:32:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:32:11 INFO - 'PWD': '/builds/slave/test-pgo', 05:32:11 INFO - 'SHELL': '/bin/bash', 05:32:11 INFO - 'SHLVL': '1', 05:32:11 INFO - 'TERM': 'linux', 05:32:11 INFO - 'TMOUT': '86400', 05:32:11 INFO - 'USER': 'cltbld', 05:32:11 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118', 05:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:11 INFO - '_': '/tools/buildbot/bin/python'} 05:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:32:12 INFO - Running setup.py (path:/tmp/pip-LPVLCd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:32:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:32:12 INFO - Running setup.py (path:/tmp/pip-XQXUtn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:32:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:32:12 INFO - Running setup.py (path:/tmp/pip-Y3Gqng-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:32:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:32:12 INFO - Running setup.py (path:/tmp/pip-_zXwxD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:32:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:32:12 INFO - Running setup.py (path:/tmp/pip-ufLJkd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:32:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:32:12 INFO - Running setup.py (path:/tmp/pip-6yrf93-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:32:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:32:12 INFO - Running setup.py (path:/tmp/pip-duUDx8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:32:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:32:12 INFO - Running setup.py (path:/tmp/pip-_9BoAX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:32:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:32:12 INFO - Running setup.py (path:/tmp/pip-nnGr65-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:32:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:32:13 INFO - Running setup.py (path:/tmp/pip-SRoIfn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:32:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:32:13 INFO - Running setup.py (path:/tmp/pip-NwHMkq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:32:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:32:13 INFO - Running setup.py (path:/tmp/pip-BQuWJf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:32:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:32:13 INFO - Running setup.py (path:/tmp/pip-RSZjpo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:32:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:32:13 INFO - Running setup.py (path:/tmp/pip-mwmURR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:32:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:32:13 INFO - Running setup.py (path:/tmp/pip-2G50U2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:32:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:32:13 INFO - Running setup.py (path:/tmp/pip-BTsYW0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:32:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:32:13 INFO - Running setup.py (path:/tmp/pip-6yyrP3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:32:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:32:13 INFO - Running setup.py install for manifestparser 05:32:13 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:32:13 INFO - Running setup.py install for mozcrash 05:32:13 INFO - Running setup.py install for mozdebug 05:32:13 INFO - Running setup.py install for mozdevice 05:32:14 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:32:14 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:32:14 INFO - Running setup.py install for mozfile 05:32:14 INFO - Running setup.py install for mozhttpd 05:32:14 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:32:14 INFO - Running setup.py install for mozinfo 05:32:14 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:32:14 INFO - Running setup.py install for mozInstall 05:32:14 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:32:14 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:32:14 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:32:14 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:32:14 INFO - Running setup.py install for mozleak 05:32:14 INFO - Running setup.py install for mozlog 05:32:14 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:32:14 INFO - Running setup.py install for moznetwork 05:32:14 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:32:14 INFO - Running setup.py install for mozprocess 05:32:14 INFO - Running setup.py install for mozprofile 05:32:14 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:32:14 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:32:14 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:32:14 INFO - Running setup.py install for mozrunner 05:32:15 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:32:15 INFO - Running setup.py install for mozscreenshot 05:32:15 INFO - Running setup.py install for moztest 05:32:15 INFO - Running setup.py install for mozversion 05:32:15 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:32:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:32:15 INFO - Cleaning up... 05:32:15 INFO - Return code: 0 05:32:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f4950d17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0c840>, '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 0xe796b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe79b60>, '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': '1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118', '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:32:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:32:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:32:15 INFO - Using env: {'DISPLAY': ':0', 05:32:15 INFO - 'HOME': '/home/cltbld', 05:32:15 INFO - 'LANG': 'en_US.UTF-8', 05:32:15 INFO - 'LANGUAGE': 'en_US:en', 05:32:15 INFO - 'LOGNAME': 'cltbld', 05:32:15 INFO - 'MAIL': '/var/mail/cltbld', 05:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:15 INFO - 'MOZ_NO_REMOTE': '1', 05:32:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:15 INFO - 'NO_EM_RESTART': '1', 05:32:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:32:15 INFO - 'PWD': '/builds/slave/test-pgo', 05:32:15 INFO - 'SHELL': '/bin/bash', 05:32:15 INFO - 'SHLVL': '1', 05:32:15 INFO - 'TERM': 'linux', 05:32:15 INFO - 'TMOUT': '86400', 05:32:15 INFO - 'USER': 'cltbld', 05:32:15 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118', 05:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:15 INFO - '_': '/tools/buildbot/bin/python'} 05:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:32:15 INFO - Running setup.py (path:/tmp/pip-mJ0TdR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:32:15 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:32:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:32:15 INFO - Running setup.py (path:/tmp/pip-5EyJ0r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:32:15 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:32:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:32:15 INFO - Running setup.py (path:/tmp/pip-qgWWWN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:32:15 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:32:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:32:15 INFO - Running setup.py (path:/tmp/pip-LIz6SH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:32:15 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:32:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:32:15 INFO - Running setup.py (path:/tmp/pip-doAvJO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:32:16 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:32:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:32:16 INFO - Running setup.py (path:/tmp/pip-aoJwlm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:32:16 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:32:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:32:16 INFO - Running setup.py (path:/tmp/pip-EFZU8B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:32:16 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:32:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:32:16 INFO - Running setup.py (path:/tmp/pip-EaQ_Yp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:32:16 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:32:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:32:16 INFO - Running setup.py (path:/tmp/pip-Bef75v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:32:16 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:32:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:32:16 INFO - Running setup.py (path:/tmp/pip-YbqiKB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:32:16 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:32:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:32:16 INFO - Running setup.py (path:/tmp/pip-jcxdWp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:32:16 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:32:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:32:16 INFO - Running setup.py (path:/tmp/pip-juQaSe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:32:16 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:32:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:32:16 INFO - Running setup.py (path:/tmp/pip-ebbclC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:32:16 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:32:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:32:16 INFO - Running setup.py (path:/tmp/pip-O14ONV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:32:16 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:32:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:32:16 INFO - Running setup.py (path:/tmp/pip-1688TV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:32:16 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:32:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:32:16 INFO - Running setup.py (path:/tmp/pip-4Dzkw5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:32:16 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:32:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:32:16 INFO - Running setup.py (path:/tmp/pip-6Ypzyj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:32:16 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:32:16 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:32:16 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:32:16 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:32:16 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:32:16 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:32:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:32:16 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:32:16 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:32:16 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:32:16 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:32:16 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:32:16 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:32:18 INFO - Downloading blessings-1.5.1.tar.gz 05:32:18 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:32:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:32:18 INFO - Installing collected packages: blessings 05:32:18 INFO - Running setup.py install for blessings 05:32:18 INFO - Successfully installed blessings 05:32:18 INFO - Cleaning up... 05:32:18 INFO - Return code: 0 05:32:18 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:32:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:32:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:32:19 INFO - Reading from file tmpfile_stdout 05:32:19 INFO - Current package versions: 05:32:19 INFO - argparse == 1.2.1 05:32:19 INFO - blessings == 1.5.1 05:32:19 INFO - blobuploader == 1.2.4 05:32:19 INFO - docopt == 0.6.1 05:32:19 INFO - manifestparser == 1.1 05:32:19 INFO - mozInstall == 1.12 05:32:19 INFO - mozcrash == 0.16 05:32:19 INFO - mozdebug == 0.1 05:32:19 INFO - mozdevice == 0.48 05:32:19 INFO - mozfile == 1.2 05:32:19 INFO - mozhttpd == 0.7 05:32:19 INFO - mozinfo == 0.9 05:32:19 INFO - mozleak == 0.1 05:32:19 INFO - mozlog == 3.1 05:32:19 INFO - moznetwork == 0.27 05:32:19 INFO - mozprocess == 0.22 05:32:19 INFO - mozprofile == 0.28 05:32:19 INFO - mozrunner == 6.11 05:32:19 INFO - mozscreenshot == 0.1 05:32:19 INFO - mozsystemmonitor == 0.0 05:32:19 INFO - moztest == 0.7 05:32:19 INFO - mozversion == 1.4 05:32:19 INFO - psutil == 3.1.1 05:32:19 INFO - requests == 1.2.3 05:32:19 INFO - wsgiref == 0.1.2 05:32:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:32:19 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:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:19 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:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f4950d17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0c840>, '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 0xe796b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe79b60>, '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': '1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118', '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:32:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:32:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:32:19 INFO - Using env: {'DISPLAY': ':0', 05:32:19 INFO - 'HOME': '/home/cltbld', 05:32:19 INFO - 'LANG': 'en_US.UTF-8', 05:32:19 INFO - 'LANGUAGE': 'en_US:en', 05:32:19 INFO - 'LOGNAME': 'cltbld', 05:32:19 INFO - 'MAIL': '/var/mail/cltbld', 05:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:19 INFO - 'MOZ_NO_REMOTE': '1', 05:32:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:19 INFO - 'NO_EM_RESTART': '1', 05:32:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:32:19 INFO - 'PWD': '/builds/slave/test-pgo', 05:32:19 INFO - 'SHELL': '/bin/bash', 05:32:19 INFO - 'SHLVL': '1', 05:32:19 INFO - 'TERM': 'linux', 05:32:19 INFO - 'TMOUT': '86400', 05:32:19 INFO - 'USER': 'cltbld', 05:32:19 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118', 05:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:19 INFO - '_': '/tools/buildbot/bin/python'} 05:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:19 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:32:19 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:32:19 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:32:19 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:32:19 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:32:19 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:32:19 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:32:19 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:32:19 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:32:19 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:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:32:19 INFO - Cleaning up... 05:32:19 INFO - Return code: 0 05:32:19 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:32:19 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:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:19 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:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f4950d17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0c840>, '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 0xe796b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe79b60>, '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': '1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118', '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:32:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:32:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:32:19 INFO - Using env: {'DISPLAY': ':0', 05:32:19 INFO - 'HOME': '/home/cltbld', 05:32:19 INFO - 'LANG': 'en_US.UTF-8', 05:32:19 INFO - 'LANGUAGE': 'en_US:en', 05:32:19 INFO - 'LOGNAME': 'cltbld', 05:32:19 INFO - 'MAIL': '/var/mail/cltbld', 05:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:19 INFO - 'MOZ_NO_REMOTE': '1', 05:32:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:19 INFO - 'NO_EM_RESTART': '1', 05:32:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:32:19 INFO - 'PWD': '/builds/slave/test-pgo', 05:32:19 INFO - 'SHELL': '/bin/bash', 05:32:19 INFO - 'SHLVL': '1', 05:32:19 INFO - 'TERM': 'linux', 05:32:19 INFO - 'TMOUT': '86400', 05:32:19 INFO - 'USER': 'cltbld', 05:32:19 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118', 05:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:19 INFO - '_': '/tools/buildbot/bin/python'} 05:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:19 INFO - Downloading/unpacking jsonschema 05:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:32:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 05:32:21 INFO - Downloading/unpacking functools32 (from jsonschema) 05:32: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:32: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:32: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:32: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:32: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:32: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:32:21 INFO - Downloading functools32-3.2.3-2.tar.gz 05:32:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:32:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:32:21 INFO - warning: no files found matching '*.txt' 05:32:21 INFO - no previously-included directories found matching 'build' 05:32:21 INFO - no previously-included directories found matching 'dist' 05:32:21 INFO - no previously-included directories found matching '.git*' 05:32:21 INFO - Installing collected packages: jsonschema, functools32 05:32:21 INFO - Running setup.py install for functools32 05:32:21 INFO - warning: no files found matching '*.txt' 05:32:21 INFO - no previously-included directories found matching 'build' 05:32:21 INFO - no previously-included directories found matching 'dist' 05:32:21 INFO - no previously-included directories found matching '.git*' 05:32:21 INFO - Successfully installed jsonschema functools32 05:32:21 INFO - Cleaning up... 05:32:21 INFO - Return code: 0 05:32:21 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:32: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:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f4950d17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0c840>, '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 0xe796b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe79b60>, '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': '1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118', '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:32:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:32:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:32:21 INFO - Using env: {'DISPLAY': ':0', 05:32:21 INFO - 'HOME': '/home/cltbld', 05:32:21 INFO - 'LANG': 'en_US.UTF-8', 05:32:21 INFO - 'LANGUAGE': 'en_US:en', 05:32:21 INFO - 'LOGNAME': 'cltbld', 05:32:21 INFO - 'MAIL': '/var/mail/cltbld', 05:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:21 INFO - 'MOZ_NO_REMOTE': '1', 05:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:21 INFO - 'NO_EM_RESTART': '1', 05:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:32:21 INFO - 'PWD': '/builds/slave/test-pgo', 05:32:21 INFO - 'SHELL': '/bin/bash', 05:32:21 INFO - 'SHLVL': '1', 05:32:21 INFO - 'TERM': 'linux', 05:32:21 INFO - 'TMOUT': '86400', 05:32:21 INFO - 'USER': 'cltbld', 05:32:21 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118', 05:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:21 INFO - '_': '/tools/buildbot/bin/python'} 05:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:21 INFO - Downloading/unpacking flake8 05:32: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:32: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:32: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:32: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:32: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:32: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:32:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:32:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 05:32:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:32:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 05:32:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 05:32:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:32:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:32:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:32:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:32:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:32:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:32:24 INFO - no previously-included directories found matching 'docs/_build' 05:32:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:32:24 INFO - Running setup.py install for pep8 05:32:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:32:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:32:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:32:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:32:24 INFO - no previously-included directories found matching 'docs/_build' 05:32:24 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:32:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:32:24 INFO - Cleaning up... 05:32:24 INFO - Return code: 0 05:32:24 INFO - Running post-action listener: _resource_record_post_action 05:32:24 INFO - Running post-action listener: _start_resource_monitoring 05:32:24 INFO - Starting resource monitoring. 05:32:24 INFO - ##### 05:32:24 INFO - ##### Running install step. 05:32:24 INFO - ##### 05:32:24 INFO - Running pre-action listener: _resource_record_pre_action 05:32:24 INFO - Running main action method: install 05:32:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:32:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:32:24 INFO - Reading from file tmpfile_stdout 05:32:24 INFO - Detecting whether we're running mozinstall >=1.0... 05:32:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:32:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:32:24 INFO - Reading from file tmpfile_stdout 05:32:24 INFO - Output received: 05:32:24 INFO - Usage: mozinstall [options] installer 05:32:24 INFO - Options: 05:32:24 INFO - -h, --help show this help message and exit 05:32:24 INFO - -d DEST, --destination=DEST 05:32:24 INFO - Directory to install application into. [default: 05:32:24 INFO - "/builds/slave/test-pgo"] 05:32:24 INFO - --app=APP Application being installed. [default: firefox] 05:32:24 INFO - mkdir: /builds/slave/test-pgo/build/application 05:32:24 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:32:24 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:32:40 INFO - Reading from file tmpfile_stdout 05:32:40 INFO - Output received: 05:32:40 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:32:40 INFO - Running post-action listener: _resource_record_post_action 05:32:40 INFO - ##### 05:32:40 INFO - ##### Running run-tests step. 05:32:40 INFO - ##### 05:32:40 INFO - Running pre-action listener: _resource_record_pre_action 05:32:40 INFO - Running main action method: run_tests 05:32:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:32:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:32:40 INFO - Python 2.7.3 05:32:40 INFO - Return code: 0 05:32:40 INFO - grabbing minidump binary from tooltool 05:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:40 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 0xf0c840>, '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 0xe796b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe79b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:32:40 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:32:40 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:32:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:32:40 INFO - Return code: 0 05:32:40 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:32:40 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:32:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:32:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:32:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:32:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:32:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:32:41 INFO - Return code: 0 05:32:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 05:32:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:32:41 INFO - Using env: {'DISPLAY': ':0', 05:32:41 INFO - 'HOME': '/home/cltbld', 05:32:41 INFO - 'LANG': 'en_US.UTF-8', 05:32:41 INFO - 'LANGUAGE': 'en_US:en', 05:32:41 INFO - 'LOGNAME': 'cltbld', 05:32:41 INFO - 'MAIL': '/var/mail/cltbld', 05:32:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:32:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:41 INFO - 'MOZ_NO_REMOTE': '1', 05:32:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:41 INFO - 'NO_EM_RESTART': '1', 05:32:41 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:32:41 INFO - 'PWD': '/builds/slave/test-pgo', 05:32:41 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:32:41 INFO - 'SHELL': '/bin/bash', 05:32:41 INFO - 'SHLVL': '1', 05:32:41 INFO - 'TERM': 'linux', 05:32:41 INFO - 'TMOUT': '86400', 05:32:41 INFO - 'USER': 'cltbld', 05:32:41 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118', 05:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:41 INFO - '_': '/tools/buildbot/bin/python'} 05:32:41 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:32:42 INFO - mozversion application_buildid: 20160114030246 05:32:42 INFO - mozversion application_changeset: 6fa2ab99f52feb1b6ead5581b8f5d398546a55a5 05:32:42 INFO - mozversion application_display_name: Nightly 05:32:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:32:42 INFO - mozversion application_name: Firefox 05:32:42 INFO - mozversion application_remotingname: firefox 05:32:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:32:42 INFO - mozversion application_vendor: Mozilla 05:32:42 INFO - mozversion application_version: 46.0a1 05:32:42 INFO - mozversion platform_buildid: 20160114030246 05:32:42 INFO - mozversion platform_changeset: 6fa2ab99f52feb1b6ead5581b8f5d398546a55a5 05:32:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:32:42 INFO - mozversion platform_version: 46.0a1 05:32:42 INFO - using testdate: 1452778362 05:32:42 INFO - actual date: 1452778362 05:32:42 INFO - starting webserver on 'localhost:34899' 05:32:42 INFO - SUITE-START | Running 3 tests 05:32:42 INFO - TEST-START | dromaeo_css 05:32:42 INFO - operating with platform_type : linux_ 05:32:42 INFO - Initialising browser for dromaeo_css test... 05:32:42 INFO - TEST-INFO | started process 4490 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt6ckY2/profile http://localhost:34899/getInfo.html) 05:32:45 INFO - PROCESS | 4490 | 05:32:45 INFO - PROCESS | 4490 | (process:4575): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:32:46 INFO - PROCESS | 4490 | __metrics Screen width/height:1600/1200 05:32:46 INFO - PROCESS | 4490 | colorDepth:24 05:32:46 INFO - PROCESS | 4490 | Browser inner width/height: 1024/670 05:32:46 INFO - PROCESS | 4490 | __metrics 05:32:46 INFO - PROCESS | 4490 | 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:47 INFO - TEST-INFO | 4490: exit 0 05:32:47 INFO - Browser initialized. 05:32:47 INFO - Running cycle 1/1 for dromaeo_css test... 05:32:47 INFO - TEST-INFO | started process 4624 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt6ckY2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:32:48 INFO - PROCESS | 4624 | 05:32:48 INFO - PROCESS | 4624 | (process:4686): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:32:59 INFO - PROCESS | 4624 | RSS: Main: 151232512 05:32:59 INFO - PROCESS | 4624 | 05:33:48 INFO - PROCESS | 4624 | 1452778428960 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:35:58 INFO - PROCESS | 4624 | Cycle 1(1): loaded http://localhost:34899/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34899/tests/dromaeo/cssquery-ext.html) 05:35:59 INFO - PROCESS | 4624 | RSS: Main: 155860992 05:35:59 INFO - PROCESS | 4624 | 05:39:01 INFO - PROCESS | 4624 | Cycle 1(1): loaded http://localhost:34899/tests/dromaeo/cssquery-ext.html (next: http://localhost:34899/tests/dromaeo/cssquery-jquery.html) 05:39:01 INFO - PROCESS | 4624 | RSS: Main: 150409216 05:39:01 INFO - PROCESS | 4624 | 05:42:03 INFO - PROCESS | 4624 | Cycle 1(1): loaded http://localhost:34899/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34899/tests/dromaeo/cssquery-mootools.html) 05:42:04 INFO - PROCESS | 4624 | RSS: Main: 152219648 05:42:04 INFO - PROCESS | 4624 | 05:45:06 INFO - PROCESS | 4624 | Cycle 1(1): loaded http://localhost:34899/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34899/tests/dromaeo/cssquery-prototype.html) 05:45:06 INFO - PROCESS | 4624 | RSS: Main: 150544384 05:45:06 INFO - PROCESS | 4624 | 05:48:08 INFO - PROCESS | 4624 | Cycle 1(1): loaded http://localhost:34899/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34899/tests/dromaeo/cssquery-yui.html) 05:48:09 INFO - PROCESS | 4624 | RSS: Main: 151592960 05:48:09 INFO - PROCESS | 4624 | 05:51:11 INFO - PROCESS | 4624 | Cycle 1(1): loaded http://localhost:34899/tests/dromaeo/cssquery-yui.html (next: http://localhost:34899/tests/dromaeo/cssquery-dojo.html) 05:51:12 INFO - PROCESS | 4624 | RSS: Main: 153493504 05:51:12 INFO - PROCESS | 4624 | 05:51:12 INFO - PROCESS | 4624 | __start_tp_report 05:51:12 INFO - PROCESS | 4624 | _x_x_mozilla_page_load 05:51:12 INFO - PROCESS | 4624 | _x_x_mozilla_page_load_details 05:51:12 INFO - PROCESS | 4624 | |i|pagename|runs| 05:51:12 INFO - PROCESS | 4624 | |0;dojo.html;3191.8244496552693;3208.1017315151753;3235.7896736712128;3239.5950506186728;3255.300110476248;5164.9483505164935;5234.345706786652;5240.790368385265;5244.056069907415;5244.868878278045;5167.586593072545;5173.042987047399;5299.761510732017;5362.43694412087;5362.4637536246355;4731.929021064687;4773.952260477386;4827.63792715546;4837.419509658828;4905.0925578767865;4786.162421576228;4824.565789078983;4833.3958255218095;4873.658843880929;4943.901121977558;4685.789139488731;4754.881127971828;4774.952250477503;4784.83253086142;4821.373221481185;4764.6426518011285;4800.25596032612;4805.303231031516;4835.2505361669;4841.515848415165;4699.906001879977;4768.976155119202;4778.044391121754;4787.042591481718;4811.615070794328;4942.061008408391;4992.350994370745;5152.381714194321;5153.793848246066;5240.371155461331;5611.971940140314;5630;5631.8592035199445;5632;5635.3519345275;5657.094864821609;5671.2060311556415;5674.687892165929;5675.34733505648;5684.715764211773;5216.374035115772;5252.3171987641745;5276.050310944029;5292.841214763564;5351.545118664879;5754.74103665336;5789.45000224978;5802.274715660543;5805.970970145122;5815.331236907725;5458.099413596712;5484.91772623411;5537.501624853782;5540.722963851791;5569.443055694398;5573.27547418833;5598.216249725042;5598.412166722517;5599.860003499945;5686.34607020198;5647.604667673223;5652.689102099342;5665.971670141623;5667.603267771299;5688.06146985751;5621.831345059655;5637.041702910515;5658.773649053992;5663.207150998864;5665.178549110356;4320.632746216606;4369.43197384338;4381.145676593033;4408.9559104408545;4416.425864637641;3850.5956874528333;3861.4400911867624;3876.8836934891997;3904.629060239273;3920.980395098063;5225.634205605647;5243.868903277372;5244.737763111829;5244.921326180111;5246.055709972242;5520.889582208413;5560.499555040065;5605.075162598126;5656.519195868397;5663.207150998864;5232.136697444955;5273.288106105703;5273.868153296198;5276.762545685453;5287.762050707727;4761.428628564525;4762.9523704763205;4764.190087685032;4770.809167633325;4797.18447863864;5804.970975145097;5819.301683797887;5820.708964551755;5829.88340233193;5964.403559644088;5658.094704847204;5673.262475878275;5681.715914204356;5686.658800471985;5691.430856914441;5855.063189889597;5861.325947515919;5872;5872.647641141545;5900.881982360243;5402.108652072521;5550.5282051026115;5551.417101204477;5581.134924086773;5649.096144616841;5703.828885133453;5705.686187259741;5708.628939118944;5713.285839270091;5729.742161602821;5479.561635069264;5496.422875598005;5529.336479622471;5536.197251398606;5544.528715059265;5392.191171324333;5493.835184944458;5535.391106978149;5585.720713964367;5665.886682266249;5408.405075441777;5409.350877894678;5414.35027796667;5417.7832886685665;5417.945820541901;5460.972695136499;5467.589930755289;5489.615726899079;5547;5591.496765291144;5350.892982140257;5373.543248823894;5397.298351214317;5442.619016668795;5489.149181876815 05:51:12 INFO - PROCESS | 4624 | |1;ext.html;529.1348644965483;538.9137737961926;546.934367875855;551.0054351894829;573.911043788213;35669.82165089174;36442.27115457689;36652;36675.63324366756;36693.81653091738;38760.61239387605;39125.804370978105;39359.0160245994;39367.40948885769;39371.40942885859;8340.582970851463;8571.314294856396;8613.440126391764;8615.95692021539;8639.049704532528;8333.833323333529;8407.663693452254;8429.3256539477;8448.11294814045;8453.365997550209;8732.257758090569;8767.780805479882;8842.734717958472;8850.070742572034;8860.24687901529;8729.694460693878;8760.8685869712;8804.119588041209;8818.20636142747;8837.95581022094;8632.827343453158;8705.912940870574;8708.17272359125;8770.254528365096;8789.384743067987;40192;40528;40618.796906015574;40743.185136297405;40753.59246407557;2984.850757462118;2990.3271763853177;3094.3347180356104;3235.078002769223;3798.6771124454176;29468.557971630442;29874.40251194986;30058.54912176319;30163;30468.39063218723;3881.9029524261837;4004.7797371144575;4046.919061618751;4060.2894493463823;4064.959350406488;215084;215695.99999999843;215869;216107.95298305558;217628;42527.787361063616;58838.41161588329;58917.41082589205;59193;59211;41301.79349103235;41416.79291603583;41523.377149342785;41612.79193604013;41737.165256694694;14887.776683349759;14997.775033374508;15001.849981500045;15022.924885375503;15067.397304107932;12042.759144817055;12092.395380230953;12106.334151621746;12110;12195.268283902995;14194.077384969944;14273.928630356782;14652.853471465149;14749.483768068067;14764.114153150846;5736.139579063174;5841.240638716939;5844.9415505845245;5874.089516125007;5918.141869428995;950.7100334397936;968.8352979993418;969.60730903984;1002.5488530161457;1043.0664555223034;28201.858990704914;30668.38663226723;30949.69050309513;30986.690133098382;31379.37241255208;1029.6396261308632;1044.796264728386;1054.6888667843004;1080.6920027792041;1132.8753837077916;14638.48765293231;16064.839351606335;16242;16455.83544164567;16737.246823892954;399098;400835;400872;403194;404876;54262.728686357106;55060;55114.448855511735;55358.72320638371;55565.44434555683;1313.8554758976504;1343.9126456780473;1353.4924403348743;1356.3150608942422;1356.9389377478037;29580.852095739385;30251.316181583916;30400.447829824527;30592.235194120323;30621.846890765402;45553.77223113863;45804;46185.76907115443;46213.76893115513;46275;307667;308553;308584;309996;311582;33080.33839323248;43643.78178109089;43988.560114398446;44266.77866610646;44631.10737785291;40230.597694023854;40864.79567602143;40945.385819213334;41338;41737.58262417337;34517;34554.48168277528;34873.65126348704;35367.82316088403;39059.41410878782;34127.82936085304;34374;34467.4829877547;35005;35145.121371965906;34204.14489637779;34558.82720586381;34839.825800870836;36955.6304436963;37089.443658345685;32262.838685806422;33489.162770930925;33711.263037077304;33855.830720846236;34209.657903420644;24782;25086.247412577653;25209.85783502415;25521.61717574275;25603.615945760455 05:51:12 INFO - PROCESS | 4624 | |2;jquery.html;366.87342866710975;370.0711214850724;370.39255620781904;370.6534390345027;372.7409450431949;15095.62260943477;16065.598360041005;16156.919215403921;16792.916035419836;16970.40603578875;10988.890111098906;11078.335299881992;11336.263142895707;11404.828927566094;11409.771804563925;4764.332993380921;4936.679115857476;4937.185364414867;5012.498750124995;5373.7581808818695;5142.254373115896;5253.343332083489;5277.076511610472;5298.417174110845;5303.840884773444;3756;3913.66733827625;5159.922601160967;5274.077036518613;5379.193121031837;5237.8428647140645;5450.781968721286;5472.20653005314;5472.781088756445;5478.808241711521;5010;5179.7410129493755;5191.117510023305;5202.739863006835;5212.270282160501;12417.62747117588;12638.431270592846;15600.687986240211;20387.796122038737;20399.898000509904;1976.3379267945256;2044.7648520420043;2126.2770657976207;2169.0781417897488;2176.68438076478;9661.323707340489;10001.249906256988;10231.693049208536;10572;13292.936565074771;1801.1714611278828;1821.6629923464202;1832.743415921772;1840.3166778699012;1866.1135960418692;51136.488635113914;55767;56886.7155664219;58367.70816145892;58545.70727146337;10132.949335253277;10162.898371016343;10382.221333400024;10433.16534677224;10459;13395.263260520765;13510.324483775772;13526.59420217395;13536.59390218295;13543.45826166962;7907.5650839203245;7958.08482024563;7993.9200607994335;8004.159563245776;8048.275655191061;7722.382209423233;7772.961135194288;7792.727254546064;7806.18035106317;7832.765017049498;4500.257457519473;4504.932426013613;4530.932036019462;4538.069695712371;4579.38178345919;1844.7325137854937;1845.5478407790176;1849.2076963784514;1858.3310008396966;1920.059171006197;462.6090953144655;463.13625089208386;465.9068186362673;473.40351157541744;953.6519170502855;10615.681529554126;10732.78534429307;10783.406912619881;10796.67609971702;10960.56157753681;471.30247234093736;473.73944330618025;479.8176692856692;480.889395439051;483.9975800121047;5999.550033747487;6016.338202797689;6034.39656034393;9501.23990080792;10005.49972501372;382254;386111;387760;391708;616890;48389;49379.753101234266;69965;75195.62402187954;76865.15674216267;1156.3119943633524;1205.198542968916;1206.5025397427241;1207.8912897839236;1211.418519110814;15057.924710376377;15149;15233.162176079979;15349.155796430858;15549;32167.19582010375;32550;32889;34101;34282.48576271408;42700.5729942709;43636;43639.12721745611;44263.336049958634;45028.77485612551;7205.459590530836;7211.8557628848175;7237.927620723725;7266.96366518164;7282.635868206463;9284.21084207823;10453.843192352273;10585.364878107339;11037;11207.831882521605;8844.336674749291;9358.578863951003;9402.247820174507;9515.429074255568;9529.666461673809;3021.7582593392917;3057.4802283612285;9345.915847770355;10086.94956525242;10400.11599014062;9981.351212171186;10057.446840423847;10343.586256549654;10453.738656533344;10476.423796691255;7170.39051680613;7191.280871912767;7469.925300746923;7630.618469076635;7844.9607751960875;9350.81298374015;10216.4380959045;10226.897731022595;10261.28171028021;10288.022637849692 05:51:12 INFO - PROCESS | 4624 | |3;mootools.html;1468.2805425341585;1480.3708423919832;1623.7970253718286;1744.6336269383428;1790.794058683251;7949.960250198748;7977.04275486941;8052.39607029473;8105.392095592824;8176.059753128392;8228.094909559944;8237.958810205955;8334;8375.95812020939;8384.790380240496;2405.4467472481297;2428.9271321860374;2433.634954756792;2436.3300092474624;2437.8049756019477;2329.033451117784;2347.530493901218;2349.189529612281;2355.3640517060385;2449.1917667169882;2380.5595964746576;2389.928302150938;2430.295214387834;2434.1602147259255;2441.4506735984437;2345.0854166874933;2345.976540234593;2368.798652114572;2376.9049238030457;2397.220903206456;2384.2251268337686;2385.0817435287368;2388.928332150021;2389.7729715676983;2391.1630929174826;7739.61301934901;7743.845123097506;7779.299863012356;7783.832425136275;7799.688012479494;4871.12319782439;5009.824656137018;5053.722045287508;5059.873503162414;5076.36545431821;3177.8887738929025;3271.492918597621;3301.3067255876294;3349.547811045502;3365.848536815825;1042.5881776698238;1050.6060227414719;1074.1084899533369;1090.0788833435813;1106.3859557945336;11076;11260.493277802518;11260.605878794202;11284.210105292634;11297.661070167907;4542.159700455426;4647.3029045643425;4682.882927926829;4720.315554244616;4721.409823772028;9615.855762163574;9630.711078667651;9655.758606034764;9716;9731.075547822946;5124.692518448905;5140.742962851842;5143.331366922351;5162.432132465426;5182.53357197854;4614.180405833867;4640.744759038218;4660.953390466119;4666.440027196691;4697.13103075932;3806.200697853482;3808.143167787281;3818.0836599215986;3835.290471262825;3844.961550384516;1105.745678493951;1132.7564573616712;1159.0379984612919;1180.527788884453;1183.260462211118;1253.1603825436796;1254.3289340202948;1276.8595454499998;1277.278337739193;1286.6075846866609;7306.378957788541;7307.342339189392;7406;7640.274173953577;7663.885041724378;1097.8956999085074;1105.160078340467;1115.2694984784978;1129.4578602270956;1134.971625709364;5733.569982251264;5825.271841019872;5873.471387575053;5887.587868849225;5903.114532820111;9244.90755092454;9510.334276600572;10004.599816007423;10006.249531285182;10069.093781559695;9679.225661947028;9817.067378599022;9831.410115393099;9831.75420614476;9841.917389087195;7331.3768329692575;7488.513246638951;7495.737649182143;7530.736424225235;7705.190954949761;7445.181030086578;7451.925480745123;7532.209118042746;7543.245675432413;7545.849083018199;8812.647494100163;8865.423747456394;8866.157715017063;8884.156005179497;8898.065703101081;8529.573521324033;9146.176844083799;9161.129692679186;9226.169644731737;9231.861522077308;7146.606936618536;7227.241139680258;7264.982902393775;7267.491275610868;7304.5252058616015;7479.551226926402;7548.245175482408;7604.467687261838;7668.923310766821;7669.348105411103;6309.652969086745;7258.383037441877;7303.342699157101;7382.224866388952;7418.777436676908;7088.893666594902;7119.074520312533;7181.06646135999;7298.890516642361;7341.632918353954;6925.411340036153;6942.826429339307;6963.651817409211;6986.056882321025;7046.753363632249;6616.305287944889;6642.468602511691;6649.0691303218555;6650;6673.06577079219;6570.113034740249;6570.638614876228;6596.472282217315;6605.174353205849;6621 05:51:12 INFO - PROCESS | 4624 | |4;prototype.html;345.48867675839756;349.56304619225966;349.99900285184384;355.11044832694097;356.44572689467884;6158.168647232622;6205.379462053798;6207.193064901562;6286.3399343069;6365.427111559959;6206.348333424993;6267.2165979252595;6277.435030847223;6313.526485513582;6318.368163183679;4838.322634831126;4838.346823178878;4839.9516004840025;4840.9515904840855;4845.958119004414;4838.854834354975;4839.7096174229655;4841.661083724141;4854.34466347044;4855.951440485603;4692.741899195543;4758.119747846642;4763.19025765619;4776.450708168553;4778.235482322829;4749.525047495223;4756.619470442356;4758.833440829554;4766.713997160165;4769.3799806025345;4116.567760385146;4136.73111247768;4138.503379594438;4139.3583994480905;4141.79291035447;6017.48851347636;6025.6987150642735;6026.3672314406795;6032.728527216286;6048.274207095133;5496.148097044965;5639.774409023676;5693.971530142323;5702.6293290935955;5702.971485142589;6718.193816742022;6761.628110453923;6762.526623136382;6766.25571187174;6770.492213084039;4620.283856002325;4628.537146285378;4651.906961860777;4663.60359369454;4695.272232803921;6680.23177334603;6774.220964589037;6833.521653484258;6837.623930683811;6925.065116209297;4709.952900470951;4716.103940251342;4731.2903064539905;4735.934414756653;4741.193997020515;4790.401199850019;4793.736344501016;4795.95204047955;4795.95204047962;4800.279958006327;5524.005678977742;5566.916496252559;5568.777248910079;5574.693391863405;5581.720913954286;6461.57999730016;6740.325967403221;6745.561538499982;6754.223264324567;6771.559848609824;1651.9669606607802;1670.6825703116613;1690.6111594333372;1691.4671878358279;1695.6947749404978;1106.7011906785124;1108.905743011853;1124.7236414535257;1125.943702814856;1130.8586426696663;6231.283402408781;6231.563790534709;6253.280872699606;6261.843453913598;6266.686665666698;6758.05387245786;6782.287859774653;6801.081853949752;6816.386525212754;6836.38472537474;6103.206583144163;6212.565120441525;6252.531060170414;6256.405641464054;6259.217597800275;3678.70570354371;3684;3708.5364329458816;3710.406334986389;3725.385311423639;7054.717811287491;7100.183478899889;7111.146662400545;7111.715531378687;7120.074390329328;6824.317568243136;6930.896036559456;6972.337627925339;6990.867785325525;7003.2296447390745;7112.14654241484;7114.324139206767;7118.003479512872;7120.216776154619;7121.003059571664;6792.132163655035;6848.14398200225;6848.657567121524;6851.424172440267;6853.280405557344;6602.10871532337;6728.158980127484;6728.529002969745;6763.560368576027;6768.9661551691925;7096.929030709834;7115.359617634438;7116.928830711627;7120.465965052746;7138.678759455941;4720.693154944917;4732.313814496947;4735.431748190239;4739.857804265877;4740.6681532292405;6752.527323087336;6773;6859.759908403182;6860.108185935996;7048.718051277891;6741.629210393476;6795.014722865058;6807.727690892309;6808.353206445379;6865.27914568963;6781.762638307636;6786.728530858711;6797.28628494001;6798.456123510206;6799.830004249736;6547.083408322934;6598.868022639616;6662.733490660513;6671.39957403836;6688.097106890702;6829.31706829333;6836.5214434989075;6837.282085381163;6838;6861;6658.267590565131;6658.3674550917585;6661.566998145299;6669.2997235289595;6685.298043705536 05:51:12 INFO - PROCESS | 4624 | |5;yui.html;740.5297636001139;775.5463054113343;806.7418426103645;823.3289868756959;825.2160447574805;12733.808992865102;12756.23462592245;12772.936135319322;12819.807702884464;12842.935785321071;11817.350045747502;11830.7633847323;11851.22967007144;11856.170068095236;11864.703382415422;780.9375249980017;781.3827076609485;790.1940021178394;813.4427916876929;818.153211426174;806.4677312973439;807.446898874273;810.9918900811005;811.290121143999;815.5106935838509;840.9453385529921;843;843.2874221283006;843.2958479669484;844.5312851367488;834.5118105908051;840.1892174052039;841.0748177005306;843.4981186194204;846.1622993236713;616.1127975714957;618.3661746709614;618.8793185328863;621.710904429438;621.7544070092333;13935.163890166623;13945.930270348685;14021.64945876351;14083.507077252349;14125.576232713034;11177.441127943652;11263.324200547993;11409.20135590509;11409.37248451335;11522.539098436053;10327.018933201409;10534.209934254885;10556.577736890515;10661.786764264749;10711.83932241017;3401.4557670772556;3441.0709108540805;3462.671046250602;3509.6490350964955;3544.291141771656;48615.27077093846;48842;49014.509854901706;49023;49268;9596.66411675588;9781.119699227103;10000.349977251455;10066.647667331608;10399.376037437627;16879.831201687826;16927.40754073626;16948.152592370334;16975.74536381955;17112.05883676385;6867.862642747117;6989.825254368579;7050.894840625932;7083.787486375417;7115.181754098345;4079.2930022978207;4082.7754473503646;4242.384854196124;4312.482502099768;4321.0709697415205;3071.385722855438;3101.441740486734;3116.9376612468077;3130.857237108439;3134;567.8495198772329;590.5806877117295;594.3759052994338;610.9175261339662;614.536025300895;533.6904595334696;553.6124712701126;612.429119308971;626.2453743239386;631.3875540725489;8189.22202390772;8233.876491852627;8287.62705678234;8480.703175388955;8532.573371331533;639.5941610921767;654.2672207127952;661.1570247933827;662.4825662482547;677.9661016949133;3663.7252206084117;3794.2411517696573;3807.7144214184045;3905.062784931596;3980.3432433648704;51720.741396292775;51775.22337164945;51872;52406;52483;50304.24543631849;51066;51458.742706286976;51821;52024.73987630037;43895.56104438915;43938.12123757571;44396;44437.333439997776;44535;7772.653620840085;7926.048874135141;7932.286094251545;7968.163342848918;7987.560684162195;32839.17902052468;33591.83204083964;33828.66171338354;34030.48954265738;34046.829765852;43047.56952430436;45634.31548526841;45782.54217457916;45791.31313030374;45906;9480.194183494481;9696.5636546357;9898.653547125816;9931.503424828874;10239.180865530889;9834.803303934024;9950.850737239092;10108.898911010796;10131.594736210764;10160.54277557497;9797.461139637388;9839.212862971088;9987.950060249652;10101.444420556645;10353.171746260432;9912.752181195528;9994.800103998024;10128.84806727885;10521.631742888962;10550.472476376304;10005;10015.40755713434;10031.12662470035;10064.345817521838;10132.037456441922;7831.804204894923;8015.398845086758;8212.958935205286;8514.446560973516;8686.91313086861;7781.5331080135375;8132.9186708132165;8415.3267738582;8462.915370846458;8463.661453542036 05:51:12 INFO - PROCESS | 4624 | __end_tp_report 05:51:12 INFO - PROCESS | 4624 | __start_cc_report 05:51:12 INFO - PROCESS | 4624 | _x_x_mozilla_cycle_collect,303 05:51:12 INFO - PROCESS | 4624 | __end_cc_report 05:51:12 INFO - PROCESS | 4624 | __startTimestamp1452779472182__endTimestamp 05:51:12 INFO - PROCESS | 4624 | 05:51:12 INFO - PROCESS | 4624 | ------- Summary: start ------- 05:51:12 INFO - PROCESS | 4624 | Number of tests: 6 05:51:12 INFO - PROCESS | 4624 | 05:51:12 INFO - PROCESS | 4624 | [#0] dojo.html Cycles:165 Average:5237.46 Median:5414.35 stddev:574.53 (10.6%) stddev-sans-first:553.42 05:51:12 INFO - PROCESS | 4624 | Values: 3191.8 3208.1 3235.8 3239.6 3255.3 5164.9 5234.3 5240.8 5244.1 5244.9 5167.6 5173.0 5299.8 5362.4 5362.5 4731.9 4774.0 4827.6 4837.4 4905.1 4786.2 4824.6 4833.4 4873.7 4943.9 4685.8 4754.9 4775.0 4784.8 4821.4 4764.6 4800.3 4805.3 4835.3 4841.5 4699.9 4769.0 4778.0 4787.0 4811.6 4942.1 4992.4 5152.4 5153.8 5240.4 5612.0 5630.0 5631.9 5632.0 5635.4 5657.1 5671.2 5674.7 5675.3 5684.7 5216.4 5252.3 5276.1 5292.8 5351.5 5754.7 5789.5 5802.3 5806.0 5815.3 5458.1 5484.9 5537.5 5540.7 5569.4 5573.3 5598.2 5598.4 5599.9 5686.3 5647.6 5652.7 5666.0 5667.6 5688.1 5621.8 5637.0 5658.8 5663.2 5665.2 4320.6 4369.4 4381.1 4409.0 4416.4 3850.6 3861.4 3876.9 3904.6 3921.0 5225.6 5243.9 5244.7 5244.9 5246.1 5520.9 5560.5 5605.1 5656.5 5663.2 5232.1 5273.3 5273.9 5276.8 5287.8 4761.4 4763.0 4764.2 4770.8 4797.2 5805.0 5819.3 5820.7 5829.9 5964.4 5658.1 5673.3 5681.7 5686.7 5691.4 5855.1 5861.3 5872.0 5872.6 5900.9 5402.1 5550.5 5551.4 5581.1 5649.1 5703.8 5705.7 5708.6 5713.3 5729.7 5479.6 5496.4 5529.3 5536.2 5544.5 5392.2 5493.8 5535.4 5585.7 5665.9 5408.4 5409.4 5414.4 5417.8 5417.9 5461.0 5467.6 5489.6 5547.0 5591.5 5350.9 5373.5 5397.3 5442.6 5489.1 05:51:12 INFO - PROCESS | 4624 | 05:51:12 INFO - PROCESS | 4624 | [#1] ext.html Cycles:180 Average:47163.40 Median:20444.06 stddev:83767.94 (409.7%) stddev-sans-first:83929.76 05:51:12 INFO - PROCESS | 4624 | Values: 529.1 538.9 546.9 551.0 573.9 35669.8 36442.3 36652.0 36675.6 36693.8 38760.6 39125.8 39359.0 39367.4 39371.4 8340.6 8571.3 8613.4 8616.0 8639.0 8333.8 8407.7 8429.3 8448.1 8453.4 8732.3 8767.8 8842.7 8850.1 8860.2 8729.7 8760.9 8804.1 8818.2 8838.0 8632.8 8705.9 8708.2 8770.3 8789.4 40192.0 40528.0 40618.8 40743.2 40753.6 2984.9 2990.3 3094.3 3235.1 3798.7 29468.6 29874.4 30058.5 30163.0 30468.4 3881.9 4004.8 4046.9 4060.3 4065.0 215084.0 215696.0 215869.0 216108.0 217628.0 42527.8 58838.4 58917.4 59193.0 59211.0 41301.8 41416.8 41523.4 41612.8 41737.2 14887.8 14997.8 15001.8 15022.9 15067.4 12042.8 12092.4 12106.3 12110.0 12195.3 14194.1 14273.9 14652.9 14749.5 14764.1 5736.1 5841.2 5844.9 5874.1 5918.1 950.7 968.8 969.6 1002.5 1043.1 28201.9 30668.4 30949.7 30986.7 31379.4 1029.6 1044.8 1054.7 1080.7 1132.9 14638.5 16064.8 16242.0 16455.8 16737.2 399098.0 400835.0 400872.0 403194.0 404876.0 54262.7 55060.0 55114.4 55358.7 55565.4 1313.9 1343.9 1353.5 1356.3 1356.9 29580.9 30251.3 30400.4 30592.2 30621.8 45553.8 45804.0 46185.8 46213.8 46275.0 307667.0 308553.0 308584.0 309996.0 311582.0 33080.3 43643.8 43988.6 44266.8 44631.1 40230.6 40864.8 40945.4 41338.0 41737.6 34517.0 34554.5 34873.7 35367.8 39059.4 34127.8 34374.0 34467.5 35005.0 35145.1 34204.1 34558.8 34839.8 36955.6 37089.4 32262.8 33489.2 33711.3 33855.8 34209.7 24782.0 25086.2 25209.9 25521.6 25603.6 05:51:12 INFO - PROCESS | 4624 | 05:51:12 INFO - PROCESS | 4624 | [#2] jquery.html Cycles:180 Average:23840.83 Median:197810.83 stddev:72510.67 (36.7%) stddev-sans-first:72692.66 05:51:12 INFO - PROCESS | 4624 | Values: 366.9 370.1 370.4 370.7 372.7 15095.6 16065.6 16156.9 16792.9 16970.4 10988.9 11078.3 11336.3 11404.8 11409.8 4764.3 4936.7 4937.2 5012.5 5373.8 5142.3 5253.3 5277.1 5298.4 5303.8 3756.0 3913.7 5159.9 5274.1 5379.2 5237.8 5450.8 5472.2 5472.8 5478.8 5010.0 5179.7 5191.1 5202.7 5212.3 12417.6 12638.4 15600.7 20387.8 20399.9 1976.3 2044.8 2126.3 2169.1 2176.7 9661.3 10001.2 10231.7 10572.0 13292.9 1801.2 1821.7 1832.7 1840.3 1866.1 51136.5 55767.0 56886.7 58367.7 58545.7 10132.9 10162.9 10382.2 10433.2 10459.0 13395.3 13510.3 13526.6 13536.6 13543.5 7907.6 7958.1 7993.9 8004.2 8048.3 7722.4 7773.0 7792.7 7806.2 7832.8 4500.3 4504.9 4530.9 4538.1 4579.4 1844.7 1845.5 1849.2 1858.3 1920.1 462.6 463.1 465.9 473.4 953.7 10615.7 10732.8 10783.4 10796.7 10960.6 471.3 473.7 479.8 480.9 484.0 5999.6 6016.3 6034.4 9501.2 10005.5 382254.0 386111.0 387760.0 391708.0 616890.0 48389.0 49379.8 69965.0 75195.6 76865.2 1156.3 1205.2 1206.5 1207.9 1211.4 15057.9 15149.0 15233.2 15349.2 15549.0 32167.2 32550.0 32889.0 34101.0 34282.5 42700.6 43636.0 43639.1 44263.3 45028.8 7205.5 7211.9 7237.9 7267.0 7282.6 9284.2 10453.8 10585.4 11037.0 11207.8 8844.3 9358.6 9402.2 9515.4 9529.7 3021.8 3057.5 9345.9 10086.9 10400.1 9981.4 10057.4 10343.6 10453.7 10476.4 7170.4 7191.3 7469.9 7630.6 7845.0 9350.8 10216.4 10226.9 10261.3 10288.0 05:51:12 INFO - PROCESS | 4624 | 05:51:12 INFO - PROCESS | 4624 | [#3] mootools.html Cycles:180 Average:5695.54 Median:5880.53 stddev:2931.98 (49.9%) stddev-sans-first:2922.99 05:51:12 INFO - PROCESS | 4624 | Values: 1468.3 1480.4 1623.8 1744.6 1790.8 7950.0 7977.0 8052.4 8105.4 8176.1 8228.1 8238.0 8334.0 8376.0 8384.8 2405.4 2428.9 2433.6 2436.3 2437.8 2329.0 2347.5 2349.2 2355.4 2449.2 2380.6 2389.9 2430.3 2434.2 2441.5 2345.1 2346.0 2368.8 2376.9 2397.2 2384.2 2385.1 2388.9 2389.8 2391.2 7739.6 7743.8 7779.3 7783.8 7799.7 4871.1 5009.8 5053.7 5059.9 5076.4 3177.9 3271.5 3301.3 3349.5 3365.8 1042.6 1050.6 1074.1 1090.1 1106.4 11076.0 11260.5 11260.6 11284.2 11297.7 4542.2 4647.3 4682.9 4720.3 4721.4 9615.9 9630.7 9655.8 9716.0 9731.1 5124.7 5140.7 5143.3 5162.4 5182.5 4614.2 4640.7 4661.0 4666.4 4697.1 3806.2 3808.1 3818.1 3835.3 3845.0 1105.7 1132.8 1159.0 1180.5 1183.3 1253.2 1254.3 1276.9 1277.3 1286.6 7306.4 7307.3 7406.0 7640.3 7663.9 1097.9 1105.2 1115.3 1129.5 1135.0 5733.6 5825.3 5873.5 5887.6 5903.1 9244.9 9510.3 10004.6 10006.2 10069.1 9679.2 9817.1 9831.4 9831.8 9841.9 7331.4 7488.5 7495.7 7530.7 7705.2 7445.2 7451.9 7532.2 7543.2 7545.8 8812.6 8865.4 8866.2 8884.2 8898.1 8529.6 9146.2 9161.1 9226.2 9231.9 7146.6 7227.2 7265.0 7267.5 7304.5 7479.6 7548.2 7604.5 7668.9 7669.3 6309.7 7258.4 7303.3 7382.2 7418.8 7088.9 7119.1 7181.1 7298.9 7341.6 6925.4 6942.8 6963.7 6986.1 7046.8 6616.3 6642.5 6649.1 6650.0 6673.1 6570.1 6570.6 6596.5 6605.2 6621.0 05:51:12 INFO - PROCESS | 4624 | 05:51:12 INFO - PROCESS | 4624 | [#4] prototype.html Cycles:180 Average:5578.16 Median:6257.81 stddev:1682.66 (26.9%) stddev-sans-first:1640.90 05:51:12 INFO - PROCESS | 4624 | Values: 345.5 349.6 350.0 355.1 356.4 6158.2 6205.4 6207.2 6286.3 6365.4 6206.3 6267.2 6277.4 6313.5 6318.4 4838.3 4838.3 4840.0 4841.0 4846.0 4838.9 4839.7 4841.7 4854.3 4856.0 4692.7 4758.1 4763.2 4776.5 4778.2 4749.5 4756.6 4758.8 4766.7 4769.4 4116.6 4136.7 4138.5 4139.4 4141.8 6017.5 6025.7 6026.4 6032.7 6048.3 5496.1 5639.8 5694.0 5702.6 5703.0 6718.2 6761.6 6762.5 6766.3 6770.5 4620.3 4628.5 4651.9 4663.6 4695.3 6680.2 6774.2 6833.5 6837.6 6925.1 4710.0 4716.1 4731.3 4735.9 4741.2 4790.4 4793.7 4796.0 4796.0 4800.3 5524.0 5566.9 5568.8 5574.7 5581.7 6461.6 6740.3 6745.6 6754.2 6771.6 1652.0 1670.7 1690.6 1691.5 1695.7 1106.7 1108.9 1124.7 1125.9 1130.9 6231.3 6231.6 6253.3 6261.8 6266.7 6758.1 6782.3 6801.1 6816.4 6836.4 6103.2 6212.6 6252.5 6256.4 6259.2 3678.7 3684.0 3708.5 3710.4 3725.4 7054.7 7100.2 7111.1 7111.7 7120.1 6824.3 6930.9 6972.3 6990.9 7003.2 7112.1 7114.3 7118.0 7120.2 7121.0 6792.1 6848.1 6848.7 6851.4 6853.3 6602.1 6728.2 6728.5 6763.6 6769.0 7096.9 7115.4 7116.9 7120.5 7138.7 4720.7 4732.3 4735.4 4739.9 4740.7 6752.5 6773.0 6859.8 6860.1 7048.7 6741.6 6795.0 6807.7 6808.4 6865.3 6781.8 6786.7 6797.3 6798.5 6799.8 6547.1 6598.9 6662.7 6671.4 6688.1 6829.3 6836.5 6837.3 6838.0 6861.0 6658.3 6658.4 6661.6 6669.3 6685.3 05:51:12 INFO - PROCESS | 4624 | 05:51:12 INFO - PROCESS | 4624 | [#5] yui.html Cycles:180 Average:13169.87 Median:51747.98 stddev:15539.28 (30.0%) stddev-sans-first:15554.84 05:51:12 INFO - PROCESS | 4624 | Values: 740.5 775.5 806.7 823.3 825.2 12733.8 12756.2 12772.9 12819.8 12842.9 11817.4 11830.8 11851.2 11856.2 11864.7 780.9 781.4 790.2 813.4 818.2 806.5 807.4 811.0 811.3 815.5 840.9 843.0 843.3 843.3 844.5 834.5 840.2 841.1 843.5 846.2 616.1 618.4 618.9 621.7 621.8 13935.2 13945.9 14021.6 14083.5 14125.6 11177.4 11263.3 11409.2 11409.4 11522.5 10327.0 10534.2 10556.6 10661.8 10711.8 3401.5 3441.1 3462.7 3509.6 3544.3 48615.3 48842.0 49014.5 49023.0 49268.0 9596.7 9781.1 10000.3 10066.6 10399.4 16879.8 16927.4 16948.2 16975.7 17112.1 6867.9 6989.8 7050.9 7083.8 7115.2 4079.3 4082.8 4242.4 4312.5 4321.1 3071.4 3101.4 3116.9 3130.9 3134.0 567.8 590.6 594.4 610.9 614.5 533.7 553.6 612.4 626.2 631.4 8189.2 8233.9 8287.6 8480.7 8532.6 639.6 654.3 661.2 662.5 678.0 3663.7 3794.2 3807.7 3905.1 3980.3 51720.7 51775.2 51872.0 52406.0 52483.0 50304.2 51066.0 51458.7 51821.0 52024.7 43895.6 43938.1 44396.0 44437.3 44535.0 7772.7 7926.0 7932.3 7968.2 7987.6 32839.2 33591.8 33828.7 34030.5 34046.8 43047.6 45634.3 45782.5 45791.3 45906.0 9480.2 9696.6 9898.7 9931.5 10239.2 9834.8 9950.9 10108.9 10131.6 10160.5 9797.5 9839.2 9988.0 10101.4 10353.2 9912.8 9994.8 10128.8 10521.6 10550.5 10005.0 10015.4 10031.1 10064.3 10132.0 7831.8 8015.4 8213.0 8514.4 8686.9 7781.5 8132.9 8415.3 8462.9 8463.7 05:51:12 INFO - PROCESS | 4624 | -------- Summary: end -------- 05:51:12 INFO - PROCESS | 4624 | 05:51:12 INFO - TEST-INFO | 4624: exit 0 05:51:12 INFO - TEST-OK | dromaeo_css | took 1110733ms 05:51:12 INFO - TEST-START | kraken 05:51:12 INFO - operating with platform_type : linux_ 05:51:12 INFO - Initialising browser for kraken test... 05:51:12 INFO - TEST-INFO | started process 4868 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLLzzCI/profile http://localhost:34899/getInfo.html) 05:51:16 INFO - PROCESS | 4868 | 05:51:16 INFO - PROCESS | 4868 | (process:4940): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:51:16 INFO - PROCESS | 4868 | __metrics Screen width/height:1600/1200 05:51:16 INFO - PROCESS | 4868 | colorDepth:24 05:51:16 INFO - PROCESS | 4868 | Browser inner width/height: 1024/670 05:51:16 INFO - PROCESS | 4868 | __metrics 05:51:17 INFO - PROCESS | 4868 | 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:51:17 INFO - TEST-INFO | 4868: exit 0 05:51:17 INFO - Browser initialized. 05:51:17 INFO - Running cycle 1/1 for kraken test... 05:51:17 INFO - TEST-INFO | started process 4989 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLLzzCI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:51:19 INFO - PROCESS | 4989 | 05:51:19 INFO - PROCESS | 4989 | (process:5049): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:51:29 INFO - PROCESS | 4989 | RSS: Main: 151429120 05:51:29 INFO - PROCESS | 4989 | 05:51:32 INFO - PROCESS | 4989 | Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34899/tests/kraken/driver.html?testName=audio-beat-detection) 05:51:32 INFO - PROCESS | 4989 | RSS: Main: 151302144 05:51:32 INFO - PROCESS | 4989 | 05:51:35 INFO - PROCESS | 4989 | Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34899/tests/kraken/driver.html?testName=audio-dft) 05:51:36 INFO - PROCESS | 4989 | RSS: Main: 155103232 05:51:36 INFO - PROCESS | 4989 | 05:51:38 INFO - PROCESS | 4989 | Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34899/tests/kraken/driver.html?testName=audio-fft) 05:51:39 INFO - PROCESS | 4989 | RSS: Main: 146960384 05:51:39 INFO - PROCESS | 4989 | 05:51:41 INFO - PROCESS | 4989 | Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34899/tests/kraken/driver.html?testName=audio-oscillator) 05:51:42 INFO - PROCESS | 4989 | RSS: Main: 148049920 05:51:42 INFO - PROCESS | 4989 | 05:51:44 INFO - PROCESS | 4989 | Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34899/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:51:45 INFO - PROCESS | 4989 | RSS: Main: 148373504 05:51:45 INFO - PROCESS | 4989 | 05:51:48 INFO - PROCESS | 4989 | Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34899/tests/kraken/driver.html?testName=imaging-darkroom) 05:51:48 INFO - PROCESS | 4989 | RSS: Main: 148381696 05:51:48 INFO - PROCESS | 4989 | 05:51:52 INFO - PROCESS | 4989 | Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34899/tests/kraken/driver.html?testName=imaging-desaturate) 05:51:52 INFO - PROCESS | 4989 | RSS: Main: 148676608 05:51:52 INFO - PROCESS | 4989 | 05:51:55 INFO - PROCESS | 4989 | Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34899/tests/kraken/driver.html?testName=json-parse-financial) 05:51:56 INFO - PROCESS | 4989 | RSS: Main: 151171072 05:51:56 INFO - PROCESS | 4989 | 05:51:57 INFO - PROCESS | 4989 | Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34899/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:51:58 INFO - PROCESS | 4989 | RSS: Main: 151207936 05:51:58 INFO - PROCESS | 4989 | 05:51:59 INFO - PROCESS | 4989 | Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34899/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:52:00 INFO - PROCESS | 4989 | RSS: Main: 151281664 05:52:00 INFO - PROCESS | 4989 | 05:52:02 INFO - PROCESS | 4989 | Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34899/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:52:03 INFO - PROCESS | 4989 | RSS: Main: 151621632 05:52:03 INFO - PROCESS | 4989 | 05:52:05 INFO - PROCESS | 4989 | Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34899/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:52:06 INFO - PROCESS | 4989 | RSS: Main: 151494656 05:52:06 INFO - PROCESS | 4989 | 05:52:08 INFO - PROCESS | 4989 | Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34899/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:52:09 INFO - PROCESS | 4989 | RSS: Main: 150470656 05:52:09 INFO - PROCESS | 4989 | 05:52:11 INFO - PROCESS | 4989 | Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34899/tests/kraken/driver.html?testName=ai-astar) 05:52:11 INFO - PROCESS | 4989 | RSS: Main: 150810624 05:52:11 INFO - PROCESS | 4989 | 05:52:11 INFO - PROCESS | 4989 | __start_tp_report 05:52:11 INFO - PROCESS | 4989 | _x_x_mozilla_page_load 05:52:11 INFO - PROCESS | 4989 | _x_x_mozilla_page_load_details 05:52:11 INFO - PROCESS | 4989 | |i|pagename|runs| 05:52:11 INFO - PROCESS | 4989 | |0;ai-astar;113;105;110;109;110;121;110;110;110;110 05:52:11 INFO - PROCESS | 4989 | |1;audio-beat-detection;146;126;169;158;130;161;147;127;169;128 05:52:11 INFO - PROCESS | 4989 | |2;audio-dft;162;163;162;163;161;161;161;167;169;161 05:52:11 INFO - PROCESS | 4989 | |3;audio-fft;76;73;72;76;71;71;146;72;72;72 05:52:11 INFO - PROCESS | 4989 | |4;audio-oscillator;96;96;143;94;96;96;141;95;96;139 05:52:11 INFO - PROCESS | 4989 | |5;imaging-gaussian-blur;110;110;110;109;111;109;110;110;110;110 05:52:11 INFO - PROCESS | 4989 | |6;imaging-darkroom;147;147;147;147;146;146;146;147;147;146 05:52:11 INFO - PROCESS | 4989 | |7;imaging-desaturate;95;97;96;97;97;97;96;96;96;96 05:52:11 INFO - PROCESS | 4989 | |8;json-parse-financial;58;61;58;59;58;58;64;58;56;56 05:52:11 INFO - PROCESS | 4989 | |9;json-stringify-tinderbox;67;71;68;67;67;68;67;67;67;67 05:52:11 INFO - PROCESS | 4989 | |10;stanford-crypto-aes;81;82;85;83;84;89;83;81;84;83 05:52:11 INFO - PROCESS | 4989 | |11;stanford-crypto-ccm;121;114;120;127;116;117;117;116;117;123 05:52:11 INFO - PROCESS | 4989 | |12;stanford-crypto-pbkdf2;134;146;150;144;146;150;146;140;145;142 05:52:11 INFO - PROCESS | 4989 | |13;stanford-crypto-sha256-iterative;69;70;70;68;69;67;68;66;69;68 05:52:11 INFO - PROCESS | 4989 | __end_tp_report 05:52:11 INFO - PROCESS | 4989 | __start_cc_report 05:52:11 INFO - PROCESS | 4989 | _x_x_mozilla_cycle_collect,745 05:52:11 INFO - PROCESS | 4989 | __end_cc_report 05:52:11 INFO - PROCESS | 4989 | __startTimestamp1452779531304__endTimestamp 05:52:11 INFO - PROCESS | 4989 | 05:52:11 INFO - PROCESS | 4989 | ------- Summary: start ------- 05:52:11 INFO - PROCESS | 4989 | Number of tests: 14 05:52:11 INFO - PROCESS | 4989 | 05:52:11 INFO - PROCESS | 4989 | [#0] ai-astar Cycles:10 Average:110.80 Median:110.00 stddev:4.08 (3.7%) stddev-sans-first:4.25 05:52:11 INFO - PROCESS | 4989 | Values: 113.0 105.0 110.0 109.0 110.0 121.0 110.0 110.0 110.0 110.0 05:52:11 INFO - PROCESS | 4989 | 05:52:11 INFO - PROCESS | 4989 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:152.50 stddev:17.54 (11.5%) stddev-sans-first:18.60 05:52:11 INFO - PROCESS | 4989 | Values: 146.0 126.0 169.0 158.0 130.0 161.0 147.0 127.0 169.0 128.0 05:52:11 INFO - PROCESS | 4989 | 05:52:11 INFO - PROCESS | 4989 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.50 stddev:2.79 (1.7%) stddev-sans-first:2.93 05:52:11 INFO - PROCESS | 4989 | Values: 162.0 163.0 162.0 163.0 161.0 161.0 161.0 167.0 169.0 161.0 05:52:11 INFO - PROCESS | 4989 | 05:52:11 INFO - PROCESS | 4989 | [#3] audio-fft Cycles:10 Average:80.10 Median:72.00 stddev:23.23 (32.3%) stddev-sans-first:24.59 05:52:11 INFO - PROCESS | 4989 | Values: 76.0 73.0 72.0 76.0 71.0 71.0 146.0 72.0 72.0 72.0 05:52:11 INFO - PROCESS | 4989 | 05:52:11 INFO - PROCESS | 4989 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:96.00 stddev:21.97 (22.9%) stddev-sans-first:22.78 05:52:11 INFO - PROCESS | 4989 | Values: 96.0 96.0 143.0 94.0 96.0 96.0 141.0 95.0 96.0 139.0 05:52:11 INFO - PROCESS | 4989 | 05:52:11 INFO - PROCESS | 4989 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 05:52:11 INFO - PROCESS | 4989 | Values: 110.0 110.0 110.0 109.0 111.0 109.0 110.0 110.0 110.0 110.0 05:52:11 INFO - PROCESS | 4989 | 05:52:11 INFO - PROCESS | 4989 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:52:11 INFO - PROCESS | 4989 | Values: 147.0 147.0 147.0 147.0 146.0 146.0 146.0 147.0 147.0 146.0 05:52:11 INFO - PROCESS | 4989 | 05:52:11 INFO - PROCESS | 4989 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.53 05:52:11 INFO - PROCESS | 4989 | Values: 95.0 97.0 96.0 97.0 97.0 97.0 96.0 96.0 96.0 96.0 05:52:11 INFO - PROCESS | 4989 | 05:52:11 INFO - PROCESS | 4989 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:58.00 stddev:2.37 (4.1%) stddev-sans-first:2.50 05:52:11 INFO - PROCESS | 4989 | Values: 58.0 61.0 58.0 59.0 58.0 58.0 64.0 58.0 56.0 56.0 05:52:11 INFO - PROCESS | 4989 | 05:52:11 INFO - PROCESS | 4989 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:67.00 stddev:1.26 (1.9%) stddev-sans-first:1.32 05:52:11 INFO - PROCESS | 4989 | Values: 67.0 71.0 68.0 67.0 67.0 68.0 67.0 67.0 67.0 67.0 05:52:11 INFO - PROCESS | 4989 | 05:52:11 INFO - PROCESS | 4989 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.50 stddev:2.32 (2.8%) stddev-sans-first:2.28 05:52:11 INFO - PROCESS | 4989 | Values: 81.0 82.0 85.0 83.0 84.0 89.0 83.0 81.0 84.0 83.0 05:52:11 INFO - PROCESS | 4989 | 05:52:11 INFO - PROCESS | 4989 | [#11] stanford-crypto-ccm Cycles:10 Average:118.80 Median:118.50 stddev:3.94 (3.3%) stddev-sans-first:4.10 05:52:11 INFO - PROCESS | 4989 | Values: 121.0 114.0 120.0 127.0 116.0 117.0 117.0 116.0 117.0 123.0 05:52:11 INFO - PROCESS | 4989 | 05:52:11 INFO - PROCESS | 4989 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.30 Median:146.00 stddev:4.76 (3.3%) stddev-sans-first:3.28 05:52:11 INFO - PROCESS | 4989 | Values: 134.0 146.0 150.0 144.0 146.0 150.0 146.0 140.0 145.0 142.0 05:52:11 INFO - PROCESS | 4989 | 05:52:11 INFO - PROCESS | 4989 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:69.00 stddev:1.26 (1.8%) stddev-sans-first:1.32 05:52:11 INFO - PROCESS | 4989 | Values: 69.0 70.0 70.0 68.0 69.0 67.0 68.0 66.0 69.0 68.0 05:52:11 INFO - PROCESS | 4989 | -------- Summary: end -------- 05:52:11 INFO - PROCESS | 4989 | 05:52:12 INFO - TEST-INFO | 4989: exit 0 05:52:12 INFO - TEST-OK | kraken | took 59408ms 05:52:12 INFO - TEST-START | v8_7 05:52:12 INFO - operating with platform_type : linux_ 05:52:12 INFO - Initialising browser for v8_7 test... 05:52:12 INFO - TEST-INFO | started process 5277 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIstv1d/profile http://localhost:34899/getInfo.html) 05:52:15 INFO - PROCESS | 5277 | 05:52:15 INFO - PROCESS | 5277 | (process:5348): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:52:16 INFO - PROCESS | 5277 | __metrics Screen width/height:1600/1200 05:52:16 INFO - PROCESS | 5277 | colorDepth:24 05:52:16 INFO - PROCESS | 5277 | Browser inner width/height: 1024/670 05:52:16 INFO - PROCESS | 5277 | __metrics 05:52:16 INFO - PROCESS | 5277 | 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:52:17 INFO - TEST-INFO | 5277: exit 0 05:52:17 INFO - Browser initialized. 05:52:17 INFO - Running cycle 1/1 for v8_7 test... 05:52:17 INFO - TEST-INFO | started process 5397 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIstv1d/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:18 INFO - PROCESS | 5397 | 05:52:18 INFO - PROCESS | 5397 | (process:5454): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:52:28 INFO - PROCESS | 5397 | RSS: Main: 150888448 05:52:28 INFO - PROCESS | 5397 | 05:52:51 INFO - PROCESS | 5397 | Cycle 1(1): loaded http://localhost:34899/tests/v8_7/run.html (next: http://localhost:34899/tests/v8_7/run.html) 05:52:51 INFO - PROCESS | 5397 | RSS: Main: 146186240 05:52:51 INFO - PROCESS | 5397 | 05:52:51 INFO - PROCESS | 5397 | __start_tp_report 05:52:51 INFO - PROCESS | 5397 | _x_x_mozilla_page_load 05:52:51 INFO - PROCESS | 5397 | _x_x_mozilla_page_load_details 05:52:51 INFO - PROCESS | 5397 | |i|pagename|runs| 05:52:51 INFO - PROCESS | 5397 | |0;Richards;165.6451880072884 05:52:51 INFO - PROCESS | 5397 | |1;DeltaBlue;187.82870022539444 05:52:51 INFO - PROCESS | 5397 | |2;Encrypt;279.09572983533354 05:52:51 INFO - PROCESS | 5397 | |3;Decrypt;5196.891191709845 05:52:51 INFO - PROCESS | 5397 | |4;RayTrace;1086.9565217391305 05:52:51 INFO - PROCESS | 5397 | |5;Earley;728.3321194464676 05:52:51 INFO - PROCESS | 5397 | |6;Boyer;12219.512195121952 05:52:51 INFO - PROCESS | 5397 | |7;RegExp;40877.551020408166 05:52:51 INFO - PROCESS | 5397 | |8;Splay;651.5837104072398 05:52:51 INFO - PROCESS | 5397 | |9;NavierStokes;4840.579710144928 05:52:51 INFO - PROCESS | 5397 | __end_tp_report 05:52:51 INFO - PROCESS | 5397 | __startTimestamp1452779571572__endTimestamp 05:52:51 INFO - PROCESS | 5397 | 05:52:51 INFO - PROCESS | 5397 | ------- Summary: start ------- 05:52:51 INFO - PROCESS | 5397 | Number of tests: 10 05:52:51 INFO - PROCESS | 5397 | 05:52:51 INFO - PROCESS | 5397 | [#0] Richards Cycles:1 Average:165.65 Median:165.65 stddev:0.00 (0.0%) 05:52:51 INFO - PROCESS | 5397 | Values: 165.6 05:52:51 INFO - PROCESS | 5397 | 05:52:51 INFO - PROCESS | 5397 | [#1] DeltaBlue Cycles:1 Average:187.83 Median:187.83 stddev:0.00 (0.0%) 05:52:51 INFO - PROCESS | 5397 | Values: 187.8 05:52:51 INFO - PROCESS | 5397 | 05:52:51 INFO - PROCESS | 5397 | [#2] Encrypt Cycles:1 Average:279.10 Median:279.10 stddev:0.00 (0.0%) 05:52:51 INFO - PROCESS | 5397 | Values: 279.1 05:52:51 INFO - PROCESS | 5397 | 05:52:51 INFO - PROCESS | 5397 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 05:52:51 INFO - PROCESS | 5397 | Values: 5196.9 05:52:51 INFO - PROCESS | 5397 | 05:52:51 INFO - PROCESS | 5397 | [#4] RayTrace Cycles:1 Average:1086.96 Median:1086.96 stddev:0.00 (0.0%) 05:52:51 INFO - PROCESS | 5397 | Values: 1087.0 05:52:51 INFO - PROCESS | 5397 | 05:52:51 INFO - PROCESS | 5397 | [#5] Earley Cycles:1 Average:728.33 Median:728.33 stddev:0.00 (0.0%) 05:52:51 INFO - PROCESS | 5397 | Values: 728.3 05:52:51 INFO - PROCESS | 5397 | 05:52:51 INFO - PROCESS | 5397 | [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 05:52:51 INFO - PROCESS | 5397 | Values: 12219.5 05:52:51 INFO - PROCESS | 5397 | 05:52:51 INFO - PROCESS | 5397 | [#7] RegExp Cycles:1 Average:40877.55 Median:40877.55 stddev:0.00 (0.0%) 05:52:51 INFO - PROCESS | 5397 | Values: 40877.6 05:52:51 INFO - PROCESS | 5397 | 05:52:51 INFO - PROCESS | 5397 | [#8] Splay Cycles:1 Average:651.58 Median:651.58 stddev:0.00 (0.0%) 05:52:51 INFO - PROCESS | 5397 | Values: 651.6 05:52:51 INFO - PROCESS | 5397 | 05:52:51 INFO - PROCESS | 5397 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 05:52:51 INFO - PROCESS | 5397 | Values: 4840.6 05:52:51 INFO - PROCESS | 5397 | -------- Summary: end -------- 05:52:51 INFO - PROCESS | 5397 | 05:52:52 INFO - TEST-INFO | 5397: exit 0 05:52:52 INFO - TEST-OK | v8_7 | took 40131ms 05:52:52 INFO - SUITE-END | took 1210s 05:52:52 INFO - Completed test suite (00:20:10) 05:52:52 INFO - Working with test: dromaeo_css 05:52:52 INFO - Generating results file: dromaeo_css 05:52:52 INFO - Working with test: kraken 05:52:52 INFO - Generating results file: kraken 05:52:52 INFO - javascript benchmark 05:52:52 INFO - Working with test: v8_7 05:52:52 INFO - Generating results file: v8_7 05:52:52 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:52:52 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 05:52:52 INFO - process_Request line: dromaeo_css 6823.70 graph.html#tests=[[72,1,43]] 05:52:52 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:52:52 INFO - process_Request line: kraken 1503.20 graph.html#tests=[[232,1,43]] 05:52:52 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:52:52 INFO - process_Request line: v8_7 20186.05 graph.html#tests=[[230,1,43]] 05:52:52 INFO - RETURN: dromaeo_css: 6823.70 05:52:52 INFO - RETURN: kraken: 1503.20 05:52:52 INFO - RETURN: v8_7: 20186.05 05:52:52 INFO - javascript benchmark 05:52:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3191.8244496552693, 3208.1017315151753, 3235.7896736712128, 3239.5950506186728, 3255.300110476248, 5164.9483505164935, 5234.345706786652, 5240.790368385265, 5244.056069907415, 5244.868878278045, 5167.586593072545, 5173.042987047399, 5299.761510732017, 5362.43694412087, 5362.4637536246355, 4731.929021064687, 4773.952260477386, 4827.63792715546, 4837.419509658828, 4905.0925578767865, 4786.162421576228, 4824.565789078983, 4833.3958255218095, 4873.658843880929, 4943.901121977558, 4685.789139488731, 4754.881127971828, 4774.952250477503, 4784.83253086142, 4821.373221481185, 4764.6426518011285, 4800.25596032612, 4805.303231031516, 4835.2505361669, 4841.515848415165, 4699.906001879977, 4768.976155119202, 4778.044391121754, 4787.042591481718, 4811.615070794328, 4942.061008408391, 4992.350994370745, 5152.381714194321, 5153.793848246066, 5240.371155461331, 5611.971940140314, 5630.0, 5631.8592035199445, 5632.0, 5635.3519345275, 5657.094864821609, 5671.2060311556415, 5674.687892165929, 5675.34733505648, 5684.715764211773, 5216.374035115772, 5252.3171987641745, 5276.050310944029, 5292.841214763564, 5351.545118664879, 5754.74103665336, 5789.45000224978, 5802.274715660543, 5805.970970145122, 5815.331236907725, 5458.099413596712, 5484.91772623411, 5537.501624853782, 5540.722963851791, 5569.443055694398, 5573.27547418833, 5598.216249725042, 5598.412166722517, 5599.860003499945, 5686.34607020198, 5647.604667673223, 5652.689102099342, 5665.971670141623, 5667.603267771299, 5688.06146985751, 5621.831345059655, 5637.041702910515, 5658.773649053992, 5663.207150998864, 5665.178549110356, 4320.632746216606, 4369.43197384338, 4381.145676593033, 4408.9559104408545, 4416.425864637641, 3850.5956874528333, 3861.4400911867624, 3876.8836934891997, 3904.629060239273, 3920.980395098063, 5225.634205605647, 5243.868903277372, 5244.737763111829, 5244.921326180111, 5246.055709972242, 5520.889582208413, 5560.499555040065, 5605.075162598126, 5656.519195868397, 5663.207150998864, 5232.136697444955, 5273.288106105703, 5273.868153296198, 5276.762545685453, 5287.762050707727, 4761.428628564525, 4762.9523704763205, 4764.190087685032, 4770.809167633325, 4797.18447863864, 5804.970975145097, 5819.301683797887, 5820.708964551755, 5829.88340233193, 5964.403559644088, 5658.094704847204, 5673.262475878275, 5681.715914204356, 5686.658800471985, 5691.430856914441, 5855.063189889597, 5861.325947515919, 5872.0, 5872.647641141545, 5900.881982360243, 5402.108652072521, 5550.5282051026115, 5551.417101204477, 5581.134924086773, 5649.096144616841, 5703.828885133453, 5705.686187259741, 5708.628939118944, 5713.285839270091, 5729.742161602821, 5479.561635069264, 5496.422875598005, 5529.336479622471, 5536.197251398606, 5544.528715059265, 5392.191171324333, 5493.835184944458, 5535.391106978149, 5585.720713964367, 5665.886682266249, 5408.405075441777, 5409.350877894678, 5414.35027796667, 5417.7832886685665, 5417.945820541901, 5460.972695136499, 5467.589930755289, 5489.615726899079, 5547.0, 5591.496765291144, 5350.892982140257, 5373.543248823894, 5397.298351214317, 5442.619016668795, 5489.149181876815], "unit": "score", "name": "dojo.html", "value": 5201.084374335796}, {"lowerIsBetter": false, "replicates": [529.1348644965483, 538.9137737961926, 546.934367875855, 551.0054351894829, 573.911043788213, 35669.82165089174, 36442.27115457689, 36652.0, 36675.63324366756, 36693.81653091738, 38760.61239387605, 39125.804370978105, 39359.0160245994, 39367.40948885769, 39371.40942885859, 8340.582970851463, 8571.314294856396, 8613.440126391764, 8615.95692021539, 8639.049704532528, 8333.833323333529, 8407.663693452254, 8429.3256539477, 8448.11294814045, 8453.365997550209, 8732.257758090569, 8767.780805479882, 8842.734717958472, 8850.070742572034, 8860.24687901529, 8729.694460693878, 8760.8685869712, 8804.119588041209, 8818.20636142747, 8837.95581022094, 8632.827343453158, 8705.912940870574, 8708.17272359125, 8770.254528365096, 8789.384743067987, 40192.0, 40528.0, 40618.796906015574, 40743.185136297405, 40753.59246407557, 2984.850757462118, 2990.3271763853177, 3094.3347180356104, 3235.078002769223, 3798.6771124454176, 29468.557971630442, 29874.40251194986, 30058.54912176319, 30163.0, 30468.39063218723, 3881.9029524261837, 4004.7797371144575, 4046.919061618751, 4060.2894493463823, 4064.959350406488, 215084.0, 215695.99999999843, 215869.0, 216107.95298305558, 217628.0, 42527.787361063616, 58838.41161588329, 58917.41082589205, 59193.0, 59211.0, 41301.79349103235, 41416.79291603583, 41523.377149342785, 41612.79193604013, 41737.165256694694, 14887.776683349759, 14997.775033374508, 15001.849981500045, 15022.924885375503, 15067.397304107932, 12042.759144817055, 12092.395380230953, 12106.334151621746, 12110.0, 12195.268283902995, 14194.077384969944, 14273.928630356782, 14652.853471465149, 14749.483768068067, 14764.114153150846, 5736.139579063174, 5841.240638716939, 5844.9415505845245, 5874.089516125007, 5918.141869428995, 950.7100334397936, 968.8352979993418, 969.60730903984, 1002.5488530161457, 1043.0664555223034, 28201.858990704914, 30668.38663226723, 30949.69050309513, 30986.690133098382, 31379.37241255208, 1029.6396261308632, 1044.796264728386, 1054.6888667843004, 1080.6920027792041, 1132.8753837077916, 14638.48765293231, 16064.839351606335, 16242.0, 16455.83544164567, 16737.246823892954, 399098.0, 400835.0, 400872.0, 403194.0, 404876.0, 54262.728686357106, 55060.0, 55114.448855511735, 55358.72320638371, 55565.44434555683, 1313.8554758976504, 1343.9126456780473, 1353.4924403348743, 1356.3150608942422, 1356.9389377478037, 29580.852095739385, 30251.316181583916, 30400.447829824527, 30592.235194120323, 30621.846890765402, 45553.77223113863, 45804.0, 46185.76907115443, 46213.76893115513, 46275.0, 307667.0, 308553.0, 308584.0, 309996.0, 311582.0, 33080.33839323248, 43643.78178109089, 43988.560114398446, 44266.77866610646, 44631.10737785291, 40230.597694023854, 40864.79567602143, 40945.385819213334, 41338.0, 41737.58262417337, 34517.0, 34554.48168277528, 34873.65126348704, 35367.82316088403, 39059.41410878782, 34127.82936085304, 34374.0, 34467.4829877547, 35005.0, 35145.121371965906, 34204.14489637779, 34558.82720586381, 34839.825800870836, 36955.6304436963, 37089.443658345685, 32262.838685806422, 33489.162770930925, 33711.263037077304, 33855.830720846236, 34209.657903420644, 24782.0, 25086.247412577653, 25209.85783502415, 25521.61717574275, 25603.615945760455], "unit": "score", "name": "ext.html", "value": 18116.07527584824}, {"lowerIsBetter": false, "replicates": [366.87342866710975, 370.0711214850724, 370.39255620781904, 370.6534390345027, 372.7409450431949, 15095.62260943477, 16065.598360041005, 16156.919215403921, 16792.916035419836, 16970.40603578875, 10988.890111098906, 11078.335299881992, 11336.263142895707, 11404.828927566094, 11409.771804563925, 4764.332993380921, 4936.679115857476, 4937.185364414867, 5012.498750124995, 5373.7581808818695, 5142.254373115896, 5253.343332083489, 5277.076511610472, 5298.417174110845, 5303.840884773444, 3756.0, 3913.66733827625, 5159.922601160967, 5274.077036518613, 5379.193121031837, 5237.8428647140645, 5450.781968721286, 5472.20653005314, 5472.781088756445, 5478.808241711521, 5010.0, 5179.7410129493755, 5191.117510023305, 5202.739863006835, 5212.270282160501, 12417.62747117588, 12638.431270592846, 15600.687986240211, 20387.796122038737, 20399.898000509904, 1976.3379267945256, 2044.7648520420043, 2126.2770657976207, 2169.0781417897488, 2176.68438076478, 9661.323707340489, 10001.249906256988, 10231.693049208536, 10572.0, 13292.936565074771, 1801.1714611278828, 1821.6629923464202, 1832.743415921772, 1840.3166778699012, 1866.1135960418692, 51136.488635113914, 55767.0, 56886.7155664219, 58367.70816145892, 58545.70727146337, 10132.949335253277, 10162.898371016343, 10382.221333400024, 10433.16534677224, 10459.0, 13395.263260520765, 13510.324483775772, 13526.59420217395, 13536.59390218295, 13543.45826166962, 7907.5650839203245, 7958.08482024563, 7993.9200607994335, 8004.159563245776, 8048.275655191061, 7722.382209423233, 7772.961135194288, 7792.727254546064, 7806.18035106317, 7832.765017049498, 4500.257457519473, 4504.932426013613, 4530.932036019462, 4538.069695712371, 4579.38178345919, 1844.7325137854937, 1845.5478407790176, 1849.2076963784514, 1858.3310008396966, 1920.059171006197, 462.6090953144655, 463.13625089208386, 465.9068186362673, 473.40351157541744, 953.6519170502855, 10615.681529554126, 10732.78534429307, 10783.406912619881, 10796.67609971702, 10960.56157753681, 471.30247234093736, 473.73944330618025, 479.8176692856692, 480.889395439051, 483.9975800121047, 5999.550033747487, 6016.338202797689, 6034.39656034393, 9501.23990080792, 10005.49972501372, 382254.0, 386111.0, 387760.0, 391708.0, 616890.0, 48389.0, 49379.753101234266, 69965.0, 75195.62402187954, 76865.15674216267, 1156.3119943633524, 1205.198542968916, 1206.5025397427241, 1207.8912897839236, 1211.418519110814, 15057.924710376377, 15149.0, 15233.162176079979, 15349.155796430858, 15549.0, 32167.19582010375, 32550.0, 32889.0, 34101.0, 34282.48576271408, 42700.5729942709, 43636.0, 43639.12721745611, 44263.336049958634, 45028.77485612551, 7205.459590530836, 7211.8557628848175, 7237.927620723725, 7266.96366518164, 7282.635868206463, 9284.21084207823, 10453.843192352273, 10585.364878107339, 11037.0, 11207.831882521605, 8844.336674749291, 9358.578863951003, 9402.247820174507, 9515.429074255568, 9529.666461673809, 3021.7582593392917, 3057.4802283612285, 9345.915847770355, 10086.94956525242, 10400.11599014062, 9981.351212171186, 10057.446840423847, 10343.586256549654, 10453.738656533344, 10476.423796691255, 7170.39051680613, 7191.280871912767, 7469.925300746923, 7630.618469076635, 7844.9607751960875, 9350.81298374015, 10216.4380959045, 10226.897731022595, 10261.28171028021, 10288.022637849692], "unit": "score", "name": "jquery.html", "value": 7553.46473403478}, {"lowerIsBetter": false, "replicates": [1468.2805425341585, 1480.3708423919832, 1623.7970253718286, 1744.6336269383428, 1790.794058683251, 7949.960250198748, 7977.04275486941, 8052.39607029473, 8105.392095592824, 8176.059753128392, 8228.094909559944, 8237.958810205955, 8334.0, 8375.95812020939, 8384.790380240496, 2405.4467472481297, 2428.9271321860374, 2433.634954756792, 2436.3300092474624, 2437.8049756019477, 2329.033451117784, 2347.530493901218, 2349.189529612281, 2355.3640517060385, 2449.1917667169882, 2380.5595964746576, 2389.928302150938, 2430.295214387834, 2434.1602147259255, 2441.4506735984437, 2345.0854166874933, 2345.976540234593, 2368.798652114572, 2376.9049238030457, 2397.220903206456, 2384.2251268337686, 2385.0817435287368, 2388.928332150021, 2389.7729715676983, 2391.1630929174826, 7739.61301934901, 7743.845123097506, 7779.299863012356, 7783.832425136275, 7799.688012479494, 4871.12319782439, 5009.824656137018, 5053.722045287508, 5059.873503162414, 5076.36545431821, 3177.8887738929025, 3271.492918597621, 3301.3067255876294, 3349.547811045502, 3365.848536815825, 1042.5881776698238, 1050.6060227414719, 1074.1084899533369, 1090.0788833435813, 1106.3859557945336, 11076.0, 11260.493277802518, 11260.605878794202, 11284.210105292634, 11297.661070167907, 4542.159700455426, 4647.3029045643425, 4682.882927926829, 4720.315554244616, 4721.409823772028, 9615.855762163574, 9630.711078667651, 9655.758606034764, 9716.0, 9731.075547822946, 5124.692518448905, 5140.742962851842, 5143.331366922351, 5162.432132465426, 5182.53357197854, 4614.180405833867, 4640.744759038218, 4660.953390466119, 4666.440027196691, 4697.13103075932, 3806.200697853482, 3808.143167787281, 3818.0836599215986, 3835.290471262825, 3844.961550384516, 1105.745678493951, 1132.7564573616712, 1159.0379984612919, 1180.527788884453, 1183.260462211118, 1253.1603825436796, 1254.3289340202948, 1276.8595454499998, 1277.278337739193, 1286.6075846866609, 7306.378957788541, 7307.342339189392, 7406.0, 7640.274173953577, 7663.885041724378, 1097.8956999085074, 1105.160078340467, 1115.2694984784978, 1129.4578602270956, 1134.971625709364, 5733.569982251264, 5825.271841019872, 5873.471387575053, 5887.587868849225, 5903.114532820111, 9244.90755092454, 9510.334276600572, 10004.599816007423, 10006.249531285182, 10069.093781559695, 9679.225661947028, 9817.067378599022, 9831.410115393099, 9831.75420614476, 9841.917389087195, 7331.3768329692575, 7488.513246638951, 7495.737649182143, 7530.736424225235, 7705.190954949761, 7445.181030086578, 7451.925480745123, 7532.209118042746, 7543.245675432413, 7545.849083018199, 8812.647494100163, 8865.423747456394, 8866.157715017063, 8884.156005179497, 8898.065703101081, 8529.573521324033, 9146.176844083799, 9161.129692679186, 9226.169644731737, 9231.861522077308, 7146.606936618536, 7227.241139680258, 7264.982902393775, 7267.491275610868, 7304.5252058616015, 7479.551226926402, 7548.245175482408, 7604.467687261838, 7668.923310766821, 7669.348105411103, 6309.652969086745, 7258.383037441877, 7303.342699157101, 7382.224866388952, 7418.777436676908, 7088.893666594902, 7119.074520312533, 7181.06646135999, 7298.890516642361, 7341.632918353954, 6925.411340036153, 6942.826429339307, 6963.651817409211, 6986.056882321025, 7046.753363632249, 6616.305287944889, 6642.468602511691, 6649.0691303218555, 6650.0, 6673.06577079219, 6570.113034740249, 6570.638614876228, 6596.472282217315, 6605.174353205849, 6621.0], "unit": "score", "name": "mootools.html", "value": 4690.1587601541}, {"lowerIsBetter": false, "replicates": [345.48867675839756, 349.56304619225966, 349.99900285184384, 355.11044832694097, 356.44572689467884, 6158.168647232622, 6205.379462053798, 6207.193064901562, 6286.3399343069, 6365.427111559959, 6206.348333424993, 6267.2165979252595, 6277.435030847223, 6313.526485513582, 6318.368163183679, 4838.322634831126, 4838.346823178878, 4839.9516004840025, 4840.9515904840855, 4845.958119004414, 4838.854834354975, 4839.7096174229655, 4841.661083724141, 4854.34466347044, 4855.951440485603, 4692.741899195543, 4758.119747846642, 4763.19025765619, 4776.450708168553, 4778.235482322829, 4749.525047495223, 4756.619470442356, 4758.833440829554, 4766.713997160165, 4769.3799806025345, 4116.567760385146, 4136.73111247768, 4138.503379594438, 4139.3583994480905, 4141.79291035447, 6017.48851347636, 6025.6987150642735, 6026.3672314406795, 6032.728527216286, 6048.274207095133, 5496.148097044965, 5639.774409023676, 5693.971530142323, 5702.6293290935955, 5702.971485142589, 6718.193816742022, 6761.628110453923, 6762.526623136382, 6766.25571187174, 6770.492213084039, 4620.283856002325, 4628.537146285378, 4651.906961860777, 4663.60359369454, 4695.272232803921, 6680.23177334603, 6774.220964589037, 6833.521653484258, 6837.623930683811, 6925.065116209297, 4709.952900470951, 4716.103940251342, 4731.2903064539905, 4735.934414756653, 4741.193997020515, 4790.401199850019, 4793.736344501016, 4795.95204047955, 4795.95204047962, 4800.279958006327, 5524.005678977742, 5566.916496252559, 5568.777248910079, 5574.693391863405, 5581.720913954286, 6461.57999730016, 6740.325967403221, 6745.561538499982, 6754.223264324567, 6771.559848609824, 1651.9669606607802, 1670.6825703116613, 1690.6111594333372, 1691.4671878358279, 1695.6947749404978, 1106.7011906785124, 1108.905743011853, 1124.7236414535257, 1125.943702814856, 1130.8586426696663, 6231.283402408781, 6231.563790534709, 6253.280872699606, 6261.843453913598, 6266.686665666698, 6758.05387245786, 6782.287859774653, 6801.081853949752, 6816.386525212754, 6836.38472537474, 6103.206583144163, 6212.565120441525, 6252.531060170414, 6256.405641464054, 6259.217597800275, 3678.70570354371, 3684.0, 3708.5364329458816, 3710.406334986389, 3725.385311423639, 7054.717811287491, 7100.183478899889, 7111.146662400545, 7111.715531378687, 7120.074390329328, 6824.317568243136, 6930.896036559456, 6972.337627925339, 6990.867785325525, 7003.2296447390745, 7112.14654241484, 7114.324139206767, 7118.003479512872, 7120.216776154619, 7121.003059571664, 6792.132163655035, 6848.14398200225, 6848.657567121524, 6851.424172440267, 6853.280405557344, 6602.10871532337, 6728.158980127484, 6728.529002969745, 6763.560368576027, 6768.9661551691925, 7096.929030709834, 7115.359617634438, 7116.928830711627, 7120.465965052746, 7138.678759455941, 4720.693154944917, 4732.313814496947, 4735.431748190239, 4739.857804265877, 4740.6681532292405, 6752.527323087336, 6773.0, 6859.759908403182, 6860.108185935996, 7048.718051277891, 6741.629210393476, 6795.014722865058, 6807.727690892309, 6808.353206445379, 6865.27914568963, 6781.762638307636, 6786.728530858711, 6797.28628494001, 6798.456123510206, 6799.830004249736, 6547.083408322934, 6598.868022639616, 6662.733490660513, 6671.39957403836, 6688.097106890702, 6829.31706829333, 6836.5214434989075, 6837.282085381163, 6838.0, 6861.0, 6658.267590565131, 6658.3674550917585, 6661.566998145299, 6669.2997235289595, 6685.298043705536], "unit": "score", "name": "prototype.html", "value": 5028.5203575474825}, {"lowerIsBetter": false, "replicates": [740.5297636001139, 775.5463054113343, 806.7418426103645, 823.3289868756959, 825.2160447574805, 12733.808992865102, 12756.23462592245, 12772.936135319322, 12819.807702884464, 12842.935785321071, 11817.350045747502, 11830.7633847323, 11851.22967007144, 11856.170068095236, 11864.703382415422, 780.9375249980017, 781.3827076609485, 790.1940021178394, 813.4427916876929, 818.153211426174, 806.4677312973439, 807.446898874273, 810.9918900811005, 811.290121143999, 815.5106935838509, 840.9453385529921, 843.0, 843.2874221283006, 843.2958479669484, 844.5312851367488, 834.5118105908051, 840.1892174052039, 841.0748177005306, 843.4981186194204, 846.1622993236713, 616.1127975714957, 618.3661746709614, 618.8793185328863, 621.710904429438, 621.7544070092333, 13935.163890166623, 13945.930270348685, 14021.64945876351, 14083.507077252349, 14125.576232713034, 11177.441127943652, 11263.324200547993, 11409.20135590509, 11409.37248451335, 11522.539098436053, 10327.018933201409, 10534.209934254885, 10556.577736890515, 10661.786764264749, 10711.83932241017, 3401.4557670772556, 3441.0709108540805, 3462.671046250602, 3509.6490350964955, 3544.291141771656, 48615.27077093846, 48842.0, 49014.509854901706, 49023.0, 49268.0, 9596.66411675588, 9781.119699227103, 10000.349977251455, 10066.647667331608, 10399.376037437627, 16879.831201687826, 16927.40754073626, 16948.152592370334, 16975.74536381955, 17112.05883676385, 6867.862642747117, 6989.825254368579, 7050.894840625932, 7083.787486375417, 7115.181754098345, 4079.2930022978207, 4082.7754473503646, 4242.384854196124, 4312.482502099768, 4321.0709697415205, 3071.385722855438, 3101.441740486734, 3116.9376612468077, 3130.857237108439, 3134.0, 567.8495198772329, 590.5806877117295, 594.3759052994338, 610.9175261339662, 614.536025300895, 533.6904595334696, 553.6124712701126, 612.429119308971, 626.2453743239386, 631.3875540725489, 8189.22202390772, 8233.876491852627, 8287.62705678234, 8480.703175388955, 8532.573371331533, 639.5941610921767, 654.2672207127952, 661.1570247933827, 662.4825662482547, 677.9661016949133, 3663.7252206084117, 3794.2411517696573, 3807.7144214184045, 3905.062784931596, 3980.3432433648704, 51720.741396292775, 51775.22337164945, 51872.0, 52406.0, 52483.0, 50304.24543631849, 51066.0, 51458.742706286976, 51821.0, 52024.73987630037, 43895.56104438915, 43938.12123757571, 44396.0, 44437.333439997776, 44535.0, 7772.653620840085, 7926.048874135141, 7932.286094251545, 7968.163342848918, 7987.560684162195, 32839.17902052468, 33591.83204083964, 33828.66171338354, 34030.48954265738, 34046.829765852, 43047.56952430436, 45634.31548526841, 45782.54217457916, 45791.31313030374, 45906.0, 9480.194183494481, 9696.5636546357, 9898.653547125816, 9931.503424828874, 10239.180865530889, 9834.803303934024, 9950.850737239092, 10108.898911010796, 10131.594736210764, 10160.54277557497, 9797.461139637388, 9839.212862971088, 9987.950060249652, 10101.444420556645, 10353.171746260432, 9912.752181195528, 9994.800103998024, 10128.84806727885, 10521.631742888962, 10550.472476376304, 10005.0, 10015.40755713434, 10031.12662470035, 10064.345817521838, 10132.037456441922, 7831.804204894923, 8015.398845086758, 8212.958935205286, 8514.446560973516, 8686.91313086861, 7781.5331080135375, 8132.9186708132165, 8415.3267738582, 8462.915370846458, 8463.661453542036], "unit": "score", "name": "yui.html", "value": 6013.856686700748}], "name": "dromaeo_css", "value": 6823.699401452869}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 105.0, 110.0, 109.0, 110.0, 121.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [146.0, 126.0, 169.0, 158.0, 130.0, 161.0, 147.0, 127.0, 169.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 163.0, 161.0, 161.0, 161.0, 167.0, 169.0, 161.0], "unit": "score", "name": "audio-dft", "value": 163.0}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 72.0, 76.0, 71.0, 71.0, 146.0, 72.0, 72.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 143.0, 94.0, 96.0, 96.0, 141.0, 95.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 111.0, 109.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 96.0, 97.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [58.0, 61.0, 58.0, 59.0, 58.0, 58.0, 64.0, 58.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.6}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 68.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 85.0, 83.0, 84.0, 89.0, 83.0, 81.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.5}, {"lowerIsBetter": true, "replicates": [121.0, 114.0, 120.0, 127.0, 116.0, 117.0, 117.0, 116.0, 117.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.8}, {"lowerIsBetter": true, "replicates": [134.0, 146.0, 150.0, 144.0, 146.0, 150.0, 146.0, 140.0, 145.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.3}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 68.0, 69.0, 67.0, 68.0, 66.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1503.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.6451880072884], "unit": "score", "name": "Richards", "value": 213.11817399999993}, {"lowerIsBetter": false, "replicates": [187.82870022539444], "unit": "score", "name": "DeltaBlue", "value": 352.01223200000004}, {"lowerIsBetter": false, "replicates": [279.09572983533354], "unit": "score", "name": "Encrypt", "value": 953.7265229999995}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1086.9565217391305], "unit": "score", "name": "RayTrace", "value": 680.7898799999998}, {"lowerIsBetter": false, "replicates": [728.3321194464676], "unit": "score", "name": "Earley", "value": 915.0536989999997}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [40877.551020408166], "unit": "score", "name": "RegExp", "value": 22.285703944083878}, {"lowerIsBetter": false, "replicates": [651.5837104072398], "unit": "score", "name": "Splay", "value": 125.06604861111116}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20186.053749993913}]} 05:52:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20186.05"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1503.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6823.70"}}} 05:52:52 INFO - Return code: 0 05:52:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:52:52 INFO - # TBPL SUCCESS # 05:52:52 INFO - Running post-action listener: _resource_record_post_action 05:52:52 INFO - Running post-run listener: _resource_record_post_run 05:52:53 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 528384; Write bytes: 316604416; Read time: 92; Write time: 235536 05:52:53 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1323008; Read time: 0; Write time: 76 05:52:53 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 528384; Write bytes: 315281408; Read time: 92; Write time: 235460 05:52:53 INFO - Running post-run listener: _upload_blobber_files 05:52:53 INFO - Blob upload gear active. 05:52:53 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:52:53 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:52:53 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:52:53 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:52:54 INFO - (blobuploader) - INFO - Open directory for files ... 05:52:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:52:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:52:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:55 INFO - (blobuploader) - INFO - Done attempting. 05:52:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:52:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:52:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:56 INFO - (blobuploader) - INFO - Done attempting. 05:52:56 INFO - (blobuploader) - INFO - Iteration through files over. 05:52:56 INFO - Return code: 0 05:52:56 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:52:56 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:52:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/308c1bf2e9cb8cd680823d856625fea79f48a1b89edadfda31098d714a2289f42cf5aa21c0eb25670f760bedbef0f4ade8985fcc442ac880ba8cd7e3f711353f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4c833a6f5e574b1f4c531f56ee7485793c12a4f9ce997ec24c5f406185b896851df7fbd7bccf0b890393faf6f50dfc669ac1e8bd78583751a3f8bdb58606ee1"} 05:52:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:52:56 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:52:56 INFO - Contents: 05:52:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/308c1bf2e9cb8cd680823d856625fea79f48a1b89edadfda31098d714a2289f42cf5aa21c0eb25670f760bedbef0f4ade8985fcc442ac880ba8cd7e3f711353f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4c833a6f5e574b1f4c531f56ee7485793c12a4f9ce997ec24c5f406185b896851df7fbd7bccf0b890393faf6f50dfc669ac1e8bd78583751a3f8bdb58606ee1"} 05:52:56 INFO - Copying logs to upload dir... 05:52:56 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1289.506632 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2016-01-14 05:52:56.160552) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 05:52:56.164585) ========= 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=1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/308c1bf2e9cb8cd680823d856625fea79f48a1b89edadfda31098d714a2289f42cf5aa21c0eb25670f760bedbef0f4ade8985fcc442ac880ba8cd7e3f711353f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4c833a6f5e574b1f4c531f56ee7485793c12a4f9ce997ec24c5f406185b896851df7fbd7bccf0b890393faf6f50dfc669ac1e8bd78583751a3f8bdb58606ee1"} build_url:https://queue.taskcluster.net/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011212 build_url: 'https://queue.taskcluster.net/v1/task/aQjpZWi7QlWmPIsQ3NrC8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/308c1bf2e9cb8cd680823d856625fea79f48a1b89edadfda31098d714a2289f42cf5aa21c0eb25670f760bedbef0f4ade8985fcc442ac880ba8cd7e3f711353f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4c833a6f5e574b1f4c531f56ee7485793c12a4f9ce997ec24c5f406185b896851df7fbd7bccf0b890393faf6f50dfc669ac1e8bd78583751a3f8bdb58606ee1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 05:52:56.189234) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 05:52:56.189557) ========= 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=1b9da9da7504fe468691862d000001b9-1452777917.847728-1011440118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004361 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 05:52:56.276410) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 05:52:56.276722) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 05:52:56.277023) ========= ========= Total master_lag: 0.19 =========