builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1452063209.11 results: success (0) buildid: 20160105203029 builduid: a79c18446c0f4909bc01e14a40158979 revision: 8fdfe4071048b427d19cb5b42ee85eb13441068f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 22:53:29.110785) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 22:53:29.111592) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 22:53:29.115973) ========= 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=d2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006437 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 22:53:29.155912) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 22:53:29.156350) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 22:53:29.250409) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:53:29.250674) ========= 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=d2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004562 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:53:29.291960) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 22:53:29.292251) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 22:53:29.292624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:53:29.292902) ========= 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=d2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-05 22:53:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.8M=0s 2016-01-05 22:53:29 (43.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112694 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:53:29.432271) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:53:29.432653) ========= 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=d2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022295 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:53:29.489548) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:53:29.489923) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 8fdfe4071048b427d19cb5b42ee85eb13441068f --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 8fdfe4071048b427d19cb5b42ee85eb13441068f --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=d2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-05 22:53:29,708 truncating revision to first 12 chars 2016-01-05 22:53:29,708 Setting DEBUG logging. 2016-01-05 22:53:29,708 attempt 1/10 2016-01-05 22:53:29,708 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/8fdfe4071048?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-05 22:53:29,964 unpacking tar archive at: b2g-inbound-8fdfe4071048/testing/mozharness/ program finished with exit code 0 elapsedTime=0.532991 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:53:30.042538) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 22:53:30.042878) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 22:53:30.052723) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 22:53:30.053068) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 22:53:30.053501) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-05 22:53:30.053787) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:53:30 INFO - MultiFileLogger online at 20160105 22:53:30 in /builds/slave/test-pgo 22:53:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 22:53:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:53:30 INFO - {'append_to_log': False, 22:53:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:53:30 INFO - 'blob_upload_branch': 'B2G-Inbound', 22:53:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:53:30 INFO - 'branch': 'B2G-Inbound', 22:53:30 INFO - 'buildbot_json_path': 'buildprops.json', 22:53:30 INFO - 'config_files': ('talos/linux_config.py',), 22:53:30 INFO - 'default_actions': ('clobber', 22:53:30 INFO - 'read-buildbot-config', 22:53:30 INFO - 'download-and-extract', 22:53:30 INFO - 'populate-webroot', 22:53:30 INFO - 'create-virtualenv', 22:53:30 INFO - 'install', 22:53:30 INFO - 'run-tests'), 22:53:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:53:30 INFO - 'download_minidump_stackwalk': True, 22:53:30 INFO - 'download_symbols': 'ondemand', 22:53:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:53:30 INFO - 'tooltool.py': '/tools/tooltool.py', 22:53:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:53:30 INFO - '/tools/misc-python/virtualenv.py')}, 22:53:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:53:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:53:30 INFO - 'installer_path': 'installer.exe', 22:53:30 INFO - 'log_level': 'info', 22:53:30 INFO - 'log_name': 'talos', 22:53:30 INFO - 'log_to_console': True, 22:53:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:53:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:53:30 INFO - 'opt_config_files': (), 22:53:30 INFO - 'pip_index': False, 22:53:30 INFO - 'sps_profile': False, 22:53:30 INFO - 'sps_profile_interval': 0, 22:53:30 INFO - 'suite': 'dromaeojs', 22:53:30 INFO - 'system_bits': '32', 22:53:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:53:30 INFO - 'title': 'talos-linux64-ix-043', 22:53:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:53:30 INFO - 'use_talos_json': True, 22:53:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:53:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:53:30 INFO - 'work_dir': 'build'} 22:53:30 INFO - ##### 22:53:30 INFO - ##### Running clobber step. 22:53:30 INFO - ##### 22:53:30 INFO - Running pre-action listener: _resource_record_pre_action 22:53:30 INFO - Running main action method: clobber 22:53:30 INFO - rmtree: /builds/slave/test-pgo/build 22:53:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:53:30 INFO - Running post-action listener: _resource_record_post_action 22:53:30 INFO - ##### 22:53:30 INFO - ##### Running read-buildbot-config step. 22:53:30 INFO - ##### 22:53:30 INFO - Running pre-action listener: _resource_record_pre_action 22:53:30 INFO - Running main action method: read_buildbot_config 22:53:30 INFO - Using buildbot properties: 22:53:30 INFO - { 22:53:30 INFO - "project": "", 22:53:30 INFO - "product": "firefox", 22:53:30 INFO - "script_repo_revision": "production", 22:53:30 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 22:53:30 INFO - "repository": "", 22:53:30 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 22:53:30 INFO - "buildid": "20160105203029", 22:53:30 INFO - "pgo_build": "True", 22:53:30 INFO - "basedir": "/builds/slave/test-pgo", 22:53:30 INFO - "buildnumber": 184, 22:53:30 INFO - "slavename": "talos-linux64-ix-043", 22:53:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:53:30 INFO - "platform": "ubuntu64_hw", 22:53:30 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 22:53:30 INFO - "branch": "b2g-inbound", 22:53:30 INFO - "repo_path": "integration/b2g-inbound", 22:53:30 INFO - "revision": "8fdfe4071048b427d19cb5b42ee85eb13441068f", 22:53:30 INFO - "stage_platform": "linux64-pgo", 22:53:30 INFO - "builduid": "a79c18446c0f4909bc01e14a40158979", 22:53:30 INFO - "slavebuilddir": "test" 22:53:30 INFO - } 22:53:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/MXKBWDP_Qym662EsSo4Y9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:53:30 INFO - Running post-action listener: _resource_record_post_action 22:53:30 INFO - ##### 22:53:30 INFO - ##### Running download-and-extract step. 22:53:30 INFO - ##### 22:53:30 INFO - Running pre-action listener: _resource_record_pre_action 22:53:30 INFO - Running main action method: download_and_extract 22:53:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:30 INFO - https://queue.taskcluster.net/v1/task/MXKBWDP_Qym662EsSo4Y9w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:53:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXKBWDP_Qym662EsSo4Y9w/artifacts/public/build/test_packages.json 22:53:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXKBWDP_Qym662EsSo4Y9w/artifacts/public/build/test_packages.json 22:53:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXKBWDP_Qym662EsSo4Y9w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:53:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXKBWDP_Qym662EsSo4Y9w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:53:31 INFO - Downloaded 1302 bytes. 22:53:31 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:53:31 INFO - Using the following test package requirements: 22:53:31 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:53:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:31 INFO - u'jsshell-linux-x86_64.zip'], 22:53:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:53:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:53:31 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:53:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:53:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:53:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:31 INFO - https://queue.taskcluster.net/v1/task/MXKBWDP_Qym662EsSo4Y9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:53:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXKBWDP_Qym662EsSo4Y9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXKBWDP_Qym662EsSo4Y9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXKBWDP_Qym662EsSo4Y9w/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 22:53:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXKBWDP_Qym662EsSo4Y9w/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 22:53:32 INFO - Downloaded 24054411 bytes. 22:53:32 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 22:53:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:32 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 22:53:33 INFO - Return code: 0 22:53:33 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 22:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:33 INFO - https://queue.taskcluster.net/v1/task/MXKBWDP_Qym662EsSo4Y9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:53:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXKBWDP_Qym662EsSo4Y9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXKBWDP_Qym662EsSo4Y9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXKBWDP_Qym662EsSo4Y9w/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 22:53:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXKBWDP_Qym662EsSo4Y9w/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 22:53:34 INFO - Downloaded 24054411 bytes. 22:53:34 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 22:53:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:34 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 22:53:35 INFO - Return code: 0 22:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:35 INFO - https://queue.taskcluster.net/v1/task/MXKBWDP_Qym662EsSo4Y9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:53:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXKBWDP_Qym662EsSo4Y9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXKBWDP_Qym662EsSo4Y9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXKBWDP_Qym662EsSo4Y9w/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 22:53:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXKBWDP_Qym662EsSo4Y9w/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 22:53:37 INFO - Downloaded 11132285 bytes. 22:53:37 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 22:53:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:37 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 22:53:37 INFO - Return code: 0 22:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:37 INFO - https://queue.taskcluster.net/v1/task/MXKBWDP_Qym662EsSo4Y9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:53:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXKBWDP_Qym662EsSo4Y9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:53:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXKBWDP_Qym662EsSo4Y9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:53:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXKBWDP_Qym662EsSo4Y9w/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 22:53:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXKBWDP_Qym662EsSo4Y9w/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 22:53:40 INFO - Downloaded 55061351 bytes. 22:53:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MXKBWDP_Qym662EsSo4Y9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:53:40 INFO - mkdir: /builds/slave/test-pgo/properties 22:53:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:53:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:53:40 INFO - Contents: 22:53:40 INFO - build_url:https://queue.taskcluster.net/v1/task/MXKBWDP_Qym662EsSo4Y9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:53:40 INFO - Running post-action listener: _resource_record_post_action 22:53:40 INFO - Running post-action listener: set_extra_try_arguments 22:53:40 INFO - ##### 22:53:40 INFO - ##### Running populate-webroot step. 22:53:40 INFO - ##### 22:53:40 INFO - Running pre-action listener: _resource_record_pre_action 22:53:40 INFO - Running main action method: populate_webroot 22:53:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:53:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:53:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:53:40 INFO - '--tppagecycles', 22:53:40 INFO - '7'], 22:53:40 INFO - 'tests': ['tsvgm']}}, 22:53:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:53:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:53:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:53:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:53:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:53:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:53:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:53:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:40 INFO - 'talos_options': ['--e10s'], 22:53:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:53:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:40 INFO - 'tests': ['damp', 'tps']}, 22:53:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:40 INFO - 'talos_options': ['--e10s'], 22:53:40 INFO - 'tests': ['damp', 'tps']}, 22:53:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:53:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:53:40 INFO - 'other': {'tests': ['a11yr', 22:53:40 INFO - 'ts_paint', 22:53:40 INFO - 'tpaint', 22:53:40 INFO - 'sessionrestore', 22:53:40 INFO - 'sessionrestore_no_auto_restore']}, 22:53:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:53:40 INFO - 'tests': ['a11yr', 22:53:40 INFO - 'ts_paint', 22:53:40 INFO - 'tpaint', 22:53:40 INFO - 'sessionrestore', 22:53:40 INFO - 'sessionrestore_no_auto_restore']}, 22:53:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:53:40 INFO - 'tests': ['a11yr', 22:53:40 INFO - 'ts_paint', 22:53:40 INFO - 'tpaint', 22:53:40 INFO - 'sessionrestore', 22:53:40 INFO - 'sessionrestore_no_auto_restore']}, 22:53:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:53:40 INFO - 'tests': ['a11yr', 22:53:40 INFO - 'ts_paint', 22:53:40 INFO - 'tpaint', 22:53:40 INFO - 'sessionrestore', 22:53:40 INFO - 'sessionrestore_no_auto_restore']}, 22:53:40 INFO - 'other_l64': {'tests': ['a11yr', 22:53:40 INFO - 'ts_paint', 22:53:40 INFO - 'tpaint', 22:53:40 INFO - 'sessionrestore', 22:53:40 INFO - 'sessionrestore_no_auto_restore']}, 22:53:40 INFO - 'other_nol64': {'tests': ['a11yr', 22:53:40 INFO - 'ts_paint', 22:53:40 INFO - 'tpaint', 22:53:40 INFO - 'sessionrestore', 22:53:40 INFO - 'sessionrestore_no_auto_restore']}, 22:53:40 INFO - 'svgr': {'tests': ['tsvgx', 22:53:40 INFO - 'tsvgr_opacity', 22:53:40 INFO - 'tart', 22:53:40 INFO - 'tscrollx', 22:53:40 INFO - 'cart']}, 22:53:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:53:40 INFO - 'tests': ['tsvgx', 22:53:40 INFO - 'tsvgr_opacity', 22:53:40 INFO - 'tart', 22:53:40 INFO - 'tscrollx', 22:53:40 INFO - 'cart']}, 22:53:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:40 INFO - 'tests': ['tp5o']}, 22:53:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:40 INFO - 'talos_options': ['--e10s'], 22:53:40 INFO - 'tests': ['tp5o']}, 22:53:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:40 INFO - 'talos_options': ['--xperf_path', 22:53:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:53:40 INFO - 'tests': ['tp5n']}, 22:53:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:40 INFO - 'talos_options': ['--e10s', 22:53:40 INFO - '--xperf_path', 22:53:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:53:40 INFO - 'tests': ['tp5n']}}, 22:53:40 INFO - 'talos.zip': {'path': '', 22:53:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:53:40 INFO - Running post-action listener: _resource_record_post_action 22:53:40 INFO - ##### 22:53:40 INFO - ##### Running create-virtualenv step. 22:53:40 INFO - ##### 22:53:40 INFO - Running pre-action listener: _resource_record_pre_action 22:53:40 INFO - Running main action method: create_virtualenv 22:53:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:53:40 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 22:53:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:53:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:53:40 INFO - Using real prefix '/usr' 22:53:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:53:41 INFO - Installing distribute.............................................................................................................................................................................................done. 22:53:43 INFO - Installing pip.................done. 22:53:43 INFO - Return code: 0 22:53:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:53:43 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')]} 22:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:43 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')]} 22:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:43 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 0x7fc877637f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b47840>, '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 0x1ab46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab4b60>, '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': 'd2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553', '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 22:53:43 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 22:53:43 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 22:53:43 INFO - Using env: {'DISPLAY': ':0', 22:53:43 INFO - 'HOME': '/home/cltbld', 22:53:43 INFO - 'LANG': 'en_US.UTF-8', 22:53:43 INFO - 'LANGUAGE': 'en_US:en', 22:53:43 INFO - 'LOGNAME': 'cltbld', 22:53:43 INFO - 'MAIL': '/var/mail/cltbld', 22:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:43 INFO - 'MOZ_NO_REMOTE': '1', 22:53:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:43 INFO - 'NO_EM_RESTART': '1', 22:53:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:43 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:43 INFO - 'SHELL': '/bin/bash', 22:53:43 INFO - 'SHLVL': '1', 22:53:43 INFO - 'TERM': 'linux', 22:53:43 INFO - 'TMOUT': '86400', 22:53:43 INFO - 'USER': 'cltbld', 22:53:43 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553', 22:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:43 INFO - '_': '/tools/buildbot/bin/python'} 22:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:43 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 22:53:43 INFO - Cleaning up... 22:53:43 INFO - Return code: 0 22:53:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:53:43 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')]} 22:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:43 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')]} 22:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:43 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 0x7fc877637f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b47840>, '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 0x1ab46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab4b60>, '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': 'd2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553', '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 22:53:43 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 22:53:43 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 22:53:43 INFO - Using env: {'DISPLAY': ':0', 22:53:43 INFO - 'HOME': '/home/cltbld', 22:53:43 INFO - 'LANG': 'en_US.UTF-8', 22:53:43 INFO - 'LANGUAGE': 'en_US:en', 22:53:43 INFO - 'LOGNAME': 'cltbld', 22:53:43 INFO - 'MAIL': '/var/mail/cltbld', 22:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:43 INFO - 'MOZ_NO_REMOTE': '1', 22:53:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:43 INFO - 'NO_EM_RESTART': '1', 22:53:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:43 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:43 INFO - 'SHELL': '/bin/bash', 22:53:43 INFO - 'SHLVL': '1', 22:53:43 INFO - 'TERM': 'linux', 22:53:43 INFO - 'TMOUT': '86400', 22:53:43 INFO - 'USER': 'cltbld', 22:53:43 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553', 22:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:43 INFO - '_': '/tools/buildbot/bin/python'} 22:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:43 INFO - Downloading/unpacking psutil>=0.7.1 22:53:43 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 22:53:43 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 22:53:43 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 22:53:43 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 22:53:43 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 22:53:43 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 22:53:45 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:53:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:53:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:53:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:53:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:53:45 INFO - Installing collected packages: psutil 22:53:45 INFO - Running setup.py install for psutil 22:53:45 INFO - building 'psutil._psutil_linux' extension 22:53:45 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 22:53:45 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 22:53:45 INFO - building 'psutil._psutil_posix' extension 22:53:45 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 22:53:45 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 22:53:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:53:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:53:45 INFO - Successfully installed psutil 22:53:45 INFO - Cleaning up... 22:53:45 INFO - Return code: 0 22:53:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:45 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 0x7fc877637f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b47840>, '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 0x1ab46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab4b60>, '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': 'd2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553', '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 22:53:45 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 22:53:45 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 22:53:45 INFO - Using env: {'DISPLAY': ':0', 22:53:45 INFO - 'HOME': '/home/cltbld', 22:53:45 INFO - 'LANG': 'en_US.UTF-8', 22:53:45 INFO - 'LANGUAGE': 'en_US:en', 22:53:45 INFO - 'LOGNAME': 'cltbld', 22:53:45 INFO - 'MAIL': '/var/mail/cltbld', 22:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:45 INFO - 'MOZ_NO_REMOTE': '1', 22:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:45 INFO - 'NO_EM_RESTART': '1', 22:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:45 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:45 INFO - 'SHELL': '/bin/bash', 22:53:45 INFO - 'SHLVL': '1', 22:53:45 INFO - 'TERM': 'linux', 22:53:45 INFO - 'TMOUT': '86400', 22:53:45 INFO - 'USER': 'cltbld', 22:53:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553', 22:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:45 INFO - '_': '/tools/buildbot/bin/python'} 22:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:53:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:53:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:53:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:53:48 INFO - Installing collected packages: mozsystemmonitor 22:53:48 INFO - Running setup.py install for mozsystemmonitor 22:53:48 INFO - Successfully installed mozsystemmonitor 22:53:48 INFO - Cleaning up... 22:53:48 INFO - Return code: 0 22:53:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:53:48 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')]} 22:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:48 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')]} 22:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:48 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 0x7fc877637f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b47840>, '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 0x1ab46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab4b60>, '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': 'd2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553', '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 22:53:48 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 22:53:48 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 22:53:48 INFO - Using env: {'DISPLAY': ':0', 22:53:48 INFO - 'HOME': '/home/cltbld', 22:53:48 INFO - 'LANG': 'en_US.UTF-8', 22:53:48 INFO - 'LANGUAGE': 'en_US:en', 22:53:48 INFO - 'LOGNAME': 'cltbld', 22:53:48 INFO - 'MAIL': '/var/mail/cltbld', 22:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:48 INFO - 'MOZ_NO_REMOTE': '1', 22:53:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:48 INFO - 'NO_EM_RESTART': '1', 22:53:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:48 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:48 INFO - 'SHELL': '/bin/bash', 22:53:48 INFO - 'SHLVL': '1', 22:53:48 INFO - 'TERM': 'linux', 22:53:48 INFO - 'TMOUT': '86400', 22:53:48 INFO - 'USER': 'cltbld', 22:53:48 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553', 22:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:48 INFO - '_': '/tools/buildbot/bin/python'} 22:53:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:48 INFO - Downloading/unpacking blobuploader==1.2.4 22:53:48 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 22:53:48 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 22:53:48 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 22:53:48 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 22:53:48 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 22:53:48 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 22:53:50 INFO - Downloading blobuploader-1.2.4.tar.gz 22:53:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:53:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:53:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:53:50 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 22:53:50 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 22:53:50 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 22:53:50 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 22:53:50 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 22:53:50 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 22:53:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:53:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:53:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:53:50 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 22:53:50 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 22:53:50 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 22:53:50 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 22:53:50 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 22:53:50 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 22:53:50 INFO - Downloading docopt-0.6.1.tar.gz 22:53:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:53:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:53:50 INFO - Installing collected packages: blobuploader, requests, docopt 22:53:50 INFO - Running setup.py install for blobuploader 22:53:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:53:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:53:51 INFO - Running setup.py install for requests 22:53:51 INFO - Running setup.py install for docopt 22:53:51 INFO - Successfully installed blobuploader requests docopt 22:53:51 INFO - Cleaning up... 22:53:51 INFO - Return code: 0 22:53:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:53: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')]} 22:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53: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')]} 22:53:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:51 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 0x7fc877637f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b47840>, '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 0x1ab46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab4b60>, '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': 'd2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553', '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 22:53:51 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 22:53:51 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 22:53:51 INFO - Using env: {'DISPLAY': ':0', 22:53:51 INFO - 'HOME': '/home/cltbld', 22:53:51 INFO - 'LANG': 'en_US.UTF-8', 22:53:51 INFO - 'LANGUAGE': 'en_US:en', 22:53:51 INFO - 'LOGNAME': 'cltbld', 22:53:51 INFO - 'MAIL': '/var/mail/cltbld', 22:53:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:51 INFO - 'MOZ_NO_REMOTE': '1', 22:53:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:51 INFO - 'NO_EM_RESTART': '1', 22:53:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:51 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:51 INFO - 'SHELL': '/bin/bash', 22:53:51 INFO - 'SHLVL': '1', 22:53:51 INFO - 'TERM': 'linux', 22:53:51 INFO - 'TMOUT': '86400', 22:53:51 INFO - 'USER': 'cltbld', 22:53:51 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553', 22:53:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:51 INFO - '_': '/tools/buildbot/bin/python'} 22:53:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:53:51 INFO - Running setup.py (path:/tmp/pip-OjFOJo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:53:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:53:51 INFO - Running setup.py (path:/tmp/pip-YFsOG1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:53:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:53:51 INFO - Running setup.py (path:/tmp/pip-XzGqkK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:53:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:53:51 INFO - Running setup.py (path:/tmp/pip-lBZnLW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:53:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:53:52 INFO - Running setup.py (path:/tmp/pip-Nr8Bob-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:53:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:53:52 INFO - Running setup.py (path:/tmp/pip-QxYTPG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:53:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:53:52 INFO - Running setup.py (path:/tmp/pip-NkjIoq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:53:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:53:52 INFO - Running setup.py (path:/tmp/pip-3r02wM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:53:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:53:52 INFO - Running setup.py (path:/tmp/pip-vLIaSC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:53:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:53:52 INFO - Running setup.py (path:/tmp/pip-eY4l5P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:53:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:53:52 INFO - Running setup.py (path:/tmp/pip-Z75kx8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:53:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:53:52 INFO - Running setup.py (path:/tmp/pip-HDNeCl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:53:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:53:52 INFO - Running setup.py (path:/tmp/pip-MARNcC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:53:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:53:52 INFO - Running setup.py (path:/tmp/pip-ggc5Ov-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:53:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:53:52 INFO - Running setup.py (path:/tmp/pip-oQS1vW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:53:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:53:52 INFO - Running setup.py (path:/tmp/pip-cXLUPZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:53:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:53:52 INFO - Running setup.py (path:/tmp/pip-wuyxiS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:53:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:53:52 INFO - Running setup.py install for manifestparser 22:53:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:53:53 INFO - Running setup.py install for mozcrash 22:53:53 INFO - Running setup.py install for mozdebug 22:53:53 INFO - Running setup.py install for mozdevice 22:53:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:53:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:53:53 INFO - Running setup.py install for mozfile 22:53:53 INFO - Running setup.py install for mozhttpd 22:53:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:53:53 INFO - Running setup.py install for mozinfo 22:53:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:53:53 INFO - Running setup.py install for mozInstall 22:53:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:53:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:53:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:53:53 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:53:53 INFO - Running setup.py install for mozleak 22:53:53 INFO - Running setup.py install for mozlog 22:53:53 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:53:53 INFO - Running setup.py install for moznetwork 22:53:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:53:54 INFO - Running setup.py install for mozprocess 22:53:54 INFO - Running setup.py install for mozprofile 22:53:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:53:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:53:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:53:54 INFO - Running setup.py install for mozrunner 22:53:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:53:54 INFO - Running setup.py install for mozscreenshot 22:53:54 INFO - Running setup.py install for moztest 22:53:54 INFO - Running setup.py install for mozversion 22:53:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:53:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:53:54 INFO - Cleaning up... 22:53:54 INFO - Return code: 0 22:53:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:53:54 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')]} 22:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:54 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')]} 22:53:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:54 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 0x7fc877637f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b47840>, '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 0x1ab46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab4b60>, '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': 'd2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553', '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 22:53:54 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 22:53:54 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 22:53:54 INFO - Using env: {'DISPLAY': ':0', 22:53:54 INFO - 'HOME': '/home/cltbld', 22:53:54 INFO - 'LANG': 'en_US.UTF-8', 22:53:54 INFO - 'LANGUAGE': 'en_US:en', 22:53:54 INFO - 'LOGNAME': 'cltbld', 22:53:54 INFO - 'MAIL': '/var/mail/cltbld', 22:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:54 INFO - 'MOZ_NO_REMOTE': '1', 22:53:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:54 INFO - 'NO_EM_RESTART': '1', 22:53:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:54 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:54 INFO - 'SHELL': '/bin/bash', 22:53:54 INFO - 'SHLVL': '1', 22:53:54 INFO - 'TERM': 'linux', 22:53:54 INFO - 'TMOUT': '86400', 22:53:54 INFO - 'USER': 'cltbld', 22:53:54 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553', 22:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:54 INFO - '_': '/tools/buildbot/bin/python'} 22:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:53:54 INFO - Running setup.py (path:/tmp/pip-zI5MES-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:53:55 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)) 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:53:55 INFO - Running setup.py (path:/tmp/pip-qwMabl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:53:55 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)) 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:53:55 INFO - Running setup.py (path:/tmp/pip-Bp5rep-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:53:55 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)) 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:53:55 INFO - Running setup.py (path:/tmp/pip-8voont-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:53:55 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)) 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:53:55 INFO - Running setup.py (path:/tmp/pip-aC8Tpv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:53:55 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)) 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:53:55 INFO - Running setup.py (path:/tmp/pip-Lg4i8D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:53:55 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)) 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:53:55 INFO - Running setup.py (path:/tmp/pip-DTli3Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:53:55 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)) 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:53:55 INFO - Running setup.py (path:/tmp/pip-Tnm6QE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:53:55 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)) 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:53:55 INFO - Running setup.py (path:/tmp/pip-z52JT6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:53:55 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)) 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:53:55 INFO - Running setup.py (path:/tmp/pip-BIV4YN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:53:55 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)) 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:53:55 INFO - Running setup.py (path:/tmp/pip-r3je6G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:53:55 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)) 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:53:55 INFO - Running setup.py (path:/tmp/pip-vaa7Gy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:53:55 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)) 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:53:55 INFO - Running setup.py (path:/tmp/pip-88z5FI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:53:55 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)) 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:53:55 INFO - Running setup.py (path:/tmp/pip-oCnR0d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:53:55 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)) 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:53:55 INFO - Running setup.py (path:/tmp/pip-GbUXUS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:53:56 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)) 22:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:53:56 INFO - Running setup.py (path:/tmp/pip-txT98u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:53:56 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)) 22:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:53:56 INFO - Running setup.py (path:/tmp/pip-M2n4u3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:53:56 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)) 22:53:56 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)) 22:53:56 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)) 22:53:56 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)) 22:53:56 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)) 22:53:56 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)) 22:53:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53:57 INFO - Downloading blessings-1.5.1.tar.gz 22:53:57 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 22:53:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:53:57 INFO - Installing collected packages: blessings 22:53:57 INFO - Running setup.py install for blessings 22:53:58 INFO - Successfully installed blessings 22:53:58 INFO - Cleaning up... 22:53:58 INFO - Return code: 0 22:53:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:53:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:53:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:53:58 INFO - Reading from file tmpfile_stdout 22:53:58 INFO - Current package versions: 22:53:58 INFO - argparse == 1.2.1 22:53:58 INFO - blessings == 1.5.1 22:53:58 INFO - blobuploader == 1.2.4 22:53:58 INFO - docopt == 0.6.1 22:53:58 INFO - manifestparser == 1.1 22:53:58 INFO - mozInstall == 1.12 22:53:58 INFO - mozcrash == 0.16 22:53:58 INFO - mozdebug == 0.1 22:53:58 INFO - mozdevice == 0.47 22:53:58 INFO - mozfile == 1.2 22:53:58 INFO - mozhttpd == 0.7 22:53:58 INFO - mozinfo == 0.9 22:53:58 INFO - mozleak == 0.1 22:53:58 INFO - mozlog == 3.1 22:53:58 INFO - moznetwork == 0.27 22:53:58 INFO - mozprocess == 0.22 22:53:58 INFO - mozprofile == 0.28 22:53:58 INFO - mozrunner == 6.11 22:53:58 INFO - mozscreenshot == 0.1 22:53:58 INFO - mozsystemmonitor == 0.0 22:53:58 INFO - moztest == 0.7 22:53:58 INFO - mozversion == 1.4 22:53:58 INFO - psutil == 3.1.1 22:53:58 INFO - requests == 1.2.3 22:53:58 INFO - wsgiref == 0.1.2 22:53:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:53: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')]} 22:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53: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')]} 22:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53: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', '-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 0x7fc877637f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b47840>, '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 0x1ab46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab4b60>, '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': 'd2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553', '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 22:53:58 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 22:53:58 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 22:53:58 INFO - Using env: {'DISPLAY': ':0', 22:53:58 INFO - 'HOME': '/home/cltbld', 22:53:58 INFO - 'LANG': 'en_US.UTF-8', 22:53:58 INFO - 'LANGUAGE': 'en_US:en', 22:53:58 INFO - 'LOGNAME': 'cltbld', 22:53:58 INFO - 'MAIL': '/var/mail/cltbld', 22:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:58 INFO - 'MOZ_NO_REMOTE': '1', 22:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:58 INFO - 'NO_EM_RESTART': '1', 22:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:58 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:58 INFO - 'SHELL': '/bin/bash', 22:53:58 INFO - 'SHLVL': '1', 22:53:58 INFO - 'TERM': 'linux', 22:53:58 INFO - 'TMOUT': '86400', 22:53:58 INFO - 'USER': 'cltbld', 22:53:58 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553', 22:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:58 INFO - '_': '/tools/buildbot/bin/python'} 22:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:58 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)) 22:53:58 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)) 22:53:58 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)) 22:53:58 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)) 22:53:58 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)) 22:53:58 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)) 22:53:58 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)) 22:53:58 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)) 22:53:58 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)) 22:53:58 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)) 22:53:58 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)) 22:53:58 INFO - Cleaning up... 22:53:58 INFO - Return code: 0 22:53:58 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:53: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')]} 22:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53: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')]} 22:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc877637f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b47840>, '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 0x1ab46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab4b60>, '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': 'd2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553', '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 22:53: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', 'jsonschema'] in /builds/slave/test-pgo/build 22:53: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 jsonschema 22:53:58 INFO - Using env: {'DISPLAY': ':0', 22:53:58 INFO - 'HOME': '/home/cltbld', 22:53:58 INFO - 'LANG': 'en_US.UTF-8', 22:53:58 INFO - 'LANGUAGE': 'en_US:en', 22:53:58 INFO - 'LOGNAME': 'cltbld', 22:53:58 INFO - 'MAIL': '/var/mail/cltbld', 22:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:58 INFO - 'MOZ_NO_REMOTE': '1', 22:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:58 INFO - 'NO_EM_RESTART': '1', 22:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:58 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:58 INFO - 'SHELL': '/bin/bash', 22:53:58 INFO - 'SHLVL': '1', 22:53:58 INFO - 'TERM': 'linux', 22:53:58 INFO - 'TMOUT': '86400', 22:53:58 INFO - 'USER': 'cltbld', 22:53:58 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553', 22:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:58 INFO - '_': '/tools/buildbot/bin/python'} 22:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:58 INFO - Downloading/unpacking jsonschema 22:53:58 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 22:53:58 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 22:53:58 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 22:53:58 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 22:53:58 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 22:53:58 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 22:54:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:54:00 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 22:54:00 INFO - Downloading/unpacking functools32 (from jsonschema) 22:54:00 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 22:54:00 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 22:54:00 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 22:54:00 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 22:54:00 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 22:54:00 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 22:54:00 INFO - Downloading functools32-3.2.3-2.tar.gz 22:54:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:54:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:54:00 INFO - warning: no files found matching '*.txt' 22:54:00 INFO - no previously-included directories found matching 'build' 22:54:00 INFO - no previously-included directories found matching 'dist' 22:54:00 INFO - no previously-included directories found matching '.git*' 22:54:00 INFO - Installing collected packages: jsonschema, functools32 22:54:00 INFO - Running setup.py install for functools32 22:54:01 INFO - warning: no files found matching '*.txt' 22:54:01 INFO - no previously-included directories found matching 'build' 22:54:01 INFO - no previously-included directories found matching 'dist' 22:54:01 INFO - no previously-included directories found matching '.git*' 22:54:01 INFO - Successfully installed jsonschema functools32 22:54:01 INFO - Cleaning up... 22:54:01 INFO - Return code: 0 22:54:01 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:01 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 0x7fc877637f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b47840>, '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 0x1ab46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab4b60>, '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': 'd2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553', '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 22:54:01 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 22:54:01 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 22:54:01 INFO - Using env: {'DISPLAY': ':0', 22:54:01 INFO - 'HOME': '/home/cltbld', 22:54:01 INFO - 'LANG': 'en_US.UTF-8', 22:54:01 INFO - 'LANGUAGE': 'en_US:en', 22:54:01 INFO - 'LOGNAME': 'cltbld', 22:54:01 INFO - 'MAIL': '/var/mail/cltbld', 22:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:01 INFO - 'MOZ_NO_REMOTE': '1', 22:54:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:01 INFO - 'NO_EM_RESTART': '1', 22:54:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:01 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:01 INFO - 'SHELL': '/bin/bash', 22:54:01 INFO - 'SHLVL': '1', 22:54:01 INFO - 'TERM': 'linux', 22:54:01 INFO - 'TMOUT': '86400', 22:54:01 INFO - 'USER': 'cltbld', 22:54:01 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553', 22:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:01 INFO - '_': '/tools/buildbot/bin/python'} 22:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:01 INFO - Downloading/unpacking flake8 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:54:03 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 22:54:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:54:03 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 22:54:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:03 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 22:54:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:54:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:54:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:54:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:54:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:54:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:54:03 INFO - no previously-included directories found matching 'docs/_build' 22:54:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:54:03 INFO - Running setup.py install for pep8 22:54:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:54:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:54:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:54:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:54:03 INFO - no previously-included directories found matching 'docs/_build' 22:54:03 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:54:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:54:03 INFO - Cleaning up... 22:54:03 INFO - Return code: 0 22:54:03 INFO - Running post-action listener: _resource_record_post_action 22:54:03 INFO - Running post-action listener: _start_resource_monitoring 22:54:03 INFO - Starting resource monitoring. 22:54:03 INFO - ##### 22:54:03 INFO - ##### Running install step. 22:54:03 INFO - ##### 22:54:03 INFO - Running pre-action listener: _resource_record_pre_action 22:54:03 INFO - Running main action method: install 22:54:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:54:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:54:04 INFO - Reading from file tmpfile_stdout 22:54:04 INFO - Detecting whether we're running mozinstall >=1.0... 22:54:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:54:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:54:04 INFO - Reading from file tmpfile_stdout 22:54:04 INFO - Output received: 22:54:04 INFO - Usage: mozinstall [options] installer 22:54:04 INFO - Options: 22:54:04 INFO - -h, --help show this help message and exit 22:54:04 INFO - -d DEST, --destination=DEST 22:54:04 INFO - Directory to install application into. [default: 22:54:04 INFO - "/builds/slave/test-pgo"] 22:54:04 INFO - --app=APP Application being installed. [default: firefox] 22:54:04 INFO - mkdir: /builds/slave/test-pgo/build/application 22:54:04 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'] 22:54:04 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 22:54:20 INFO - Reading from file tmpfile_stdout 22:54:20 INFO - Output received: 22:54:20 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:54:20 INFO - Running post-action listener: _resource_record_post_action 22:54:20 INFO - ##### 22:54:20 INFO - ##### Running run-tests step. 22:54:20 INFO - ##### 22:54:20 INFO - Running pre-action listener: _resource_record_pre_action 22:54:20 INFO - Running main action method: run_tests 22:54:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:54:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:54:20 INFO - Python 2.7.3 22:54:20 INFO - Return code: 0 22:54:20 INFO - grabbing minidump binary from tooltool 22:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:20 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 0x1b47840>, '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 0x1ab46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab4b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:54:20 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 22:54:20 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 22:54:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:54:20 INFO - Return code: 0 22:54:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:54:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:54:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:54:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:54:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:54:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:54:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:54:21 INFO - Return code: 0 22:54:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MXKBWDP_Qym662EsSo4Y9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 22:54:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MXKBWDP_Qym662EsSo4Y9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 22:54:21 INFO - Using env: {'DISPLAY': ':0', 22:54:21 INFO - 'HOME': '/home/cltbld', 22:54:21 INFO - 'LANG': 'en_US.UTF-8', 22:54:21 INFO - 'LANGUAGE': 'en_US:en', 22:54:21 INFO - 'LOGNAME': 'cltbld', 22:54:21 INFO - 'MAIL': '/var/mail/cltbld', 22:54:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:54:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:54:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:21 INFO - 'MOZ_NO_REMOTE': '1', 22:54:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:54:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:21 INFO - 'NO_EM_RESTART': '1', 22:54:21 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:21 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:21 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:54:21 INFO - 'SHELL': '/bin/bash', 22:54:21 INFO - 'SHLVL': '1', 22:54:21 INFO - 'TERM': 'linux', 22:54:21 INFO - 'TMOUT': '86400', 22:54:21 INFO - 'USER': 'cltbld', 22:54:21 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553', 22:54:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:21 INFO - '_': '/tools/buildbot/bin/python'} 22:54:21 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MXKBWDP_Qym662EsSo4Y9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:54:21 INFO - mozversion application_buildid: 20160105203029 22:54:21 INFO - mozversion application_changeset: 8fdfe4071048b427d19cb5b42ee85eb13441068f 22:54:21 INFO - mozversion application_display_name: Nightly 22:54:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:54:21 INFO - mozversion application_name: Firefox 22:54:21 INFO - mozversion application_remotingname: firefox 22:54:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 22:54:21 INFO - mozversion application_vendor: Mozilla 22:54:21 INFO - mozversion application_version: 46.0a1 22:54:21 INFO - mozversion platform_buildid: 20160105203029 22:54:21 INFO - mozversion platform_changeset: 8fdfe4071048b427d19cb5b42ee85eb13441068f 22:54:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 22:54:21 INFO - mozversion platform_version: 46.0a1 22:54:21 INFO - using testdate: 1452063261 22:54:21 INFO - actual date: 1452063261 22:54:21 INFO - starting webserver on 'localhost:41914' 22:54:21 INFO - SUITE-START | Running 3 tests 22:54:21 INFO - TEST-START | dromaeo_css 22:54:21 INFO - operating with platform_type : linux_ 22:54:21 INFO - Initialising browser for dromaeo_css test... 22:54:21 INFO - TEST-INFO | started process 28862 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkEEDTZ/profile http://localhost:41914/getInfo.html) 22:54:26 INFO - PROCESS | 28862 | __metrics Screen width/height:1600/1200 22:54:26 INFO - PROCESS | 28862 | colorDepth:24 22:54:26 INFO - PROCESS | 28862 | Browser inner width/height: 1024/697 22:54:26 INFO - PROCESS | 28862 | __metrics 22:54:26 INFO - PROCESS | 28862 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:54:26 INFO - PROCESS | 28862 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:54:27 INFO - TEST-INFO | 28862: exit 0 22:54:27 INFO - Browser initialized. 22:54:27 INFO - Running cycle 1/1 for dromaeo_css test... 22:54:27 INFO - TEST-INFO | started process 28959 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkEEDTZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:54:38 INFO - PROCESS | 28959 | RSS: Main: 149897216 22:54:38 INFO - PROCESS | 28959 | 22:55:30 INFO - PROCESS | 28959 | 1452063330521 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] 22:57:38 INFO - PROCESS | 28959 | Cycle 1(1): loaded http://localhost:41914/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41914/tests/dromaeo/cssquery-ext.html) 22:57:40 INFO - PROCESS | 28959 | RSS: Main: 270876672 22:57:40 INFO - PROCESS | 28959 | 23:00:42 INFO - PROCESS | 28959 | Cycle 1(1): loaded http://localhost:41914/tests/dromaeo/cssquery-ext.html (next: http://localhost:41914/tests/dromaeo/cssquery-jquery.html) 23:00:43 INFO - PROCESS | 28959 | RSS: Main: 239202304 23:00:43 INFO - PROCESS | 28959 | 23:03:45 INFO - PROCESS | 28959 | Cycle 1(1): loaded http://localhost:41914/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41914/tests/dromaeo/cssquery-mootools.html) 23:03:45 INFO - PROCESS | 28959 | RSS: Main: 232910848 23:03:45 INFO - PROCESS | 28959 | 23:06:47 INFO - PROCESS | 28959 | Cycle 1(1): loaded http://localhost:41914/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41914/tests/dromaeo/cssquery-prototype.html) 23:06:48 INFO - PROCESS | 28959 | RSS: Main: 213913600 23:06:48 INFO - PROCESS | 28959 | 23:09:50 INFO - PROCESS | 28959 | Cycle 1(1): loaded http://localhost:41914/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41914/tests/dromaeo/cssquery-yui.html) 23:09:51 INFO - PROCESS | 28959 | RSS: Main: 220663808 23:09:51 INFO - PROCESS | 28959 | 23:12:53 INFO - PROCESS | 28959 | Cycle 1(1): loaded http://localhost:41914/tests/dromaeo/cssquery-yui.html (next: http://localhost:41914/tests/dromaeo/cssquery-dojo.html) 23:12:53 INFO - PROCESS | 28959 | RSS: Main: 286896128 23:12:53 INFO - PROCESS | 28959 | 23:12:53 INFO - PROCESS | 28959 | __start_tp_report 23:12:53 INFO - PROCESS | 28959 | _x_x_mozilla_page_load 23:12:53 INFO - PROCESS | 28959 | _x_x_mozilla_page_load_details 23:12:53 INFO - PROCESS | 28959 | |i|pagename|runs| 23:12:53 INFO - PROCESS | 28959 | |0;dojo.html;3057.5566542851284;3096.6903309669037;3111.4088323218602;3148.2286839724256;3183.251935795088;5113.284140220363;5176.663516871401;5201.0898092833695;5238.266642670024;5273.129933560967;5118.283440318359;5122.6926384416965;5195.454477279888;5203.817866374678;5261.552768014723;4695.17834378984;4718.127146477913;4750.97624511877;4853.951460485385;4869.70781753096;4736.052789442108;4803.2795080738;4844.636652251078;4850.054239423313;4866.805327786884;4632.3051542268595;4672.696274742131;4750.311204875291;4786.353842231289;4796.136695394827;4733.905321893577;4760.143174228638;4768.47546769855;4776.689515181502;4803.3995750531185;4625.676202665814;4715.245560710304;4725.929111063337;4753.762311884392;4775.832845850378;5016.874578135576;5031.22016087507;5086.1353569892835;5089.491050894881;5111.872203194913;5609.382967873531;5623.381428042912;5623.409541998072;5632.127020311858;5635.295588051494;5490.945090549083;5631.831045068655;5662;5670.092785154356;5676.631018983753;5214.400343960455;5229.764660590245;5308.92036619451;5312.73436328182;5326.387465441485;5734.77060917567;5748.5688573357165;5752.108423194411;5763.423657634203;5764.481196692318;5442.156465747816;5501.9174712379345;5515.338159420895;5516.531094856902;5553.444655534414;5552.555795536347;5578.358488773762;5628.521575666033;5639.548836093103;5683.460071293221;5513.255710479034;5547.223388725582;5568.081266591048;5570.387257401682;5572.944270557324;5453.481919217668;5564.66612003273;5575.358833734173;5579.776808927598;5580.9441905580425;4345.413369195181;4393.0335326228815;4397.9560204398185;4431.800568974404;4440.4671439427475;3842.193139440693;3855.575886652466;3863.9227215455535;3867.903302417406;3907.1404291055924;5143.27994080829;5261.263423120766;5266.368035835724;5275.63070585063;5292.603054770908;5571.832845014656;5647.576431767634;5667.4615911488345;5681.062624666966;5702.059160238514;5229.921551176735;5236.188390799432;5253.947460525423;5272.420033796279;5274.894502109936;4704.9529504704515;4832.420109586872;4832.855014349575;4837.661363704507;4862.319275301461;5677.432256774372;5726.856828579319;5759.366469688331;5759.65442073477;5806.44838740319;5619.522340601095;5629.6903670298525;5636.802711905064;5640.774369025193;5645.887082258414;5667.688277144632;5813.94186058134;5825.50483208932;5826.359100499027;5832.24180856486;5468.28912241406;5487.835364939058;5537.861553461195;5543.584231182596;5546;5606.187102870143;5635.661860288232;5652.7738890443925;5662.292213473316;5665.461781130786;5398.892022159614;5515.062439385234;5521.585881058856;5521.751521181476;5529.30883639545;5408.45915408456;5471.179323101566;5501.119820828808;5501.642393244426;5536.446355364431;5397.59518036141;5404.78472721469;5409.296791417248;5413.891722165614;5415.5938304626525;5324.414314425333;5430.15832545956;5488.945110548843;5515.944840551543;5560.6107572471155;5272.077386457431;5396.21754845553;5399.352077750695;5401.081816091352;5425.538829199562 23:12:53 INFO - PROCESS | 28959 | |1;ext.html;529.2458246998028;531.9148936170213;535.5073332534071;552.417199854154;556;27351;28296.85851570742;34675.47986780197;35248.47127293086;35412.2917541649;37682.24635507288;37976.81011594945;38040;38069.23861522775;38070.42894356587;7466.850662986737;8230.629621667025;8391.748247552583;8392.076871544125;8395.748127556182;7684.07791065073;7765.611719414035;9891.208703303719;10091.747706307364;10096.949515252414;9651.324407291493;9789.902100979007;9795.755106122368;9802.2158227342;9806.264530160266;7653.579053152074;7840.960795195988;9714.805703885953;9732.756681082994;9851.458169800659;9852.261080418997;10145.797084058351;10151.593936242542;10152.187824974058;10154.08613224806;34280.31439371199;34641;34650.82674586636;34659.6534034659;34724.47913281303;3176.745860331168;3205;3216.823074730889;3263.7715359924814;3492.545969024036;28920.13239602815;29132.27169320763;29261.70738292611;29430;29781.851090744407;3917.1186483041374;3923.6272554107313;3925.038365600418;3942.7831469269177;3958.8218530166214;208074;210228;210499;210647;210817.945910271;51430.22854657183;52090;53445;58446.41553584495;60360.69819650961;54498;54536.72731636316;54889;54913;54955.175672364945;14195.85804141966;14358.784618230735;14367.13797172173;14373.64065898361;14378.065425747292;10841.457927103613;10921.67234982936;10932.398718070583;10934.507947142398;10934.945325273322;19217.62931292834;19434.402303366027;19510.709775321582;19596.510087247647;19617.411477655693;7494.812629684193;7600.733974310872;7723.111842138226;7731.884021739678;7806.570638614817;878.5080355001091;906.1120102299783;915.5696822493418;924.3991405586422;939.6382392778693;24852.627210591854;25102.87448562782;25385.61921571178;26630.20109396721;26668.19995400141;1009.7324209084599;1019.2202964731986;1038.190211634926;1039.1375158618328;1122.3882983773863;14122.747432772787;14131.85868141326;14231.715365692628;14366.066205696596;14367.2098034607;391092;393241;398670;398945;400318;50633.48099557019;51083.489165108615;51133.48866511287;51207.23189152166;51272;1301.9804702929464;1308.2346827106248;1311.1870640202944;1319.142557337719;1321.1742660836976;25997.480050398506;26604;26930.73069269282;27040;27142;41400.37899431451;41885.79057104695;41963.7901810489;41975.58024419717;41986.79006604947;269820;272766;272885;279346;286613;29621.703782962755;29843.403131936804;29844.701552984192;30246.54630180505;30258.394832103673;39959.60040399559;40660.79669601751;41217.58782412137;41676.79161604172;42274.15451691011;35055.12362190965;35406.46890296699;35501.289974199855;35524;36044.45933311055;35045.012171530994;35321.64678353183;35824.28351433009;35949.1012724684;36169;34092.829535853154;34364.65635343615;34808;35054.12364690903;35168.64831351654;30460.238494037825;32166.83916580496;32217.677823222406;32418.513722294658;32448.351032978735;24068.759312407354;24434.633480498163;24472.755272447048;24658.753412465645;24743.38141546404 23:12:53 INFO - PROCESS | 28959 | |2;jquery.html;359.08791669160337;359.5020896058958;360.03869667986487;360.65197084813155;365.0891026887915;14112.082714623542;14347.856521434782;16191.433299834509;16409.917950410247;17034.233459494306;14126.717465650681;14737.336819843105;14747;15072.623184420396;15163.317650705718;5209.583233341333;5321.095413779667;5334.413214546396;5335.546478549328;5341.172118321647;4084.81618327176;4200.768957707325;5270.209468579725;5305.753148010214;5776.653400795944;5826.854328641797;5836.824895253149;5857.619254748449;5907.0548712206055;5918.2898052233795;5701.828945131652;5841.211436456109;5842.298924129111;5852.882942341172;5859.326177489601;5128.71792051437;5151.407588127338;5154.9484505155215;5164.715940623264;5166.586673066184;14844.183569903651;16158.434454794144;18336.174872130785;20177.798222017886;20198.697019544717;2132.584146091497;2174.7390313162364;2210.2043264424956;2241.3330817584965;2532.987335063331;12788.296643684595;12941.935290323489;13029.934850325688;13215.933920330337;13250.138740981902;1783;1810.8641851861164;1829.3962992212537;1832.129738374275;1854.5085552328644;58602.413975860545;60370;63507.36492635061;64087.359126408606;64346.67826660837;9516.857247141299;9710.563024663767;9980.700578982642;9996.150327222267;10042.497875106215;13125.374925015036;13173.275469849059;13177;13212.801807972888;13216.140950838164;7269.7455589054125;7278.781636550912;7295.088113985752;7340.743073992385;7472.551646901204;6958.443324534025;6982.720691172398;6984.5110842241575;7058.964705176544;7065.682044308019;5850.882982340329;5852.882942341129;5931.762729490858;5960.523158147338;5986.311574168939;1652.5290292266886;1713.6230029393514;1731.9480415587552;1734.1849330814498;1794.0222578694643;895.9776005599782;940.1538615246196;969.743018100204;1035.4563853976572;1049.2602715085845;15533.922330388501;16695.16834269808;16999.40502082446;17267.74098388525;17882.731759023623;978.7455261632027;1008.7390761548065;1020.0564477857952;1039.9168066554657;1041.770810421721;9466.90533094674;9599.520023998772;9633.662821801343;9669.90330096704;9686.418814871131;359776;366488;514037;519009;519733;75594;79768;79817;83377;84688.57655711682;1068.7755571329951;1088.9618863339745;1095.4084794211037;1108.8503052088026;1123.3709122891044;15203;15394.307256173723;15538;15617.843821562094;15928.123953182687;33602;34109.317813643094;34543.481847772804;35251.294974100885;35465;45464;45475.54524454713;46823.063538729715;46989.2951605733;49037.754811225714;8969.596368163579;9313.720588382359;9376.671816486663;9380.765480863032;9498.95250523743;11276.830847537458;11282;11512.94243528777;11514;11525.250858694493;13757.724845503235;14041.297935102999;14100.717985640025;14325.856741432452;14350.928245359124;13467.3939672713;13653.726925461237;14074.296285185495;14136.646583835487;14196.148231106166;14369.712605747618;14573.344199510835;14884.255787210812;14936;15152.469663561722;9544.665936692183;9589.712308630753;9604.135627793532;9894.653687120915;9918.40489570628;14538.781918271447;14663.853361466676;14789.482368117064;14804.7779283313;14833.629159271104 23:12:53 INFO - PROCESS | 28959 | |3;mootools.html;1209.6431552691954;1380.3098450774612;1393.3312010235086;1492.5000124958137;1699.838515341043;6660.50046246531;7157.8926316105235;7240.420766338693;7243.311885370895;7249.130104387467;6969.094017777682;7161.2122666506775;7164.391026762732;7169.7849064528145;7174.497785155041;1908.6946088625823;1958.7453631027947;1958.7943265957012;2093.3301343570024;2126.914923403062;1996.2713609532561;2166.306781829815;2191.0359441845535;2200.449887528118;2202.042111681416;2141.3575927221773;2163.0374483354913;2169.717936668231;2171.0447403142643;2214.8671079735186;2200.7909248621354;2222.2333295013113;2224.5773303072365;2225.4658881868318;2227.432004838772;2117.2907076129513;2158.3632828315526;2177.205320058167;2179.531400748831;2181.1275489804207;7302.671379787922;7359.043324367798;7382.520136191184;7383.630818459055;7390.704371825121;4348.434703488558;4418.381426600278;4425.889352766175;4429.357743127229;4433.800478978422;2917.0519581136004;2935.8238505689515;3010.834404107773;3047.7104675055834;3048.8170709757487;889.364104665161;928.5032507608464;942.2838642631581;944.8818897637796;944.900785417535;9910.058544438267;9921.40471571708;9936.354136981074;9942.701718948443;9949.502524873727;3952.130531283113;4007.0984028593916;4044.130511939947;4056.1684854604737;4101.815418306183;8556.700515481929;8564.3148548116;8577;8578.78553036179;8595.269402100766;4320.978395108004;4372.125574885035;4372.540883207281;4372.693911426233;4378.2119218540965;3974.3442332014893;3974.5230572331507;3980.0447892506168;3980.960190398117;3984.322665146874;3233.870645174167;3447.1382154461385;3491;3507.631698671654;3519.771214871025;1045.3884477580548;1066.5840322274319;1069.224812011301;1070.175964507325;1102.8897110289067;908.0646933658343;909.490685216281;969.6170012845027;987.76293689514;1266.2465832829453;6830.487713421513;6915.757948471779;6916.965415172892;6935.3411425914455;6960.269171736894;1073.8765042020111;1081.5187241677536;1093.3767752381225;1097.7475180708482;1110.1729211737145;5009.89980200394;5044.218146187347;5151.098557752378;5179.300794392784;5224.477552244821;8208.83582328362;8434.62044208012;8453.619587118594;8545.74362769118;8549.145085491526;8216.178382161735;8333.958330208432;8408.033076196194;8431.072582015973;8432.241098301183;6797.72809087631;6807.217170025411;6821.317868213238;6858.5199036067;6900.2064762551945;6503.6097834130105;6519.3480651936325;6581.308962558863;6588.275289718223;6591.934080659132;7526.24737526243;7802.219778022152;7868.134505204309;7869.567173805495;7871.921280787348;7859.685612575661;7870.252326029018;7975.082865470546;7976.16250293734;7982.760517184493;6311;6393.808185754435;6418.711157997995;6432.935670643421;6473.385028422293;6768.695408706521;6809.727610895508;6835.965820170867;6838;6839.316068393121;5859.648421094748;6377.553571249968;6479.935200647933;6570.047343135123;6607.80176594703;6285.120083188449;6423.775167869289;6442.194725659293;6538.378854008862;6553.574017688835;6463.450606698295;6474.5791523550815;6485.383888530582;6543.411093001462;6582.539222254396;6057.727402266821;6097;6100.603460775035;6102.816915492543;6106.877862442815;6074.51403887679;6117.449429551184;6132.264128304453;6179.1040299155475;6215.160953271251 23:12:53 INFO - PROCESS | 28959 | |4;prototype.html;335.8203361201757;342.2743783179658;348.79595436669547;349.45833957366074;351.1589742566555;5750.9999999999945;5758.596898217122;5780.450857168567;5841.474267315952;5844.503217226541;5503.972480137603;5543.223948647193;5644.689542075184;5727.198192253078;5747.2528571285775;4443.400140980959;4464.821407143719;4471.28459446487;4478.03722199727;4481.058977614704;4272.914541709164;4453.465584129909;4462.397576327203;4476.9776151119195;4478.552144785528;4304.418903448041;4310.590493903074;4372.366006928994;4387.166438376714;4388.956110438887;4373.1909596724545;4385.210662080856;4386.2324093283705;4388.561143885618;4397.956020439787;3879.2047630235734;3884.2231553689094;3926.8821935341984;3927.0771368728324;3944.1717239379764;5481.068218402881;5508.586855985817;5513.255710479114;5520.530754885839;5542.196381524656;4997.700137991696;5128.9230661540105;5151.278820965068;5154.355705536808;5161.638685292031;6084.391560843925;6094.847628809315;6095;6096.207493025879;6101.359357267512;4291.506476755182;4295.183915056129;4295.2912769393015;4297;4298.656107511391;6167.321594624633;6294.055891616248;6370.1718776558755;6385.48916086712;6403.423691867754;4367.5632436756705;4385.342198670225;4389.31965545341;4390.780460976938;4390.934135987899;4447.799849006802;4448.332750087513;4452.510223875371;4459.866204013885;4470.463544374696;5136.460671629425;5139.511746384088;5143.537081662668;5149.382074151126;5153.252778347119;5984.281886173687;6132.233470816148;6135.846603834851;6151.677389361309;6154.476869466056;1559.0723519505875;1579.2103948025988;1582.1061100478194;1583.754518049704;1584.952451426459;1038.5638032026568;1057.0222544146786;1064.1274155192823;1066.248294952057;1078.4931082391263;5903.291605007426;5913.645181289136;5918.260217472816;5921.141434491975;5931.970340148272;6346.27017892939;6352.2694890087305;6352.936470635234;6357.078223657544;6358.109864618957;5789.3052833659385;5833.329167145747;5873.089671100986;5875.559333050039;5936.347001829795;3408.062782734718;3417.572803399575;3420.504026916083;3429;3442.0534353053113;6591.703373348211;6592.30780768022;6605.603663780189;6614.801555953329;6614.900776488356;6278.246610406781;6486.091947127406;6497.577657452251;6501.577397469149;6510;6589.9341006590275;6604.240512341046;6604.405603495612;6608.900866486911;6613.272540020594;6349.396807303484;6369.9681501592195;6372.840678982877;6375.234971803413;6376.043593461018;6077.544184186116;6254.249490061222;6306.337834527309;6309.3690630936535;6313.3686631336495;6600.669966501751;6604.273529911802;6604.3725846044545;6613.933860661525;6615.239247486408;4405.383246345578;4443.355713421601;4444.82220711168;4449.021215332622;4450.109978004347;6231.688415579112;6390.169277993831;6404.1674582304;6410.326915673973;6417.422431981144;6233.283172435228;6238.001919693009;6244.843878903063;6245.313015568193;6247.375262473716;6228.501719862491;6232.283287421823;6233.2208473940755;6233.812985610439;6238.563300568917;5975.790847320323;6112.541559383153;6124.448799608057;6127.509799215963;6131.202943617302;6247.031710084944;6249;6253.874922501615;6270.0908368287255;6275.309715931336;6115.388461153849;6121.755129794758;6124.38756124384;6131.141640170469;6132.141500190066 23:12:53 INFO - PROCESS | 28959 | |5;yui.html;733.7028503456102;743.9256074392558;747.0848210941593;760.3271105072013;760.3954855889567;12999.220046797198;13192.934035329834;13207.537736179213;13227.140235884674;13258.535951241709;11910.106741994341;12034.69913252167;12054.276743395381;12054.517819287217;12055.33695646739;640.57081755224;653.879032379009;786.1077676836803;799.5522507395848;801.390942883407;787.9921200787976;791.1297572670046;792.1088775127981;793.972210972616;796.9322607578334;685.0067402266708;694.4166899804163;820.7783898347443;828.3911325175991;828.6850996621275;818.9918100819004;822;824.1017291152673;830.5598033042497;833.291702053253;608.5770389579244;617.4042049422329;617.728199592178;617.9258488981351;618.1963447518208;10645.361278323326;10701.83947240792;10736.194785391126;10745.355278683304;10748.462576871125;11414.143939204592;11741.354225517593;11746.471408786625;11850.585229517012;11929.164958452911;9442.858357124649;9511.857322140173;9558.330916835825;9563.907681448325;9661.90338096617;3524.2775231077826;3576.928461430783;3577.9821100894587;3579.8210089495683;3584.301061293049;44340.55659443397;44519.777401112784;44797;45283.565972083234;45785.08429831418;8518.148185181431;8615.61229744663;8669.523176225242;8825.374070423752;8828.51443170619;17984.550386240448;18002.819971800116;18005.369812056517;18007.36974205923;18025.098745062693;6913.3777959983845;7123.287671232835;7253.782386528413;7387.187409384964;7514.286142816533;4266.807993640294;4318.52496225415;4376.767848397277;4406.581374769392;4430.446194225722;2507;2513.5349960257413;2515.710693270261;2548.350170706495;2548.98725506375;508.4534125814764;513.2147813844823;525.4823998361687;527.5542166868989;531.8510816971254;505.2169137836339;556.3907521264209;597.2862429396915;615.5998600909355;648.8126728087589;8360;8388.203120703523;8492.235698787015;8513.489190648581;8829.293656507463;511.3250509327726;513.4147072337464;514.9407818100966;534.0760484362075;626.2797782550103;3690.409534474471;3893.162969961472;4007.358822588372;4087.693422993287;4243.427137336482;51608.74195629073;53136.73431632817;54124.45875541194;54187.72906135444;54210.72894635502;46836.297455538195;47135.764321178176;47212.5278747215;47279.27207279313;47400.28899566509;41778;43588.12823743507;43625.345619815096;44024.11951760947;44316.778416107714;8013.959930200312;8125.268725814469;8188.5905704715715;8223.54770487629;8301.750947471586;32317.192070197492;32393.35213295768;32736.34527309488;33138.5029224557;33409.49885751667;38346;38730.61269387383;41685.374719378626;43157.784211078746;43818.56181438272;9072.002079771351;9384.3900146493;9590.520473976412;9871;9920.305578609428;10415.270931034755;10873.401962891801;10906.072983796466;11019.44902754843;11051.834222486508;11150.776984460428;11346.149038821955;11454.885451145716;11648.708782280512;11820.586279480176;11234.943825280821;11326.37704926237;11332.093432525544;11787.292762434281;11830.171887968105;11010.39442830652;11454.370009649549;11487.827682584935;11497.655070347902;11504.769904602028;9274.44353338802;9360;9453.243740500606;10101.393916365041;10150.695479135638;8690.956545217234;8958.596863141305;9108.499032553273;9470.289728270269;9517.238620910171 23:12:53 INFO - PROCESS | 28959 | __end_tp_report 23:12:53 INFO - PROCESS | 28959 | __start_cc_report 23:12:53 INFO - PROCESS | 28959 | _x_x_mozilla_cycle_collect,1007 23:12:53 INFO - PROCESS | 28959 | __end_cc_report 23:12:53 INFO - PROCESS | 28959 | __startTimestamp1452064373700__endTimestamp 23:12:53 INFO - PROCESS | 28959 | 23:12:53 INFO - PROCESS | 28959 | ------- Summary: start ------- 23:12:53 INFO - PROCESS | 28959 | Number of tests: 6 23:12:53 INFO - PROCESS | 28959 | 23:12:53 INFO - PROCESS | 28959 | [#0] dojo.html Cycles:165 Average:5202.90 Median:5404.78 stddev:573.59 (10.6%) stddev-sans-first:550.11 23:12:53 INFO - PROCESS | 28959 | Values: 3057.6 3096.7 3111.4 3148.2 3183.3 5113.3 5176.7 5201.1 5238.3 5273.1 5118.3 5122.7 5195.5 5203.8 5261.6 4695.2 4718.1 4751.0 4854.0 4869.7 4736.1 4803.3 4844.6 4850.1 4866.8 4632.3 4672.7 4750.3 4786.4 4796.1 4733.9 4760.1 4768.5 4776.7 4803.4 4625.7 4715.2 4725.9 4753.8 4775.8 5016.9 5031.2 5086.1 5089.5 5111.9 5609.4 5623.4 5623.4 5632.1 5635.3 5490.9 5631.8 5662.0 5670.1 5676.6 5214.4 5229.8 5308.9 5312.7 5326.4 5734.8 5748.6 5752.1 5763.4 5764.5 5442.2 5501.9 5515.3 5516.5 5553.4 5552.6 5578.4 5628.5 5639.5 5683.5 5513.3 5547.2 5568.1 5570.4 5572.9 5453.5 5564.7 5575.4 5579.8 5580.9 4345.4 4393.0 4398.0 4431.8 4440.5 3842.2 3855.6 3863.9 3867.9 3907.1 5143.3 5261.3 5266.4 5275.6 5292.6 5571.8 5647.6 5667.5 5681.1 5702.1 5229.9 5236.2 5253.9 5272.4 5274.9 4705.0 4832.4 4832.9 4837.7 4862.3 5677.4 5726.9 5759.4 5759.7 5806.4 5619.5 5629.7 5636.8 5640.8 5645.9 5667.7 5813.9 5825.5 5826.4 5832.2 5468.3 5487.8 5537.9 5543.6 5546.0 5606.2 5635.7 5652.8 5662.3 5665.5 5398.9 5515.1 5521.6 5521.8 5529.3 5408.5 5471.2 5501.1 5501.6 5536.4 5397.6 5404.8 5409.3 5413.9 5415.6 5324.4 5430.2 5488.9 5515.9 5560.6 5272.1 5396.2 5399.4 5401.1 5425.5 23:12:53 INFO - PROCESS | 28959 | 23:12:53 INFO - PROCESS | 28959 | [#1] ext.html Cycles:180 Average:45258.47 Median:19150.27 stddev:80093.02 (418.2%) stddev-sans-first:80247.29 23:12:53 INFO - PROCESS | 28959 | Values: 529.2 531.9 535.5 552.4 556.0 27351.0 28296.9 34675.5 35248.5 35412.3 37682.2 37976.8 38040.0 38069.2 38070.4 7466.9 8230.6 8391.7 8392.1 8395.7 7684.1 7765.6 9891.2 10091.7 10096.9 9651.3 9789.9 9795.8 9802.2 9806.3 7653.6 7841.0 9714.8 9732.8 9851.5 9852.3 10145.8 10151.6 10152.2 10154.1 34280.3 34641.0 34650.8 34659.7 34724.5 3176.7 3205.0 3216.8 3263.8 3492.5 28920.1 29132.3 29261.7 29430.0 29781.9 3917.1 3923.6 3925.0 3942.8 3958.8 208074.0 210228.0 210499.0 210647.0 210817.9 51430.2 52090.0 53445.0 58446.4 60360.7 54498.0 54536.7 54889.0 54913.0 54955.2 14195.9 14358.8 14367.1 14373.6 14378.1 10841.5 10921.7 10932.4 10934.5 10934.9 19217.6 19434.4 19510.7 19596.5 19617.4 7494.8 7600.7 7723.1 7731.9 7806.6 878.5 906.1 915.6 924.4 939.6 24852.6 25102.9 25385.6 26630.2 26668.2 1009.7 1019.2 1038.2 1039.1 1122.4 14122.7 14131.9 14231.7 14366.1 14367.2 391092.0 393241.0 398670.0 398945.0 400318.0 50633.5 51083.5 51133.5 51207.2 51272.0 1302.0 1308.2 1311.2 1319.1 1321.2 25997.5 26604.0 26930.7 27040.0 27142.0 41400.4 41885.8 41963.8 41975.6 41986.8 269820.0 272766.0 272885.0 279346.0 286613.0 29621.7 29843.4 29844.7 30246.5 30258.4 39959.6 40660.8 41217.6 41676.8 42274.2 35055.1 35406.5 35501.3 35524.0 36044.5 35045.0 35321.6 35824.3 35949.1 36169.0 34092.8 34364.7 34808.0 35054.1 35168.6 30460.2 32166.8 32217.7 32418.5 32448.4 24068.8 24434.6 24472.8 24658.8 24743.4 23:12:53 INFO - PROCESS | 28959 | 23:12:53 INFO - PROCESS | 28959 | [#2] jquery.html Cycles:180 Average:26416.36 Median:35358.15 stddev:75752.50 (214.2%) stddev-sans-first:75939.74 23:12:53 INFO - PROCESS | 28959 | Values: 359.1 359.5 360.0 360.7 365.1 14112.1 14347.9 16191.4 16409.9 17034.2 14126.7 14737.3 14747.0 15072.6 15163.3 5209.6 5321.1 5334.4 5335.5 5341.2 4084.8 4200.8 5270.2 5305.8 5776.7 5826.9 5836.8 5857.6 5907.1 5918.3 5701.8 5841.2 5842.3 5852.9 5859.3 5128.7 5151.4 5154.9 5164.7 5166.6 14844.2 16158.4 18336.2 20177.8 20198.7 2132.6 2174.7 2210.2 2241.3 2533.0 12788.3 12941.9 13029.9 13215.9 13250.1 1783.0 1810.9 1829.4 1832.1 1854.5 58602.4 60370.0 63507.4 64087.4 64346.7 9516.9 9710.6 9980.7 9996.2 10042.5 13125.4 13173.3 13177.0 13212.8 13216.1 7269.7 7278.8 7295.1 7340.7 7472.6 6958.4 6982.7 6984.5 7059.0 7065.7 5850.9 5852.9 5931.8 5960.5 5986.3 1652.5 1713.6 1731.9 1734.2 1794.0 896.0 940.2 969.7 1035.5 1049.3 15533.9 16695.2 16999.4 17267.7 17882.7 978.7 1008.7 1020.1 1039.9 1041.8 9466.9 9599.5 9633.7 9669.9 9686.4 359776.0 366488.0 514037.0 519009.0 519733.0 75594.0 79768.0 79817.0 83377.0 84688.6 1068.8 1089.0 1095.4 1108.9 1123.4 15203.0 15394.3 15538.0 15617.8 15928.1 33602.0 34109.3 34543.5 35251.3 35465.0 45464.0 45475.5 46823.1 46989.3 49037.8 8969.6 9313.7 9376.7 9380.8 9499.0 11276.8 11282.0 11512.9 11514.0 11525.3 13757.7 14041.3 14100.7 14325.9 14350.9 13467.4 13653.7 14074.3 14136.6 14196.1 14369.7 14573.3 14884.3 14936.0 15152.5 9544.7 9589.7 9604.1 9894.7 9918.4 14538.8 14663.9 14789.5 14804.8 14833.6 23:12:53 INFO - PROCESS | 28959 | 23:12:53 INFO - PROCESS | 28959 | [#3] mootools.html Cycles:180 Average:5064.60 Median:6406.26 stddev:2593.53 (40.5%) stddev-sans-first:2584.61 23:12:53 INFO - PROCESS | 28959 | Values: 1209.6 1380.3 1393.3 1492.5 1699.8 6660.5 7157.9 7240.4 7243.3 7249.1 6969.1 7161.2 7164.4 7169.8 7174.5 1908.7 1958.7 1958.8 2093.3 2126.9 1996.3 2166.3 2191.0 2200.4 2202.0 2141.4 2163.0 2169.7 2171.0 2214.9 2200.8 2222.2 2224.6 2225.5 2227.4 2117.3 2158.4 2177.2 2179.5 2181.1 7302.7 7359.0 7382.5 7383.6 7390.7 4348.4 4418.4 4425.9 4429.4 4433.8 2917.1 2935.8 3010.8 3047.7 3048.8 889.4 928.5 942.3 944.9 944.9 9910.1 9921.4 9936.4 9942.7 9949.5 3952.1 4007.1 4044.1 4056.2 4101.8 8556.7 8564.3 8577.0 8578.8 8595.3 4321.0 4372.1 4372.5 4372.7 4378.2 3974.3 3974.5 3980.0 3981.0 3984.3 3233.9 3447.1 3491.0 3507.6 3519.8 1045.4 1066.6 1069.2 1070.2 1102.9 908.1 909.5 969.6 987.8 1266.2 6830.5 6915.8 6917.0 6935.3 6960.3 1073.9 1081.5 1093.4 1097.7 1110.2 5009.9 5044.2 5151.1 5179.3 5224.5 8208.8 8434.6 8453.6 8545.7 8549.1 8216.2 8334.0 8408.0 8431.1 8432.2 6797.7 6807.2 6821.3 6858.5 6900.2 6503.6 6519.3 6581.3 6588.3 6591.9 7526.2 7802.2 7868.1 7869.6 7871.9 7859.7 7870.3 7975.1 7976.2 7982.8 6311.0 6393.8 6418.7 6432.9 6473.4 6768.7 6809.7 6836.0 6838.0 6839.3 5859.6 6377.6 6479.9 6570.0 6607.8 6285.1 6423.8 6442.2 6538.4 6553.6 6463.5 6474.6 6485.4 6543.4 6582.5 6057.7 6097.0 6100.6 6102.8 6106.9 6074.5 6117.4 6132.3 6179.1 6215.2 23:12:53 INFO - PROCESS | 28959 | 23:12:53 INFO - PROCESS | 28959 | [#4] prototype.html Cycles:180 Average:5155.92 Median:5842.99 stddev:1548.59 (26.5%) stddev-sans-first:1510.08 23:12:53 INFO - PROCESS | 28959 | Values: 335.8 342.3 348.8 349.5 351.2 5751.0 5758.6 5780.5 5841.5 5844.5 5504.0 5543.2 5644.7 5727.2 5747.3 4443.4 4464.8 4471.3 4478.0 4481.1 4272.9 4453.5 4462.4 4477.0 4478.6 4304.4 4310.6 4372.4 4387.2 4389.0 4373.2 4385.2 4386.2 4388.6 4398.0 3879.2 3884.2 3926.9 3927.1 3944.2 5481.1 5508.6 5513.3 5520.5 5542.2 4997.7 5128.9 5151.3 5154.4 5161.6 6084.4 6094.8 6095.0 6096.2 6101.4 4291.5 4295.2 4295.3 4297.0 4298.7 6167.3 6294.1 6370.2 6385.5 6403.4 4367.6 4385.3 4389.3 4390.8 4390.9 4447.8 4448.3 4452.5 4459.9 4470.5 5136.5 5139.5 5143.5 5149.4 5153.3 5984.3 6132.2 6135.8 6151.7 6154.5 1559.1 1579.2 1582.1 1583.8 1585.0 1038.6 1057.0 1064.1 1066.2 1078.5 5903.3 5913.6 5918.3 5921.1 5932.0 6346.3 6352.3 6352.9 6357.1 6358.1 5789.3 5833.3 5873.1 5875.6 5936.3 3408.1 3417.6 3420.5 3429.0 3442.1 6591.7 6592.3 6605.6 6614.8 6614.9 6278.2 6486.1 6497.6 6501.6 6510.0 6589.9 6604.2 6604.4 6608.9 6613.3 6349.4 6370.0 6372.8 6375.2 6376.0 6077.5 6254.2 6306.3 6309.4 6313.4 6600.7 6604.3 6604.4 6613.9 6615.2 4405.4 4443.4 4444.8 4449.0 4450.1 6231.7 6390.2 6404.2 6410.3 6417.4 6233.3 6238.0 6244.8 6245.3 6247.4 6228.5 6232.3 6233.2 6233.8 6238.6 5975.8 6112.5 6124.4 6127.5 6131.2 6247.0 6249.0 6253.9 6270.1 6275.3 6115.4 6121.8 6124.4 6131.1 6132.1 23:12:53 INFO - PROCESS | 28959 | 23:12:53 INFO - PROCESS | 28959 | [#5] yui.html Cycles:180 Average:12916.59 Median:47339.78 stddev:14812.42 (31.3%) stddev-sans-first:14825.72 23:12:53 INFO - PROCESS | 28959 | Values: 733.7 743.9 747.1 760.3 760.4 12999.2 13192.9 13207.5 13227.1 13258.5 11910.1 12034.7 12054.3 12054.5 12055.3 640.6 653.9 786.1 799.6 801.4 788.0 791.1 792.1 794.0 796.9 685.0 694.4 820.8 828.4 828.7 819.0 822.0 824.1 830.6 833.3 608.6 617.4 617.7 617.9 618.2 10645.4 10701.8 10736.2 10745.4 10748.5 11414.1 11741.4 11746.5 11850.6 11929.2 9442.9 9511.9 9558.3 9563.9 9661.9 3524.3 3576.9 3578.0 3579.8 3584.3 44340.6 44519.8 44797.0 45283.6 45785.1 8518.1 8615.6 8669.5 8825.4 8828.5 17984.6 18002.8 18005.4 18007.4 18025.1 6913.4 7123.3 7253.8 7387.2 7514.3 4266.8 4318.5 4376.8 4406.6 4430.4 2507.0 2513.5 2515.7 2548.4 2549.0 508.5 513.2 525.5 527.6 531.9 505.2 556.4 597.3 615.6 648.8 8360.0 8388.2 8492.2 8513.5 8829.3 511.3 513.4 514.9 534.1 626.3 3690.4 3893.2 4007.4 4087.7 4243.4 51608.7 53136.7 54124.5 54187.7 54210.7 46836.3 47135.8 47212.5 47279.3 47400.3 41778.0 43588.1 43625.3 44024.1 44316.8 8014.0 8125.3 8188.6 8223.5 8301.8 32317.2 32393.4 32736.3 33138.5 33409.5 38346.0 38730.6 41685.4 43157.8 43818.6 9072.0 9384.4 9590.5 9871.0 9920.3 10415.3 10873.4 10906.1 11019.4 11051.8 11150.8 11346.1 11454.9 11648.7 11820.6 11234.9 11326.4 11332.1 11787.3 11830.2 11010.4 11454.4 11487.8 11497.7 11504.8 9274.4 9360.0 9453.2 10101.4 10150.7 8691.0 8958.6 9108.5 9470.3 9517.2 23:12:53 INFO - PROCESS | 28959 | -------- Summary: end -------- 23:12:53 INFO - PROCESS | 28959 | 23:12:54 INFO - TEST-INFO | 28959: exit 0 23:12:54 INFO - TEST-OK | dromaeo_css | took 1112844ms 23:12:54 INFO - TEST-START | kraken 23:12:54 INFO - operating with platform_type : linux_ 23:12:54 INFO - Initialising browser for kraken test... 23:12:54 INFO - TEST-INFO | started process 29150 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8exHmO/profile http://localhost:41914/getInfo.html) 23:12:58 INFO - PROCESS | 29150 | __metrics Screen width/height:1600/1200 23:12:58 INFO - PROCESS | 29150 | colorDepth:24 23:12:58 INFO - PROCESS | 29150 | Browser inner width/height: 1024/697 23:12:58 INFO - PROCESS | 29150 | __metrics 23:12:58 INFO - PROCESS | 29150 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:12:58 INFO - PROCESS | 29150 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:12:59 INFO - TEST-INFO | 29150: exit 0 23:12:59 INFO - Browser initialized. 23:12:59 INFO - Running cycle 1/1 for kraken test... 23:12:59 INFO - TEST-INFO | started process 29234 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8exHmO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:13:11 INFO - PROCESS | 29234 | RSS: Main: 150179840 23:13:11 INFO - PROCESS | 29234 | 23:13:14 INFO - PROCESS | 29234 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41914/tests/kraken/driver.html?testName=audio-beat-detection) 23:13:14 INFO - PROCESS | 29234 | RSS: Main: 183783424 23:13:14 INFO - PROCESS | 29234 | 23:13:17 INFO - PROCESS | 29234 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41914/tests/kraken/driver.html?testName=audio-dft) 23:13:17 INFO - PROCESS | 29234 | RSS: Main: 174747648 23:13:17 INFO - PROCESS | 29234 | 23:13:20 INFO - PROCESS | 29234 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41914/tests/kraken/driver.html?testName=audio-fft) 23:13:21 INFO - PROCESS | 29234 | RSS: Main: 160120832 23:13:21 INFO - PROCESS | 29234 | 23:13:23 INFO - PROCESS | 29234 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41914/tests/kraken/driver.html?testName=audio-oscillator) 23:13:23 INFO - PROCESS | 29234 | RSS: Main: 162123776 23:13:23 INFO - PROCESS | 29234 | 23:13:26 INFO - PROCESS | 29234 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41914/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:13:26 INFO - PROCESS | 29234 | RSS: Main: 164560896 23:13:26 INFO - PROCESS | 29234 | 23:13:29 INFO - PROCESS | 29234 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41914/tests/kraken/driver.html?testName=imaging-darkroom) 23:13:30 INFO - PROCESS | 29234 | RSS: Main: 164827136 23:13:30 INFO - PROCESS | 29234 | 23:13:33 INFO - PROCESS | 29234 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41914/tests/kraken/driver.html?testName=imaging-desaturate) 23:13:34 INFO - PROCESS | 29234 | RSS: Main: 165814272 23:13:34 INFO - PROCESS | 29234 | 23:13:36 INFO - PROCESS | 29234 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41914/tests/kraken/driver.html?testName=json-parse-financial) 23:13:37 INFO - PROCESS | 29234 | RSS: Main: 165797888 23:13:37 INFO - PROCESS | 29234 | 23:13:39 INFO - PROCESS | 29234 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41914/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:13:39 INFO - PROCESS | 29234 | RSS: Main: 174448640 23:13:39 INFO - PROCESS | 29234 | 23:13:41 INFO - PROCESS | 29234 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41914/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:13:42 INFO - PROCESS | 29234 | RSS: Main: 173146112 23:13:42 INFO - PROCESS | 29234 | 23:13:44 INFO - PROCESS | 29234 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41914/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:13:44 INFO - PROCESS | 29234 | RSS: Main: 187203584 23:13:44 INFO - PROCESS | 29234 | 23:13:47 INFO - PROCESS | 29234 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41914/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:13:47 INFO - PROCESS | 29234 | RSS: Main: 192217088 23:13:47 INFO - PROCESS | 29234 | 23:13:50 INFO - PROCESS | 29234 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41914/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:13:50 INFO - PROCESS | 29234 | RSS: Main: 192483328 23:13:50 INFO - PROCESS | 29234 | 23:13:52 INFO - PROCESS | 29234 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41914/tests/kraken/driver.html?testName=ai-astar) 23:13:52 INFO - PROCESS | 29234 | RSS: Main: 249454592 23:13:52 INFO - PROCESS | 29234 | 23:13:52 INFO - PROCESS | 29234 | __start_tp_report 23:13:52 INFO - PROCESS | 29234 | _x_x_mozilla_page_load 23:13:52 INFO - PROCESS | 29234 | _x_x_mozilla_page_load_details 23:13:52 INFO - PROCESS | 29234 | |i|pagename|runs| 23:13:52 INFO - PROCESS | 29234 | |0;ai-astar;109;110;104;111;112;111;102;110;111;109 23:13:52 INFO - PROCESS | 29234 | |1;audio-beat-detection;167;130;154;164;126;151;159;126;176;126 23:13:52 INFO - PROCESS | 29234 | |2;audio-dft;160;161;161;162;161;161;160;162;160;163 23:13:52 INFO - PROCESS | 29234 | |3;audio-fft;74;73;80;95;73;73;71;111;89;71 23:13:52 INFO - PROCESS | 29234 | |4;audio-oscillator;97;97;140;95;96;96;136;96;96;147 23:13:52 INFO - PROCESS | 29234 | |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;109 23:13:52 INFO - PROCESS | 29234 | |6;imaging-darkroom;146;145;145;145;146;144;146;146;145;145 23:13:52 INFO - PROCESS | 29234 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;95 23:13:52 INFO - PROCESS | 29234 | |8;json-parse-financial;58;57;58;58;56;60;57;66;55;55 23:13:52 INFO - PROCESS | 29234 | |9;json-stringify-tinderbox;67;68;68;68;79;68;68;71;69;69 23:13:52 INFO - PROCESS | 29234 | |10;stanford-crypto-aes;86;87;86;85;85;85;85;85;86;92 23:13:52 INFO - PROCESS | 29234 | |11;stanford-crypto-ccm;114;120;120;117;115;124;122;125;123;116 23:13:52 INFO - PROCESS | 29234 | |12;stanford-crypto-pbkdf2;145;144;146;155;156;146;158;163;154;153 23:13:52 INFO - PROCESS | 29234 | |13;stanford-crypto-sha256-iterative;72;72;76;71;72;70;71;71;70;69 23:13:52 INFO - PROCESS | 29234 | __end_tp_report 23:13:52 INFO - PROCESS | 29234 | __start_cc_report 23:13:52 INFO - PROCESS | 29234 | _x_x_mozilla_cycle_collect,942 23:13:52 INFO - PROCESS | 29234 | __end_cc_report 23:13:52 INFO - PROCESS | 29234 | __startTimestamp1452064432836__endTimestamp 23:13:52 INFO - PROCESS | 29234 | 23:13:52 INFO - PROCESS | 29234 | ------- Summary: start ------- 23:13:52 INFO - PROCESS | 29234 | Number of tests: 14 23:13:52 INFO - PROCESS | 29234 | 23:13:52 INFO - PROCESS | 29234 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.50 stddev:3.28 (3.0%) stddev-sans-first:3.48 23:13:52 INFO - PROCESS | 29234 | Values: 109.0 110.0 104.0 111.0 112.0 111.0 102.0 110.0 111.0 109.0 23:13:52 INFO - PROCESS | 29234 | 23:13:52 INFO - PROCESS | 29234 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:156.50 stddev:19.27 (12.3%) stddev-sans-first:19.16 23:13:52 INFO - PROCESS | 29234 | Values: 167.0 130.0 154.0 164.0 126.0 151.0 159.0 126.0 176.0 126.0 23:13:52 INFO - PROCESS | 29234 | 23:13:52 INFO - PROCESS | 29234 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:0.97 23:13:52 INFO - PROCESS | 29234 | Values: 160.0 161.0 161.0 162.0 161.0 161.0 160.0 162.0 160.0 163.0 23:13:52 INFO - PROCESS | 29234 | 23:13:52 INFO - PROCESS | 29234 | [#3] audio-fft Cycles:10 Average:81.00 Median:73.50 stddev:13.34 (18.2%) stddev-sans-first:13.91 23:13:52 INFO - PROCESS | 29234 | Values: 74.0 73.0 80.0 95.0 73.0 73.0 71.0 111.0 89.0 71.0 23:13:52 INFO - PROCESS | 29234 | 23:13:52 INFO - PROCESS | 29234 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:96.00 stddev:21.83 (22.7%) stddev-sans-first:22.68 23:13:52 INFO - PROCESS | 29234 | Values: 97.0 97.0 140.0 95.0 96.0 96.0 136.0 96.0 96.0 147.0 23:13:52 INFO - PROCESS | 29234 | 23:13:52 INFO - PROCESS | 29234 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 23:13:52 INFO - PROCESS | 29234 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 23:13:52 INFO - PROCESS | 29234 | 23:13:52 INFO - PROCESS | 29234 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 23:13:52 INFO - PROCESS | 29234 | Values: 146.0 145.0 145.0 145.0 146.0 144.0 146.0 146.0 145.0 145.0 23:13:52 INFO - PROCESS | 29234 | 23:13:52 INFO - PROCESS | 29234 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 23:13:52 INFO - PROCESS | 29234 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 23:13:52 INFO - PROCESS | 29234 | 23:13:52 INFO - PROCESS | 29234 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.00 stddev:3.20 (5.5%) stddev-sans-first:3.39 23:13:52 INFO - PROCESS | 29234 | Values: 58.0 57.0 58.0 58.0 56.0 60.0 57.0 66.0 55.0 55.0 23:13:52 INFO - PROCESS | 29234 | 23:13:52 INFO - PROCESS | 29234 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:68.50 stddev:3.50 (5.1%) stddev-sans-first:3.60 23:13:52 INFO - PROCESS | 29234 | Values: 67.0 68.0 68.0 68.0 79.0 68.0 68.0 71.0 69.0 69.0 23:13:52 INFO - PROCESS | 29234 | 23:13:52 INFO - PROCESS | 29234 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:86.00 stddev:2.15 (2.5%) stddev-sans-first:2.28 23:13:52 INFO - PROCESS | 29234 | Values: 86.0 87.0 86.0 85.0 85.0 85.0 85.0 85.0 86.0 92.0 23:13:52 INFO - PROCESS | 29234 | 23:13:52 INFO - PROCESS | 29234 | [#11] stanford-crypto-ccm Cycles:10 Average:119.60 Median:121.00 stddev:3.92 (3.2%) stddev-sans-first:3.60 23:13:52 INFO - PROCESS | 29234 | Values: 114.0 120.0 120.0 117.0 115.0 124.0 122.0 125.0 123.0 116.0 23:13:52 INFO - PROCESS | 29234 | 23:13:52 INFO - PROCESS | 29234 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.00 Median:154.50 stddev:6.43 (4.2%) stddev-sans-first:6.30 23:13:52 INFO - PROCESS | 29234 | Values: 145.0 144.0 146.0 155.0 156.0 146.0 158.0 163.0 154.0 153.0 23:13:52 INFO - PROCESS | 29234 | 23:13:52 INFO - PROCESS | 29234 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.50 stddev:1.90 (2.7%) stddev-sans-first:2.00 23:13:52 INFO - PROCESS | 29234 | Values: 72.0 72.0 76.0 71.0 72.0 70.0 71.0 71.0 70.0 69.0 23:13:52 INFO - PROCESS | 29234 | -------- Summary: end -------- 23:13:52 INFO - PROCESS | 29234 | 23:13:53 INFO - TEST-INFO | 29234: exit 0 23:13:53 INFO - TEST-OK | kraken | took 59351ms 23:13:53 INFO - TEST-START | v8_7 23:13:53 INFO - operating with platform_type : linux_ 23:13:53 INFO - Initialising browser for v8_7 test... 23:13:53 INFO - TEST-INFO | started process 29482 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGqR6x1/profile http://localhost:41914/getInfo.html) 23:13:57 INFO - PROCESS | 29482 | __metrics Screen width/height:1600/1200 23:13:57 INFO - PROCESS | 29482 | colorDepth:24 23:13:57 INFO - PROCESS | 29482 | Browser inner width/height: 1024/697 23:13:57 INFO - PROCESS | 29482 | __metrics 23:13:58 INFO - PROCESS | 29482 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:13:58 INFO - PROCESS | 29482 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:13:59 INFO - TEST-INFO | 29482: exit 0 23:13:59 INFO - Browser initialized. 23:13:59 INFO - Running cycle 1/1 for v8_7 test... 23:13:59 INFO - TEST-INFO | started process 29564 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGqR6x1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:14:10 INFO - PROCESS | 29564 | RSS: Main: 149884928 23:14:10 INFO - PROCESS | 29564 | 23:14:32 INFO - PROCESS | 29564 | Cycle 1(1): loaded http://localhost:41914/tests/v8_7/run.html (next: http://localhost:41914/tests/v8_7/run.html) 23:14:32 INFO - PROCESS | 29564 | RSS: Main: 605462528 23:14:32 INFO - PROCESS | 29564 | 23:14:32 INFO - PROCESS | 29564 | __start_tp_report 23:14:32 INFO - PROCESS | 29564 | _x_x_mozilla_page_load 23:14:32 INFO - PROCESS | 29564 | _x_x_mozilla_page_load_details 23:14:32 INFO - PROCESS | 29564 | |i|pagename|runs| 23:14:32 INFO - PROCESS | 29564 | |0;Richards;167.7289500167729 23:14:32 INFO - PROCESS | 29564 | |1;DeltaBlue;190.5487804878049 23:14:32 INFO - PROCESS | 29564 | |2;Encrypt;279.79854504756577 23:14:32 INFO - PROCESS | 29564 | |3;Decrypt;5175.257731958763 23:14:32 INFO - PROCESS | 29564 | |4;RayTrace;2016.1290322580646 23:14:32 INFO - PROCESS | 29564 | |5;Earley;793.0214115781126 23:14:32 INFO - PROCESS | 29564 | |6;Boyer;12395.061728395061 23:14:32 INFO - PROCESS | 29564 | |7;RegExp;25525 23:14:32 INFO - PROCESS | 29564 | |8;Splay;669.5652173913044 23:14:32 INFO - PROCESS | 29564 | |9;NavierStokes;4854.368932038835 23:14:32 INFO - PROCESS | 29564 | __end_tp_report 23:14:32 INFO - PROCESS | 29564 | __startTimestamp1452064472663__endTimestamp 23:14:32 INFO - PROCESS | 29564 | 23:14:32 INFO - PROCESS | 29564 | ------- Summary: start ------- 23:14:32 INFO - PROCESS | 29564 | Number of tests: 10 23:14:32 INFO - PROCESS | 29564 | 23:14:32 INFO - PROCESS | 29564 | [#0] Richards Cycles:1 Average:167.73 Median:167.73 stddev:0.00 (0.0%) 23:14:32 INFO - PROCESS | 29564 | Values: 167.7 23:14:32 INFO - PROCESS | 29564 | 23:14:32 INFO - PROCESS | 29564 | [#1] DeltaBlue Cycles:1 Average:190.55 Median:190.55 stddev:0.00 (0.0%) 23:14:32 INFO - PROCESS | 29564 | Values: 190.5 23:14:32 INFO - PROCESS | 29564 | 23:14:32 INFO - PROCESS | 29564 | [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 23:14:32 INFO - PROCESS | 29564 | Values: 279.8 23:14:32 INFO - PROCESS | 29564 | 23:14:32 INFO - PROCESS | 29564 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 23:14:32 INFO - PROCESS | 29564 | Values: 5175.3 23:14:32 INFO - PROCESS | 29564 | 23:14:32 INFO - PROCESS | 29564 | [#4] RayTrace Cycles:1 Average:2016.13 Median:2016.13 stddev:0.00 (0.0%) 23:14:32 INFO - PROCESS | 29564 | Values: 2016.1 23:14:32 INFO - PROCESS | 29564 | 23:14:32 INFO - PROCESS | 29564 | [#5] Earley Cycles:1 Average:793.02 Median:793.02 stddev:0.00 (0.0%) 23:14:32 INFO - PROCESS | 29564 | Values: 793.0 23:14:32 INFO - PROCESS | 29564 | 23:14:32 INFO - PROCESS | 29564 | [#6] Boyer Cycles:1 Average:12395.06 Median:12395.06 stddev:0.00 (0.0%) 23:14:32 INFO - PROCESS | 29564 | Values: 12395.1 23:14:32 INFO - PROCESS | 29564 | 23:14:32 INFO - PROCESS | 29564 | [#7] RegExp Cycles:1 Average:25525.00 Median:25525.00 stddev:0.00 (0.0%) 23:14:32 INFO - PROCESS | 29564 | Values: 25525.0 23:14:32 INFO - PROCESS | 29564 | 23:14:32 INFO - PROCESS | 29564 | [#8] Splay Cycles:1 Average:669.57 Median:669.57 stddev:0.00 (0.0%) 23:14:32 INFO - PROCESS | 29564 | Values: 669.6 23:14:32 INFO - PROCESS | 29564 | 23:14:32 INFO - PROCESS | 29564 | [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 23:14:32 INFO - PROCESS | 29564 | Values: 4854.4 23:14:32 INFO - PROCESS | 29564 | -------- Summary: end -------- 23:14:32 INFO - PROCESS | 29564 | 23:14:33 INFO - TEST-INFO | 29564: exit 0 23:14:33 INFO - TEST-OK | v8_7 | took 39800ms 23:14:33 INFO - SUITE-END | took 1211s 23:14:33 INFO - Completed test suite (00:20:12) 23:14:33 INFO - Working with test: dromaeo_css 23:14:33 INFO - Generating results file: dromaeo_css 23:14:33 INFO - Working with test: kraken 23:14:33 INFO - Generating results file: kraken 23:14:33 INFO - javascript benchmark 23:14:33 INFO - Working with test: v8_7 23:14:33 INFO - Generating results file: v8_7 23:14:33 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:14:33 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 23:14:33 INFO - process_Request line: dromaeo_css 6735.70 graph.html#tests=[[72,201,35]] 23:14:33 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:14:33 INFO - process_Request line: kraken 1514.60 graph.html#tests=[[232,201,35]] 23:14:33 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:14:33 INFO - process_Request line: v8_7 19555.19 graph.html#tests=[[230,201,35]] 23:14:33 INFO - RETURN: dromaeo_css: 6735.70 23:14:33 INFO - RETURN: kraken: 1514.60 23:14:33 INFO - RETURN: v8_7: 19555.19 23:14:33 INFO - javascript benchmark 23:14:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3057.5566542851284, 3096.6903309669037, 3111.4088323218602, 3148.2286839724256, 3183.251935795088, 5113.284140220363, 5176.663516871401, 5201.0898092833695, 5238.266642670024, 5273.129933560967, 5118.283440318359, 5122.6926384416965, 5195.454477279888, 5203.817866374678, 5261.552768014723, 4695.17834378984, 4718.127146477913, 4750.97624511877, 4853.951460485385, 4869.70781753096, 4736.052789442108, 4803.2795080738, 4844.636652251078, 4850.054239423313, 4866.805327786884, 4632.3051542268595, 4672.696274742131, 4750.311204875291, 4786.353842231289, 4796.136695394827, 4733.905321893577, 4760.143174228638, 4768.47546769855, 4776.689515181502, 4803.3995750531185, 4625.676202665814, 4715.245560710304, 4725.929111063337, 4753.762311884392, 4775.832845850378, 5016.874578135576, 5031.22016087507, 5086.1353569892835, 5089.491050894881, 5111.872203194913, 5609.382967873531, 5623.381428042912, 5623.409541998072, 5632.127020311858, 5635.295588051494, 5490.945090549083, 5631.831045068655, 5662.0, 5670.092785154356, 5676.631018983753, 5214.400343960455, 5229.764660590245, 5308.92036619451, 5312.73436328182, 5326.387465441485, 5734.77060917567, 5748.5688573357165, 5752.108423194411, 5763.423657634203, 5764.481196692318, 5442.156465747816, 5501.9174712379345, 5515.338159420895, 5516.531094856902, 5553.444655534414, 5552.555795536347, 5578.358488773762, 5628.521575666033, 5639.548836093103, 5683.460071293221, 5513.255710479034, 5547.223388725582, 5568.081266591048, 5570.387257401682, 5572.944270557324, 5453.481919217668, 5564.66612003273, 5575.358833734173, 5579.776808927598, 5580.9441905580425, 4345.413369195181, 4393.0335326228815, 4397.9560204398185, 4431.800568974404, 4440.4671439427475, 3842.193139440693, 3855.575886652466, 3863.9227215455535, 3867.903302417406, 3907.1404291055924, 5143.27994080829, 5261.263423120766, 5266.368035835724, 5275.63070585063, 5292.603054770908, 5571.832845014656, 5647.576431767634, 5667.4615911488345, 5681.062624666966, 5702.059160238514, 5229.921551176735, 5236.188390799432, 5253.947460525423, 5272.420033796279, 5274.894502109936, 4704.9529504704515, 4832.420109586872, 4832.855014349575, 4837.661363704507, 4862.319275301461, 5677.432256774372, 5726.856828579319, 5759.366469688331, 5759.65442073477, 5806.44838740319, 5619.522340601095, 5629.6903670298525, 5636.802711905064, 5640.774369025193, 5645.887082258414, 5667.688277144632, 5813.94186058134, 5825.50483208932, 5826.359100499027, 5832.24180856486, 5468.28912241406, 5487.835364939058, 5537.861553461195, 5543.584231182596, 5546.0, 5606.187102870143, 5635.661860288232, 5652.7738890443925, 5662.292213473316, 5665.461781130786, 5398.892022159614, 5515.062439385234, 5521.585881058856, 5521.751521181476, 5529.30883639545, 5408.45915408456, 5471.179323101566, 5501.119820828808, 5501.642393244426, 5536.446355364431, 5397.59518036141, 5404.78472721469, 5409.296791417248, 5413.891722165614, 5415.5938304626525, 5324.414314425333, 5430.15832545956, 5488.945110548843, 5515.944840551543, 5560.6107572471155, 5272.077386457431, 5396.21754845553, 5399.352077750695, 5401.081816091352, 5425.538829199562], "unit": "score", "name": "dojo.html", "value": 5165.847407810838}, {"lowerIsBetter": false, "replicates": [529.2458246998028, 531.9148936170213, 535.5073332534071, 552.417199854154, 556.0, 27351.0, 28296.85851570742, 34675.47986780197, 35248.47127293086, 35412.2917541649, 37682.24635507288, 37976.81011594945, 38040.0, 38069.23861522775, 38070.42894356587, 7466.850662986737, 8230.629621667025, 8391.748247552583, 8392.076871544125, 8395.748127556182, 7684.07791065073, 7765.611719414035, 9891.208703303719, 10091.747706307364, 10096.949515252414, 9651.324407291493, 9789.902100979007, 9795.755106122368, 9802.2158227342, 9806.264530160266, 7653.579053152074, 7840.960795195988, 9714.805703885953, 9732.756681082994, 9851.458169800659, 9852.261080418997, 10145.797084058351, 10151.593936242542, 10152.187824974058, 10154.08613224806, 34280.31439371199, 34641.0, 34650.82674586636, 34659.6534034659, 34724.47913281303, 3176.745860331168, 3205.0, 3216.823074730889, 3263.7715359924814, 3492.545969024036, 28920.13239602815, 29132.27169320763, 29261.70738292611, 29430.0, 29781.851090744407, 3917.1186483041374, 3923.6272554107313, 3925.038365600418, 3942.7831469269177, 3958.8218530166214, 208074.0, 210228.0, 210499.0, 210647.0, 210817.945910271, 51430.22854657183, 52090.0, 53445.0, 58446.41553584495, 60360.69819650961, 54498.0, 54536.72731636316, 54889.0, 54913.0, 54955.175672364945, 14195.85804141966, 14358.784618230735, 14367.13797172173, 14373.64065898361, 14378.065425747292, 10841.457927103613, 10921.67234982936, 10932.398718070583, 10934.507947142398, 10934.945325273322, 19217.62931292834, 19434.402303366027, 19510.709775321582, 19596.510087247647, 19617.411477655693, 7494.812629684193, 7600.733974310872, 7723.111842138226, 7731.884021739678, 7806.570638614817, 878.5080355001091, 906.1120102299783, 915.5696822493418, 924.3991405586422, 939.6382392778693, 24852.627210591854, 25102.87448562782, 25385.61921571178, 26630.20109396721, 26668.19995400141, 1009.7324209084599, 1019.2202964731986, 1038.190211634926, 1039.1375158618328, 1122.3882983773863, 14122.747432772787, 14131.85868141326, 14231.715365692628, 14366.066205696596, 14367.2098034607, 391092.0, 393241.0, 398670.0, 398945.0, 400318.0, 50633.48099557019, 51083.489165108615, 51133.48866511287, 51207.23189152166, 51272.0, 1301.9804702929464, 1308.2346827106248, 1311.1870640202944, 1319.142557337719, 1321.1742660836976, 25997.480050398506, 26604.0, 26930.73069269282, 27040.0, 27142.0, 41400.37899431451, 41885.79057104695, 41963.7901810489, 41975.58024419717, 41986.79006604947, 269820.0, 272766.0, 272885.0, 279346.0, 286613.0, 29621.703782962755, 29843.403131936804, 29844.701552984192, 30246.54630180505, 30258.394832103673, 39959.60040399559, 40660.79669601751, 41217.58782412137, 41676.79161604172, 42274.15451691011, 35055.12362190965, 35406.46890296699, 35501.289974199855, 35524.0, 36044.45933311055, 35045.012171530994, 35321.64678353183, 35824.28351433009, 35949.1012724684, 36169.0, 34092.829535853154, 34364.65635343615, 34808.0, 35054.12364690903, 35168.64831351654, 30460.238494037825, 32166.83916580496, 32217.677823222406, 32418.513722294658, 32448.351032978735, 24068.759312407354, 24434.633480498163, 24472.755272447048, 24658.753412465645, 24743.38141546404], "unit": "score", "name": "ext.html", "value": 17796.57150731784}, {"lowerIsBetter": false, "replicates": [359.08791669160337, 359.5020896058958, 360.03869667986487, 360.65197084813155, 365.0891026887915, 14112.082714623542, 14347.856521434782, 16191.433299834509, 16409.917950410247, 17034.233459494306, 14126.717465650681, 14737.336819843105, 14747.0, 15072.623184420396, 15163.317650705718, 5209.583233341333, 5321.095413779667, 5334.413214546396, 5335.546478549328, 5341.172118321647, 4084.81618327176, 4200.768957707325, 5270.209468579725, 5305.753148010214, 5776.653400795944, 5826.854328641797, 5836.824895253149, 5857.619254748449, 5907.0548712206055, 5918.2898052233795, 5701.828945131652, 5841.211436456109, 5842.298924129111, 5852.882942341172, 5859.326177489601, 5128.71792051437, 5151.407588127338, 5154.9484505155215, 5164.715940623264, 5166.586673066184, 14844.183569903651, 16158.434454794144, 18336.174872130785, 20177.798222017886, 20198.697019544717, 2132.584146091497, 2174.7390313162364, 2210.2043264424956, 2241.3330817584965, 2532.987335063331, 12788.296643684595, 12941.935290323489, 13029.934850325688, 13215.933920330337, 13250.138740981902, 1783.0, 1810.8641851861164, 1829.3962992212537, 1832.129738374275, 1854.5085552328644, 58602.413975860545, 60370.0, 63507.36492635061, 64087.359126408606, 64346.67826660837, 9516.857247141299, 9710.563024663767, 9980.700578982642, 9996.150327222267, 10042.497875106215, 13125.374925015036, 13173.275469849059, 13177.0, 13212.801807972888, 13216.140950838164, 7269.7455589054125, 7278.781636550912, 7295.088113985752, 7340.743073992385, 7472.551646901204, 6958.443324534025, 6982.720691172398, 6984.5110842241575, 7058.964705176544, 7065.682044308019, 5850.882982340329, 5852.882942341129, 5931.762729490858, 5960.523158147338, 5986.311574168939, 1652.5290292266886, 1713.6230029393514, 1731.9480415587552, 1734.1849330814498, 1794.0222578694643, 895.9776005599782, 940.1538615246196, 969.743018100204, 1035.4563853976572, 1049.2602715085845, 15533.922330388501, 16695.16834269808, 16999.40502082446, 17267.74098388525, 17882.731759023623, 978.7455261632027, 1008.7390761548065, 1020.0564477857952, 1039.9168066554657, 1041.770810421721, 9466.90533094674, 9599.520023998772, 9633.662821801343, 9669.90330096704, 9686.418814871131, 359776.0, 366488.0, 514037.0, 519009.0, 519733.0, 75594.0, 79768.0, 79817.0, 83377.0, 84688.57655711682, 1068.7755571329951, 1088.9618863339745, 1095.4084794211037, 1108.8503052088026, 1123.3709122891044, 15203.0, 15394.307256173723, 15538.0, 15617.843821562094, 15928.123953182687, 33602.0, 34109.317813643094, 34543.481847772804, 35251.294974100885, 35465.0, 45464.0, 45475.54524454713, 46823.063538729715, 46989.2951605733, 49037.754811225714, 8969.596368163579, 9313.720588382359, 9376.671816486663, 9380.765480863032, 9498.95250523743, 11276.830847537458, 11282.0, 11512.94243528777, 11514.0, 11525.250858694493, 13757.724845503235, 14041.297935102999, 14100.717985640025, 14325.856741432452, 14350.928245359124, 13467.3939672713, 13653.726925461237, 14074.296285185495, 14136.646583835487, 14196.148231106166, 14369.712605747618, 14573.344199510835, 14884.255787210812, 14936.0, 15152.469663561722, 9544.665936692183, 9589.712308630753, 9604.135627793532, 9894.653687120915, 9918.40489570628, 14538.781918271447, 14663.853361466676, 14789.482368117064, 14804.7779283313, 14833.629159271104], "unit": "score", "name": "jquery.html", "value": 8830.310755146587}, {"lowerIsBetter": false, "replicates": [1209.6431552691954, 1380.3098450774612, 1393.3312010235086, 1492.5000124958137, 1699.838515341043, 6660.50046246531, 7157.8926316105235, 7240.420766338693, 7243.311885370895, 7249.130104387467, 6969.094017777682, 7161.2122666506775, 7164.391026762732, 7169.7849064528145, 7174.497785155041, 1908.6946088625823, 1958.7453631027947, 1958.7943265957012, 2093.3301343570024, 2126.914923403062, 1996.2713609532561, 2166.306781829815, 2191.0359441845535, 2200.449887528118, 2202.042111681416, 2141.3575927221773, 2163.0374483354913, 2169.717936668231, 2171.0447403142643, 2214.8671079735186, 2200.7909248621354, 2222.2333295013113, 2224.5773303072365, 2225.4658881868318, 2227.432004838772, 2117.2907076129513, 2158.3632828315526, 2177.205320058167, 2179.531400748831, 2181.1275489804207, 7302.671379787922, 7359.043324367798, 7382.520136191184, 7383.630818459055, 7390.704371825121, 4348.434703488558, 4418.381426600278, 4425.889352766175, 4429.357743127229, 4433.800478978422, 2917.0519581136004, 2935.8238505689515, 3010.834404107773, 3047.7104675055834, 3048.8170709757487, 889.364104665161, 928.5032507608464, 942.2838642631581, 944.8818897637796, 944.900785417535, 9910.058544438267, 9921.40471571708, 9936.354136981074, 9942.701718948443, 9949.502524873727, 3952.130531283113, 4007.0984028593916, 4044.130511939947, 4056.1684854604737, 4101.815418306183, 8556.700515481929, 8564.3148548116, 8577.0, 8578.78553036179, 8595.269402100766, 4320.978395108004, 4372.125574885035, 4372.540883207281, 4372.693911426233, 4378.2119218540965, 3974.3442332014893, 3974.5230572331507, 3980.0447892506168, 3980.960190398117, 3984.322665146874, 3233.870645174167, 3447.1382154461385, 3491.0, 3507.631698671654, 3519.771214871025, 1045.3884477580548, 1066.5840322274319, 1069.224812011301, 1070.175964507325, 1102.8897110289067, 908.0646933658343, 909.490685216281, 969.6170012845027, 987.76293689514, 1266.2465832829453, 6830.487713421513, 6915.757948471779, 6916.965415172892, 6935.3411425914455, 6960.269171736894, 1073.8765042020111, 1081.5187241677536, 1093.3767752381225, 1097.7475180708482, 1110.1729211737145, 5009.89980200394, 5044.218146187347, 5151.098557752378, 5179.300794392784, 5224.477552244821, 8208.83582328362, 8434.62044208012, 8453.619587118594, 8545.74362769118, 8549.145085491526, 8216.178382161735, 8333.958330208432, 8408.033076196194, 8431.072582015973, 8432.241098301183, 6797.72809087631, 6807.217170025411, 6821.317868213238, 6858.5199036067, 6900.2064762551945, 6503.6097834130105, 6519.3480651936325, 6581.308962558863, 6588.275289718223, 6591.934080659132, 7526.24737526243, 7802.219778022152, 7868.134505204309, 7869.567173805495, 7871.921280787348, 7859.685612575661, 7870.252326029018, 7975.082865470546, 7976.16250293734, 7982.760517184493, 6311.0, 6393.808185754435, 6418.711157997995, 6432.935670643421, 6473.385028422293, 6768.695408706521, 6809.727610895508, 6835.965820170867, 6838.0, 6839.316068393121, 5859.648421094748, 6377.553571249968, 6479.935200647933, 6570.047343135123, 6607.80176594703, 6285.120083188449, 6423.775167869289, 6442.194725659293, 6538.378854008862, 6553.574017688835, 6463.450606698295, 6474.5791523550815, 6485.383888530582, 6543.411093001462, 6582.539222254396, 6057.727402266821, 6097.0, 6100.603460775035, 6102.816915492543, 6106.877862442815, 6074.51403887679, 6117.449429551184, 6132.264128304453, 6179.1040299155475, 6215.160953271251], "unit": "score", "name": "mootools.html", "value": 4173.376932412815}, {"lowerIsBetter": false, "replicates": [335.8203361201757, 342.2743783179658, 348.79595436669547, 349.45833957366074, 351.1589742566555, 5750.9999999999945, 5758.596898217122, 5780.450857168567, 5841.474267315952, 5844.503217226541, 5503.972480137603, 5543.223948647193, 5644.689542075184, 5727.198192253078, 5747.2528571285775, 4443.400140980959, 4464.821407143719, 4471.28459446487, 4478.03722199727, 4481.058977614704, 4272.914541709164, 4453.465584129909, 4462.397576327203, 4476.9776151119195, 4478.552144785528, 4304.418903448041, 4310.590493903074, 4372.366006928994, 4387.166438376714, 4388.956110438887, 4373.1909596724545, 4385.210662080856, 4386.2324093283705, 4388.561143885618, 4397.956020439787, 3879.2047630235734, 3884.2231553689094, 3926.8821935341984, 3927.0771368728324, 3944.1717239379764, 5481.068218402881, 5508.586855985817, 5513.255710479114, 5520.530754885839, 5542.196381524656, 4997.700137991696, 5128.9230661540105, 5151.278820965068, 5154.355705536808, 5161.638685292031, 6084.391560843925, 6094.847628809315, 6095.0, 6096.207493025879, 6101.359357267512, 4291.506476755182, 4295.183915056129, 4295.2912769393015, 4297.0, 4298.656107511391, 6167.321594624633, 6294.055891616248, 6370.1718776558755, 6385.48916086712, 6403.423691867754, 4367.5632436756705, 4385.342198670225, 4389.31965545341, 4390.780460976938, 4390.934135987899, 4447.799849006802, 4448.332750087513, 4452.510223875371, 4459.866204013885, 4470.463544374696, 5136.460671629425, 5139.511746384088, 5143.537081662668, 5149.382074151126, 5153.252778347119, 5984.281886173687, 6132.233470816148, 6135.846603834851, 6151.677389361309, 6154.476869466056, 1559.0723519505875, 1579.2103948025988, 1582.1061100478194, 1583.754518049704, 1584.952451426459, 1038.5638032026568, 1057.0222544146786, 1064.1274155192823, 1066.248294952057, 1078.4931082391263, 5903.291605007426, 5913.645181289136, 5918.260217472816, 5921.141434491975, 5931.970340148272, 6346.27017892939, 6352.2694890087305, 6352.936470635234, 6357.078223657544, 6358.109864618957, 5789.3052833659385, 5833.329167145747, 5873.089671100986, 5875.559333050039, 5936.347001829795, 3408.062782734718, 3417.572803399575, 3420.504026916083, 3429.0, 3442.0534353053113, 6591.703373348211, 6592.30780768022, 6605.603663780189, 6614.801555953329, 6614.900776488356, 6278.246610406781, 6486.091947127406, 6497.577657452251, 6501.577397469149, 6510.0, 6589.9341006590275, 6604.240512341046, 6604.405603495612, 6608.900866486911, 6613.272540020594, 6349.396807303484, 6369.9681501592195, 6372.840678982877, 6375.234971803413, 6376.043593461018, 6077.544184186116, 6254.249490061222, 6306.337834527309, 6309.3690630936535, 6313.3686631336495, 6600.669966501751, 6604.273529911802, 6604.3725846044545, 6613.933860661525, 6615.239247486408, 4405.383246345578, 4443.355713421601, 4444.82220711168, 4449.021215332622, 4450.109978004347, 6231.688415579112, 6390.169277993831, 6404.1674582304, 6410.326915673973, 6417.422431981144, 6233.283172435228, 6238.001919693009, 6244.843878903063, 6245.313015568193, 6247.375262473716, 6228.501719862491, 6232.283287421823, 6233.2208473940755, 6233.812985610439, 6238.563300568917, 5975.790847320323, 6112.541559383153, 6124.448799608057, 6127.509799215963, 6131.202943617302, 6247.031710084944, 6249.0, 6253.874922501615, 6270.0908368287255, 6275.309715931336, 6115.388461153849, 6121.755129794758, 6124.38756124384, 6131.141640170469, 6132.141500190066], "unit": "score", "name": "prototype.html", "value": 4660.046282926277}, {"lowerIsBetter": false, "replicates": [733.7028503456102, 743.9256074392558, 747.0848210941593, 760.3271105072013, 760.3954855889567, 12999.220046797198, 13192.934035329834, 13207.537736179213, 13227.140235884674, 13258.535951241709, 11910.106741994341, 12034.69913252167, 12054.276743395381, 12054.517819287217, 12055.33695646739, 640.57081755224, 653.879032379009, 786.1077676836803, 799.5522507395848, 801.390942883407, 787.9921200787976, 791.1297572670046, 792.1088775127981, 793.972210972616, 796.9322607578334, 685.0067402266708, 694.4166899804163, 820.7783898347443, 828.3911325175991, 828.6850996621275, 818.9918100819004, 822.0, 824.1017291152673, 830.5598033042497, 833.291702053253, 608.5770389579244, 617.4042049422329, 617.728199592178, 617.9258488981351, 618.1963447518208, 10645.361278323326, 10701.83947240792, 10736.194785391126, 10745.355278683304, 10748.462576871125, 11414.143939204592, 11741.354225517593, 11746.471408786625, 11850.585229517012, 11929.164958452911, 9442.858357124649, 9511.857322140173, 9558.330916835825, 9563.907681448325, 9661.90338096617, 3524.2775231077826, 3576.928461430783, 3577.9821100894587, 3579.8210089495683, 3584.301061293049, 44340.55659443397, 44519.777401112784, 44797.0, 45283.565972083234, 45785.08429831418, 8518.148185181431, 8615.61229744663, 8669.523176225242, 8825.374070423752, 8828.51443170619, 17984.550386240448, 18002.819971800116, 18005.369812056517, 18007.36974205923, 18025.098745062693, 6913.3777959983845, 7123.287671232835, 7253.782386528413, 7387.187409384964, 7514.286142816533, 4266.807993640294, 4318.52496225415, 4376.767848397277, 4406.581374769392, 4430.446194225722, 2507.0, 2513.5349960257413, 2515.710693270261, 2548.350170706495, 2548.98725506375, 508.4534125814764, 513.2147813844823, 525.4823998361687, 527.5542166868989, 531.8510816971254, 505.2169137836339, 556.3907521264209, 597.2862429396915, 615.5998600909355, 648.8126728087589, 8360.0, 8388.203120703523, 8492.235698787015, 8513.489190648581, 8829.293656507463, 511.3250509327726, 513.4147072337464, 514.9407818100966, 534.0760484362075, 626.2797782550103, 3690.409534474471, 3893.162969961472, 4007.358822588372, 4087.693422993287, 4243.427137336482, 51608.74195629073, 53136.73431632817, 54124.45875541194, 54187.72906135444, 54210.72894635502, 46836.297455538195, 47135.764321178176, 47212.5278747215, 47279.27207279313, 47400.28899566509, 41778.0, 43588.12823743507, 43625.345619815096, 44024.11951760947, 44316.778416107714, 8013.959930200312, 8125.268725814469, 8188.5905704715715, 8223.54770487629, 8301.750947471586, 32317.192070197492, 32393.35213295768, 32736.34527309488, 33138.5029224557, 33409.49885751667, 38346.0, 38730.61269387383, 41685.374719378626, 43157.784211078746, 43818.56181438272, 9072.002079771351, 9384.3900146493, 9590.520473976412, 9871.0, 9920.305578609428, 10415.270931034755, 10873.401962891801, 10906.072983796466, 11019.44902754843, 11051.834222486508, 11150.776984460428, 11346.149038821955, 11454.885451145716, 11648.708782280512, 11820.586279480176, 11234.943825280821, 11326.37704926237, 11332.093432525544, 11787.292762434281, 11830.171887968105, 11010.39442830652, 11454.370009649549, 11487.827682584935, 11497.655070347902, 11504.769904602028, 9274.44353338802, 9360.0, 9453.243740500606, 10101.393916365041, 10150.695479135638, 8690.956545217234, 8958.596863141305, 9108.499032553273, 9470.289728270269, 9517.238620910171], "unit": "score", "name": "yui.html", "value": 5914.566611023695}], "name": "dromaeo_css", "value": 6735.699300039788}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 104.0, 111.0, 112.0, 111.0, 102.0, 110.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.9}, {"lowerIsBetter": true, "replicates": [167.0, 130.0, 154.0, 164.0, 126.0, 151.0, 159.0, 126.0, 176.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 147.9}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 162.0, 161.0, 161.0, 160.0, 162.0, 160.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 80.0, 95.0, 73.0, 73.0, 71.0, 111.0, 89.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 140.0, 95.0, 96.0, 96.0, 136.0, 96.0, 96.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 144.0, 146.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 58.0, 58.0, 56.0, 60.0, 57.0, 66.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.0}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 79.0, 68.0, 68.0, 71.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.5}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 86.0, 85.0, 85.0, 85.0, 85.0, 85.0, 86.0, 92.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [114.0, 120.0, 120.0, 117.0, 115.0, 124.0, 122.0, 125.0, 123.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.6}, {"lowerIsBetter": true, "replicates": [145.0, 144.0, 146.0, 155.0, 156.0, 146.0, 158.0, 163.0, 154.0, 153.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.0}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 76.0, 71.0, 72.0, 70.0, 71.0, 71.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.4}], "name": "kraken", "value": 1514.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.7289500167729], "unit": "score", "name": "Richards", "value": 210.47052400000004}, {"lowerIsBetter": false, "replicates": [190.5487804878049], "unit": "score", "name": "DeltaBlue", "value": 346.9872640000001}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [2016.1290322580646], "unit": "score", "name": "RayTrace", "value": 367.03454399999987}, {"lowerIsBetter": false, "replicates": [793.0214115781126], "unit": "score", "name": "Earley", "value": 840.4098429999997}, {"lowerIsBetter": false, "replicates": [12395.061728395061], "unit": "score", "name": "Boyer", "value": 53.768429282868496}, {"lowerIsBetter": false, "replicates": [25525.0], "unit": "score", "name": "RegExp", "value": 35.689911851126354}, {"lowerIsBetter": false, "replicates": [669.5652173913044], "unit": "score", "name": "Splay", "value": 121.70733766233766}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 19555.18800289848}]} 23:14:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19555.19"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1514.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6735.70"}}} 23:14:33 INFO - Return code: 0 23:14:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:14:33 INFO - # TBPL SUCCESS # 23:14:33 INFO - Running post-action listener: _resource_record_post_action 23:14:33 INFO - Running post-run listener: _resource_record_post_run 23:14:34 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 571584512; Read time: 0; Write time: 729044 23:14:34 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 248041472; Read time: 0; Write time: 398296 23:14:35 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 319512576; Read time: 0; Write time: 330300 23:14:35 INFO - Running post-run listener: _upload_blobber_files 23:14:35 INFO - Blob upload gear active. 23:14:35 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:14:35 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 23:14:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:14:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:14:35 INFO - (blobuploader) - INFO - Open directory for files ... 23:14:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:14:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:14:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:14:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:14:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:14:36 INFO - (blobuploader) - INFO - Done attempting. 23:14:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:14:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:14:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:14:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:14:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:14:37 INFO - (blobuploader) - INFO - Done attempting. 23:14:37 INFO - (blobuploader) - INFO - Iteration through files over. 23:14:37 INFO - Return code: 0 23:14:37 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:14:37 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:14:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/a8198db63b0bba1e19a893c63e93bab38efe6352606def2f0ba8b31d2302ba48a864e78326d46f9b12717838e3303b031076032d22f49438fd70f2e647ce60c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/f96e02e7465799f6819a2a1ca29a1a318ab77c29cbd1aaabf5a29414e1fc140144c96ec35b69e82a719dde33feeaa0098bfe8baa4f3c1367b317b6582140d2f4"} 23:14:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:14:37 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:14:37 INFO - Contents: 23:14:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/a8198db63b0bba1e19a893c63e93bab38efe6352606def2f0ba8b31d2302ba48a864e78326d46f9b12717838e3303b031076032d22f49438fd70f2e647ce60c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/f96e02e7465799f6819a2a1ca29a1a318ab77c29cbd1aaabf5a29414e1fc140144c96ec35b69e82a719dde33feeaa0098bfe8baa4f3c1367b317b6582140d2f4"} 23:14:37 INFO - Copying logs to upload dir... 23:14:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.875422 ========= master_lag: 1.61 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-05 23:14:38.541563) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 23:14:38.544739) ========= 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=d2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/a8198db63b0bba1e19a893c63e93bab38efe6352606def2f0ba8b31d2302ba48a864e78326d46f9b12717838e3303b031076032d22f49438fd70f2e647ce60c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/f96e02e7465799f6819a2a1ca29a1a318ab77c29cbd1aaabf5a29414e1fc140144c96ec35b69e82a719dde33feeaa0098bfe8baa4f3c1367b317b6582140d2f4"} build_url:https://queue.taskcluster.net/v1/task/MXKBWDP_Qym662EsSo4Y9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011407 build_url: 'https://queue.taskcluster.net/v1/task/MXKBWDP_Qym662EsSo4Y9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/a8198db63b0bba1e19a893c63e93bab38efe6352606def2f0ba8b31d2302ba48a864e78326d46f9b12717838e3303b031076032d22f49438fd70f2e647ce60c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/f96e02e7465799f6819a2a1ca29a1a318ab77c29cbd1aaabf5a29414e1fc140144c96ec35b69e82a719dde33feeaa0098bfe8baa4f3c1367b317b6582140d2f4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 23:14:38.572567) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 23:14:38.572911) ========= 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=d2a8c569965ab8367867b893000001a1-1452063028.544579-1969403553 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 23:14:38.622217) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 23:14:38.622544) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 23:14:38.622840) ========= ========= Total master_lag: 1.82 =========