builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-069 starttime: 1450878569.05 results: success (0) buildid: 20151223030323 builduid: bc8591a4a26b4371b3c220396af6d5e6 revision: 35b211eaad1fa828064514c547057e4400e24459 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-23 05:49:29.050351) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-23 05:49:29.050873) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-23 05:49:29.051218) ========= 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=d96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006318 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-23 05:49:29.075191) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-23 05:49:29.075552) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-23 05:49:29.090244) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 05:49:29.090616) ========= 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=d96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004589 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 05:49:29.141759) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-23 05:49:29.142265) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-23 05:49:29.142873) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 05:49:29.143369) ========= 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=d96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-23 05:49:30-- 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% 60.7M=0s 2015-12-23 05:49:30 (60.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181556 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 05:49:29.339779) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 05:49:29.340095) ========= 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=d96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015284 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 05:49:29.393433) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 05:49:29.393851) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 35b211eaad1fa828064514c547057e4400e24459 --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 35b211eaad1fa828064514c547057e4400e24459 --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=d96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-23 05:49:30,989 truncating revision to first 12 chars 2015-12-23 05:49:30,989 Setting DEBUG logging. 2015-12-23 05:49:30,990 attempt 1/10 2015-12-23 05:49:30,990 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/35b211eaad1f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-23 05:49:31,229 unpacking tar archive at: mozilla-central-35b211eaad1f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.534481 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 05:49:29.944150) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-23 05:49:29.944482) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-23 05:49:30.004618) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-23 05:49:30.005193) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-23 05:49:30.005698) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-23 05:49:30.006029) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --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', '--system-bits', '64', '--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=d96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:49:31 INFO - MultiFileLogger online at 20151223 05:49:31 in /builds/slave/test-pgo 05:49:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:49:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:49:31 INFO - {'append_to_log': False, 05:49:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:49:31 INFO - 'blob_upload_branch': 'Firefox', 05:49:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:49:31 INFO - 'branch': 'Firefox', 05:49:31 INFO - 'buildbot_json_path': 'buildprops.json', 05:49:31 INFO - 'config_files': ('talos/linux_config.py',), 05:49:31 INFO - 'default_actions': ('clobber', 05:49:31 INFO - 'read-buildbot-config', 05:49:31 INFO - 'download-and-extract', 05:49:31 INFO - 'populate-webroot', 05:49:31 INFO - 'create-virtualenv', 05:49:31 INFO - 'install', 05:49:31 INFO - 'run-tests'), 05:49:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:49:31 INFO - 'download_minidump_stackwalk': True, 05:49:31 INFO - 'download_symbols': 'ondemand', 05:49:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:49:31 INFO - 'tooltool.py': '/tools/tooltool.py', 05:49:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:49:31 INFO - '/tools/misc-python/virtualenv.py')}, 05:49:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:49:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:49:31 INFO - 'installer_path': 'installer.exe', 05:49:31 INFO - 'log_level': 'info', 05:49:31 INFO - 'log_name': 'talos', 05:49:31 INFO - 'log_to_console': True, 05:49:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:49:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:49:31 INFO - 'opt_config_files': (), 05:49:31 INFO - 'pip_index': False, 05:49:31 INFO - 'sps_profile': False, 05:49:31 INFO - 'sps_profile_interval': 0, 05:49:31 INFO - 'suite': 'dromaeojs-e10s', 05:49:31 INFO - 'system_bits': '64', 05:49:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:49:31 INFO - 'title': 'talos-linux64-ix-069', 05:49:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:49:31 INFO - 'use_talos_json': True, 05:49:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:49:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:49:31 INFO - 'work_dir': 'build'} 05:49:31 INFO - ##### 05:49:31 INFO - ##### Running clobber step. 05:49:31 INFO - ##### 05:49:31 INFO - Running pre-action listener: _resource_record_pre_action 05:49:31 INFO - Running main action method: clobber 05:49:31 INFO - rmtree: /builds/slave/test-pgo/build 05:49:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:49:32 INFO - Running post-action listener: _resource_record_post_action 05:49:32 INFO - ##### 05:49:32 INFO - ##### Running read-buildbot-config step. 05:49:32 INFO - ##### 05:49:32 INFO - Running pre-action listener: _resource_record_pre_action 05:49:32 INFO - Running main action method: read_buildbot_config 05:49:32 INFO - Using buildbot properties: 05:49:32 INFO - { 05:49:32 INFO - "project": "", 05:49:32 INFO - "product": "firefox", 05:49:32 INFO - "script_repo_revision": "production", 05:49:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:49:32 INFO - "repository": "", 05:49:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:49:32 INFO - "buildid": "20151223030323", 05:49:32 INFO - "stage_platform": "linux64-pgo", 05:49:32 INFO - "basedir": "/builds/slave/test-pgo", 05:49:32 INFO - "nightly_build": "True", 05:49:32 INFO - "buildnumber": 275, 05:49:32 INFO - "slavename": "talos-linux64-ix-069", 05:49:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:49:32 INFO - "platform": "ubuntu64_hw", 05:49:32 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:49:32 INFO - "branch": "mozilla-central", 05:49:32 INFO - "repo_path": "mozilla-central", 05:49:32 INFO - "revision": "35b211eaad1fa828064514c547057e4400e24459", 05:49:32 INFO - "pgo_build": "True", 05:49:32 INFO - "builduid": "bc8591a4a26b4371b3c220396af6d5e6", 05:49:32 INFO - "slavebuilddir": "test" 05:49:32 INFO - } 05:49:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/WcVlU4W1SRmK0kh7-ZicKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:49:32 INFO - Running post-action listener: _resource_record_post_action 05:49:32 INFO - ##### 05:49:32 INFO - ##### Running download-and-extract step. 05:49:32 INFO - ##### 05:49:32 INFO - Running pre-action listener: _resource_record_pre_action 05:49:32 INFO - Running main action method: download_and_extract 05:49:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:32 INFO - https://queue.taskcluster.net/v1/task/WcVlU4W1SRmK0kh7-ZicKA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:49:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcVlU4W1SRmK0kh7-ZicKA/artifacts/public/build/test_packages.json 05:49:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcVlU4W1SRmK0kh7-ZicKA/artifacts/public/build/test_packages.json 05:49:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcVlU4W1SRmK0kh7-ZicKA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:49:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcVlU4W1SRmK0kh7-ZicKA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:49:38 INFO - Downloaded 1302 bytes. 05:49:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:49:38 INFO - Using the following test package requirements: 05:49:38 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:49:38 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:49:38 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:38 INFO - u'jsshell-linux-x86_64.zip'], 05:49:38 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:49:38 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:49:38 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:49:38 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:49:38 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:49:38 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:49:38 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:49:38 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:38 INFO - https://queue.taskcluster.net/v1/task/WcVlU4W1SRmK0kh7-ZicKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:49:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcVlU4W1SRmK0kh7-ZicKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:49:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcVlU4W1SRmK0kh7-ZicKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:49:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcVlU4W1SRmK0kh7-ZicKA/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:49:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcVlU4W1SRmK0kh7-ZicKA/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:49:46 INFO - Downloaded 23180958 bytes. 05:49:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:49:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:49:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:49:47 INFO - Return code: 0 05:49:47 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:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:47 INFO - https://queue.taskcluster.net/v1/task/WcVlU4W1SRmK0kh7-ZicKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:49:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcVlU4W1SRmK0kh7-ZicKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:49:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcVlU4W1SRmK0kh7-ZicKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:49:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcVlU4W1SRmK0kh7-ZicKA/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:49:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcVlU4W1SRmK0kh7-ZicKA/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:49:49 INFO - Downloaded 23180958 bytes. 05:49:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:49:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:49:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:49:51 INFO - Return code: 0 05:49:51 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:49:51 INFO - https://queue.taskcluster.net/v1/task/WcVlU4W1SRmK0kh7-ZicKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:49:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcVlU4W1SRmK0kh7-ZicKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:49:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcVlU4W1SRmK0kh7-ZicKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:49:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcVlU4W1SRmK0kh7-ZicKA/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:49:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcVlU4W1SRmK0kh7-ZicKA/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:49:51 INFO - Downloaded 11132277 bytes. 05:49:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:49:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:49:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:49:52 INFO - Return code: 0 05:49: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:49:52 INFO - https://queue.taskcluster.net/v1/task/WcVlU4W1SRmK0kh7-ZicKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:49:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcVlU4W1SRmK0kh7-ZicKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:49:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcVlU4W1SRmK0kh7-ZicKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:49:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcVlU4W1SRmK0kh7-ZicKA/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:49:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcVlU4W1SRmK0kh7-ZicKA/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:49:53 INFO - Downloaded 54837535 bytes. 05:49:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WcVlU4W1SRmK0kh7-ZicKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:49:53 INFO - mkdir: /builds/slave/test-pgo/properties 05:49:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:49:53 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:49:53 INFO - Contents: 05:49:53 INFO - build_url:https://queue.taskcluster.net/v1/task/WcVlU4W1SRmK0kh7-ZicKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:49:53 INFO - Running post-action listener: _resource_record_post_action 05:49:53 INFO - Running post-action listener: set_extra_try_arguments 05:49:53 INFO - ##### 05:49:53 INFO - ##### Running populate-webroot step. 05:49:53 INFO - ##### 05:49:53 INFO - Running pre-action listener: _resource_record_pre_action 05:49:53 INFO - Running main action method: populate_webroot 05:49:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:49:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:49:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:49:53 INFO - '--tppagecycles', 05:49:53 INFO - '7'], 05:49:53 INFO - 'tests': ['tsvgm']}}, 05:49:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:49:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:49:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:49:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:49:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:49:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:49:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:53 INFO - 'talos_options': ['--e10s'], 05:49:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:53 INFO - 'tests': ['damp', 'tps']}, 05:49:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:53 INFO - 'talos_options': ['--e10s'], 05:49:53 INFO - 'tests': ['damp', 'tps']}, 05:49:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:49:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:49:53 INFO - 'other': {'tests': ['a11yr', 05:49:53 INFO - 'ts_paint', 05:49:53 INFO - 'tpaint', 05:49:53 INFO - 'sessionrestore', 05:49:53 INFO - 'sessionrestore_no_auto_restore']}, 05:49:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:49:53 INFO - 'tests': ['a11yr', 05:49:53 INFO - 'ts_paint', 05:49:53 INFO - 'tpaint', 05:49:53 INFO - 'sessionrestore', 05:49:53 INFO - 'sessionrestore_no_auto_restore']}, 05:49:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:49:53 INFO - 'tests': ['a11yr', 05:49:53 INFO - 'ts_paint', 05:49:53 INFO - 'tpaint', 05:49:53 INFO - 'sessionrestore', 05:49:53 INFO - 'sessionrestore_no_auto_restore']}, 05:49:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:49:53 INFO - 'tests': ['a11yr', 05:49:53 INFO - 'ts_paint', 05:49:53 INFO - 'tpaint', 05:49:53 INFO - 'sessionrestore', 05:49:53 INFO - 'sessionrestore_no_auto_restore']}, 05:49:53 INFO - 'other_l64': {'tests': ['a11yr', 05:49:53 INFO - 'ts_paint', 05:49:53 INFO - 'tpaint', 05:49:53 INFO - 'sessionrestore', 05:49:53 INFO - 'sessionrestore_no_auto_restore']}, 05:49:53 INFO - 'other_nol64': {'tests': ['a11yr', 05:49:53 INFO - 'ts_paint', 05:49:53 INFO - 'tpaint', 05:49:53 INFO - 'sessionrestore', 05:49:53 INFO - 'sessionrestore_no_auto_restore']}, 05:49:53 INFO - 'svgr': {'tests': ['tsvgx', 05:49:53 INFO - 'tsvgr_opacity', 05:49:53 INFO - 'tart', 05:49:53 INFO - 'tscrollx', 05:49:53 INFO - 'cart']}, 05:49:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:49:53 INFO - 'tests': ['tsvgx', 05:49:53 INFO - 'tsvgr_opacity', 05:49:53 INFO - 'tart', 05:49:53 INFO - 'tscrollx', 05:49:53 INFO - 'cart']}, 05:49:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:53 INFO - 'tests': ['tp5o']}, 05:49:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:53 INFO - 'talos_options': ['--e10s'], 05:49:53 INFO - 'tests': ['tp5o']}, 05:49:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:53 INFO - 'talos_options': ['--xperf_path', 05:49:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:53 INFO - 'tests': ['tp5n']}, 05:49:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:53 INFO - 'talos_options': ['--e10s', 05:49:53 INFO - '--xperf_path', 05:49:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:53 INFO - 'tests': ['tp5n']}}, 05:49:53 INFO - 'talos.zip': {'path': '', 05:49:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:49:53 INFO - Running post-action listener: _resource_record_post_action 05:49:53 INFO - ##### 05:49:53 INFO - ##### Running create-virtualenv step. 05:49:53 INFO - ##### 05:49:53 INFO - Running pre-action listener: _resource_record_pre_action 05:49:53 INFO - Running main action method: create_virtualenv 05:49:53 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:49:53 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:49:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:49:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:49:53 INFO - Using real prefix '/usr' 05:49:53 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:49:54 INFO - Installing distribute.............................................................................................................................................................................................done. 05:49:56 INFO - Installing pip.................done. 05:49:56 INFO - Return code: 0 05:49:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:56 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 0x7fc550e87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1818480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a7660>, '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 0x18a8560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a8a10>, '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': 'd96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418', '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:49:56 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:49:56 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:49:56 INFO - Using env: {'DISPLAY': ':0', 05:49:56 INFO - 'HOME': '/home/cltbld', 05:49:56 INFO - 'LANG': 'en_US.UTF-8', 05:49:56 INFO - 'LANGUAGE': 'en_US:en', 05:49:56 INFO - 'LOGNAME': 'cltbld', 05:49:56 INFO - 'MAIL': '/var/mail/cltbld', 05:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:56 INFO - 'MOZ_NO_REMOTE': '1', 05:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:56 INFO - 'NO_EM_RESTART': '1', 05:49:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:49:56 INFO - 'PWD': '/builds/slave/test-pgo', 05:49:56 INFO - 'SHELL': '/bin/bash', 05:49:56 INFO - 'SHLVL': '1', 05:49:56 INFO - 'TERM': 'linux', 05:49:56 INFO - 'TMOUT': '86400', 05:49:56 INFO - 'USER': 'cltbld', 05:49:56 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418', 05:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:56 INFO - '_': '/tools/buildbot/bin/python'} 05:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:56 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:49:56 INFO - Cleaning up... 05:49:56 INFO - Return code: 0 05:49:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:56 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 0x7fc550e87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1818480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a7660>, '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 0x18a8560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a8a10>, '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': 'd96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418', '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:49:56 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:49:56 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:49:56 INFO - Using env: {'DISPLAY': ':0', 05:49:56 INFO - 'HOME': '/home/cltbld', 05:49:56 INFO - 'LANG': 'en_US.UTF-8', 05:49:56 INFO - 'LANGUAGE': 'en_US:en', 05:49:56 INFO - 'LOGNAME': 'cltbld', 05:49:56 INFO - 'MAIL': '/var/mail/cltbld', 05:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:56 INFO - 'MOZ_NO_REMOTE': '1', 05:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:56 INFO - 'NO_EM_RESTART': '1', 05:49:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:49:56 INFO - 'PWD': '/builds/slave/test-pgo', 05:49:56 INFO - 'SHELL': '/bin/bash', 05:49:56 INFO - 'SHLVL': '1', 05:49:56 INFO - 'TERM': 'linux', 05:49:56 INFO - 'TMOUT': '86400', 05:49:56 INFO - 'USER': 'cltbld', 05:49:56 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418', 05:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:56 INFO - '_': '/tools/buildbot/bin/python'} 05:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:56 INFO - Downloading/unpacking psutil>=0.7.1 05:49:56 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:49:56 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:49:56 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:49:56 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:49:56 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:49:56 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:49:58 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:49:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:49:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:49:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:58 INFO - Installing collected packages: psutil 05:49:58 INFO - Running setup.py install for psutil 05:49:58 INFO - building 'psutil._psutil_linux' extension 05:49:58 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:49:58 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:49:58 INFO - building 'psutil._psutil_posix' extension 05:49:58 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:49:58 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:49:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:58 INFO - Successfully installed psutil 05:49:58 INFO - Cleaning up... 05:49:58 INFO - Return code: 0 05:49:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:49:58 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:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:58 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:49:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:58 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 0x7fc550e87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1818480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a7660>, '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 0x18a8560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a8a10>, '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': 'd96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418', '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:49:58 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:49:58 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:49:58 INFO - Using env: {'DISPLAY': ':0', 05:49:58 INFO - 'HOME': '/home/cltbld', 05:49:58 INFO - 'LANG': 'en_US.UTF-8', 05:49:58 INFO - 'LANGUAGE': 'en_US:en', 05:49:58 INFO - 'LOGNAME': 'cltbld', 05:49:58 INFO - 'MAIL': '/var/mail/cltbld', 05:49:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:58 INFO - 'MOZ_NO_REMOTE': '1', 05:49:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:58 INFO - 'NO_EM_RESTART': '1', 05:49:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:49:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:49:58 INFO - 'SHELL': '/bin/bash', 05:49:58 INFO - 'SHLVL': '1', 05:49:58 INFO - 'TERM': 'linux', 05:49:58 INFO - 'TMOUT': '86400', 05:49:58 INFO - 'USER': 'cltbld', 05:49:58 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418', 05:49:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:58 INFO - '_': '/tools/buildbot/bin/python'} 05:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:49:59 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:49:59 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:49:59 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:49:59 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:49:59 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:49:59 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:50:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:50:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:50:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:50:00 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:50:00 INFO - Installing collected packages: mozsystemmonitor 05:50:00 INFO - Running setup.py install for mozsystemmonitor 05:50:00 INFO - Successfully installed mozsystemmonitor 05:50:00 INFO - Cleaning up... 05:50:00 INFO - Return code: 0 05:50:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:50:00 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:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:00 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:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:00 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 0x7fc550e87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1818480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a7660>, '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 0x18a8560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a8a10>, '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': 'd96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418', '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:50:00 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:50:00 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:50:00 INFO - Using env: {'DISPLAY': ':0', 05:50:00 INFO - 'HOME': '/home/cltbld', 05:50:00 INFO - 'LANG': 'en_US.UTF-8', 05:50:00 INFO - 'LANGUAGE': 'en_US:en', 05:50:00 INFO - 'LOGNAME': 'cltbld', 05:50:00 INFO - 'MAIL': '/var/mail/cltbld', 05:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:00 INFO - 'MOZ_NO_REMOTE': '1', 05:50:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:00 INFO - 'NO_EM_RESTART': '1', 05:50:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:50:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:50:00 INFO - 'SHELL': '/bin/bash', 05:50:00 INFO - 'SHLVL': '1', 05:50:00 INFO - 'TERM': 'linux', 05:50:00 INFO - 'TMOUT': '86400', 05:50:00 INFO - 'USER': 'cltbld', 05:50:00 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418', 05:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:00 INFO - '_': '/tools/buildbot/bin/python'} 05:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:01 INFO - Downloading/unpacking blobuploader==1.2.4 05:50:01 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:50:01 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:50:01 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:50:01 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:50:01 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:50:01 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:50:02 INFO - Downloading blobuploader-1.2.4.tar.gz 05:50:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:50:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:50:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:50:02 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:50:02 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:50:02 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:50:02 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:50:02 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:50:02 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:50:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:50:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:50:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:50: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:50: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:50: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:50: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:50: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:50: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:50:03 INFO - Downloading docopt-0.6.1.tar.gz 05:50:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:50:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:50:03 INFO - Installing collected packages: blobuploader, requests, docopt 05:50:03 INFO - Running setup.py install for blobuploader 05:50:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:50:03 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:50:03 INFO - Running setup.py install for requests 05:50:04 INFO - Running setup.py install for docopt 05:50:04 INFO - Successfully installed blobuploader requests docopt 05:50:04 INFO - Cleaning up... 05:50:04 INFO - Return code: 0 05:50:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:50:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:04 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 0x7fc550e87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1818480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a7660>, '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 0x18a8560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a8a10>, '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': 'd96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418', '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:50:04 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:50:04 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:50:04 INFO - Using env: {'DISPLAY': ':0', 05:50:04 INFO - 'HOME': '/home/cltbld', 05:50:04 INFO - 'LANG': 'en_US.UTF-8', 05:50:04 INFO - 'LANGUAGE': 'en_US:en', 05:50:04 INFO - 'LOGNAME': 'cltbld', 05:50:04 INFO - 'MAIL': '/var/mail/cltbld', 05:50:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:04 INFO - 'MOZ_NO_REMOTE': '1', 05:50:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:04 INFO - 'NO_EM_RESTART': '1', 05:50:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:50:04 INFO - 'PWD': '/builds/slave/test-pgo', 05:50:04 INFO - 'SHELL': '/bin/bash', 05:50:04 INFO - 'SHLVL': '1', 05:50:04 INFO - 'TERM': 'linux', 05:50:04 INFO - 'TMOUT': '86400', 05:50:04 INFO - 'USER': 'cltbld', 05:50:04 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418', 05:50:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:04 INFO - '_': '/tools/buildbot/bin/python'} 05:50:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:50:04 INFO - Running setup.py (path:/tmp/pip-HY_HlP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:50:04 INFO - Running setup.py (path:/tmp/pip-C4ZXg5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:50:04 INFO - Running setup.py (path:/tmp/pip-Yg9IOD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:50:04 INFO - Running setup.py (path:/tmp/pip-5mG4lD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:50:04 INFO - Running setup.py (path:/tmp/pip-16rx4p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:50:04 INFO - Running setup.py (path:/tmp/pip-h31lGO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:50:04 INFO - Running setup.py (path:/tmp/pip-qxNkf3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:50:04 INFO - Running setup.py (path:/tmp/pip-_Dgm9S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:50:04 INFO - Running setup.py (path:/tmp/pip-5v4dC1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:50:05 INFO - Running setup.py (path:/tmp/pip-9VfoNi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:50:05 INFO - Running setup.py (path:/tmp/pip-1sEDKn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:50:05 INFO - Running setup.py (path:/tmp/pip-587IHB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:50:05 INFO - Running setup.py (path:/tmp/pip-uUawLq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:50:05 INFO - Running setup.py (path:/tmp/pip-CVusT1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:50:05 INFO - Running setup.py (path:/tmp/pip-BWxWnY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:50:05 INFO - Running setup.py (path:/tmp/pip-jZp33Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:50:05 INFO - Running setup.py (path:/tmp/pip-1mkk6E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:50:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:50:05 INFO - Running setup.py install for manifestparser 05:50:05 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:50:05 INFO - Running setup.py install for mozcrash 05:50:05 INFO - Running setup.py install for mozdebug 05:50:05 INFO - Running setup.py install for mozdevice 05:50:06 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:50:06 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:50:06 INFO - Running setup.py install for mozfile 05:50:06 INFO - Running setup.py install for mozhttpd 05:50:06 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:50:06 INFO - Running setup.py install for mozinfo 05:50:06 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:50:06 INFO - Running setup.py install for mozInstall 05:50:06 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:50:06 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:50:06 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:50:06 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:50:06 INFO - Running setup.py install for mozleak 05:50:06 INFO - Running setup.py install for mozlog 05:50:06 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:50:06 INFO - Running setup.py install for moznetwork 05:50:06 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:50:06 INFO - Running setup.py install for mozprocess 05:50:06 INFO - Running setup.py install for mozprofile 05:50:06 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:50:06 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:50:06 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:50:06 INFO - Running setup.py install for mozrunner 05:50:07 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:50:07 INFO - Running setup.py install for mozscreenshot 05:50:07 INFO - Running setup.py install for moztest 05:50:07 INFO - Running setup.py install for mozversion 05:50:07 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:50:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:50:07 INFO - Cleaning up... 05:50:07 INFO - Return code: 0 05:50:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:50: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:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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:50:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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', '-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 0x7fc550e87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1818480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a7660>, '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 0x18a8560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a8a10>, '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': 'd96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418', '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:50:07 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:50:07 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:50:07 INFO - Using env: {'DISPLAY': ':0', 05:50:07 INFO - 'HOME': '/home/cltbld', 05:50:07 INFO - 'LANG': 'en_US.UTF-8', 05:50:07 INFO - 'LANGUAGE': 'en_US:en', 05:50:07 INFO - 'LOGNAME': 'cltbld', 05:50:07 INFO - 'MAIL': '/var/mail/cltbld', 05:50:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:07 INFO - 'MOZ_NO_REMOTE': '1', 05:50:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:07 INFO - 'NO_EM_RESTART': '1', 05:50:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:50:07 INFO - 'PWD': '/builds/slave/test-pgo', 05:50:07 INFO - 'SHELL': '/bin/bash', 05:50:07 INFO - 'SHLVL': '1', 05:50:07 INFO - 'TERM': 'linux', 05:50:07 INFO - 'TMOUT': '86400', 05:50:07 INFO - 'USER': 'cltbld', 05:50:07 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418', 05:50:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:07 INFO - '_': '/tools/buildbot/bin/python'} 05:50:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:50:07 INFO - Running setup.py (path:/tmp/pip-SvlR3v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:50:07 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:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:50:07 INFO - Running setup.py (path:/tmp/pip-E2Iq6p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:50:07 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:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:50:07 INFO - Running setup.py (path:/tmp/pip-kF258B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:50:07 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:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:50:07 INFO - Running setup.py (path:/tmp/pip-6xdeTc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:50:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:50:07 INFO - Running setup.py (path:/tmp/pip-HYbpxL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:50:07 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:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:50:07 INFO - Running setup.py (path:/tmp/pip-yK9FGA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:50:08 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:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:50:08 INFO - Running setup.py (path:/tmp/pip-pkFFDt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:50:08 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:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:50:08 INFO - Running setup.py (path:/tmp/pip-r0jt1o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:50:08 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:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:50:08 INFO - Running setup.py (path:/tmp/pip-Ob5LAP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:50:08 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:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:50:08 INFO - Running setup.py (path:/tmp/pip-0vmoD0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:50:08 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:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:50:08 INFO - Running setup.py (path:/tmp/pip-dzzltl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:50:08 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:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:50:08 INFO - Running setup.py (path:/tmp/pip-Qhgtxg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:50:08 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:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:50:08 INFO - Running setup.py (path:/tmp/pip-TxoBWi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:50:08 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:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:50:08 INFO - Running setup.py (path:/tmp/pip-v2DPHD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:50:08 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:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:50:08 INFO - Running setup.py (path:/tmp/pip-vH2N5g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:50:08 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:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:50:08 INFO - Running setup.py (path:/tmp/pip-dNcKHG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:50:08 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:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:50:08 INFO - Running setup.py (path:/tmp/pip-Egs2fy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:50:08 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:50:08 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:50:08 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:50:08 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:50:08 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:50:08 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:50:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:50: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:50: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:50: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:50: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:50: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:50: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:50:10 INFO - Downloading blessings-1.5.1.tar.gz 05:50:10 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:50:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:50:10 INFO - Installing collected packages: blessings 05:50:10 INFO - Running setup.py install for blessings 05:50:10 INFO - Successfully installed blessings 05:50:10 INFO - Cleaning up... 05:50:11 INFO - Return code: 0 05:50:11 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:50:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:50:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:50:11 INFO - Reading from file tmpfile_stdout 05:50:11 INFO - Current package versions: 05:50:11 INFO - argparse == 1.2.1 05:50:11 INFO - blessings == 1.5.1 05:50:11 INFO - blobuploader == 1.2.4 05:50:11 INFO - docopt == 0.6.1 05:50:11 INFO - manifestparser == 1.1 05:50:11 INFO - mozInstall == 1.12 05:50:11 INFO - mozcrash == 0.16 05:50:11 INFO - mozdebug == 0.1 05:50:11 INFO - mozdevice == 0.47 05:50:11 INFO - mozfile == 1.2 05:50:11 INFO - mozhttpd == 0.7 05:50:11 INFO - mozinfo == 0.9 05:50:11 INFO - mozleak == 0.1 05:50:11 INFO - mozlog == 3.1 05:50:11 INFO - moznetwork == 0.27 05:50:11 INFO - mozprocess == 0.22 05:50:11 INFO - mozprofile == 0.28 05:50:11 INFO - mozrunner == 6.11 05:50:11 INFO - mozscreenshot == 0.1 05:50:11 INFO - mozsystemmonitor == 0.0 05:50:11 INFO - moztest == 0.7 05:50:11 INFO - mozversion == 1.4 05:50:11 INFO - psutil == 3.1.1 05:50:11 INFO - requests == 1.2.3 05:50:11 INFO - wsgiref == 0.1.2 05:50:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:50: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:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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:50:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:11 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 0x7fc550e87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1818480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a7660>, '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 0x18a8560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a8a10>, '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': 'd96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418', '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:50:11 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:50:11 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:50:11 INFO - Using env: {'DISPLAY': ':0', 05:50:11 INFO - 'HOME': '/home/cltbld', 05:50:11 INFO - 'LANG': 'en_US.UTF-8', 05:50:11 INFO - 'LANGUAGE': 'en_US:en', 05:50:11 INFO - 'LOGNAME': 'cltbld', 05:50:11 INFO - 'MAIL': '/var/mail/cltbld', 05:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:11 INFO - 'MOZ_NO_REMOTE': '1', 05:50:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:11 INFO - 'NO_EM_RESTART': '1', 05:50:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:50:11 INFO - 'PWD': '/builds/slave/test-pgo', 05:50:11 INFO - 'SHELL': '/bin/bash', 05:50:11 INFO - 'SHLVL': '1', 05:50:11 INFO - 'TERM': 'linux', 05:50:11 INFO - 'TMOUT': '86400', 05:50:11 INFO - 'USER': 'cltbld', 05:50:11 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418', 05:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:11 INFO - '_': '/tools/buildbot/bin/python'} 05:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:11 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:50:11 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:50:11 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:50:11 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:50:11 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:50:11 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:50:11 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:50:11 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:50:11 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:50:11 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:50:11 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:50:11 INFO - Cleaning up... 05:50:11 INFO - Return code: 0 05:50:11 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:50: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:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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:50:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:11 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 0x7fc550e87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1818480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a7660>, '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 0x18a8560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a8a10>, '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': 'd96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418', '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:50:11 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:50:11 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:50:11 INFO - Using env: {'DISPLAY': ':0', 05:50:11 INFO - 'HOME': '/home/cltbld', 05:50:11 INFO - 'LANG': 'en_US.UTF-8', 05:50:11 INFO - 'LANGUAGE': 'en_US:en', 05:50:11 INFO - 'LOGNAME': 'cltbld', 05:50:11 INFO - 'MAIL': '/var/mail/cltbld', 05:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:11 INFO - 'MOZ_NO_REMOTE': '1', 05:50:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:11 INFO - 'NO_EM_RESTART': '1', 05:50:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:50:11 INFO - 'PWD': '/builds/slave/test-pgo', 05:50:11 INFO - 'SHELL': '/bin/bash', 05:50:11 INFO - 'SHLVL': '1', 05:50:11 INFO - 'TERM': 'linux', 05:50:11 INFO - 'TMOUT': '86400', 05:50:11 INFO - 'USER': 'cltbld', 05:50:11 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418', 05:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:11 INFO - '_': '/tools/buildbot/bin/python'} 05:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:11 INFO - Downloading/unpacking jsonschema 05:50:11 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:50:11 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:50:11 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:50:11 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:50:11 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:50:11 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:50:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:50:13 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:50:13 INFO - Downloading/unpacking functools32 (from jsonschema) 05:50:13 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:50:13 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:50:13 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:50:13 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:50:13 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:50:13 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:50:13 INFO - Downloading functools32-3.2.3-2.tar.gz 05:50:13 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:50:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:50:13 INFO - warning: no files found matching '*.txt' 05:50:13 INFO - no previously-included directories found matching 'build' 05:50:13 INFO - no previously-included directories found matching 'dist' 05:50:13 INFO - no previously-included directories found matching '.git*' 05:50:13 INFO - Installing collected packages: jsonschema, functools32 05:50:13 INFO - Running setup.py install for functools32 05:50:13 INFO - warning: no files found matching '*.txt' 05:50:13 INFO - no previously-included directories found matching 'build' 05:50:13 INFO - no previously-included directories found matching 'dist' 05:50:13 INFO - no previously-included directories found matching '.git*' 05:50:13 INFO - Successfully installed jsonschema functools32 05:50:13 INFO - Cleaning up... 05:50:13 INFO - Return code: 0 05:50:13 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:50:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:13 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 0x7fc550e87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1818480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a7660>, '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 0x18a8560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a8a10>, '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': 'd96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418', '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:50:13 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:50:13 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:50:13 INFO - Using env: {'DISPLAY': ':0', 05:50:13 INFO - 'HOME': '/home/cltbld', 05:50:13 INFO - 'LANG': 'en_US.UTF-8', 05:50:13 INFO - 'LANGUAGE': 'en_US:en', 05:50:13 INFO - 'LOGNAME': 'cltbld', 05:50:13 INFO - 'MAIL': '/var/mail/cltbld', 05:50:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:13 INFO - 'MOZ_NO_REMOTE': '1', 05:50:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:13 INFO - 'NO_EM_RESTART': '1', 05:50:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:50:13 INFO - 'PWD': '/builds/slave/test-pgo', 05:50:13 INFO - 'SHELL': '/bin/bash', 05:50:13 INFO - 'SHLVL': '1', 05:50:13 INFO - 'TERM': 'linux', 05:50:13 INFO - 'TMOUT': '86400', 05:50:13 INFO - 'USER': 'cltbld', 05:50:13 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418', 05:50:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:13 INFO - '_': '/tools/buildbot/bin/python'} 05:50:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:14 INFO - Downloading/unpacking flake8 05:50:14 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:50:14 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:50:14 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:50:14 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:50:14 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:50:14 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:50:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:50:15 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:50:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:50:15 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:50:15 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:50:15 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:50:15 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:50:15 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:50:15 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:50:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:50:16 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:50:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:50: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:50: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:50: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:50: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:50: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:50: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:50:16 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:50:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:50: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:50: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:50: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:50: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:50: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:50: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:50:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:50:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:50:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:50:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:50:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:50:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:50:16 INFO - no previously-included directories found matching 'docs/_build' 05:50:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:50:16 INFO - Running setup.py install for pep8 05:50:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:50:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:50:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:50:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:50:16 INFO - no previously-included directories found matching 'docs/_build' 05:50:16 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:50:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:50:16 INFO - Cleaning up... 05:50:16 INFO - Return code: 0 05:50:16 INFO - Running post-action listener: _resource_record_post_action 05:50:16 INFO - Running post-action listener: _start_resource_monitoring 05:50:16 INFO - Starting resource monitoring. 05:50:16 INFO - ##### 05:50:16 INFO - ##### Running install step. 05:50:16 INFO - ##### 05:50:16 INFO - Running pre-action listener: _resource_record_pre_action 05:50:16 INFO - Running main action method: install 05:50:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:50:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:50:16 INFO - Reading from file tmpfile_stdout 05:50:16 INFO - Detecting whether we're running mozinstall >=1.0... 05:50:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:50:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:50:17 INFO - Reading from file tmpfile_stdout 05:50:17 INFO - Output received: 05:50:17 INFO - Usage: mozinstall [options] installer 05:50:17 INFO - Options: 05:50:17 INFO - -h, --help show this help message and exit 05:50:17 INFO - -d DEST, --destination=DEST 05:50:17 INFO - Directory to install application into. [default: 05:50:17 INFO - "/builds/slave/test-pgo"] 05:50:17 INFO - --app=APP Application being installed. [default: firefox] 05:50:17 INFO - mkdir: /builds/slave/test-pgo/build/application 05:50:17 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:50:17 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:50:32 INFO - Reading from file tmpfile_stdout 05:50:32 INFO - Output received: 05:50:32 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:50:32 INFO - Running post-action listener: _resource_record_post_action 05:50:32 INFO - ##### 05:50:32 INFO - ##### Running run-tests step. 05:50:32 INFO - ##### 05:50:32 INFO - Running pre-action listener: _resource_record_pre_action 05:50:32 INFO - Running main action method: run_tests 05:50:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:50:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:50:32 INFO - Python 2.7.3 05:50:32 INFO - Return code: 0 05:50:32 INFO - grabbing minidump binary from tooltool 05:50:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:32 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 0x18a7660>, '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 0x18a8560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a8a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:50:32 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:50:32 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:50:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:50:32 INFO - Return code: 0 05:50:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:50:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:50:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:50:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:50:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:50:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:50:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:50:33 INFO - Return code: 0 05:50:33 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/WcVlU4W1SRmK0kh7-ZicKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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:50:33 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/WcVlU4W1SRmK0kh7-ZicKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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:50:33 INFO - Using env: {'DISPLAY': ':0', 05:50:33 INFO - 'HOME': '/home/cltbld', 05:50:33 INFO - 'LANG': 'en_US.UTF-8', 05:50:33 INFO - 'LANGUAGE': 'en_US:en', 05:50:33 INFO - 'LOGNAME': 'cltbld', 05:50:33 INFO - 'MAIL': '/var/mail/cltbld', 05:50:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:50:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:50:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:33 INFO - 'MOZ_NO_REMOTE': '1', 05:50:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:50:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:33 INFO - 'NO_EM_RESTART': '1', 05:50:33 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:50:33 INFO - 'PWD': '/builds/slave/test-pgo', 05:50:33 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:50:33 INFO - 'SHELL': '/bin/bash', 05:50:33 INFO - 'SHLVL': '1', 05:50:33 INFO - 'TERM': 'linux', 05:50:33 INFO - 'TMOUT': '86400', 05:50:33 INFO - 'USER': 'cltbld', 05:50:33 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418', 05:50:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:33 INFO - '_': '/tools/buildbot/bin/python'} 05:50:33 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/WcVlU4W1SRmK0kh7-ZicKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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:50:34 INFO - mozversion application_buildid: 20151223030323 05:50:34 INFO - mozversion application_changeset: 35b211eaad1fa828064514c547057e4400e24459 05:50:34 INFO - mozversion application_display_name: Nightly 05:50:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:50:34 INFO - mozversion application_name: Firefox 05:50:34 INFO - mozversion application_remotingname: firefox 05:50:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:50:34 INFO - mozversion application_vendor: Mozilla 05:50:34 INFO - mozversion application_version: 46.0a1 05:50:34 INFO - mozversion platform_buildid: 20151223030323 05:50:34 INFO - mozversion platform_changeset: 35b211eaad1fa828064514c547057e4400e24459 05:50:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:50:34 INFO - mozversion platform_version: 46.0a1 05:50:34 INFO - using testdate: 1450878634 05:50:34 INFO - actual date: 1450878634 05:50:34 INFO - starting webserver on 'localhost:38462' 05:50:34 INFO - SUITE-START | Running 3 tests 05:50:34 INFO - TEST-START | dromaeo_css 05:50:34 INFO - operating with platform_type : linux_ 05:50:34 INFO - Initialising browser for dromaeo_css test... 05:50:34 INFO - TEST-INFO | started process 20303 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWCg7sk/profile http://localhost:38462/getInfo.html) 05:50:38 INFO - PROCESS | 20303 | __metrics Screen width/height:1600/1200 05:50:38 INFO - PROCESS | 20303 | colorDepth:24 05:50:38 INFO - PROCESS | 20303 | Browser inner width/height: 1024/670 05:50:38 INFO - PROCESS | 20303 | __metrics 05:50:39 INFO - PROCESS | 20303 | 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:50:40 INFO - TEST-INFO | 20303: exit 0 05:50:40 INFO - Browser initialized. 05:50:40 INFO - Running cycle 1/1 for dromaeo_css test... 05:50:40 INFO - TEST-INFO | started process 20437 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWCg7sk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:50:51 INFO - PROCESS | 20437 | RSS: Main: 151588864 05:50:51 INFO - PROCESS | 20437 | 05:51:41 INFO - PROCESS | 20437 | 1450878701415 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:53:50 INFO - PROCESS | 20437 | Cycle 1(1): loaded http://localhost:38462/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38462/tests/dromaeo/cssquery-ext.html) 05:53:51 INFO - PROCESS | 20437 | RSS: Main: 157540352 05:53:51 INFO - PROCESS | 20437 | 05:56:53 INFO - PROCESS | 20437 | Cycle 1(1): loaded http://localhost:38462/tests/dromaeo/cssquery-ext.html (next: http://localhost:38462/tests/dromaeo/cssquery-jquery.html) 05:56:54 INFO - PROCESS | 20437 | RSS: Main: 153694208 05:56:54 INFO - PROCESS | 20437 | 05:59:55 INFO - PROCESS | 20437 | Cycle 1(1): loaded http://localhost:38462/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38462/tests/dromaeo/cssquery-mootools.html) 05:59:56 INFO - PROCESS | 20437 | RSS: Main: 154365952 05:59:56 INFO - PROCESS | 20437 | 06:02:58 INFO - PROCESS | 20437 | Cycle 1(1): loaded http://localhost:38462/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38462/tests/dromaeo/cssquery-prototype.html) 06:02:58 INFO - PROCESS | 20437 | RSS: Main: 152793088 06:02:58 INFO - PROCESS | 20437 | 06:06:01 INFO - PROCESS | 20437 | Cycle 1(1): loaded http://localhost:38462/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38462/tests/dromaeo/cssquery-yui.html) 06:06:01 INFO - PROCESS | 20437 | RSS: Main: 153358336 06:06:01 INFO - PROCESS | 20437 | 06:09:04 INFO - PROCESS | 20437 | Cycle 1(1): loaded http://localhost:38462/tests/dromaeo/cssquery-yui.html (next: http://localhost:38462/tests/dromaeo/cssquery-dojo.html) 06:09:04 INFO - PROCESS | 20437 | RSS: Main: 155451392 06:09:04 INFO - PROCESS | 20437 | 06:09:04 INFO - PROCESS | 20437 | __start_tp_report 06:09:04 INFO - PROCESS | 20437 | _x_x_mozilla_page_load 06:09:04 INFO - PROCESS | 20437 | _x_x_mozilla_page_load_details 06:09:04 INFO - PROCESS | 20437 | |i|pagename|runs| 06:09:04 INFO - PROCESS | 20437 | |0;dojo.html;3208.7914285571437;3231.466807976684;3270.1007223013653;3279.245773472102;3285.3757786020656;5347;5438.619296649226;5452.67283962962;5455.945440545594;5462.863428414292;5490.69801160936;5506.146547285167;5517.841253336794;5580.386157522669;5660.29246344207;4924.778384972676;4966.404031516223;5034.697918124924;5037.722925239111;5144;5056.873578160538;5078.238264260372;5107.7956881724685;5156.561692256163;5167.302414174094;4766.713997160146;4888.535589119028;4972.179590367585;4981.651284410093;5011.14810482217;4960.429550601691;4969.975150124263;4983.676061056056;4996.775145118442;5063.924041139386;4902.803887844482;4989.700617962933;5003.449620541737;5008.974955125201;5063.721495317756;5181.53366197044;5230.529252367267;5262.210668399733;5269.394019687747;5335.0663633863915;5915.231019967377;6021.157038014681;6022.066579680157;6022.337542870281;6029.216201893726;5762.798302059449;5886.941130588682;6054.545909056838;6082.482988945945;6088.178095957033;5467.835964921019;5531.585131115183;5538.75075621598;5540.335159780811;5566.832995010156;6102.701334035014;6103.981246026694;6107.408898231393;6111.691282510336;6116.4879456621975;5820.301563812285;5888.735006924699;5908.497777688945;5913.349531551526;5941.079132734433;5815.825525234165;5839.532837373;5935.614185077956;5973;5985.610935289193;5975.641461512323;5977.372375900555;5981.282246130405;6002.0996850472775;6028.638281703112;5876.294844618587;5968.104784282393;5980.162777211194;5982.371850955674;5985.970070149621;4417.911641767147;4475.373447717322;4504.2793153096;4544.795484203219;4610.608098311614;4086.3870419436726;4103.548609652936;4106;4113.218488487178;4126.195391898551;5539.058360078796;5570.220169176318;5576.1356989666665;5588.329400471969;5613.438656134435;5861.1501332307425;5887.322957859816;5956.851078723066;5979.581429299994;5989.431004054608;5509.338879334506;5537.446255374511;5554.389017208104;5565.193047008162;5574.498295153456;5110.131277682803;5136.203888397305;5146.485351464824;5151.793928242828;5155.7679904404395;6017.578769486094;6082.300535438393;6143.385661433821;6144.064619644798;6146.0473626587955;5827.446392592697;5872.647641141545;5874.942510348178;5885.646861188171;5996.370381110095;5846.532277417711;6094.299155597163;6104.969475152596;6118.632882027093;6124.112003759519;5834.795782147605;5854.326752423526;5855.916655418761;5870.031444811729;5871.031279838779;5853.531717462678;5895.322037965518;5963.105534169909;5984.19213406202;6000.039993601003;5777.682227477361;5793.623414478046;5826.73779679907;5839.153322768259;5846.6784326862435;5574.275344205227;5742.224799651994;5805.738741756547;5817.738201781015;5818.894410062075;5671.943280567141;5684.488396044376;5719.971400142973;5731.426857314235;5745.913811292918;5753;5793.594448388572;5827.679477628772;5830.125481177857;5832.445917637818;5501.532369748456;5551.111822108443;5660.971695141498;5686.459786320293;5707.286589176353 06:09:04 INFO - PROCESS | 20437 | |1;ext.html;559.1603624076785;586.7447660267784;595.934447210807;600.1208229943134;606.7451670298476;37089.44365834511;37502.62497375025;37923.431148532756;38158.23683526328;38228;42409.78795106028;42584.72245832622;42904;42998;43021;8719.215270625642;8756.562171891412;8812.118788121168;8837.690680826172;8928.37501374904;8538.359623028298;8677.69628063018;8689.82620347596;8728.25809806164;8767.605457754384;8765.342599305046;8811.559422028873;8842.867356989651;8885;8916.063813299608;8658.956705216466;8786.07746186654;8797.692080777206;8803.735887923373;8850.291976641918;8587.828243435097;8679.43583667066;8691.174338437839;8725.214730674206;8731.563421828947;39755.60244397577;40364.394534082014;40421.393679094836;40466;40522.797386013175;3248.3665685191395;3352.715019223369;3530.3998320285614;3874.2832575973252;3946.881593552198;29720.55419168714;30039.098827035225;30089.398212035638;30335.69664303351;30430.54354184689;3780.640839120279;3821.48409964654;3834.6740527055235;3880.165764360676;3981.0843505993785;258157;258322;258327;259048.9999999981;259184;57089.42910570924;57480.137797933065;57527.71236143876;57574.424255757745;57637.42362576321;53141.7342913283;54037.45962540403;66836.6658166706;68081.31918680848;68123;13024.54414095502;13215.273159976294;13334.599962001155;13336;13388.263645499395;9722.2708296878;9827.459489728133;9862.211023118134;9870.901290986998;9876.506174691236;18795.90602046981;19034.238630454627;19084.71372929407;19144.808551914302;19242.422727318204;8011.439199256112;8143.032750022481;8166.1833816619055;8286.254237118688;8312.459690120122;982.3271059324386;1020.0513522424069;1064.669952314785;1076.4079756134252;1093.9771313821602;27640.723592763814;27708.861455692593;27710.584341234495;27789.583156252673;27881.30296742557;1064.3294724323628;1070.0797314309686;1074.2211896375222;1118.6755840806238;1165.3823473559028;14503.709925801424;15189.772153417707;15503.922480387751;15556.45552405683;15643.608909777118;314900;317097;319432;319525;319800;49352.50647493551;49777;49861;50106.74946625243;50129;1354.3702178487051;1362.0942073521196;1374.2785037855006;1378.6484446466288;1388.222595346609;27236.182914512596;28147.71852281451;28171.43657126887;28176.937857807206;28312.575311370758;43901.121977560906;44279.55720442755;44456.33315500205;44500.33249501196;44617.55382446134;297198;297425;299659;299828;300454;30241.848790755907;31003.224919377197;31844.6815531851;31938.520922185722;32065.51901721523;37980;39441.60558394379;40738.59261407348;41174;41212.58787412207;34202.82898585491;34619.30761384708;35192.64807351996;35210.78988847048;35379;34273.82863085669;34376.48435273523;34754;34783.82608086943;35197;33490.33019339648;33845.66154338425;34271.31457370789;34292;34360.65639343575;30015.54976675308;30728.846355768077;31983;32059.198520036254;32220;24329;24339.878300608383;24342.391440214138;24688.876555617106;24746.133885313928 06:09:04 INFO - PROCESS | 20437 | |2;jquery.html;364.9927001459971;366.5216891955997;366.8642602237173;367.4855202716197;367.87860006197957;16335.264913078925;17146.685197498333;17573.64852702945;17990.370337038206;18413.815861841376;10589.629362972297;11799.70500737482;16689.749653755174;16698.49904502864;16734.16329183539;5126.436092029874;5615.101583746601;5621.550275977932;5622.437756224365;5624.3531993820825;5460.972695136519;5562.221289019541;5585.972070139644;5587.776488940458;5591.9720401397935;4873.244647079709;5080.009398167341;5085.669431486942;5501.889962200754;5517.062099443085;4991.201407774775;5064.189729643258;5064.366954130734;5067.619928505377;5068.695878247298;5052.520010598987;5062.392512898439;5063.797448102072;5081.644284900059;5089.6691715038405;12296.262224266573;12437.253764774052;12449.25304481734;14811.555653330417;20206.49483762903;2054.157795303933;2114.1332053858;2135.231316725977;2199.0763879170786;2245.7754224577575;9489.90510094904;10633.787324253472;10984.890151098547;13255.933720331337;13595.864041359559;1796.5329014456204;1805.9548511287192;1831.9816801831944;1852.148011914521;1905.1522072677665;63016;66386;67124.6643766778;67647.32352676509;68171.65914170447;10209.846852297222;10597.470126493645;10606.681799546026;10623;10687.022900763384;13727.107737996997;13888.305584720723;13925.234112123728;13925.442982280596;13931.791023134661;6774.593524388552;6995.8950615740805;7015.403690686247;7041;7156.463265255023;6515.12045873801;6548.083268342436;6561.901571476432;6578.3750543699225;6619.66901654925;4471.105778844244;4545.6136228420955;4580.587747102777;4583.427071616048;4591.724496530219;1751.798543167552;1754.561359660085;1844.3176024870884;1870.7474490943548;1915.6647586672277;837.7361131243639;944.9196818270524;960.5245403525299;990.4948476277151;1011.261778901406;15598;16085.131386970337;16547.586310342336;16831.32674693023;18405.26378944854;916.706653870755;921.6543796076471;938.4041133879899;961.1397798969883;1001.1090129784498;8047.811538212893;9985.750356241007;10063.245256605784;10072.143867771176;10133.695989120339;396651;399205;400296;403708;563570;80248;82922;83900.58049709712;84596;86467.56766216255;1111.283222321598;1127.937963412004;1129.108004676313;1147.5409836065473;1155.3010428690689;15317.846821531642;15466.458673946358;15607.21963901823;15715.528534143994;15731.370745170065;32701.698964826002;32927.50608740823;32997.67002329946;34540.65459345374;35745.28509429849;38306.61693383031;38788.80605596954;39999.000074993906;40452.39321410123;40613.1877362457;9626.855597166188;9777.967126056437;9879.308448408543;9945;10037.799244014932;17152.914235428743;17795.82204177942;18033.819661803213;18104.18531166074;18123.637527249117;11713;12994.935025324812;13549.119307244997;13550.119242249222;13847.584572462842;13606.659833504242;13772.449102035805;14081;14116.717665646835;14437.85562144365;14656.633584160054;14784.556463306119;14785.852141478877;15218.467353642569;15350.539483815503;9263.814723705624;9292.39599426035;9394.154526092685;9433.386829856037;9480;11878.524859005543;14521.85478145205;14602.415903364172;14874.851251487347;15152.545423637308 06:09:04 INFO - PROCESS | 20437 | |3;mootools.html;1533.6165958510373;1700.4558541266795;1768.1512873820566;1768.2396569475125;1787.9016654084028;7020.824479388005;7166.319199676022;7660.578668173248;7929.24672156145;7960.044794624639;7072.68172932218;7118.359347658709;7235.602041887694;7241.203467618558;7278.417726581874;2322.1292015494146;2373.299876536426;2383.5828729972272;2388.7850093491584;2389.8088152947807;2344.9531009379803;2357.446000189954;2380.73811880693;2396.9640455393182;2400.411899084718;2335.94160145996;2343.9648405273933;2373.5727569037567;2374.536965291769;2377.3818807110188;2319.072371051576;2327.8836058197107;2345.6950596422357;2349.7885190332954;2369.2892132360307;2329.650552417134;2335.1243283768586;2335.708036495438;2353.2351985604746;2362.043372434167;7812.492188007818;7877.212278772135;7883.566403847786;7893.289603935616;7906;4714.952850471485;4734.786934587952;4745.762711864428;4747.786349614275;4762.809487620491;3201.0876900083363;3233.822139782311;3243.8215898125595;3274.2141885947203;3275.5577996970583;1078.7411021354897;1082.718493191768;1113.5378817790606;1123.1127409346607;1128.3959806475623;10916.235863489559;10917.39954302513;10934.56261749537;10936.289141205876;10970.177236707279;4330.718503297276;4367.868963931087;4381.364702118239;4400.559944005574;4407.096545208225;9395.389299695498;9402.43585384879;9411;9417.811643767087;9422.858657120149;4818.4217893852265;4829.710217386968;4831.130396528588;4836.685615434985;4840.201366774513;4307.56924307573;4351.0645211279725;4385.473743150842;4423.734575925455;4426.623736982393;3677.3748462761396;3722.683571896365;3728.496652951871;3751.793651349202;3755.0987762936697;1142.5030111901349;1153.7173392518887;1161.3960740415105;1163.3543383422113;1174.2426135142784;1298.0070246261616;1298.7532368850077;1302.0299876592;1348.2112963916022;1358.185088946624;7176.856462870714;7216.097987751531;7277.381422579034;7312.597807120553;7325.890111648329;511.37867490998616;517.503196930943;519.0941806547598;521.1817446608787;527.5779376498785;5340.385855626652;5347.679139251657;5349.5720342372515;5362.570994320523;5371.838844834661;9176.587053582605;9280;9314.487703176255;9370.297227707813;9411.388259763231;9332.953335233417;9367.110124538294;9393.90606093944;9404.811903761887;9420.387674801115;7111.7866464006165;7257.52826066304;7285.615733010711;7294.234105418961;7390.29792169743;7120.857582848211;7195.0646415967685;7220.0613920190035;7229.674664639999;7250.74622388235;8097.068837083811;8128.227818357246;8293.58532073406;8410.032846222763;8420.4947703138;8457.619407126816;8559.700410485602;8643.26532244741;8676.78308042304;8705.47767133974;6666.633335166613;6890.655467226518;6926.857068583628;6962.060121883684;6975.3024697529845;7619.69521219145;7624.80937976555;7627.199144089791;7628.160902300853;7629.351505121905;7022.859542809218;7152;7179;7261.419086473175;7275.599842008741;7033.191183013814;7079.39825114871;7131.572105673677;7216.422686185198;7272.854542909006;6695.230048544479;6797.5581587196675;6840.452763778985;6852.280510546321;6852.5203235773015;6252.9062064069985;6262.373762623702;6310.5267104968225;6316.526260530387;6324.968375158095;6339.587926784744;6406.871862562816;6420.7431702731365;6420.839479013062;6431.549791514549 06:09:04 INFO - PROCESS | 20437 | |4;prototype.html;330.7916012911865;334.4565081742169;339.4009573103473;340.6865683571114;348.00470653929756;6274.717637706302;6298.023806310018;6353.396427339407;6358.713857876395;6469.70886310116;6232.376762323765;6242.313345531988;6279.717412716427;6284.8743025139465;6293.961496353108;4743.383360163174;4772.90454190916;4787.281907713854;4787.569118779309;4795.568398844103;4808.038392321532;4809.677338731842;4812.759362031885;4813.315339631118;4824.504403634867;4567.246404343279;4669.603083737887;4673.088747694201;4710.788014539354;4761.262004389325;4666.9066618667775;4690.882727931812;4710;4714.481407045222;4716.434027916637;4000.5399379071487;4065.5934406559404;4069.7558146511305;4073.307537718595;4075.8369665213354;5947.702614869282;5974.074018527135;5982.790602328898;5996.070609055603;5996.280446346423;5343.519083282523;5426.891462170774;5476.835694929118;5477.096279113942;5481.342238931314;6609.239937407212;6613.603183808987;6637.2367177774695;6645.900311495331;6650.70071846768;4514.164879497303;4514.277715565527;4514.6388288936805;4518.164139634146;4521.118381915528;6878.312168783132;6943.375096241312;6946.0622815920215;6987.091678081919;7015.473839462061;4613.8385156520035;4613.976930115395;4623.86128416148;4631.143238500888;4633.86098417048;4678.6491013174145;4686.343911852344;4688.835890743876;4691.507391723888;4693.342931989524;5418.620696551282;5441.863953401117;5454.127339625641;5461.508464238158;5471.945280547223;6557.9344206557325;6686.966565167143;6699.799006029827;6709.127813384229;6714;1624.7969003874516;1637.959051023734;1669.899806011619;1672.030222470964;1675.103819456585;1082.983755243672;1083.4799296337644;1094.43089593411;1094.7372630568607;1098.7967226063045;6238.095476156022;6242.781502647385;6251.12484252205;6260.812175634738;6284.088807122942;6763.628000459924;6765.323467653196;6781.152355955505;6791;6808.6936087876165;6132.50939924805;6173.382661733881;6181.629102253879;6184.783532576338;6185.072239164161;3656.213914008501;3680.0799800049986;3687.2809802088336;3707;3708.554973403209;7065.328793764585;7072.1513418389095;7088.574685518885;7090.929090709027;7090.929090709027;6801.693923773442;7012;7023.367896889305;7041.394683966965;7044.401225895754;6999.440044796404;7057.4001209896705;7062.117235345582;7065.116860392451;7067.257937916547;6760.459163266829;6780.220274668476;6789.456843452611;6796.490263230178;6796.83007924786;6562.606243625398;6685.565438246498;6724.193096828412;6724.361185687352;6734.057231987427;7056.788296351117;7062.470314726519;7068.11648543932;7071.222165561681;7071.858562828817;4661.580457758818;4695.060987802385;4700.882477938079;4702.7883745230865;4703.31801888731;6682.498812588978;6780.423663988616;6781.6948237330425;6802.591844489347;7009.754658586925;6690.632015239208;6702.329767023259;6711.865762684816;6722.865542689216;6731.663416829237;6732.360425759545;6735.124433823572;6736.528443008942;6743.52795304324;6747.730090796314;6490.967545162244;6600.108985287116;6615.834604134935;6633.734650613921;6634.436072933661;6740.292269311652;6757.358050985148;6798.354156355138;6806.9659651703405;6824.351686589965;6563.507736919845;6605.933940660724;6620.503462240447;6646.102776125162;6656.36764507371 06:09:04 INFO - PROCESS | 20437 | |5;yui.html;822.3626689315779;844.4595458906301;845.6913226672264;850.196564246787;869.9739007829768;13491.999999999987;13619;13694.109882857607;13703.38334774935;13755.44978200872;12666.80999785004;12780.424880880359;12805.679858003532;12812.871871281284;12814.615561533146;663.8904580744171;676.0906580649043;802.7270727952495;810.4610434061372;819.6680344460503;807.4590024683447;811.6063709101081;812.252727490707;812.4394168024045;822.7284995951352;836.8368168207202;841.2680967558202;842.4608250719544;848.7708318753932;849.9277561407288;828.6146941672122;830.7466222802043;834.7245409015011;839.5340585974782;840.1850205300879;620.6803496199461;621.6891554222889;625.4027403829377;625.6996641612006;627.5952010952956;13295.135816171918;13316;13323.26722030288;13326.200427974352;13357.732845343136;11124.332540047542;12051.57819476323;12092.395380230953;12320.75358492825;12373.443195056245;10252.64115755945;10293.948530257301;10337.121344685711;10418.21863360251;10522.158227341793;3581.6418358164237;3586.1572530455323;3635.1093981974323;3664.0839790052487;3717.7769333840056;41239.58760412387;41457.378139327935;41532.792336038125;41564;41624.583754162675;9478.431294122374;9587.568559414844;9924.454155021544;9958.950205249072;10029.749256268651;17171.227294771765;17181.828181718272;17293.740593891103;17365;17394.565135871704;7624.351930086005;7752.7674169775;7767.37860971121;7786.299233068938;7826.2173782621285;4436.800343984464;4440.378347031418;4446.844360447433;4458.219811532968;4476.306172543261;2996.7752418568693;2996.955045674317;3010.0217429335553;3026.303950091491;3027.9243018924262;521.324884274865;537.6182910133771;548.0518702644367;552.3675391676508;552.8866582350608;489.4713709194062;529.6080900133874;600.1867469578658;606.7057477123592;617.2222999021176;7834.647440865175;7855.8821617675785;7953.447124821917;8061.6372263248295;8155.510669359857;511.58050398673475;515.4021335251166;515.6004096824915;516.9689818610896;542.785599688121;3569.9837682607067;3802.5627052888717;3817.351050321452;3890.435886796399;3892.2993861104706;55066.449335506935;55139.724301379036;55281.44718552763;55420.72289638607;61433.38566614276;48175.5182448178;48239.5176048235;48560.514394856305;48770.56147192626;49221.261681074815;44421;44555;45329;45883.770581146884;46205.537944620795;7663.233676632292;7795.766127016199;8434.957825210835;8599.226069653761;8708.956455217683;34211.65788342085;34268.82865585656;34696.479552807235;34758.82620586881;35837.10407239736;40140.59859401369;40222.79888600538;43026.569734303506;43588.34617480804;43687.78156109199;9904.603815847286;10232.079112879877;10363.32638378503;10381.896181038093;10459.738506537398;11646.24299420535;11859;12000.57997970067;12598.811017834556;12643.620691379274;10376.198426424671;10441.112505437122;10498.107660848913;10688.946555267485;10788.95679830901;10665.200109991627;10686.73283167927;10797.460126993776;10882.945585272022;11134.164937629872;9619.51902404863;10236.232282578687;10376.481175941324;10382.428966406618;10419.739506512398;8660.78348041304;8858.11418858109;9210.401323913924;9535.52322383892;9705;8296.336293096658;9159.542022898695;9224.538773061186;9400.435973841591;9588.185004274716 06:09:04 INFO - PROCESS | 20437 | __end_tp_report 06:09:04 INFO - PROCESS | 20437 | __start_cc_report 06:09:04 INFO - PROCESS | 20437 | _x_x_mozilla_cycle_collect,321 06:09:04 INFO - PROCESS | 20437 | __end_cc_report 06:09:04 INFO - PROCESS | 20437 | __startTimestamp1450879744574__endTimestamp 06:09:04 INFO - PROCESS | 20437 | 06:09:04 INFO - PROCESS | 20437 | ------- Summary: start ------- 06:09:04 INFO - PROCESS | 20437 | Number of tests: 6 06:09:04 INFO - PROCESS | 20437 | 06:09:04 INFO - PROCESS | 20437 | [#0] dojo.html Cycles:165 Average:5493.63 Median:5707.29 stddev:624.02 (10.9%) stddev-sans-first:599.64 06:09:04 INFO - PROCESS | 20437 | Values: 3208.8 3231.5 3270.1 3279.2 3285.4 5347.0 5438.6 5452.7 5455.9 5462.9 5490.7 5506.1 5517.8 5580.4 5660.3 4924.8 4966.4 5034.7 5037.7 5144.0 5056.9 5078.2 5107.8 5156.6 5167.3 4766.7 4888.5 4972.2 4981.7 5011.1 4960.4 4970.0 4983.7 4996.8 5063.9 4902.8 4989.7 5003.4 5009.0 5063.7 5181.5 5230.5 5262.2 5269.4 5335.1 5915.2 6021.2 6022.1 6022.3 6029.2 5762.8 5886.9 6054.5 6082.5 6088.2 5467.8 5531.6 5538.8 5540.3 5566.8 6102.7 6104.0 6107.4 6111.7 6116.5 5820.3 5888.7 5908.5 5913.3 5941.1 5815.8 5839.5 5935.6 5973.0 5985.6 5975.6 5977.4 5981.3 6002.1 6028.6 5876.3 5968.1 5980.2 5982.4 5986.0 4417.9 4475.4 4504.3 4544.8 4610.6 4086.4 4103.5 4106.0 4113.2 4126.2 5539.1 5570.2 5576.1 5588.3 5613.4 5861.2 5887.3 5956.9 5979.6 5989.4 5509.3 5537.4 5554.4 5565.2 5574.5 5110.1 5136.2 5146.5 5151.8 5155.8 6017.6 6082.3 6143.4 6144.1 6146.0 5827.4 5872.6 5874.9 5885.6 5996.4 5846.5 6094.3 6105.0 6118.6 6124.1 5834.8 5854.3 5855.9 5870.0 5871.0 5853.5 5895.3 5963.1 5984.2 6000.0 5777.7 5793.6 5826.7 5839.2 5846.7 5574.3 5742.2 5805.7 5817.7 5818.9 5671.9 5684.5 5720.0 5731.4 5745.9 5753.0 5793.6 5827.7 5830.1 5832.4 5501.5 5551.1 5661.0 5686.5 5707.3 06:09:04 INFO - PROCESS | 20437 | 06:09:04 INFO - PROCESS | 20437 | [#1] ext.html Cycles:180 Average:45782.24 Median:19454.70 stddev:76609.45 (393.8%) stddev-sans-first:76749.11 06:09:04 INFO - PROCESS | 20437 | Values: 559.2 586.7 595.9 600.1 606.7 37089.4 37502.6 37923.4 38158.2 38228.0 42409.8 42584.7 42904.0 42998.0 43021.0 8719.2 8756.6 8812.1 8837.7 8928.4 8538.4 8677.7 8689.8 8728.3 8767.6 8765.3 8811.6 8842.9 8885.0 8916.1 8659.0 8786.1 8797.7 8803.7 8850.3 8587.8 8679.4 8691.2 8725.2 8731.6 39755.6 40364.4 40421.4 40466.0 40522.8 3248.4 3352.7 3530.4 3874.3 3946.9 29720.6 30039.1 30089.4 30335.7 30430.5 3780.6 3821.5 3834.7 3880.2 3981.1 258157.0 258322.0 258327.0 259049.0 259184.0 57089.4 57480.1 57527.7 57574.4 57637.4 53141.7 54037.5 66836.7 68081.3 68123.0 13024.5 13215.3 13334.6 13336.0 13388.3 9722.3 9827.5 9862.2 9870.9 9876.5 18795.9 19034.2 19084.7 19144.8 19242.4 8011.4 8143.0 8166.2 8286.3 8312.5 982.3 1020.1 1064.7 1076.4 1094.0 27640.7 27708.9 27710.6 27789.6 27881.3 1064.3 1070.1 1074.2 1118.7 1165.4 14503.7 15189.8 15503.9 15556.5 15643.6 314900.0 317097.0 319432.0 319525.0 319800.0 49352.5 49777.0 49861.0 50106.7 50129.0 1354.4 1362.1 1374.3 1378.6 1388.2 27236.2 28147.7 28171.4 28176.9 28312.6 43901.1 44279.6 44456.3 44500.3 44617.6 297198.0 297425.0 299659.0 299828.0 300454.0 30241.8 31003.2 31844.7 31938.5 32065.5 37980.0 39441.6 40738.6 41174.0 41212.6 34202.8 34619.3 35192.6 35210.8 35379.0 34273.8 34376.5 34754.0 34783.8 35197.0 33490.3 33845.7 34271.3 34292.0 34360.7 30015.5 30728.8 31983.0 32059.2 32220.0 24329.0 24339.9 24342.4 24688.9 24746.1 06:09:04 INFO - PROCESS | 20437 | 06:09:04 INFO - PROCESS | 20437 | [#2] jquery.html Cycles:180 Average:25768.83 Median:32814.60 stddev:71905.17 (219.1%) stddev-sans-first:72081.58 06:09:04 INFO - PROCESS | 20437 | Values: 365.0 366.5 366.9 367.5 367.9 16335.3 17146.7 17573.6 17990.4 18413.8 10589.6 11799.7 16689.7 16698.5 16734.2 5126.4 5615.1 5621.6 5622.4 5624.4 5461.0 5562.2 5586.0 5587.8 5592.0 4873.2 5080.0 5085.7 5501.9 5517.1 4991.2 5064.2 5064.4 5067.6 5068.7 5052.5 5062.4 5063.8 5081.6 5089.7 12296.3 12437.3 12449.3 14811.6 20206.5 2054.2 2114.1 2135.2 2199.1 2245.8 9489.9 10633.8 10984.9 13255.9 13595.9 1796.5 1806.0 1832.0 1852.1 1905.2 63016.0 66386.0 67124.7 67647.3 68171.7 10209.8 10597.5 10606.7 10623.0 10687.0 13727.1 13888.3 13925.2 13925.4 13931.8 6774.6 6995.9 7015.4 7041.0 7156.5 6515.1 6548.1 6561.9 6578.4 6619.7 4471.1 4545.6 4580.6 4583.4 4591.7 1751.8 1754.6 1844.3 1870.7 1915.7 837.7 944.9 960.5 990.5 1011.3 15598.0 16085.1 16547.6 16831.3 18405.3 916.7 921.7 938.4 961.1 1001.1 8047.8 9985.8 10063.2 10072.1 10133.7 396651.0 399205.0 400296.0 403708.0 563570.0 80248.0 82922.0 83900.6 84596.0 86467.6 1111.3 1127.9 1129.1 1147.5 1155.3 15317.8 15466.5 15607.2 15715.5 15731.4 32701.7 32927.5 32997.7 34540.7 35745.3 38306.6 38788.8 39999.0 40452.4 40613.2 9626.9 9778.0 9879.3 9945.0 10037.8 17152.9 17795.8 18033.8 18104.2 18123.6 11713.0 12994.9 13549.1 13550.1 13847.6 13606.7 13772.4 14081.0 14116.7 14437.9 14656.6 14784.6 14785.9 15218.5 15350.5 9263.8 9292.4 9394.2 9433.4 9480.0 11878.5 14521.9 14602.4 14874.9 15152.5 06:09:04 INFO - PROCESS | 20437 | 06:09:04 INFO - PROCESS | 20437 | [#3] mootools.html Cycles:180 Average:5468.57 Median:6257.64 stddev:2820.62 (45.1%) stddev-sans-first:2813.03 06:09:04 INFO - PROCESS | 20437 | Values: 1533.6 1700.5 1768.2 1768.2 1787.9 7020.8 7166.3 7660.6 7929.2 7960.0 7072.7 7118.4 7235.6 7241.2 7278.4 2322.1 2373.3 2383.6 2388.8 2389.8 2345.0 2357.4 2380.7 2397.0 2400.4 2335.9 2344.0 2373.6 2374.5 2377.4 2319.1 2327.9 2345.7 2349.8 2369.3 2329.7 2335.1 2335.7 2353.2 2362.0 7812.5 7877.2 7883.6 7893.3 7906.0 4715.0 4734.8 4745.8 4747.8 4762.8 3201.1 3233.8 3243.8 3274.2 3275.6 1078.7 1082.7 1113.5 1123.1 1128.4 10916.2 10917.4 10934.6 10936.3 10970.2 4330.7 4367.9 4381.4 4400.6 4407.1 9395.4 9402.4 9411.0 9417.8 9422.9 4818.4 4829.7 4831.1 4836.7 4840.2 4307.6 4351.1 4385.5 4423.7 4426.6 3677.4 3722.7 3728.5 3751.8 3755.1 1142.5 1153.7 1161.4 1163.4 1174.2 1298.0 1298.8 1302.0 1348.2 1358.2 7176.9 7216.1 7277.4 7312.6 7325.9 511.4 517.5 519.1 521.2 527.6 5340.4 5347.7 5349.6 5362.6 5371.8 9176.6 9280.0 9314.5 9370.3 9411.4 9333.0 9367.1 9393.9 9404.8 9420.4 7111.8 7257.5 7285.6 7294.2 7390.3 7120.9 7195.1 7220.1 7229.7 7250.7 8097.1 8128.2 8293.6 8410.0 8420.5 8457.6 8559.7 8643.3 8676.8 8705.5 6666.6 6890.7 6926.9 6962.1 6975.3 7619.7 7624.8 7627.2 7628.2 7629.4 7022.9 7152.0 7179.0 7261.4 7275.6 7033.2 7079.4 7131.6 7216.4 7272.9 6695.2 6797.6 6840.5 6852.3 6852.5 6252.9 6262.4 6310.5 6316.5 6325.0 6339.6 6406.9 6420.7 6420.8 6431.5 06:09:04 INFO - PROCESS | 20437 | 06:09:04 INFO - PROCESS | 20437 | [#4] prototype.html Cycles:180 Average:5533.00 Median:6267.76 stddev:1688.15 (26.9%) stddev-sans-first:1647.11 06:09:04 INFO - PROCESS | 20437 | Values: 330.8 334.5 339.4 340.7 348.0 6274.7 6298.0 6353.4 6358.7 6469.7 6232.4 6242.3 6279.7 6284.9 6294.0 4743.4 4772.9 4787.3 4787.6 4795.6 4808.0 4809.7 4812.8 4813.3 4824.5 4567.2 4669.6 4673.1 4710.8 4761.3 4666.9 4690.9 4710.0 4714.5 4716.4 4000.5 4065.6 4069.8 4073.3 4075.8 5947.7 5974.1 5982.8 5996.1 5996.3 5343.5 5426.9 5476.8 5477.1 5481.3 6609.2 6613.6 6637.2 6645.9 6650.7 4514.2 4514.3 4514.6 4518.2 4521.1 6878.3 6943.4 6946.1 6987.1 7015.5 4613.8 4614.0 4623.9 4631.1 4633.9 4678.6 4686.3 4688.8 4691.5 4693.3 5418.6 5441.9 5454.1 5461.5 5471.9 6557.9 6687.0 6699.8 6709.1 6714.0 1624.8 1638.0 1669.9 1672.0 1675.1 1083.0 1083.5 1094.4 1094.7 1098.8 6238.1 6242.8 6251.1 6260.8 6284.1 6763.6 6765.3 6781.2 6791.0 6808.7 6132.5 6173.4 6181.6 6184.8 6185.1 3656.2 3680.1 3687.3 3707.0 3708.6 7065.3 7072.2 7088.6 7090.9 7090.9 6801.7 7012.0 7023.4 7041.4 7044.4 6999.4 7057.4 7062.1 7065.1 7067.3 6760.5 6780.2 6789.5 6796.5 6796.8 6562.6 6685.6 6724.2 6724.4 6734.1 7056.8 7062.5 7068.1 7071.2 7071.9 4661.6 4695.1 4700.9 4702.8 4703.3 6682.5 6780.4 6781.7 6802.6 7009.8 6690.6 6702.3 6711.9 6722.9 6731.7 6732.4 6735.1 6736.5 6743.5 6747.7 6491.0 6600.1 6615.8 6633.7 6634.4 6740.3 6757.4 6798.4 6807.0 6824.4 6563.5 6605.9 6620.5 6646.1 6656.4 06:09:04 INFO - PROCESS | 20437 | 06:09:04 INFO - PROCESS | 20437 | [#5] yui.html Cycles:180 Average:13206.98 Median:24902.65 stddev:15148.78 (60.8%) stddev-sans-first:15162.73 06:09:04 INFO - PROCESS | 20437 | Values: 822.4 844.5 845.7 850.2 870.0 13492.0 13619.0 13694.1 13703.4 13755.4 12666.8 12780.4 12805.7 12812.9 12814.6 663.9 676.1 802.7 810.5 819.7 807.5 811.6 812.3 812.4 822.7 836.8 841.3 842.5 848.8 849.9 828.6 830.7 834.7 839.5 840.2 620.7 621.7 625.4 625.7 627.6 13295.1 13316.0 13323.3 13326.2 13357.7 11124.3 12051.6 12092.4 12320.8 12373.4 10252.6 10293.9 10337.1 10418.2 10522.2 3581.6 3586.2 3635.1 3664.1 3717.8 41239.6 41457.4 41532.8 41564.0 41624.6 9478.4 9587.6 9924.5 9959.0 10029.7 17171.2 17181.8 17293.7 17365.0 17394.6 7624.4 7752.8 7767.4 7786.3 7826.2 4436.8 4440.4 4446.8 4458.2 4476.3 2996.8 2997.0 3010.0 3026.3 3027.9 521.3 537.6 548.1 552.4 552.9 489.5 529.6 600.2 606.7 617.2 7834.6 7855.9 7953.4 8061.6 8155.5 511.6 515.4 515.6 517.0 542.8 3570.0 3802.6 3817.4 3890.4 3892.3 55066.4 55139.7 55281.4 55420.7 61433.4 48175.5 48239.5 48560.5 48770.6 49221.3 44421.0 44555.0 45329.0 45883.8 46205.5 7663.2 7795.8 8435.0 8599.2 8709.0 34211.7 34268.8 34696.5 34758.8 35837.1 40140.6 40222.8 43026.6 43588.3 43687.8 9904.6 10232.1 10363.3 10381.9 10459.7 11646.2 11859.0 12000.6 12598.8 12643.6 10376.2 10441.1 10498.1 10688.9 10789.0 10665.2 10686.7 10797.5 10882.9 11134.2 9619.5 10236.2 10376.5 10382.4 10419.7 8660.8 8858.1 9210.4 9535.5 9705.0 8296.3 9159.5 9224.5 9400.4 9588.2 06:09:04 INFO - PROCESS | 20437 | -------- Summary: end -------- 06:09:04 INFO - PROCESS | 20437 | 06:09:05 INFO - TEST-INFO | 20437: exit 0 06:09:05 INFO - TEST-OK | dromaeo_css | took 1111204ms 06:09:05 INFO - TEST-START | kraken 06:09:05 INFO - operating with platform_type : linux_ 06:09:05 INFO - Initialising browser for kraken test... 06:09:05 INFO - TEST-INFO | started process 20677 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmporYGDP/profile http://localhost:38462/getInfo.html) 06:09:09 INFO - PROCESS | 20677 | __metrics Screen width/height:1600/1200 06:09:09 INFO - PROCESS | 20677 | colorDepth:24 06:09:09 INFO - PROCESS | 20677 | Browser inner width/height: 1024/670 06:09:09 INFO - PROCESS | 20677 | __metrics 06:09:09 INFO - PROCESS | 20677 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:09:10 INFO - TEST-INFO | 20677: exit 0 06:09:10 INFO - Browser initialized. 06:09:10 INFO - Running cycle 1/1 for kraken test... 06:09:10 INFO - TEST-INFO | started process 20799 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmporYGDP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:09:22 INFO - PROCESS | 20799 | RSS: Main: 150654976 06:09:22 INFO - PROCESS | 20799 | 06:09:25 INFO - PROCESS | 20799 | Cycle 1(1): loaded http://localhost:38462/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38462/tests/kraken/driver.html?testName=audio-beat-detection) 06:09:25 INFO - PROCESS | 20799 | RSS: Main: 151764992 06:09:25 INFO - PROCESS | 20799 | 06:09:28 INFO - PROCESS | 20799 | Cycle 1(1): loaded http://localhost:38462/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38462/tests/kraken/driver.html?testName=audio-dft) 06:09:29 INFO - PROCESS | 20799 | RSS: Main: 151863296 06:09:29 INFO - PROCESS | 20799 | 06:09:31 INFO - PROCESS | 20799 | Cycle 1(1): loaded http://localhost:38462/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38462/tests/kraken/driver.html?testName=audio-fft) 06:09:32 INFO - PROCESS | 20799 | RSS: Main: 145883136 06:09:32 INFO - PROCESS | 20799 | 06:09:34 INFO - PROCESS | 20799 | Cycle 1(1): loaded http://localhost:38462/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38462/tests/kraken/driver.html?testName=audio-oscillator) 06:09:35 INFO - PROCESS | 20799 | RSS: Main: 145584128 06:09:35 INFO - PROCESS | 20799 | 06:09:37 INFO - PROCESS | 20799 | Cycle 1(1): loaded http://localhost:38462/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38462/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:09:37 INFO - PROCESS | 20799 | RSS: Main: 146489344 06:09:37 INFO - PROCESS | 20799 | 06:09:40 INFO - PROCESS | 20799 | Cycle 1(1): loaded http://localhost:38462/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38462/tests/kraken/driver.html?testName=imaging-darkroom) 06:09:41 INFO - PROCESS | 20799 | RSS: Main: 146468864 06:09:41 INFO - PROCESS | 20799 | 06:09:44 INFO - PROCESS | 20799 | Cycle 1(1): loaded http://localhost:38462/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38462/tests/kraken/driver.html?testName=imaging-desaturate) 06:09:45 INFO - PROCESS | 20799 | RSS: Main: 147472384 06:09:45 INFO - PROCESS | 20799 | 06:09:48 INFO - PROCESS | 20799 | Cycle 1(1): loaded http://localhost:38462/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38462/tests/kraken/driver.html?testName=json-parse-financial) 06:09:48 INFO - PROCESS | 20799 | RSS: Main: 148164608 06:09:48 INFO - PROCESS | 20799 | 06:09:50 INFO - PROCESS | 20799 | Cycle 1(1): loaded http://localhost:38462/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38462/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:09:50 INFO - PROCESS | 20799 | RSS: Main: 148774912 06:09:50 INFO - PROCESS | 20799 | 06:09:52 INFO - PROCESS | 20799 | Cycle 1(1): loaded http://localhost:38462/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38462/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:09:53 INFO - PROCESS | 20799 | RSS: Main: 147836928 06:09:53 INFO - PROCESS | 20799 | 06:09:55 INFO - PROCESS | 20799 | Cycle 1(1): loaded http://localhost:38462/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38462/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:09:55 INFO - PROCESS | 20799 | RSS: Main: 147931136 06:09:55 INFO - PROCESS | 20799 | 06:09:58 INFO - PROCESS | 20799 | Cycle 1(1): loaded http://localhost:38462/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:09:59 INFO - PROCESS | 20799 | RSS: Main: 148328448 06:09:59 INFO - PROCESS | 20799 | 06:10:01 INFO - PROCESS | 20799 | Cycle 1(1): loaded http://localhost:38462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:10:02 INFO - PROCESS | 20799 | RSS: Main: 148074496 06:10:02 INFO - PROCESS | 20799 | 06:10:03 INFO - PROCESS | 20799 | Cycle 1(1): loaded http://localhost:38462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38462/tests/kraken/driver.html?testName=ai-astar) 06:10:04 INFO - PROCESS | 20799 | RSS: Main: 148738048 06:10:04 INFO - PROCESS | 20799 | 06:10:04 INFO - PROCESS | 20799 | __start_tp_report 06:10:04 INFO - PROCESS | 20799 | _x_x_mozilla_page_load 06:10:04 INFO - PROCESS | 20799 | _x_x_mozilla_page_load_details 06:10:04 INFO - PROCESS | 20799 | |i|pagename|runs| 06:10:04 INFO - PROCESS | 20799 | |0;ai-astar;109;105;111;110;113;124;110;111;109;111 06:10:04 INFO - PROCESS | 20799 | |1;audio-beat-detection;154;123;154;168;126;149;159;126;162;124 06:10:04 INFO - PROCESS | 20799 | |2;audio-dft;162;162;162;164;164;161;161;166;169;165 06:10:04 INFO - PROCESS | 20799 | |3;audio-fft;75;73;72;81;74;73;142;73;72;70 06:10:04 INFO - PROCESS | 20799 | |4;audio-oscillator;95;93;141;92;94;94;139;93;94;143 06:10:04 INFO - PROCESS | 20799 | |5;imaging-gaussian-blur;109;110;110;110;110;109;111;110;110;110 06:10:04 INFO - PROCESS | 20799 | |6;imaging-darkroom;150;147;147;148;147;147;148;147;147;148 06:10:04 INFO - PROCESS | 20799 | |7;imaging-desaturate;96;96;98;96;97;96;97;96;97;97 06:10:04 INFO - PROCESS | 20799 | |8;json-parse-financial;59;59;59;60;60;59;59;60;58;56 06:10:04 INFO - PROCESS | 20799 | |9;json-stringify-tinderbox;67;67;67;66;66;66;68;67;67;67 06:10:04 INFO - PROCESS | 20799 | |10;stanford-crypto-aes;84;86;85;87;85;83;84;91;86;93 06:10:04 INFO - PROCESS | 20799 | |11;stanford-crypto-ccm;124;121;119;130;124;118;118;128;128;131 06:10:04 INFO - PROCESS | 20799 | |12;stanford-crypto-pbkdf2;140;141;151;156;147;139;154;154;152;141 06:10:04 INFO - PROCESS | 20799 | |13;stanford-crypto-sha256-iterative;67;66;69;66;67;68;68;77;67;65 06:10:04 INFO - PROCESS | 20799 | __end_tp_report 06:10:04 INFO - PROCESS | 20799 | __start_cc_report 06:10:04 INFO - PROCESS | 20799 | _x_x_mozilla_cycle_collect,746 06:10:04 INFO - PROCESS | 20799 | __end_cc_report 06:10:04 INFO - PROCESS | 20799 | __startTimestamp1450879804128__endTimestamp 06:10:04 INFO - PROCESS | 20799 | 06:10:04 INFO - PROCESS | 20799 | ------- Summary: start ------- 06:10:04 INFO - PROCESS | 20799 | Number of tests: 14 06:10:04 INFO - PROCESS | 20799 | 06:10:04 INFO - PROCESS | 20799 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:4.92 (4.4%) stddev-sans-first:5.15 06:10:04 INFO - PROCESS | 20799 | Values: 109.0 105.0 111.0 110.0 113.0 124.0 110.0 111.0 109.0 111.0 06:10:04 INFO - PROCESS | 20799 | 06:10:04 INFO - PROCESS | 20799 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:154.00 stddev:17.75 (11.5%) stddev-sans-first:18.49 06:10:04 INFO - PROCESS | 20799 | Values: 154.0 123.0 154.0 168.0 126.0 149.0 159.0 126.0 162.0 124.0 06:10:04 INFO - PROCESS | 20799 | 06:10:04 INFO - PROCESS | 20799 | [#2] audio-dft Cycles:10 Average:163.60 Median:164.00 stddev:2.55 (1.6%) stddev-sans-first:2.64 06:10:04 INFO - PROCESS | 20799 | Values: 162.0 162.0 162.0 164.0 164.0 161.0 161.0 166.0 169.0 165.0 06:10:04 INFO - PROCESS | 20799 | 06:10:04 INFO - PROCESS | 20799 | [#3] audio-fft Cycles:10 Average:80.50 Median:73.00 stddev:21.80 (29.9%) stddev-sans-first:23.03 06:10:04 INFO - PROCESS | 20799 | Values: 75.0 73.0 72.0 81.0 74.0 73.0 142.0 73.0 72.0 70.0 06:10:04 INFO - PROCESS | 20799 | 06:10:04 INFO - PROCESS | 20799 | [#4] audio-oscillator Cycles:10 Average:107.80 Median:93.50 stddev:22.94 (24.5%) stddev-sans-first:23.86 06:10:04 INFO - PROCESS | 20799 | Values: 95.0 93.0 141.0 92.0 94.0 94.0 139.0 93.0 94.0 143.0 06:10:04 INFO - PROCESS | 20799 | 06:10:04 INFO - PROCESS | 20799 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 06:10:04 INFO - PROCESS | 20799 | Values: 109.0 110.0 110.0 110.0 110.0 109.0 111.0 110.0 110.0 110.0 06:10:04 INFO - PROCESS | 20799 | 06:10:04 INFO - PROCESS | 20799 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:0.97 (0.7%) stddev-sans-first:0.50 06:10:04 INFO - PROCESS | 20799 | Values: 150.0 147.0 147.0 148.0 147.0 147.0 148.0 147.0 147.0 148.0 06:10:04 INFO - PROCESS | 20799 | 06:10:04 INFO - PROCESS | 20799 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 06:10:04 INFO - PROCESS | 20799 | Values: 96.0 96.0 98.0 96.0 97.0 96.0 97.0 96.0 97.0 97.0 06:10:04 INFO - PROCESS | 20799 | 06:10:04 INFO - PROCESS | 20799 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:59.00 stddev:1.20 (2.0%) stddev-sans-first:1.27 06:10:04 INFO - PROCESS | 20799 | Values: 59.0 59.0 59.0 60.0 60.0 59.0 59.0 60.0 58.0 56.0 06:10:04 INFO - PROCESS | 20799 | 06:10:04 INFO - PROCESS | 20799 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 06:10:04 INFO - PROCESS | 20799 | Values: 67.0 67.0 67.0 66.0 66.0 66.0 68.0 67.0 67.0 67.0 06:10:04 INFO - PROCESS | 20799 | 06:10:04 INFO - PROCESS | 20799 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:86.00 stddev:3.20 (3.7%) stddev-sans-first:3.28 06:10:04 INFO - PROCESS | 20799 | Values: 84.0 86.0 85.0 87.0 85.0 83.0 84.0 91.0 86.0 93.0 06:10:04 INFO - PROCESS | 20799 | 06:10:04 INFO - PROCESS | 20799 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:126.00 stddev:4.98 (3.9%) stddev-sans-first:5.28 06:10:04 INFO - PROCESS | 20799 | Values: 124.0 121.0 119.0 130.0 124.0 118.0 118.0 128.0 128.0 131.0 06:10:04 INFO - PROCESS | 20799 | 06:10:04 INFO - PROCESS | 20799 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.50 Median:151.50 stddev:6.69 (4.4%) stddev-sans-first:6.52 06:10:04 INFO - PROCESS | 20799 | Values: 140.0 141.0 151.0 156.0 147.0 139.0 154.0 154.0 152.0 141.0 06:10:04 INFO - PROCESS | 20799 | 06:10:04 INFO - PROCESS | 20799 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:67.50 stddev:3.37 (5.0%) stddev-sans-first:3.55 06:10:04 INFO - PROCESS | 20799 | Values: 67.0 66.0 69.0 66.0 67.0 68.0 68.0 77.0 67.0 65.0 06:10:04 INFO - PROCESS | 20799 | -------- Summary: end -------- 06:10:04 INFO - PROCESS | 20799 | 06:10:05 INFO - TEST-INFO | 20799: exit 0 06:10:05 INFO - TEST-OK | kraken | took 60030ms 06:10:05 INFO - TEST-START | v8_7 06:10:05 INFO - operating with platform_type : linux_ 06:10:05 INFO - Initialising browser for v8_7 test... 06:10:05 INFO - TEST-INFO | started process 21085 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpE9MWRw/profile http://localhost:38462/getInfo.html) 06:10:10 INFO - PROCESS | 21085 | __metrics Screen width/height:1600/1200 06:10:10 INFO - PROCESS | 21085 | colorDepth:24 06:10:10 INFO - PROCESS | 21085 | Browser inner width/height: 1024/670 06:10:10 INFO - PROCESS | 21085 | __metrics 06:10:10 INFO - PROCESS | 21085 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:10:11 INFO - TEST-INFO | 21085: exit 0 06:10:11 INFO - Browser initialized. 06:10:11 INFO - Running cycle 1/1 for v8_7 test... 06:10:11 INFO - TEST-INFO | started process 21207 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpE9MWRw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:10:22 INFO - PROCESS | 21207 | RSS: Main: 151490560 06:10:22 INFO - PROCESS | 21207 | 06:10:44 INFO - PROCESS | 21207 | Cycle 1(1): loaded http://localhost:38462/tests/v8_7/run.html (next: http://localhost:38462/tests/v8_7/run.html) 06:10:44 INFO - PROCESS | 21207 | RSS: Main: 145551360 06:10:44 INFO - PROCESS | 21207 | 06:10:44 INFO - PROCESS | 21207 | __start_tp_report 06:10:44 INFO - PROCESS | 21207 | _x_x_mozilla_page_load 06:10:44 INFO - PROCESS | 21207 | _x_x_mozilla_page_load_details 06:10:44 INFO - PROCESS | 21207 | |i|pagename|runs| 06:10:44 INFO - PROCESS | 21207 | |0;Richards;165.80998176090202 06:10:44 INFO - PROCESS | 21207 | |1;DeltaBlue;194.4012441679627 06:10:44 INFO - PROCESS | 21207 | |2;Encrypt;284.9002849002849 06:10:44 INFO - PROCESS | 21207 | |3;Decrypt;5202.072538860104 06:10:44 INFO - PROCESS | 21207 | |4;RayTrace;1055.9662090813094 06:10:44 INFO - PROCESS | 21207 | |5;Earley;726.7441860465116 06:10:44 INFO - PROCESS | 21207 | |6;Boyer;12256.09756097561 06:10:44 INFO - PROCESS | 21207 | |7;RegExp;28000 06:10:44 INFO - PROCESS | 21207 | |8;Splay;638.9776357827476 06:10:44 INFO - PROCESS | 21207 | |9;NavierStokes;4840.579710144928 06:10:44 INFO - PROCESS | 21207 | __end_tp_report 06:10:44 INFO - PROCESS | 21207 | __startTimestamp1450879844604__endTimestamp 06:10:44 INFO - PROCESS | 21207 | 06:10:44 INFO - PROCESS | 21207 | ------- Summary: start ------- 06:10:44 INFO - PROCESS | 21207 | Number of tests: 10 06:10:44 INFO - PROCESS | 21207 | 06:10:44 INFO - PROCESS | 21207 | [#0] Richards Cycles:1 Average:165.81 Median:165.81 stddev:0.00 (0.0%) 06:10:44 INFO - PROCESS | 21207 | Values: 165.8 06:10:44 INFO - PROCESS | 21207 | 06:10:44 INFO - PROCESS | 21207 | [#1] DeltaBlue Cycles:1 Average:194.40 Median:194.40 stddev:0.00 (0.0%) 06:10:44 INFO - PROCESS | 21207 | Values: 194.4 06:10:44 INFO - PROCESS | 21207 | 06:10:44 INFO - PROCESS | 21207 | [#2] Encrypt Cycles:1 Average:284.90 Median:284.90 stddev:0.00 (0.0%) 06:10:44 INFO - PROCESS | 21207 | Values: 284.9 06:10:44 INFO - PROCESS | 21207 | 06:10:44 INFO - PROCESS | 21207 | [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 06:10:44 INFO - PROCESS | 21207 | Values: 5202.1 06:10:44 INFO - PROCESS | 21207 | 06:10:44 INFO - PROCESS | 21207 | [#4] RayTrace Cycles:1 Average:1055.97 Median:1055.97 stddev:0.00 (0.0%) 06:10:44 INFO - PROCESS | 21207 | Values: 1056.0 06:10:44 INFO - PROCESS | 21207 | 06:10:44 INFO - PROCESS | 21207 | [#5] Earley Cycles:1 Average:726.74 Median:726.74 stddev:0.00 (0.0%) 06:10:44 INFO - PROCESS | 21207 | Values: 726.7 06:10:44 INFO - PROCESS | 21207 | 06:10:44 INFO - PROCESS | 21207 | [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 06:10:44 INFO - PROCESS | 21207 | Values: 12256.1 06:10:44 INFO - PROCESS | 21207 | 06:10:44 INFO - PROCESS | 21207 | [#7] RegExp Cycles:1 Average:28000.00 Median:28000.00 stddev:0.00 (0.0%) 06:10:44 INFO - PROCESS | 21207 | Values: 28000.0 06:10:44 INFO - PROCESS | 21207 | 06:10:44 INFO - PROCESS | 21207 | [#8] Splay Cycles:1 Average:638.98 Median:638.98 stddev:0.00 (0.0%) 06:10:44 INFO - PROCESS | 21207 | Values: 639.0 06:10:44 INFO - PROCESS | 21207 | 06:10:44 INFO - PROCESS | 21207 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 06:10:44 INFO - PROCESS | 21207 | Values: 4840.6 06:10:44 INFO - PROCESS | 21207 | -------- Summary: end -------- 06:10:44 INFO - PROCESS | 21207 | 06:10:45 INFO - TEST-INFO | 21207: exit 0 06:10:45 INFO - TEST-OK | v8_7 | took 40138ms 06:10:45 INFO - SUITE-END | took 1211s 06:10:45 INFO - Completed test suite (00:20:11) 06:10:45 INFO - Working with test: dromaeo_css 06:10:45 INFO - Generating results file: dromaeo_css 06:10:45 INFO - Working with test: kraken 06:10:45 INFO - Generating results file: kraken 06:10:45 INFO - javascript benchmark 06:10:45 INFO - Working with test: v8_7 06:10:45 INFO - Generating results file: v8_7 06:10:45 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:10:45 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 06:10:45 INFO - process_Request line: dromaeo_css 6993.61 graph.html#tests=[[72,1,43]] 06:10:45 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:10:45 INFO - process_Request line: kraken 1513.50 graph.html#tests=[[232,1,43]] 06:10:45 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:10:45 INFO - process_Request line: v8_7 20920.07 graph.html#tests=[[230,1,43]] 06:10:45 INFO - RETURN: dromaeo_css: 6993.61 06:10:45 INFO - RETURN: kraken: 1513.50 06:10:45 INFO - RETURN: v8_7: 20920.07 06:10:45 INFO - javascript benchmark 06:10:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3208.7914285571437, 3231.466807976684, 3270.1007223013653, 3279.245773472102, 3285.3757786020656, 5347.0, 5438.619296649226, 5452.67283962962, 5455.945440545594, 5462.863428414292, 5490.69801160936, 5506.146547285167, 5517.841253336794, 5580.386157522669, 5660.29246344207, 4924.778384972676, 4966.404031516223, 5034.697918124924, 5037.722925239111, 5144.0, 5056.873578160538, 5078.238264260372, 5107.7956881724685, 5156.561692256163, 5167.302414174094, 4766.713997160146, 4888.535589119028, 4972.179590367585, 4981.651284410093, 5011.14810482217, 4960.429550601691, 4969.975150124263, 4983.676061056056, 4996.775145118442, 5063.924041139386, 4902.803887844482, 4989.700617962933, 5003.449620541737, 5008.974955125201, 5063.721495317756, 5181.53366197044, 5230.529252367267, 5262.210668399733, 5269.394019687747, 5335.0663633863915, 5915.231019967377, 6021.157038014681, 6022.066579680157, 6022.337542870281, 6029.216201893726, 5762.798302059449, 5886.941130588682, 6054.545909056838, 6082.482988945945, 6088.178095957033, 5467.835964921019, 5531.585131115183, 5538.75075621598, 5540.335159780811, 5566.832995010156, 6102.701334035014, 6103.981246026694, 6107.408898231393, 6111.691282510336, 6116.4879456621975, 5820.301563812285, 5888.735006924699, 5908.497777688945, 5913.349531551526, 5941.079132734433, 5815.825525234165, 5839.532837373, 5935.614185077956, 5973.0, 5985.610935289193, 5975.641461512323, 5977.372375900555, 5981.282246130405, 6002.0996850472775, 6028.638281703112, 5876.294844618587, 5968.104784282393, 5980.162777211194, 5982.371850955674, 5985.970070149621, 4417.911641767147, 4475.373447717322, 4504.2793153096, 4544.795484203219, 4610.608098311614, 4086.3870419436726, 4103.548609652936, 4106.0, 4113.218488487178, 4126.195391898551, 5539.058360078796, 5570.220169176318, 5576.1356989666665, 5588.329400471969, 5613.438656134435, 5861.1501332307425, 5887.322957859816, 5956.851078723066, 5979.581429299994, 5989.431004054608, 5509.338879334506, 5537.446255374511, 5554.389017208104, 5565.193047008162, 5574.498295153456, 5110.131277682803, 5136.203888397305, 5146.485351464824, 5151.793928242828, 5155.7679904404395, 6017.578769486094, 6082.300535438393, 6143.385661433821, 6144.064619644798, 6146.0473626587955, 5827.446392592697, 5872.647641141545, 5874.942510348178, 5885.646861188171, 5996.370381110095, 5846.532277417711, 6094.299155597163, 6104.969475152596, 6118.632882027093, 6124.112003759519, 5834.795782147605, 5854.326752423526, 5855.916655418761, 5870.031444811729, 5871.031279838779, 5853.531717462678, 5895.322037965518, 5963.105534169909, 5984.19213406202, 6000.039993601003, 5777.682227477361, 5793.623414478046, 5826.73779679907, 5839.153322768259, 5846.6784326862435, 5574.275344205227, 5742.224799651994, 5805.738741756547, 5817.738201781015, 5818.894410062075, 5671.943280567141, 5684.488396044376, 5719.971400142973, 5731.426857314235, 5745.913811292918, 5753.0, 5793.594448388572, 5827.679477628772, 5830.125481177857, 5832.445917637818, 5501.532369748456, 5551.111822108443, 5660.971695141498, 5686.459786320293, 5707.286589176353], "unit": "score", "name": "dojo.html", "value": 5452.187766569996}, {"lowerIsBetter": false, "replicates": [559.1603624076785, 586.7447660267784, 595.934447210807, 600.1208229943134, 606.7451670298476, 37089.44365834511, 37502.62497375025, 37923.431148532756, 38158.23683526328, 38228.0, 42409.78795106028, 42584.72245832622, 42904.0, 42998.0, 43021.0, 8719.215270625642, 8756.562171891412, 8812.118788121168, 8837.690680826172, 8928.37501374904, 8538.359623028298, 8677.69628063018, 8689.82620347596, 8728.25809806164, 8767.605457754384, 8765.342599305046, 8811.559422028873, 8842.867356989651, 8885.0, 8916.063813299608, 8658.956705216466, 8786.07746186654, 8797.692080777206, 8803.735887923373, 8850.291976641918, 8587.828243435097, 8679.43583667066, 8691.174338437839, 8725.214730674206, 8731.563421828947, 39755.60244397577, 40364.394534082014, 40421.393679094836, 40466.0, 40522.797386013175, 3248.3665685191395, 3352.715019223369, 3530.3998320285614, 3874.2832575973252, 3946.881593552198, 29720.55419168714, 30039.098827035225, 30089.398212035638, 30335.69664303351, 30430.54354184689, 3780.640839120279, 3821.48409964654, 3834.6740527055235, 3880.165764360676, 3981.0843505993785, 258157.0, 258322.0, 258327.0, 259048.9999999981, 259184.0, 57089.42910570924, 57480.137797933065, 57527.71236143876, 57574.424255757745, 57637.42362576321, 53141.7342913283, 54037.45962540403, 66836.6658166706, 68081.31918680848, 68123.0, 13024.54414095502, 13215.273159976294, 13334.599962001155, 13336.0, 13388.263645499395, 9722.2708296878, 9827.459489728133, 9862.211023118134, 9870.901290986998, 9876.506174691236, 18795.90602046981, 19034.238630454627, 19084.71372929407, 19144.808551914302, 19242.422727318204, 8011.439199256112, 8143.032750022481, 8166.1833816619055, 8286.254237118688, 8312.459690120122, 982.3271059324386, 1020.0513522424069, 1064.669952314785, 1076.4079756134252, 1093.9771313821602, 27640.723592763814, 27708.861455692593, 27710.584341234495, 27789.583156252673, 27881.30296742557, 1064.3294724323628, 1070.0797314309686, 1074.2211896375222, 1118.6755840806238, 1165.3823473559028, 14503.709925801424, 15189.772153417707, 15503.922480387751, 15556.45552405683, 15643.608909777118, 314900.0, 317097.0, 319432.0, 319525.0, 319800.0, 49352.50647493551, 49777.0, 49861.0, 50106.74946625243, 50129.0, 1354.3702178487051, 1362.0942073521196, 1374.2785037855006, 1378.6484446466288, 1388.222595346609, 27236.182914512596, 28147.71852281451, 28171.43657126887, 28176.937857807206, 28312.575311370758, 43901.121977560906, 44279.55720442755, 44456.33315500205, 44500.33249501196, 44617.55382446134, 297198.0, 297425.0, 299659.0, 299828.0, 300454.0, 30241.848790755907, 31003.224919377197, 31844.6815531851, 31938.520922185722, 32065.51901721523, 37980.0, 39441.60558394379, 40738.59261407348, 41174.0, 41212.58787412207, 34202.82898585491, 34619.30761384708, 35192.64807351996, 35210.78988847048, 35379.0, 34273.82863085669, 34376.48435273523, 34754.0, 34783.82608086943, 35197.0, 33490.33019339648, 33845.66154338425, 34271.31457370789, 34292.0, 34360.65639343575, 30015.54976675308, 30728.846355768077, 31983.0, 32059.198520036254, 32220.0, 24329.0, 24339.878300608383, 24342.391440214138, 24688.876555617106, 24746.133885313928], "unit": "score", "name": "ext.html", "value": 18231.36072159639}, {"lowerIsBetter": false, "replicates": [364.9927001459971, 366.5216891955997, 366.8642602237173, 367.4855202716197, 367.87860006197957, 16335.264913078925, 17146.685197498333, 17573.64852702945, 17990.370337038206, 18413.815861841376, 10589.629362972297, 11799.70500737482, 16689.749653755174, 16698.49904502864, 16734.16329183539, 5126.436092029874, 5615.101583746601, 5621.550275977932, 5622.437756224365, 5624.3531993820825, 5460.972695136519, 5562.221289019541, 5585.972070139644, 5587.776488940458, 5591.9720401397935, 4873.244647079709, 5080.009398167341, 5085.669431486942, 5501.889962200754, 5517.062099443085, 4991.201407774775, 5064.189729643258, 5064.366954130734, 5067.619928505377, 5068.695878247298, 5052.520010598987, 5062.392512898439, 5063.797448102072, 5081.644284900059, 5089.6691715038405, 12296.262224266573, 12437.253764774052, 12449.25304481734, 14811.555653330417, 20206.49483762903, 2054.157795303933, 2114.1332053858, 2135.231316725977, 2199.0763879170786, 2245.7754224577575, 9489.90510094904, 10633.787324253472, 10984.890151098547, 13255.933720331337, 13595.864041359559, 1796.5329014456204, 1805.9548511287192, 1831.9816801831944, 1852.148011914521, 1905.1522072677665, 63016.0, 66386.0, 67124.6643766778, 67647.32352676509, 68171.65914170447, 10209.846852297222, 10597.470126493645, 10606.681799546026, 10623.0, 10687.022900763384, 13727.107737996997, 13888.305584720723, 13925.234112123728, 13925.442982280596, 13931.791023134661, 6774.593524388552, 6995.8950615740805, 7015.403690686247, 7041.0, 7156.463265255023, 6515.12045873801, 6548.083268342436, 6561.901571476432, 6578.3750543699225, 6619.66901654925, 4471.105778844244, 4545.6136228420955, 4580.587747102777, 4583.427071616048, 4591.724496530219, 1751.798543167552, 1754.561359660085, 1844.3176024870884, 1870.7474490943548, 1915.6647586672277, 837.7361131243639, 944.9196818270524, 960.5245403525299, 990.4948476277151, 1011.261778901406, 15598.0, 16085.131386970337, 16547.586310342336, 16831.32674693023, 18405.26378944854, 916.706653870755, 921.6543796076471, 938.4041133879899, 961.1397798969883, 1001.1090129784498, 8047.811538212893, 9985.750356241007, 10063.245256605784, 10072.143867771176, 10133.695989120339, 396651.0, 399205.0, 400296.0, 403708.0, 563570.0, 80248.0, 82922.0, 83900.58049709712, 84596.0, 86467.56766216255, 1111.283222321598, 1127.937963412004, 1129.108004676313, 1147.5409836065473, 1155.3010428690689, 15317.846821531642, 15466.458673946358, 15607.21963901823, 15715.528534143994, 15731.370745170065, 32701.698964826002, 32927.50608740823, 32997.67002329946, 34540.65459345374, 35745.28509429849, 38306.61693383031, 38788.80605596954, 39999.000074993906, 40452.39321410123, 40613.1877362457, 9626.855597166188, 9777.967126056437, 9879.308448408543, 9945.0, 10037.799244014932, 17152.914235428743, 17795.82204177942, 18033.819661803213, 18104.18531166074, 18123.637527249117, 11713.0, 12994.935025324812, 13549.119307244997, 13550.119242249222, 13847.584572462842, 13606.659833504242, 13772.449102035805, 14081.0, 14116.717665646835, 14437.85562144365, 14656.633584160054, 14784.556463306119, 14785.852141478877, 15218.467353642569, 15350.539483815503, 9263.814723705624, 9292.39599426035, 9394.154526092685, 9433.386829856037, 9480.0, 11878.524859005543, 14521.85478145205, 14602.415903364172, 14874.851251487347, 15152.545423637308], "unit": "score", "name": "jquery.html", "value": 8730.293278464074}, {"lowerIsBetter": false, "replicates": [1533.6165958510373, 1700.4558541266795, 1768.1512873820566, 1768.2396569475125, 1787.9016654084028, 7020.824479388005, 7166.319199676022, 7660.578668173248, 7929.24672156145, 7960.044794624639, 7072.68172932218, 7118.359347658709, 7235.602041887694, 7241.203467618558, 7278.417726581874, 2322.1292015494146, 2373.299876536426, 2383.5828729972272, 2388.7850093491584, 2389.8088152947807, 2344.9531009379803, 2357.446000189954, 2380.73811880693, 2396.9640455393182, 2400.411899084718, 2335.94160145996, 2343.9648405273933, 2373.5727569037567, 2374.536965291769, 2377.3818807110188, 2319.072371051576, 2327.8836058197107, 2345.6950596422357, 2349.7885190332954, 2369.2892132360307, 2329.650552417134, 2335.1243283768586, 2335.708036495438, 2353.2351985604746, 2362.043372434167, 7812.492188007818, 7877.212278772135, 7883.566403847786, 7893.289603935616, 7906.0, 4714.952850471485, 4734.786934587952, 4745.762711864428, 4747.786349614275, 4762.809487620491, 3201.0876900083363, 3233.822139782311, 3243.8215898125595, 3274.2141885947203, 3275.5577996970583, 1078.7411021354897, 1082.718493191768, 1113.5378817790606, 1123.1127409346607, 1128.3959806475623, 10916.235863489559, 10917.39954302513, 10934.56261749537, 10936.289141205876, 10970.177236707279, 4330.718503297276, 4367.868963931087, 4381.364702118239, 4400.559944005574, 4407.096545208225, 9395.389299695498, 9402.43585384879, 9411.0, 9417.811643767087, 9422.858657120149, 4818.4217893852265, 4829.710217386968, 4831.130396528588, 4836.685615434985, 4840.201366774513, 4307.56924307573, 4351.0645211279725, 4385.473743150842, 4423.734575925455, 4426.623736982393, 3677.3748462761396, 3722.683571896365, 3728.496652951871, 3751.793651349202, 3755.0987762936697, 1142.5030111901349, 1153.7173392518887, 1161.3960740415105, 1163.3543383422113, 1174.2426135142784, 1298.0070246261616, 1298.7532368850077, 1302.0299876592, 1348.2112963916022, 1358.185088946624, 7176.856462870714, 7216.097987751531, 7277.381422579034, 7312.597807120553, 7325.890111648329, 511.37867490998616, 517.503196930943, 519.0941806547598, 521.1817446608787, 527.5779376498785, 5340.385855626652, 5347.679139251657, 5349.5720342372515, 5362.570994320523, 5371.838844834661, 9176.587053582605, 9280.0, 9314.487703176255, 9370.297227707813, 9411.388259763231, 9332.953335233417, 9367.110124538294, 9393.90606093944, 9404.811903761887, 9420.387674801115, 7111.7866464006165, 7257.52826066304, 7285.615733010711, 7294.234105418961, 7390.29792169743, 7120.857582848211, 7195.0646415967685, 7220.0613920190035, 7229.674664639999, 7250.74622388235, 8097.068837083811, 8128.227818357246, 8293.58532073406, 8410.032846222763, 8420.4947703138, 8457.619407126816, 8559.700410485602, 8643.26532244741, 8676.78308042304, 8705.47767133974, 6666.633335166613, 6890.655467226518, 6926.857068583628, 6962.060121883684, 6975.3024697529845, 7619.69521219145, 7624.80937976555, 7627.199144089791, 7628.160902300853, 7629.351505121905, 7022.859542809218, 7152.0, 7179.0, 7261.419086473175, 7275.599842008741, 7033.191183013814, 7079.39825114871, 7131.572105673677, 7216.422686185198, 7272.854542909006, 6695.230048544479, 6797.5581587196675, 6840.452763778985, 6852.280510546321, 6852.5203235773015, 6252.9062064069985, 6262.373762623702, 6310.5267104968225, 6316.526260530387, 6324.968375158095, 6339.587926784744, 6406.871862562816, 6420.7431702731365, 6420.839479013062, 6431.549791514549], "unit": "score", "name": "mootools.html", "value": 4461.5870294619945}, {"lowerIsBetter": false, "replicates": [330.7916012911865, 334.4565081742169, 339.4009573103473, 340.6865683571114, 348.00470653929756, 6274.717637706302, 6298.023806310018, 6353.396427339407, 6358.713857876395, 6469.70886310116, 6232.376762323765, 6242.313345531988, 6279.717412716427, 6284.8743025139465, 6293.961496353108, 4743.383360163174, 4772.90454190916, 4787.281907713854, 4787.569118779309, 4795.568398844103, 4808.038392321532, 4809.677338731842, 4812.759362031885, 4813.315339631118, 4824.504403634867, 4567.246404343279, 4669.603083737887, 4673.088747694201, 4710.788014539354, 4761.262004389325, 4666.9066618667775, 4690.882727931812, 4710.0, 4714.481407045222, 4716.434027916637, 4000.5399379071487, 4065.5934406559404, 4069.7558146511305, 4073.307537718595, 4075.8369665213354, 5947.702614869282, 5974.074018527135, 5982.790602328898, 5996.070609055603, 5996.280446346423, 5343.519083282523, 5426.891462170774, 5476.835694929118, 5477.096279113942, 5481.342238931314, 6609.239937407212, 6613.603183808987, 6637.2367177774695, 6645.900311495331, 6650.70071846768, 4514.164879497303, 4514.277715565527, 4514.6388288936805, 4518.164139634146, 4521.118381915528, 6878.312168783132, 6943.375096241312, 6946.0622815920215, 6987.091678081919, 7015.473839462061, 4613.8385156520035, 4613.976930115395, 4623.86128416148, 4631.143238500888, 4633.86098417048, 4678.6491013174145, 4686.343911852344, 4688.835890743876, 4691.507391723888, 4693.342931989524, 5418.620696551282, 5441.863953401117, 5454.127339625641, 5461.508464238158, 5471.945280547223, 6557.9344206557325, 6686.966565167143, 6699.799006029827, 6709.127813384229, 6714.0, 1624.7969003874516, 1637.959051023734, 1669.899806011619, 1672.030222470964, 1675.103819456585, 1082.983755243672, 1083.4799296337644, 1094.43089593411, 1094.7372630568607, 1098.7967226063045, 6238.095476156022, 6242.781502647385, 6251.12484252205, 6260.812175634738, 6284.088807122942, 6763.628000459924, 6765.323467653196, 6781.152355955505, 6791.0, 6808.6936087876165, 6132.50939924805, 6173.382661733881, 6181.629102253879, 6184.783532576338, 6185.072239164161, 3656.213914008501, 3680.0799800049986, 3687.2809802088336, 3707.0, 3708.554973403209, 7065.328793764585, 7072.1513418389095, 7088.574685518885, 7090.929090709027, 7090.929090709027, 6801.693923773442, 7012.0, 7023.367896889305, 7041.394683966965, 7044.401225895754, 6999.440044796404, 7057.4001209896705, 7062.117235345582, 7065.116860392451, 7067.257937916547, 6760.459163266829, 6780.220274668476, 6789.456843452611, 6796.490263230178, 6796.83007924786, 6562.606243625398, 6685.565438246498, 6724.193096828412, 6724.361185687352, 6734.057231987427, 7056.788296351117, 7062.470314726519, 7068.11648543932, 7071.222165561681, 7071.858562828817, 4661.580457758818, 4695.060987802385, 4700.882477938079, 4702.7883745230865, 4703.31801888731, 6682.498812588978, 6780.423663988616, 6781.6948237330425, 6802.591844489347, 7009.754658586925, 6690.632015239208, 6702.329767023259, 6711.865762684816, 6722.865542689216, 6731.663416829237, 6732.360425759545, 6735.124433823572, 6736.528443008942, 6743.52795304324, 6747.730090796314, 6490.967545162244, 6600.108985287116, 6615.834604134935, 6633.734650613921, 6634.436072933661, 6740.292269311652, 6757.358050985148, 6798.354156355138, 6806.9659651703405, 6824.351686589965, 6563.507736919845, 6605.933940660724, 6620.503462240447, 6646.102776125162, 6656.36764507371], "unit": "score", "name": "prototype.html", "value": 4977.383080553965}, {"lowerIsBetter": false, "replicates": [822.3626689315779, 844.4595458906301, 845.6913226672264, 850.196564246787, 869.9739007829768, 13491.999999999987, 13619.0, 13694.109882857607, 13703.38334774935, 13755.44978200872, 12666.80999785004, 12780.424880880359, 12805.679858003532, 12812.871871281284, 12814.615561533146, 663.8904580744171, 676.0906580649043, 802.7270727952495, 810.4610434061372, 819.6680344460503, 807.4590024683447, 811.6063709101081, 812.252727490707, 812.4394168024045, 822.7284995951352, 836.8368168207202, 841.2680967558202, 842.4608250719544, 848.7708318753932, 849.9277561407288, 828.6146941672122, 830.7466222802043, 834.7245409015011, 839.5340585974782, 840.1850205300879, 620.6803496199461, 621.6891554222889, 625.4027403829377, 625.6996641612006, 627.5952010952956, 13295.135816171918, 13316.0, 13323.26722030288, 13326.200427974352, 13357.732845343136, 11124.332540047542, 12051.57819476323, 12092.395380230953, 12320.75358492825, 12373.443195056245, 10252.64115755945, 10293.948530257301, 10337.121344685711, 10418.21863360251, 10522.158227341793, 3581.6418358164237, 3586.1572530455323, 3635.1093981974323, 3664.0839790052487, 3717.7769333840056, 41239.58760412387, 41457.378139327935, 41532.792336038125, 41564.0, 41624.583754162675, 9478.431294122374, 9587.568559414844, 9924.454155021544, 9958.950205249072, 10029.749256268651, 17171.227294771765, 17181.828181718272, 17293.740593891103, 17365.0, 17394.565135871704, 7624.351930086005, 7752.7674169775, 7767.37860971121, 7786.299233068938, 7826.2173782621285, 4436.800343984464, 4440.378347031418, 4446.844360447433, 4458.219811532968, 4476.306172543261, 2996.7752418568693, 2996.955045674317, 3010.0217429335553, 3026.303950091491, 3027.9243018924262, 521.324884274865, 537.6182910133771, 548.0518702644367, 552.3675391676508, 552.8866582350608, 489.4713709194062, 529.6080900133874, 600.1867469578658, 606.7057477123592, 617.2222999021176, 7834.647440865175, 7855.8821617675785, 7953.447124821917, 8061.6372263248295, 8155.510669359857, 511.58050398673475, 515.4021335251166, 515.6004096824915, 516.9689818610896, 542.785599688121, 3569.9837682607067, 3802.5627052888717, 3817.351050321452, 3890.435886796399, 3892.2993861104706, 55066.449335506935, 55139.724301379036, 55281.44718552763, 55420.72289638607, 61433.38566614276, 48175.5182448178, 48239.5176048235, 48560.514394856305, 48770.56147192626, 49221.261681074815, 44421.0, 44555.0, 45329.0, 45883.770581146884, 46205.537944620795, 7663.233676632292, 7795.766127016199, 8434.957825210835, 8599.226069653761, 8708.956455217683, 34211.65788342085, 34268.82865585656, 34696.479552807235, 34758.82620586881, 35837.10407239736, 40140.59859401369, 40222.79888600538, 43026.569734303506, 43588.34617480804, 43687.78156109199, 9904.603815847286, 10232.079112879877, 10363.32638378503, 10381.896181038093, 10459.738506537398, 11646.24299420535, 11859.0, 12000.57997970067, 12598.811017834556, 12643.620691379274, 10376.198426424671, 10441.112505437122, 10498.107660848913, 10688.946555267485, 10788.95679830901, 10665.200109991627, 10686.73283167927, 10797.460126993776, 10882.945585272022, 11134.164937629872, 9619.51902404863, 10236.232282578687, 10376.481175941324, 10382.428966406618, 10419.739506512398, 8660.78348041304, 8858.11418858109, 9210.401323913924, 9535.52322383892, 9705.0, 8296.336293096658, 9159.542022898695, 9224.538773061186, 9400.435973841591, 9588.185004274716], "unit": "score", "name": "yui.html", "value": 6071.047790070721}], "name": "dromaeo_css", "value": 6993.612946446139}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 105.0, 111.0, 110.0, 113.0, 124.0, 110.0, 111.0, 109.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [154.0, 123.0, 154.0, 168.0, 126.0, 149.0, 159.0, 126.0, 162.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 144.5}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 164.0, 164.0, 161.0, 161.0, 166.0, 169.0, 165.0], "unit": "score", "name": "audio-dft", "value": 163.6}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 72.0, 81.0, 74.0, 73.0, 142.0, 73.0, 72.0, 70.0], "unit": "score", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [95.0, 93.0, 141.0, 92.0, 94.0, 94.0, 139.0, 93.0, 94.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 107.8}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 111.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [150.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 98.0, 96.0, 97.0, 96.0, 97.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 59.0, 60.0, 60.0, 59.0, 59.0, 60.0, 58.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.9}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 66.0, 66.0, 66.0, 68.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.8}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 85.0, 87.0, 85.0, 83.0, 84.0, 91.0, 86.0, 93.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.4}, {"lowerIsBetter": true, "replicates": [124.0, 121.0, 119.0, 130.0, 124.0, 118.0, 118.0, 128.0, 128.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [140.0, 141.0, 151.0, 156.0, 147.0, 139.0, 154.0, 154.0, 152.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.5}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 69.0, 66.0, 67.0, 68.0, 68.0, 77.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1513.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.80998176090202], "unit": "score", "name": "Richards", "value": 212.90636200000006}, {"lowerIsBetter": false, "replicates": [194.4012441679627], "unit": "score", "name": "DeltaBlue", "value": 340.110992}, {"lowerIsBetter": false, "replicates": [284.9002849002849], "unit": "score", "name": "Encrypt", "value": 934.2953100000001}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1055.9662090813094], "unit": "score", "name": "RayTrace", "value": 700.7695829999997}, {"lowerIsBetter": false, "replicates": [726.7441860465116], "unit": "score", "name": "Earley", "value": 917.0530880000003}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [28000.0], "unit": "score", "name": "RegExp", "value": 32.53517857142855}, {"lowerIsBetter": false, "replicates": [638.9776357827476], "unit": "score", "name": "Splay", "value": 127.53341499999998}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20920.073056897043}]} 06:10:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20920.07"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1513.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6993.61"}}} 06:10:46 INFO - Return code: 0 06:10:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:10:46 INFO - # TBPL SUCCESS # 06:10:46 INFO - Running post-action listener: _resource_record_post_action 06:10:46 INFO - Running post-run listener: _resource_record_post_run 06:10:47 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 12288; Write bytes: 558841856; Read time: 56; Write time: 686424 06:10:47 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 235126784; Read time: 0; Write time: 408668 06:10:47 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 12288; Write bytes: 323715072; Read time: 56; Write time: 277756 06:10:47 INFO - Running post-run listener: _upload_blobber_files 06:10:47 INFO - Blob upload gear active. 06:10:47 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:10:47 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 06:10:47 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'] 06:10:47 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 06:10:47 INFO - (blobuploader) - INFO - Open directory for files ... 06:10:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:10:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:10:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:10:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:10:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:10:48 INFO - (blobuploader) - INFO - Done attempting. 06:10:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:10:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:10:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:10:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:10:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:10:49 INFO - (blobuploader) - INFO - Done attempting. 06:10:49 INFO - (blobuploader) - INFO - Iteration through files over. 06:10:49 INFO - Return code: 0 06:10:49 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:10:49 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:10:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d903e64d8149352837daa6b06251d97347fdc03b0cfb5c08eb4cd826dd6919481e804e7b6810a412a0423c16c58167637f5b56fdc60d22412e6f6fd2908b1dfb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa227c8fb562b28722e4820539825a019ac74b502026d5e01fd81414a02c8f364745aec09788b9f3ccd453e50306eca8cdb1b2fb167702bd61997f129b7bfd5a"} 06:10:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:10:49 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:10:49 INFO - Contents: 06:10:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d903e64d8149352837daa6b06251d97347fdc03b0cfb5c08eb4cd826dd6919481e804e7b6810a412a0423c16c58167637f5b56fdc60d22412e6f6fd2908b1dfb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa227c8fb562b28722e4820539825a019ac74b502026d5e01fd81414a02c8f364745aec09788b9f3ccd453e50306eca8cdb1b2fb167702bd61997f129b7bfd5a"} 06:10:49 INFO - Copying logs to upload dir... 06:10:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1277.642025 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-23 06:10:47.645462) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-23 06:10:47.648844) ========= 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=d96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418 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/d903e64d8149352837daa6b06251d97347fdc03b0cfb5c08eb4cd826dd6919481e804e7b6810a412a0423c16c58167637f5b56fdc60d22412e6f6fd2908b1dfb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa227c8fb562b28722e4820539825a019ac74b502026d5e01fd81414a02c8f364745aec09788b9f3ccd453e50306eca8cdb1b2fb167702bd61997f129b7bfd5a"} build_url:https://queue.taskcluster.net/v1/task/WcVlU4W1SRmK0kh7-ZicKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011248 build_url: 'https://queue.taskcluster.net/v1/task/WcVlU4W1SRmK0kh7-ZicKA/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/d903e64d8149352837daa6b06251d97347fdc03b0cfb5c08eb4cd826dd6919481e804e7b6810a412a0423c16c58167637f5b56fdc60d22412e6f6fd2908b1dfb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa227c8fb562b28722e4820539825a019ac74b502026d5e01fd81414a02c8f364745aec09788b9f3ccd453e50306eca8cdb1b2fb167702bd61997f129b7bfd5a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-23 06:10:47.676951) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 06:10:47.677550) ========= 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=d96ba47f58e561e1fc64d816000001cc-1450877617.614760-748600418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 06:10:47.760478) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-23 06:10:47.760797) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-23 06:10:47.761142) ========= ========= Total master_lag: 0.23 =========