builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1451108604.54 results: success (0) buildid: 20151225193211 builduid: d43f9b44712c410fa9350a9f14e24e73 revision: 57d8ddc976a6aa4abfdb5d7aa650b7884abfdaba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-25 21:43:24.536243) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-25 21:43:24.536770) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-25 21:43:24.537098) ========= 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=7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006302 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-25 21:43:24.589788) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-25 21:43:24.590113) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-25 21:43:24.690560) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 21:43:24.690836) ========= 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=7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004596 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 21:43:24.756178) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-25 21:43:24.756678) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-25 21:43:24.757060) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 21:43:24.757366) ========= 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=7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-25 21:43:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 37.2M=0s 2015-12-25 21:43:25 (37.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.465958 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 21:43:25.243934) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 21:43:25.244481) ========= 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=7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017066 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 21:43:25.296284) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 21:43:25.296885) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 57d8ddc976a6aa4abfdb5d7aa650b7884abfdaba --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/mozilla-inbound --rev 57d8ddc976a6aa4abfdb5d7aa650b7884abfdaba --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=7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-25 21:43:25,701 truncating revision to first 12 chars 2015-12-25 21:43:25,701 Setting DEBUG logging. 2015-12-25 21:43:25,701 attempt 1/10 2015-12-25 21:43:25,701 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/57d8ddc976a6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-25 21:43:25,958 unpacking tar archive at: mozilla-inbound-57d8ddc976a6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571821 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 21:43:25.882917) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-25 21:43:25.883309) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-25 21:43:25.893400) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-25 21:43:25.893712) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-25 21:43:25.894407) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-25 21:43:25.894689) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-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', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-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=7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:43:26 INFO - MultiFileLogger online at 20151225 21:43:26 in /builds/slave/test-pgo 21:43:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 21:43:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:43:26 INFO - {'append_to_log': False, 21:43:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:43:26 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:43:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:43:26 INFO - 'branch': 'Mozilla-Inbound', 21:43:26 INFO - 'buildbot_json_path': 'buildprops.json', 21:43:26 INFO - 'config_files': ('talos/linux_config.py',), 21:43:26 INFO - 'default_actions': ('clobber', 21:43:26 INFO - 'read-buildbot-config', 21:43:26 INFO - 'download-and-extract', 21:43:26 INFO - 'populate-webroot', 21:43:26 INFO - 'create-virtualenv', 21:43:26 INFO - 'install', 21:43:26 INFO - 'run-tests'), 21:43:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:43:26 INFO - 'download_minidump_stackwalk': True, 21:43:26 INFO - 'download_symbols': 'ondemand', 21:43:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:43:26 INFO - 'tooltool.py': '/tools/tooltool.py', 21:43:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:43:26 INFO - '/tools/misc-python/virtualenv.py')}, 21:43:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:43:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:43:26 INFO - 'installer_path': 'installer.exe', 21:43:26 INFO - 'log_level': 'info', 21:43:26 INFO - 'log_name': 'talos', 21:43:26 INFO - 'log_to_console': True, 21:43:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:43:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:43:26 INFO - 'opt_config_files': (), 21:43:26 INFO - 'pip_index': False, 21:43:26 INFO - 'sps_profile': False, 21:43:26 INFO - 'sps_profile_interval': 0, 21:43:26 INFO - 'suite': 'dromaeojs', 21:43:26 INFO - 'system_bits': '64', 21:43:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:43:26 INFO - 'title': 'talos-linux64-ix-041', 21:43:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:43:26 INFO - 'use_talos_json': True, 21:43:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:43:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:43:26 INFO - 'work_dir': 'build'} 21:43:26 INFO - ##### 21:43:26 INFO - ##### Running clobber step. 21:43:26 INFO - ##### 21:43:26 INFO - Running pre-action listener: _resource_record_pre_action 21:43:26 INFO - Running main action method: clobber 21:43:26 INFO - rmtree: /builds/slave/test-pgo/build 21:43:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:43:26 INFO - Running post-action listener: _resource_record_post_action 21:43:26 INFO - ##### 21:43:26 INFO - ##### Running read-buildbot-config step. 21:43:26 INFO - ##### 21:43:26 INFO - Running pre-action listener: _resource_record_pre_action 21:43:26 INFO - Running main action method: read_buildbot_config 21:43:26 INFO - Using buildbot properties: 21:43:26 INFO - { 21:43:26 INFO - "project": "", 21:43:26 INFO - "product": "firefox", 21:43:26 INFO - "script_repo_revision": "production", 21:43:26 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 21:43:26 INFO - "repository": "", 21:43:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 21:43:26 INFO - "buildid": "20151225193211", 21:43:26 INFO - "pgo_build": "True", 21:43:26 INFO - "basedir": "/builds/slave/test-pgo", 21:43:26 INFO - "buildnumber": 1377, 21:43:26 INFO - "slavename": "talos-linux64-ix-041", 21:43:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:43:26 INFO - "platform": "ubuntu64_hw", 21:43:26 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:43:26 INFO - "branch": "mozilla-inbound", 21:43:26 INFO - "repo_path": "integration/mozilla-inbound", 21:43:26 INFO - "revision": "57d8ddc976a6aa4abfdb5d7aa650b7884abfdaba", 21:43:26 INFO - "stage_platform": "linux64-pgo", 21:43:26 INFO - "builduid": "d43f9b44712c410fa9350a9f14e24e73", 21:43:26 INFO - "slavebuilddir": "test" 21:43:26 INFO - } 21:43:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/2867KV8kTemM-uOeolihJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 21:43:26 INFO - Running post-action listener: _resource_record_post_action 21:43:26 INFO - ##### 21:43:26 INFO - ##### Running download-and-extract step. 21:43:26 INFO - ##### 21:43:26 INFO - Running pre-action listener: _resource_record_pre_action 21:43:26 INFO - Running main action method: download_and_extract 21:43:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:43:26 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')]} 21:43:26 INFO - https://queue.taskcluster.net/v1/task/2867KV8kTemM-uOeolihJw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:43:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2867KV8kTemM-uOeolihJw/artifacts/public/build/test_packages.json 21:43:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2867KV8kTemM-uOeolihJw/artifacts/public/build/test_packages.json 21:43:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2867KV8kTemM-uOeolihJw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:43:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2867KV8kTemM-uOeolihJw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:43:29 INFO - Downloaded 1302 bytes. 21:43:29 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:43:29 INFO - Using the following test package requirements: 21:43:29 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:43:29 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:43:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:43:29 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:43:29 INFO - u'jsshell-linux-x86_64.zip'], 21:43:29 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:43:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:43:29 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:43:29 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:43:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:43:29 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:43:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:43:29 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:43:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:43:29 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:43:29 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:43:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:43:29 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:43:29 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')]} 21:43:29 INFO - https://queue.taskcluster.net/v1/task/2867KV8kTemM-uOeolihJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:43:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2867KV8kTemM-uOeolihJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:43:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2867KV8kTemM-uOeolihJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:43:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2867KV8kTemM-uOeolihJw/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 21:43:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2867KV8kTemM-uOeolihJw/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 21:43:30 INFO - Downloaded 23191652 bytes. 21:43:30 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 21:43:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:43:30 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 21:43:32 INFO - Return code: 0 21:43:32 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 21:43:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:43:32 INFO - https://queue.taskcluster.net/v1/task/2867KV8kTemM-uOeolihJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:43:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2867KV8kTemM-uOeolihJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:43:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2867KV8kTemM-uOeolihJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:43:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2867KV8kTemM-uOeolihJw/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 21:43:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2867KV8kTemM-uOeolihJw/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 21:43:36 INFO - Downloaded 23191652 bytes. 21:43:36 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 21:43:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:43:36 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 21:43:37 INFO - Return code: 0 21:43: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')]} 21:43:37 INFO - https://queue.taskcluster.net/v1/task/2867KV8kTemM-uOeolihJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:43:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2867KV8kTemM-uOeolihJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:43:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2867KV8kTemM-uOeolihJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:43:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2867KV8kTemM-uOeolihJw/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 21:43:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2867KV8kTemM-uOeolihJw/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 21:43:38 INFO - Downloaded 11132270 bytes. 21:43:38 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 21:43:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:43:38 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 21:43:38 INFO - Return code: 0 21:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:43:38 INFO - https://queue.taskcluster.net/v1/task/2867KV8kTemM-uOeolihJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:43:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2867KV8kTemM-uOeolihJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:43:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2867KV8kTemM-uOeolihJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:43:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2867KV8kTemM-uOeolihJw/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 21:43:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2867KV8kTemM-uOeolihJw/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 21:43:40 INFO - Downloaded 54921336 bytes. 21:43:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/2867KV8kTemM-uOeolihJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:43:40 INFO - mkdir: /builds/slave/test-pgo/properties 21:43:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:43:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:43:40 INFO - Contents: 21:43:40 INFO - build_url:https://queue.taskcluster.net/v1/task/2867KV8kTemM-uOeolihJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:43:40 INFO - Running post-action listener: _resource_record_post_action 21:43:40 INFO - Running post-action listener: set_extra_try_arguments 21:43:40 INFO - ##### 21:43:40 INFO - ##### Running populate-webroot step. 21:43:40 INFO - ##### 21:43:40 INFO - Running pre-action listener: _resource_record_pre_action 21:43:40 INFO - Running main action method: populate_webroot 21:43:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:43:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:43:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:43:40 INFO - '--tppagecycles', 21:43:40 INFO - '7'], 21:43:40 INFO - 'tests': ['tsvgm']}}, 21:43:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:43:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:43:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:43:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:43:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:43:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:43:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:43:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:43:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:43:40 INFO - 'talos_options': ['--e10s'], 21:43:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:43:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:43:40 INFO - 'tests': ['damp', 'tps']}, 21:43:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:43:40 INFO - 'talos_options': ['--e10s'], 21:43:40 INFO - 'tests': ['damp', 'tps']}, 21:43:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:43:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:43:40 INFO - 'other': {'tests': ['a11yr', 21:43:40 INFO - 'ts_paint', 21:43:40 INFO - 'tpaint', 21:43:40 INFO - 'sessionrestore', 21:43:40 INFO - 'sessionrestore_no_auto_restore']}, 21:43:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:43:40 INFO - 'tests': ['a11yr', 21:43:40 INFO - 'ts_paint', 21:43:40 INFO - 'tpaint', 21:43:40 INFO - 'sessionrestore', 21:43:40 INFO - 'sessionrestore_no_auto_restore']}, 21:43:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:43:40 INFO - 'tests': ['a11yr', 21:43:40 INFO - 'ts_paint', 21:43:40 INFO - 'tpaint', 21:43:40 INFO - 'sessionrestore', 21:43:40 INFO - 'sessionrestore_no_auto_restore']}, 21:43:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:43:40 INFO - 'tests': ['a11yr', 21:43:40 INFO - 'ts_paint', 21:43:40 INFO - 'tpaint', 21:43:40 INFO - 'sessionrestore', 21:43:40 INFO - 'sessionrestore_no_auto_restore']}, 21:43:40 INFO - 'other_l64': {'tests': ['a11yr', 21:43:40 INFO - 'ts_paint', 21:43:40 INFO - 'tpaint', 21:43:40 INFO - 'sessionrestore', 21:43:40 INFO - 'sessionrestore_no_auto_restore']}, 21:43:40 INFO - 'other_nol64': {'tests': ['a11yr', 21:43:40 INFO - 'ts_paint', 21:43:40 INFO - 'tpaint', 21:43:40 INFO - 'sessionrestore', 21:43:40 INFO - 'sessionrestore_no_auto_restore']}, 21:43:40 INFO - 'svgr': {'tests': ['tsvgx', 21:43:40 INFO - 'tsvgr_opacity', 21:43:40 INFO - 'tart', 21:43:40 INFO - 'tscrollx', 21:43:40 INFO - 'cart']}, 21:43:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:43:40 INFO - 'tests': ['tsvgx', 21:43:40 INFO - 'tsvgr_opacity', 21:43:40 INFO - 'tart', 21:43:40 INFO - 'tscrollx', 21:43:40 INFO - 'cart']}, 21:43:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:43:40 INFO - 'tests': ['tp5o']}, 21:43:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:43:40 INFO - 'talos_options': ['--e10s'], 21:43:40 INFO - 'tests': ['tp5o']}, 21:43:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:43:40 INFO - 'talos_options': ['--xperf_path', 21:43:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:43:40 INFO - 'tests': ['tp5n']}, 21:43:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:43:40 INFO - 'talos_options': ['--e10s', 21:43:40 INFO - '--xperf_path', 21:43:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:43:40 INFO - 'tests': ['tp5n']}}, 21:43:40 INFO - 'talos.zip': {'path': '', 21:43:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:43:40 INFO - Running post-action listener: _resource_record_post_action 21:43:40 INFO - ##### 21:43:40 INFO - ##### Running create-virtualenv step. 21:43:40 INFO - ##### 21:43:40 INFO - Running pre-action listener: _resource_record_pre_action 21:43:40 INFO - Running main action method: create_virtualenv 21:43:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:43: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 21:43:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:43:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:43:40 INFO - Using real prefix '/usr' 21:43:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:43:40 INFO - Installing distribute.............................................................................................................................................................................................done. 21:43:42 INFO - Installing pip.................done. 21:43:42 INFO - Return code: 0 21:43:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:43:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:43:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:43:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:42 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 0x7f1aa9e83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b98230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a7f0>, '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 0x1b962d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96760>, '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': '7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303', '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 21:43:42 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 21:43:42 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 21:43:42 INFO - Using env: {'DISPLAY': ':0', 21:43:42 INFO - 'HOME': '/home/cltbld', 21:43:42 INFO - 'LANG': 'en_US.UTF-8', 21:43:42 INFO - 'LANGUAGE': 'en_US:en', 21:43:42 INFO - 'LOGNAME': 'cltbld', 21:43:42 INFO - 'MAIL': '/var/mail/cltbld', 21:43:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:43:42 INFO - 'MOZ_NO_REMOTE': '1', 21:43:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:43:42 INFO - 'NO_EM_RESTART': '1', 21:43:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:43:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:43:42 INFO - 'PWD': '/builds/slave/test-pgo', 21:43:42 INFO - 'SHELL': '/bin/bash', 21:43:42 INFO - 'SHLVL': '1', 21:43:42 INFO - 'TERM': 'linux', 21:43:42 INFO - 'TMOUT': '86400', 21:43:42 INFO - 'USER': 'cltbld', 21:43:42 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303', 21:43:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:43:42 INFO - '_': '/tools/buildbot/bin/python'} 21:43:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:43: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 21:43:43 INFO - Cleaning up... 21:43:43 INFO - Return code: 0 21:43:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:43: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')]} 21:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:43:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43: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')]} 21:43:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:43:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43: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 0x7f1aa9e83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b98230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a7f0>, '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 0x1b962d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96760>, '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': '7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303', '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 21:43: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 21:43: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 21:43:43 INFO - Using env: {'DISPLAY': ':0', 21:43:43 INFO - 'HOME': '/home/cltbld', 21:43:43 INFO - 'LANG': 'en_US.UTF-8', 21:43:43 INFO - 'LANGUAGE': 'en_US:en', 21:43:43 INFO - 'LOGNAME': 'cltbld', 21:43:43 INFO - 'MAIL': '/var/mail/cltbld', 21:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:43:43 INFO - 'MOZ_NO_REMOTE': '1', 21:43:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:43:43 INFO - 'NO_EM_RESTART': '1', 21:43:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:43:43 INFO - 'PWD': '/builds/slave/test-pgo', 21:43:43 INFO - 'SHELL': '/bin/bash', 21:43:43 INFO - 'SHLVL': '1', 21:43:43 INFO - 'TERM': 'linux', 21:43:43 INFO - 'TMOUT': '86400', 21:43:43 INFO - 'USER': 'cltbld', 21:43:43 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303', 21:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:43:43 INFO - '_': '/tools/buildbot/bin/python'} 21:43:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:43:43 INFO - Downloading/unpacking psutil>=0.7.1 21:43: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 21:43: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 21:43: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 21:43: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 21:43: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 21:43: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 21:43:44 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:43:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:43:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:43:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:43:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:43:45 INFO - Installing collected packages: psutil 21:43:45 INFO - Running setup.py install for psutil 21:43:45 INFO - building 'psutil._psutil_linux' extension 21:43: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 21:43: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 21:43:45 INFO - building 'psutil._psutil_posix' extension 21:43: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 21:43: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 21:43:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:43:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:43:45 INFO - Successfully installed psutil 21:43:45 INFO - Cleaning up... 21:43:45 INFO - Return code: 0 21:43:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:43: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')]} 21:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43: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')]} 21:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43: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 0x7f1aa9e83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b98230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a7f0>, '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 0x1b962d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96760>, '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': '7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303', '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 21:43: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 21:43: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 21:43:45 INFO - Using env: {'DISPLAY': ':0', 21:43:45 INFO - 'HOME': '/home/cltbld', 21:43:45 INFO - 'LANG': 'en_US.UTF-8', 21:43:45 INFO - 'LANGUAGE': 'en_US:en', 21:43:45 INFO - 'LOGNAME': 'cltbld', 21:43:45 INFO - 'MAIL': '/var/mail/cltbld', 21:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:43:45 INFO - 'MOZ_NO_REMOTE': '1', 21:43:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:43:45 INFO - 'NO_EM_RESTART': '1', 21:43:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:43:45 INFO - 'PWD': '/builds/slave/test-pgo', 21:43:45 INFO - 'SHELL': '/bin/bash', 21:43:45 INFO - 'SHLVL': '1', 21:43:45 INFO - 'TERM': 'linux', 21:43:45 INFO - 'TMOUT': '86400', 21:43:45 INFO - 'USER': 'cltbld', 21:43:45 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303', 21:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:43:45 INFO - '_': '/tools/buildbot/bin/python'} 21:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:43:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:43:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:43:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:43:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:43:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:43:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:43:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:43:47 INFO - Installing collected packages: mozsystemmonitor 21:43:47 INFO - Running setup.py install for mozsystemmonitor 21:43:47 INFO - Successfully installed mozsystemmonitor 21:43:47 INFO - Cleaning up... 21:43:47 INFO - Return code: 0 21:43:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:43:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:43:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:43:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:47 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 0x7f1aa9e83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b98230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a7f0>, '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 0x1b962d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96760>, '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': '7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303', '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 21:43:47 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 21:43:47 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 21:43:47 INFO - Using env: {'DISPLAY': ':0', 21:43:47 INFO - 'HOME': '/home/cltbld', 21:43:47 INFO - 'LANG': 'en_US.UTF-8', 21:43:47 INFO - 'LANGUAGE': 'en_US:en', 21:43:47 INFO - 'LOGNAME': 'cltbld', 21:43:47 INFO - 'MAIL': '/var/mail/cltbld', 21:43:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:43:47 INFO - 'MOZ_NO_REMOTE': '1', 21:43:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:43:47 INFO - 'NO_EM_RESTART': '1', 21:43:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:43:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:43:47 INFO - 'PWD': '/builds/slave/test-pgo', 21:43:47 INFO - 'SHELL': '/bin/bash', 21:43:47 INFO - 'SHLVL': '1', 21:43:47 INFO - 'TERM': 'linux', 21:43:47 INFO - 'TMOUT': '86400', 21:43:47 INFO - 'USER': 'cltbld', 21:43:47 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303', 21:43:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:43:47 INFO - '_': '/tools/buildbot/bin/python'} 21:43:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:43:47 INFO - Downloading/unpacking blobuploader==1.2.4 21:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:43:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:43:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:43:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:43:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:43:49 INFO - Downloading blobuploader-1.2.4.tar.gz 21:43:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:43:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:43:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:43:49 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 21:43:49 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 21:43:49 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 21:43:49 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 21:43:49 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 21:43:49 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 21:43:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:43:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:43:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:43:49 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 21:43:49 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 21:43:49 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 21:43:49 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 21:43:49 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 21:43:49 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 21:43:50 INFO - Downloading docopt-0.6.1.tar.gz 21:43:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:43:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:43:50 INFO - Installing collected packages: blobuploader, requests, docopt 21:43:50 INFO - Running setup.py install for blobuploader 21:43:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:43:50 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:43:50 INFO - Running setup.py install for requests 21:43:50 INFO - Running setup.py install for docopt 21:43:50 INFO - Successfully installed blobuploader requests docopt 21:43:50 INFO - Cleaning up... 21:43:50 INFO - Return code: 0 21:43:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:43:50 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')]} 21:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:43:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:50 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')]} 21:43:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:43:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:50 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 0x7f1aa9e83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b98230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a7f0>, '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 0x1b962d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96760>, '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': '7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303', '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 21:43:50 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 21:43:50 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 21:43:50 INFO - Using env: {'DISPLAY': ':0', 21:43:50 INFO - 'HOME': '/home/cltbld', 21:43:50 INFO - 'LANG': 'en_US.UTF-8', 21:43:50 INFO - 'LANGUAGE': 'en_US:en', 21:43:50 INFO - 'LOGNAME': 'cltbld', 21:43:50 INFO - 'MAIL': '/var/mail/cltbld', 21:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:43:50 INFO - 'MOZ_NO_REMOTE': '1', 21:43:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:43:50 INFO - 'NO_EM_RESTART': '1', 21:43:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:43:50 INFO - 'PWD': '/builds/slave/test-pgo', 21:43:50 INFO - 'SHELL': '/bin/bash', 21:43:50 INFO - 'SHLVL': '1', 21:43:50 INFO - 'TERM': 'linux', 21:43:50 INFO - 'TMOUT': '86400', 21:43:50 INFO - 'USER': 'cltbld', 21:43:50 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303', 21:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:43:50 INFO - '_': '/tools/buildbot/bin/python'} 21:43:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:43:51 INFO - Running setup.py (path:/tmp/pip-zQvmIz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:43:51 INFO - Running setup.py (path:/tmp/pip-7guvNg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:43:51 INFO - Running setup.py (path:/tmp/pip-81tmZY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:43:51 INFO - Running setup.py (path:/tmp/pip-fHWv4H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:43:51 INFO - Running setup.py (path:/tmp/pip-fgZrv4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:43:51 INFO - Running setup.py (path:/tmp/pip-tyQIaU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:43:51 INFO - Running setup.py (path:/tmp/pip-h2lh0K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:43:51 INFO - Running setup.py (path:/tmp/pip-Rh9VjX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:43:51 INFO - Running setup.py (path:/tmp/pip-HSorKY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:43:51 INFO - Running setup.py (path:/tmp/pip-zKqwU4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:43:51 INFO - Running setup.py (path:/tmp/pip-RUbGqq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:43:51 INFO - Running setup.py (path:/tmp/pip-JoP80_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:43:51 INFO - Running setup.py (path:/tmp/pip-I8Bieg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:43:51 INFO - Running setup.py (path:/tmp/pip-BYqCAa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:43:52 INFO - Running setup.py (path:/tmp/pip-ChBCBz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:43:52 INFO - Running setup.py (path:/tmp/pip-jOWmBr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:43:52 INFO - Running setup.py (path:/tmp/pip-D1V0fG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:43:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:43:52 INFO - Running setup.py install for manifestparser 21:43:52 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:43:52 INFO - Running setup.py install for mozcrash 21:43:52 INFO - Running setup.py install for mozdebug 21:43:52 INFO - Running setup.py install for mozdevice 21:43:52 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:43:52 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:43:52 INFO - Running setup.py install for mozfile 21:43:52 INFO - Running setup.py install for mozhttpd 21:43:52 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:43:52 INFO - Running setup.py install for mozinfo 21:43:52 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:43:52 INFO - Running setup.py install for mozInstall 21:43:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:43:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:43:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:43:53 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:43:53 INFO - Running setup.py install for mozleak 21:43:53 INFO - Running setup.py install for mozlog 21:43:53 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:43:53 INFO - Running setup.py install for moznetwork 21:43:53 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:43:53 INFO - Running setup.py install for mozprocess 21:43:53 INFO - Running setup.py install for mozprofile 21:43:53 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:43:53 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:43:53 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:43:53 INFO - Running setup.py install for mozrunner 21:43:53 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:43:53 INFO - Running setup.py install for mozscreenshot 21:43:53 INFO - Running setup.py install for moztest 21:43:53 INFO - Running setup.py install for mozversion 21:43:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:43:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:43:54 INFO - Cleaning up... 21:43:54 INFO - Return code: 0 21:43:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:43: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')]} 21:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:43:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43: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')]} 21:43:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:43:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43: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 0x7f1aa9e83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b98230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a7f0>, '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 0x1b962d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96760>, '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': '7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303', '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 21:43: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 21:43: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 21:43:54 INFO - Using env: {'DISPLAY': ':0', 21:43:54 INFO - 'HOME': '/home/cltbld', 21:43:54 INFO - 'LANG': 'en_US.UTF-8', 21:43:54 INFO - 'LANGUAGE': 'en_US:en', 21:43:54 INFO - 'LOGNAME': 'cltbld', 21:43:54 INFO - 'MAIL': '/var/mail/cltbld', 21:43:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:43:54 INFO - 'MOZ_NO_REMOTE': '1', 21:43:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:43:54 INFO - 'NO_EM_RESTART': '1', 21:43:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:43:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:43:54 INFO - 'PWD': '/builds/slave/test-pgo', 21:43:54 INFO - 'SHELL': '/bin/bash', 21:43:54 INFO - 'SHLVL': '1', 21:43:54 INFO - 'TERM': 'linux', 21:43:54 INFO - 'TMOUT': '86400', 21:43:54 INFO - 'USER': 'cltbld', 21:43:54 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303', 21:43:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:43:54 INFO - '_': '/tools/buildbot/bin/python'} 21:43:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:43:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:43:54 INFO - Running setup.py (path:/tmp/pip-MJyiIt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:43:54 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)) 21:43:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:43:54 INFO - Running setup.py (path:/tmp/pip-Ca6End-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:43:54 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)) 21:43:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:43:54 INFO - Running setup.py (path:/tmp/pip-N0EOE5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:43:54 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)) 21:43:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:43:54 INFO - Running setup.py (path:/tmp/pip-UEh3J7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:43:54 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)) 21:43:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:43:54 INFO - Running setup.py (path:/tmp/pip-BcoYAo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:43:54 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)) 21:43:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:43:54 INFO - Running setup.py (path:/tmp/pip-DbevCy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:43:54 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)) 21:43:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:43:54 INFO - Running setup.py (path:/tmp/pip-BOGSCb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:43:54 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)) 21:43:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:43:54 INFO - Running setup.py (path:/tmp/pip-y6PEDr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:43:54 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)) 21:43:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:43:54 INFO - Running setup.py (path:/tmp/pip-ezYlzh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:43:54 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)) 21:43:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:43:54 INFO - Running setup.py (path:/tmp/pip-7tOOsC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:43:54 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)) 21:43:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:43:54 INFO - Running setup.py (path:/tmp/pip-pQX8Gf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:43: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)) 21:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:43:55 INFO - Running setup.py (path:/tmp/pip-qxTrWF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:43: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)) 21:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:43:55 INFO - Running setup.py (path:/tmp/pip-J62TX4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:43: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)) 21:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:43:55 INFO - Running setup.py (path:/tmp/pip-dVNsWG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:43: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)) 21:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:43:55 INFO - Running setup.py (path:/tmp/pip-Uw1fqw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:43:55 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)) 21:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:43:55 INFO - Running setup.py (path:/tmp/pip-VFfJYm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:43:55 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)) 21:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:43:55 INFO - Running setup.py (path:/tmp/pip-e6srxZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:43:55 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)) 21:43:55 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)) 21:43:55 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)) 21:43:55 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)) 21:43:55 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)) 21:43:55 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)) 21:43:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:43:55 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 21:43:55 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 21:43:55 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 21:43:55 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 21:43:55 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 21:43:55 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 21:43:57 INFO - Downloading blessings-1.5.1.tar.gz 21:43: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 21:43:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:43:57 INFO - Installing collected packages: blessings 21:43:57 INFO - Running setup.py install for blessings 21:43:57 INFO - Successfully installed blessings 21:43:57 INFO - Cleaning up... 21:43:57 INFO - Return code: 0 21:43:57 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:43:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:43:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:43:57 INFO - Reading from file tmpfile_stdout 21:43:57 INFO - Current package versions: 21:43:57 INFO - argparse == 1.2.1 21:43:57 INFO - blessings == 1.5.1 21:43:57 INFO - blobuploader == 1.2.4 21:43:57 INFO - docopt == 0.6.1 21:43:57 INFO - manifestparser == 1.1 21:43:57 INFO - mozInstall == 1.12 21:43:57 INFO - mozcrash == 0.16 21:43:57 INFO - mozdebug == 0.1 21:43:57 INFO - mozdevice == 0.47 21:43:57 INFO - mozfile == 1.2 21:43:57 INFO - mozhttpd == 0.7 21:43:57 INFO - mozinfo == 0.9 21:43:57 INFO - mozleak == 0.1 21:43:57 INFO - mozlog == 3.1 21:43:57 INFO - moznetwork == 0.27 21:43:57 INFO - mozprocess == 0.22 21:43:57 INFO - mozprofile == 0.28 21:43:57 INFO - mozrunner == 6.11 21:43:57 INFO - mozscreenshot == 0.1 21:43:57 INFO - mozsystemmonitor == 0.0 21:43:57 INFO - moztest == 0.7 21:43:57 INFO - mozversion == 1.4 21:43:57 INFO - psutil == 3.1.1 21:43:57 INFO - requests == 1.2.3 21:43:57 INFO - wsgiref == 0.1.2 21:43:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:43:57 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')]} 21:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:43:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:57 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')]} 21:43:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:43:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:57 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 0x7f1aa9e83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b98230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a7f0>, '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 0x1b962d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96760>, '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': '7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303', '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 21:43:57 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 21:43:57 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 21:43:57 INFO - Using env: {'DISPLAY': ':0', 21:43:57 INFO - 'HOME': '/home/cltbld', 21:43:57 INFO - 'LANG': 'en_US.UTF-8', 21:43:57 INFO - 'LANGUAGE': 'en_US:en', 21:43:57 INFO - 'LOGNAME': 'cltbld', 21:43:57 INFO - 'MAIL': '/var/mail/cltbld', 21:43:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:43:57 INFO - 'MOZ_NO_REMOTE': '1', 21:43:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:43:57 INFO - 'NO_EM_RESTART': '1', 21:43:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:43:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:43:57 INFO - 'PWD': '/builds/slave/test-pgo', 21:43:57 INFO - 'SHELL': '/bin/bash', 21:43:57 INFO - 'SHLVL': '1', 21:43:57 INFO - 'TERM': 'linux', 21:43:57 INFO - 'TMOUT': '86400', 21:43:57 INFO - 'USER': 'cltbld', 21:43:57 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303', 21:43:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:43:57 INFO - '_': '/tools/buildbot/bin/python'} 21:43:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:43:57 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)) 21:43:57 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)) 21:43:57 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)) 21:43:57 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)) 21:43:57 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)) 21:43:57 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)) 21:43:57 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)) 21:43:57 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)) 21:43:57 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)) 21:43:57 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)) 21:43:57 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)) 21:43:57 INFO - Cleaning up... 21:43:57 INFO - Return code: 0 21:43:57 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 21:43:57 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')]} 21:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:43:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:57 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')]} 21:43:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:43:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:57 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 0x7f1aa9e83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b98230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a7f0>, '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 0x1b962d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96760>, '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': '7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303', '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 21:43:57 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 21:43:57 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 21:43:57 INFO - Using env: {'DISPLAY': ':0', 21:43:57 INFO - 'HOME': '/home/cltbld', 21:43:57 INFO - 'LANG': 'en_US.UTF-8', 21:43:57 INFO - 'LANGUAGE': 'en_US:en', 21:43:57 INFO - 'LOGNAME': 'cltbld', 21:43:57 INFO - 'MAIL': '/var/mail/cltbld', 21:43:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:43:57 INFO - 'MOZ_NO_REMOTE': '1', 21:43:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:43:57 INFO - 'NO_EM_RESTART': '1', 21:43:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:43:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:43:57 INFO - 'PWD': '/builds/slave/test-pgo', 21:43:57 INFO - 'SHELL': '/bin/bash', 21:43:57 INFO - 'SHLVL': '1', 21:43:57 INFO - 'TERM': 'linux', 21:43:57 INFO - 'TMOUT': '86400', 21:43:57 INFO - 'USER': 'cltbld', 21:43:57 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303', 21:43:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:43:57 INFO - '_': '/tools/buildbot/bin/python'} 21:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:43:58 INFO - Downloading/unpacking jsonschema 21:43: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 21:43: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 21:43: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 21:43: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 21:43: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 21:43: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 21:43:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:43:59 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 21:43:59 INFO - Downloading/unpacking functools32 (from jsonschema) 21:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:43:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:43:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:43:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:43:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:43:59 INFO - Downloading functools32-3.2.3-2.tar.gz 21:43:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 21:43:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 21:43:59 INFO - warning: no files found matching '*.txt' 21:43:59 INFO - no previously-included directories found matching 'build' 21:43:59 INFO - no previously-included directories found matching 'dist' 21:43:59 INFO - no previously-included directories found matching '.git*' 21:43:59 INFO - Installing collected packages: jsonschema, functools32 21:44:00 INFO - Running setup.py install for functools32 21:44:00 INFO - warning: no files found matching '*.txt' 21:44:00 INFO - no previously-included directories found matching 'build' 21:44:00 INFO - no previously-included directories found matching 'dist' 21:44:00 INFO - no previously-included directories found matching '.git*' 21:44:00 INFO - Successfully installed jsonschema functools32 21:44:00 INFO - Cleaning up... 21:44:00 INFO - Return code: 0 21:44:00 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 21:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1aa9e83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b98230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a7f0>, '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 0x1b962d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96760>, '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': '7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303', '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 21:44:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 21:44:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 21:44:00 INFO - Using env: {'DISPLAY': ':0', 21:44:00 INFO - 'HOME': '/home/cltbld', 21:44:00 INFO - 'LANG': 'en_US.UTF-8', 21:44:00 INFO - 'LANGUAGE': 'en_US:en', 21:44:00 INFO - 'LOGNAME': 'cltbld', 21:44:00 INFO - 'MAIL': '/var/mail/cltbld', 21:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:44:00 INFO - 'MOZ_NO_REMOTE': '1', 21:44:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:44:00 INFO - 'NO_EM_RESTART': '1', 21:44:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:44:00 INFO - 'PWD': '/builds/slave/test-pgo', 21:44:00 INFO - 'SHELL': '/bin/bash', 21:44:00 INFO - 'SHLVL': '1', 21:44:00 INFO - 'TERM': 'linux', 21:44:00 INFO - 'TMOUT': '86400', 21:44:00 INFO - 'USER': 'cltbld', 21:44:00 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303', 21:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:44:00 INFO - '_': '/tools/buildbot/bin/python'} 21:44:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:44:00 INFO - Downloading/unpacking flake8 21:44: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 21:44: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 21:44: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 21:44: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 21:44: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 21:44: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 21:44:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:44:02 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 21:44:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:44:02 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 21:44:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:02 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 21:44:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 21:44:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 21:44:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:44:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:44:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:44:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:44:02 INFO - no previously-included directories found matching 'docs/_build' 21:44:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:44:02 INFO - Running setup.py install for pep8 21:44:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:44:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:44:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:44:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:44:02 INFO - no previously-included directories found matching 'docs/_build' 21:44:02 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 21:44:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:44:02 INFO - Cleaning up... 21:44:03 INFO - Return code: 0 21:44:03 INFO - Running post-action listener: _resource_record_post_action 21:44:03 INFO - Running post-action listener: _start_resource_monitoring 21:44:03 INFO - Starting resource monitoring. 21:44:03 INFO - ##### 21:44:03 INFO - ##### Running install step. 21:44:03 INFO - ##### 21:44:03 INFO - Running pre-action listener: _resource_record_pre_action 21:44:03 INFO - Running main action method: install 21:44:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:44:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:44:03 INFO - Reading from file tmpfile_stdout 21:44:03 INFO - Detecting whether we're running mozinstall >=1.0... 21:44:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:44:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:44:03 INFO - Reading from file tmpfile_stdout 21:44:03 INFO - Output received: 21:44:03 INFO - Usage: mozinstall [options] installer 21:44:03 INFO - Options: 21:44:03 INFO - -h, --help show this help message and exit 21:44:03 INFO - -d DEST, --destination=DEST 21:44:03 INFO - Directory to install application into. [default: 21:44:03 INFO - "/builds/slave/test-pgo"] 21:44:03 INFO - --app=APP Application being installed. [default: firefox] 21:44:03 INFO - mkdir: /builds/slave/test-pgo/build/application 21:44:03 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'] 21:44:03 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 21:44:19 INFO - Reading from file tmpfile_stdout 21:44:19 INFO - Output received: 21:44:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:44:19 INFO - Running post-action listener: _resource_record_post_action 21:44:19 INFO - ##### 21:44:19 INFO - ##### Running run-tests step. 21:44:19 INFO - ##### 21:44:19 INFO - Running pre-action listener: _resource_record_pre_action 21:44:19 INFO - Running main action method: run_tests 21:44:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:44:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:44:19 INFO - Python 2.7.3 21:44:19 INFO - Return code: 0 21:44:19 INFO - grabbing minidump binary from tooltool 21:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:44:19 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 0x1c2a7f0>, '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 0x1b962d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:44:19 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 21:44:19 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 21:44:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:44:19 INFO - Return code: 0 21:44:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:44:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:44:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:44:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:44:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:44:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 21:44:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 21:44:20 INFO - Return code: 0 21:44:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2867KV8kTemM-uOeolihJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 21:44:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/2867KV8kTemM-uOeolihJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 21:44:20 INFO - Using env: {'DISPLAY': ':0', 21:44:20 INFO - 'HOME': '/home/cltbld', 21:44:20 INFO - 'LANG': 'en_US.UTF-8', 21:44:20 INFO - 'LANGUAGE': 'en_US:en', 21:44:20 INFO - 'LOGNAME': 'cltbld', 21:44:20 INFO - 'MAIL': '/var/mail/cltbld', 21:44:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:44:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:44:20 INFO - 'MOZ_NO_REMOTE': '1', 21:44:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:44:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:44:20 INFO - 'NO_EM_RESTART': '1', 21:44:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:44:20 INFO - 'PWD': '/builds/slave/test-pgo', 21:44:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:44:20 INFO - 'SHELL': '/bin/bash', 21:44:20 INFO - 'SHLVL': '1', 21:44:20 INFO - 'TERM': 'linux', 21:44:20 INFO - 'TMOUT': '86400', 21:44:20 INFO - 'USER': 'cltbld', 21:44:20 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303', 21:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:44:20 INFO - '_': '/tools/buildbot/bin/python'} 21:44:20 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2867KV8kTemM-uOeolihJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 21:44:20 INFO - mozversion application_buildid: 20151225193211 21:44:20 INFO - mozversion application_changeset: 57d8ddc976a6aa4abfdb5d7aa650b7884abfdaba 21:44:20 INFO - mozversion application_display_name: Nightly 21:44:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:44:20 INFO - mozversion application_name: Firefox 21:44:20 INFO - mozversion application_remotingname: firefox 21:44:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:44:20 INFO - mozversion application_vendor: Mozilla 21:44:20 INFO - mozversion application_version: 46.0a1 21:44:20 INFO - mozversion platform_buildid: 20151225193211 21:44:20 INFO - mozversion platform_changeset: 57d8ddc976a6aa4abfdb5d7aa650b7884abfdaba 21:44:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:44:20 INFO - mozversion platform_version: 46.0a1 21:44:20 INFO - using testdate: 1451108660 21:44:20 INFO - actual date: 1451108660 21:44:20 INFO - starting webserver on 'localhost:40375' 21:44:20 INFO - SUITE-START | Running 3 tests 21:44:20 INFO - TEST-START | dromaeo_css 21:44:20 INFO - operating with platform_type : linux_ 21:44:20 INFO - Initialising browser for dromaeo_css test... 21:44:20 INFO - TEST-INFO | started process 22892 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpo8PfPS/profile http://localhost:40375/getInfo.html) 21:44:24 INFO - PROCESS | 22892 | __metrics Screen width/height:1600/1200 21:44:24 INFO - PROCESS | 22892 | colorDepth:24 21:44:24 INFO - PROCESS | 22892 | Browser inner width/height: 1024/697 21:44:24 INFO - PROCESS | 22892 | __metrics 21:44:24 INFO - PROCESS | 22892 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:44:24 INFO - PROCESS | 22892 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:44:25 INFO - TEST-INFO | 22892: exit 0 21:44:25 INFO - Browser initialized. 21:44:25 INFO - Running cycle 1/1 for dromaeo_css test... 21:44:25 INFO - TEST-INFO | started process 22987 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpo8PfPS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:44:37 INFO - PROCESS | 22987 | RSS: Main: 150016000 21:44:37 INFO - PROCESS | 22987 | 21:45:28 INFO - PROCESS | 22987 | 1451108728312 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] 21:47:36 INFO - PROCESS | 22987 | Cycle 1(1): loaded http://localhost:40375/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40375/tests/dromaeo/cssquery-ext.html) 21:47:38 INFO - PROCESS | 22987 | RSS: Main: 285544448 21:47:38 INFO - PROCESS | 22987 | 21:50:40 INFO - PROCESS | 22987 | Cycle 1(1): loaded http://localhost:40375/tests/dromaeo/cssquery-ext.html (next: http://localhost:40375/tests/dromaeo/cssquery-jquery.html) 21:50:41 INFO - PROCESS | 22987 | RSS: Main: 233869312 21:50:41 INFO - PROCESS | 22987 | 21:53:42 INFO - PROCESS | 22987 | Cycle 1(1): loaded http://localhost:40375/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40375/tests/dromaeo/cssquery-mootools.html) 21:53:43 INFO - PROCESS | 22987 | RSS: Main: 222601216 21:53:43 INFO - PROCESS | 22987 | 21:56:45 INFO - PROCESS | 22987 | Cycle 1(1): loaded http://localhost:40375/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40375/tests/dromaeo/cssquery-prototype.html) 21:56:45 INFO - PROCESS | 22987 | RSS: Main: 208441344 21:56:45 INFO - PROCESS | 22987 | 21:59:48 INFO - PROCESS | 22987 | Cycle 1(1): loaded http://localhost:40375/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40375/tests/dromaeo/cssquery-yui.html) 21:59:49 INFO - PROCESS | 22987 | RSS: Main: 215183360 21:59:49 INFO - PROCESS | 22987 | 22:02:51 INFO - PROCESS | 22987 | Cycle 1(1): loaded http://localhost:40375/tests/dromaeo/cssquery-yui.html (next: http://localhost:40375/tests/dromaeo/cssquery-dojo.html) 22:02:52 INFO - PROCESS | 22987 | RSS: Main: 237088768 22:02:52 INFO - PROCESS | 22987 | 22:02:52 INFO - PROCESS | 22987 | __start_tp_report 22:02:52 INFO - PROCESS | 22987 | _x_x_mozilla_page_load 22:02:52 INFO - PROCESS | 22987 | _x_x_mozilla_page_load_details 22:02:52 INFO - PROCESS | 22987 | |i|pagename|runs| 22:02:52 INFO - PROCESS | 22987 | |0;dojo.html;3062.9540556891643;3087.3207894263255;3131.6085489313837;3135.1848519384966;3163.256634690847;5019.774110165043;5084.822031228908;5105.030044291587;5111.6166287528395;5140.408852981904;5064;5087.211482220253;5105.438401775802;5180.637355385115;5259.789608415659;4724.078804633098;4745.240761478164;4761.880952976186;4803.63972702047;4864;375.58391211605056;4564.292534657116;4716.127516409475;4742.099001189763;4819.180739274314;4645.488996210414;4674.135284972274;4754.0967216229155;4776.9283460747765;4780.3307536944685;4721.622270218409;4723.008168284664;4725.10223057618;4729.810807567693;4766.6901651392545;4554.3851580036935;4694.906101877978;4718.575328220442;4721.6458765592715;4766.189747742892;4887.780049897728;4932.284818701304;4989.027139707759;5008.699478031293;5016.072026675077;5541.667499950016;5543.085390910495;5549.472800083986;5550;5555.166724991243;5291.1798671206025;5570.415106413809;5578.693171875545;5585.832425027255;5607.831765047055;5132.820351287724;5145.073886700392;5243.737813109329;5250.44870288618;5256.789728410859;5636.830895073154;5637.830865073973;5638.182463542763;5651.745671444794;5704.286964129484;5424.294841670558;5452.972735136299;5453.23654688344;5458.426865179178;5498.147787093007;5348.5186333230195;5440.510354068153;5488.094464413327;5493.423190565013;5574.832755017356;5478.890422191534;5524.66851988882;5525.751341189656;5560.388357280696;5570.220169176318;5513.9448605513435;5518.66887986714;5522.088855338824;5524.33707955048;5529.612927095145;4185.142045880648;4230.830766769356;4248.299030659907;4285.957140428618;4332.458442694663;3869.9226015479535;3871.477350557695;3876.127871228951;3906.9609303906595;3907.667848232932;5170.71561064145;5173.508516690908;5175.353080864892;5185.870353241124;5222.3472065991755;5393.110136827379;5431.131019036935;5488.094464413407;5574.749136288877;5585.301837270341;5063.670861394071;5066.290719299301;5089.465606111379;5091.7963281469065;5129.769160387791;4795.256735205979;4799.592034677022;4800.207965685692;4806.375171227718;4845.1278769821065;5586.16207568868;5695.686737229492;5700.201971723962;5708.286464191976;5721.8569535761935;5500.669959802424;5586.804461843816;5589.664620122806;5591.4688104629995;5633.211350410864;5734.22587950638;5734.885302294014;5736.110902810071;5737;5739.397363276796;5314.176302673091;5396.568274537949;5403.13549832025;5496.697681627389;5512.724363781875;5550.722463876871;5589.916151257816;5603.663780173202;5609.467100625434;5655.179998900218;5337.653052551572;5359.624826262124;5365.275687782256;5383.084875571084;5389.649672771257;5271.288376069181;5346.812861549983;5370.704611246263;5398.08232600451;5408.648437851527;5374.57003439716;5376.1398176291605;5381.704006279536;5385.784568617368;5390.757415916215;5467.371252306036;5477.397486276427;5479.643823151642;5480.761095156746;5534.418886016911;5211.218317252443;5289.814856480005;5296.523312901857;5341;5432.0765469871 22:02:52 INFO - PROCESS | 22987 | |1;ext.html;535.4077149147905;568.690063915166;590.9911351329728;594.732370433305;600.6546235914349;29003;29815.850920745394;29833;37227;37681.246375072486;39933.20133597327;40904.18191636165;40935;40936.795316023454;40944.59055409445;8491.957540212306;8642.827143457158;8670.046294907586;8673.913260867404;8674.566271686423;7538.623068846536;7673.539587624732;10319.48402579868;10497.895021049806;10544.841827372595;10176.542055607479;10240.846387304196;10253.589856405735;10256.53845576947;10263.846042309371;7426.405887528985;7563.886541701879;10201.132903703194;10290.742731431737;10300.433476158809;10229.744256393575;10420.426876521788;10430.113440357578;10437.478126093742;10446.059854613046;37104.25791484155;37529.81235093807;37554;37560.62439375626;37650.43524347137;3285.2772390074147;3297.3405318936307;3387.9322413551836;3438.535797667333;3645.398509245971;25139.24582262535;25245.873770631213;25450;26372.208833735018;26643.467130657278;3923.7479036627633;3968.1071758854314;3971.185906889081;4033.556308806029;4094.529129150156;192484.0375798112;193803;193841;194155.02922485437;194318;54708.72645636826;55497.72251138799;60299.698501508086;60673;60898.39101609016;56569;56690;56915.715421423454;56994.43005569974;57004.159500860165;13782.586522404345;13968.441262349392;14021.719565608631;14029.719405611831;14040;10251.897481025095;10323.32898361604;10367.118794902366;10377.429241391796;10381.11760500366;19412.902935485232;20283;20400;20542.79457205409;20555.38333849987;7222.349988501061;7423.85152296951;7504.474686771873;7583.5070720403;7584.5070070445245;923.3859483443434;943.4763706143157;961.245422343457;985.7190700650281;1075.473018221066;25810.354741131247;26117.869410652824;29161.708382916324;29294.707052929625;29983;963.9518024098767;1029.8661174047477;1054.1040115901421;1079.9794194486135;1084.6800193942806;13959.930200348934;13960.162390256617;13999.44002239899;14150.858491414954;14207.147571145764;313726;319876;320174;320894;321933;53328.20007699887;53576;53582.73208633932;53648.46351536435;53667.463325367025;1310.168043292497;1316.5721140629335;1321.4582021371384;1321.8017297405274;1329.9202047877159;25242.74757252404;26640.866795665897;27687.58468622932;29078.7092129076;29431.55852662169;42016;42603;42613.14773704571;42614.78692606517;42632.36051459169;245504;246517;246920;246938;247221;28236.43527129405;28788;33980.32039359248;34059.82970085134;34430.65569344274;40460;41024.384634229915;41415.58584414118;41471.37792933169;41825.372619410125;34064.31871362509;35621.64378356287;35735.28529429449;35979.46030809487;36500.45249321315;35166.12084697903;35946.4608030885;36000.8199959009;36092.45861312135;36377.636223637426;34642.307153857284;35047.824760877054;35405.46891796677;35460.64539354573;35579.46630800592;30335;31507.36985260328;32488.837555812068;32661.673383265865;32669.346613068083;24687;25011.249662510152;25067;25373.492530148924;25379.61930571006 22:02:52 INFO - PROCESS | 22987 | |2;jquery.html;327.53653580184033;332.76041250299784;335.3377080266474;345.4231433506046;346.9791812491249;16139.435119770811;16320;17749.290028398882;18118.184681689323;18122.275108995625;16597;16930.40743573975;17017.744733829004;17218;17220.483385498424;5171.637985341028;5320.866978325544;5372.301600791891;5445.128779395298;5446;5252.8424147275455;5271.551918086948;5324.946750532503;5331.040412725708;5331.067063263933;3912.8826135215845;4008.2384346974127;5283.392409872856;5293.8941221175555;5712.086066229404;5798.362180160179;5817.709114544298;5859.824205273849;5864.23764910561;5868.471837534621;5032.597392208614;5121.641485096045;5134.922976155361;5138.845834624967;5156.613254005964;15456.690866182726;15889.28498217583;18260.178291976892;18875.90562047181;19518;1941.8931958742264;2173.217641649005;2190.0582749417745;2354.7409784923816;2375.89520872795;13045.54340598084;13054.477820887154;13116.540921067812;13170.143940643828;13342.533011344653;1827.844633206179;1854.2026928420773;1876.6152938647544;1885.3118611706766;1977.821996020365;58763.70618146882;59134.40865591332;60790;61147;61305;9388.295877809192;9485.193758530602;9735.367201131903;9738;9804.117629413244;12571.74856502883;12681;12692.238465692088;12718.300493472763;12727.10910236293;6917.100776898971;7136.607486588184;7147.53541019832;7209.6395180241825;7213;6500.70746816385;6553.377429144223;6602.8349291268105;6772.966135169293;6868.072810170563;4327.069680018811;4345.543717909574;4351.4995775485595;4379;4388.978055109768;1774.7071733164141;1786.455131184975;1791.3819732192374;1819.1177279019664;1821.2805941653237;825.4551995682821;856.1181982557976;871.2333146830748;894.280104515871;932.1796818799548;15258.389664413522;16020.679586408207;17108.48674539766;17196;17315.653686926442;827.903640384968;920.6961702638114;932.883389576303;933.8552524358736;1012.377387906447;8874.511901845332;9517.5717092731;9576.281778866613;10038;10427.322224055411;380105;382564;387738;388251;547935;41258.793706031276;41505.792471038054;58545.12182317269;64080.679596601716;70218.29781702219;1104.17738784606;1121.9495122719497;1122.4948773052158;1126.774645070989;1135.8750537440874;14906.32921518556;15539.922300388425;15554.533363999099;15881.761773573637;16172.676546468769;32247.35505289834;32283.19292017718;32481.07384695254;33426.16434589155;35872.8206358977;41794.79102604467;43123.353149703406;44278.11443771042;44426.11147777091;44490.77754611206;9619.807603847745;9714.3199976001;9728;9812.901870981199;9819.803603927738;15126.319315630602;17135;18217.544561386072;18245;18462.723059154392;10840.566377345134;13872.514461993782;14276.21480818565;14430.12408386903;14882.330295136528;13615.659608509866;13725;13881.861181388056;14388.20864852443;14451;15119.622009449851;15149.848501515286;15355.769663454834;15641.92179039143;15710;9095.818083638158;9610.567524461556;9791.559379828068;9817.754556135867;9849.26130540198;10206.183505319408;10242.436665983443;13506.662333441349;13959.511417100353;14131.64670883195 22:02:52 INFO - PROCESS | 22987 | |3;mootools.html;1306.5427100514828;1412.4703236286393;1422.2675322209063;1527.3432424057657;1711.152979275259;6052.334243233241;6581.70382332795;6596.637184954826;6659.966700166505;6681.799546013622;6532.183477065367;6670.399664030237;6678.065070890068;6680.966595167018;6682.766103186389;1889.5370634194642;1926;2120.6076875777953;2121.0561300221407;2156.9892150539304;2175.869447833135;2180.3458962311324;2183.224955140926;2184.137265780016;2184.159098746978;2117.2272120676;2171.5005548723802;2176.880271585062;2177.2814971059593;2177.3685631167023;1886.1041005522336;1922.9903850480728;2114.661654135331;2154.91380344786;2166.1876796201423;2054.9178032878667;2059.4439501334555;2077.1276064053136;2081.6773400123006;2152.461884528868;6671.5997040177745;6736.865262694768;6744.561603495807;6749.763758268437;6750.493712971547;4196.139791342767;4253.447051883235;4259.914801703949;4266.253405654029;4272.636825869805;2804.579313103051;2860;2882.7261410166;2886.422715456917;2936.9853150734325;978.9412635241837;995.5221493683073;1015.9593616255415;1017.2726500552067;1056.2553399853084;8776.868346974801;8801.911980880237;8809.691660791905;8812;8849.513276769776;3792.1088544192094;3903.4730311408166;3935.704822138351;3960.980195099006;3986.880393588197;7664.808379790438;7670.501417407851;7672.079350477867;7674.386049116058;7681.039870016248;4274.487061552633;4300.0969796343115;4326.891827704332;4329.826806927751;4331.5451877552405;3972.2651309507833;3972.7616343019513;3973.324534829086;3979.641832235113;3981.3828856527284;3417.333619944087;3422.418188907892;3429.9314013720086;3430.485427185942;3472.5138480612736;1111.766529028913;1126.9211155219057;1130.46867972053;1131.7340425000118;1132.2923173016864;954.479808504353;1272.3320256865036;1273.3951373097889;1290.832191815058;1294.5533790842144;5759.596828221985;6454.741810327534;6544.672766361663;6557.967210163919;6558.344165583403;584.2647337407892;588.5174157191148;596.4900010491054;627.4854619212293;627.8399008252866;4995.475475075064;5003.7998480061115;5011.7494125294315;5029.446760856303;5036.974815125901;7591.354734847489;7628.313451789255;7699.576523291273;7718.035245594301;7866.410019248579;7723.729669461542;7810.258025487569;7827.356255186361;7829.491083079582;7829.530228186327;6247.687615619201;6283.088952102011;6335.841603959846;6365.713542890581;6404.935950640527;6400.231972163184;6408.327125651739;6446.161998940108;6456.160699109086;6456.806295811133;7197.280271972761;7237.8914316284245;7321.963390183015;7338.266173382619;7383.261673832574;7114.537555058904;7192.784216473514;7193.676284567103;7532.924670753222;7547.0943486781935;6140.662263575367;6161.260648722182;6165.506759459143;6198.690065496798;6213.813585592439;6546.410823025951;6598.175228096488;6632.966835165793;6638.070670106285;6656.500762442739;6115.663638499747;6206.379362063757;6255.46828519581;6277.780277690442;6396.872062558816;6261.499080073674;6267.122602835516;6294.622322660472;6306.432421082125;6423.42189202974;5632.183333416549;5723.198752174782;6180.258368995749;6186.969065154645;6218.253809542884;5668.603197776116;5768.94231057684;5785.8553536161935;5799;5801.158831969256;5757.769689212385;5764.682942438206;5782.913256301074;5783.103618938903;5789.9710501447225 22:02:52 INFO - PROCESS | 22987 | |4;prototype.html;331.28773137753825;333.3782495645621;341.249251646378;344.1585323883106;346.9028671971847;5887.8528036799;6000.969995150029;6023;6054.122152287916;6074;5802.65184088955;5895.056790913454;5918.7632494700265;5920.289565252176;5970.820875373734;4612.446506419226;4615.192341340269;4620.399348084761;4622.491525932145;4630.819141119026;4408.86773396797;4499.1001799640035;4505.031418245077;4625.676202665814;4635.837745678902;4572.359869618256;4584.908301833978;4588.862334129982;4600.769961501928;4604.263317869141;4575.633949284049;4581.335706322598;4595.862124136282;4597.448306203243;4614.100250451163;4042.3532234842282;4051.9392209116886;4053.695972802022;4058.7767672777986;4071.1043570414463;5621.494065534081;5694;5696.829095127153;5709.600327977043;5736.799212027559;5365.7585408656705;5381.112116500773;5393.2719082923695;5395.190721391783;5400.487863398254;6048.909266361008;6340.3659634036685;6368.872622547523;6371.458426033792;6378.138951241569;4329.458817647794;4347.304431290978;4385.298352263622;4402.163588918127;4406.1187762447635;6551.148350714424;6618.271990081135;6619.801405957781;6624.701888415081;6629.237637671633;4597.172508948422;4599.08018396322;4600.5629465200755;4600.769961501912;4605.078984203173;4341.6526677865695;4432.556744325541;4459.9331010034875;4662.696924699883;4671.789769460383;5169.793208271627;5203.245529398216;5205.5315021647475;5213.2701421800975;5230.163173892159;6407.615543067431;6411.1024456576115;6411.6153030818305;6411.711472983727;6416.711247993851;1569.8351673074392;1604.8796340274525;1604.903705777657;1605.4220480626966;1607.4534658216028;1038.7558923652934;1053.0890779475699;1054.4516851237313;1063.6330465989377;1093.781243751253;6011.609245399035;6021.277446706424;6026.5178785697035;6035.275766907999;6037.63774173551;6596.868062638816;6600.2409722882485;6601.636909969901;6603;6604.14146160996;5878.29460464747;6007.909881351783;6015.368386319461;6040.855496298751;6043.7280322385595;3479.860805567749;3577.4276115821344;3578.1054736315923;3581.230035542371;3585.462180672868;6804.11546498952;6810.9318906810295;6811.080504131879;6900.792976210621;6906.37842594169;6805.9659701701175;6811.761588344384;6811.897821532681;6814.557053791487;6820.454363650896;6687.799366019027;6921.826954326182;6929;6932;6938.063361446241;6396.008618664115;6470.352964703492;6556.377144171296;6662.333766623493;6663.533552651268;6529.902051469327;6576.079348891063;6587.176602924635;6605.174353205849;6633.867322653424;6886.208086070166;6896.655167241517;6903.965480172567;6905.205901321412;6910.861782764216;4355.934660980024;4456.220161471794;4480.61914737251;4508.413906192305;4510.097980403998;6557.311482294481;6608.603483790988;6614.801555953329;6623.3376662333385;6628.701708423229;6431.260405053292;6456.386643268882;6460.838479038061;6465.741370345321;6476.417122459001;6301.747930082745;6448.580842245239;6456.903146452713;6464.321246269262;6504.772332968323;6380.425761681471;6384.680765961776;6388.680565971776;6390.808275751735;6390.90413643805;6521;6532;6534.248561415498;6538.378854008862;6538.869222615616;6209.720562574786;6344.413896525869;6369.777057802955;6373.458256048288;6375.776847810304 22:02:52 INFO - PROCESS | 22987 | |5;yui.html;781.6326326626483;852.518327145163;852.6163226548053;858.3305022082774;875.4003507597296;12739.299338536377;12952.093353465261;12980.675483112927;12981.286029268398;12990;12451.68870778231;12846;12953.611391658242;12990.610281691565;12993.220406775576;696.9581825090486;703.7994171661078;834.4534330013851;847.0597636623343;847.6609356257485;833.8832563441123;848.817504236589;855.482433127958;856.1481326080559;856.5588721808274;881.6781874615751;883.3860466975455;889.89321281446;892.848215803315;894.5124906925741;724.5290561135278;733.4022771441258;869.882565853608;890.3366991591273;897.712731925784;637.1303171171364;637.2957881540877;639.7920675780343;642.8328634555003;642.8360768004129;13639.113457625223;13761.793573096411;13769.380377883019;13774.380152893144;13784.931075344559;12111.878881211163;12117;12343.814842777365;12761.744765104646;13040.282784446852;10430.113440357578;10702.143828493701;10763.515641796137;10813.513391897384;10963.397013164273;3699.907502312437;3772.6604605585353;3784.432335149722;3814.6376094271;3895.4935858338235;48866.7556662218;49106.50893491055;49720;49889.75055124737;49919.75040124812;10548.156147508182;10860.782784344427;10868.293560918673;11016.283941543774;11395.430228488542;18837.905810471133;18933.526661833563;18948.336808211923;18994.430167095008;18996.62006759857;7823.100343460461;7833.64748586315;7835.608219588998;7889.526628402315;7922.683092676343;4205.3902184183125;4236.661067114624;4240.151969606091;4324.459442569679;4337.15425492026;3094.4739394302574;3119.750419966397;3126.5466507356305;3134.3104517006223;3145.229418792365;570.0622476026996;571.6970005896882;580.7473748919234;583.381615487576;595.7200115945499;630.2059405149453;675.3651567526509;684.4626967830329;691.2361840166644;692.4771797293012;8177.9591102044105;8626.309895208367;8908.73273801787;9020.097990201059;9166.069009482842;536.2010604199714;552.4696291560148;553.748044639696;604.7550741949517;619.9597026193283;3841.3853783394525;3908.5700572936953;3919;3989.7007724420205;4016.2569924563463;52587.47412525826;52723;52911;53197.734011329696;56297.718511408;47515.922293210235;48771.26843097356;49219;49471.25793113106;49719.25421118686;44356.3346549802;44613;44641.77679111584;44897.32654010192;45466.77266613646;8603.870941935751;8803.295736341206;8844.70859469748;8876.822463550821;9060;33733.32533349368;34058.65941340654;34273;34355.65644343525;34473.138171545914;45269.77365113285;45863.31205031861;45898.08203835972;46068.30897536607;46311.305330419396;10901.65161419072;11192.384418856715;11310.886891130984;11367.431628418712;11448.599299024494;12092.153549251469;12337.93831030875;12476.563320283747;12554.121211515107;12682.87317126817;11691.590794322157;11886.34625095628;11958;12013.63959081229;12272.325022123869;10975.341479511255;11447.713807154554;11507.424628768695;11755.823662645238;11830.231034982698;10562;10846.132309415385;11084.224104312943;11280.943595281971;11449.42752862337;9816.65641702537;10038.498075096362;10143;10391.740206494898;10417.531211095367;7932.206779322021;7988.201179881965;8296.585170741559;8338.166183381612;8657.783555411164 22:02:52 INFO - PROCESS | 22987 | __end_tp_report 22:02:52 INFO - PROCESS | 22987 | __start_cc_report 22:02:52 INFO - PROCESS | 22987 | _x_x_mozilla_cycle_collect,909 22:02:52 INFO - PROCESS | 22987 | __end_cc_report 22:02:52 INFO - PROCESS | 22987 | __startTimestamp1451109772099__endTimestamp 22:02:52 INFO - PROCESS | 22987 | 22:02:52 INFO - PROCESS | 22987 | ------- Summary: start ------- 22:02:52 INFO - PROCESS | 22987 | Number of tests: 6 22:02:52 INFO - PROCESS | 22987 | 22:02:52 INFO - PROCESS | 22987 | [#0] dojo.html Cycles:165 Average:5110.88 Median:5341.00 stddev:668.78 (12.5%) stddev-sans-first:651.25 22:02:52 INFO - PROCESS | 22987 | Values: 3063.0 3087.3 3131.6 3135.2 3163.3 5019.8 5084.8 5105.0 5111.6 5140.4 5064.0 5087.2 5105.4 5180.6 5259.8 4724.1 4745.2 4761.9 4803.6 4864.0 375.6 4564.3 4716.1 4742.1 4819.2 4645.5 4674.1 4754.1 4776.9 4780.3 4721.6 4723.0 4725.1 4729.8 4766.7 4554.4 4694.9 4718.6 4721.6 4766.2 4887.8 4932.3 4989.0 5008.7 5016.1 5541.7 5543.1 5549.5 5550.0 5555.2 5291.2 5570.4 5578.7 5585.8 5607.8 5132.8 5145.1 5243.7 5250.4 5256.8 5636.8 5637.8 5638.2 5651.7 5704.3 5424.3 5453.0 5453.2 5458.4 5498.1 5348.5 5440.5 5488.1 5493.4 5574.8 5478.9 5524.7 5525.8 5560.4 5570.2 5513.9 5518.7 5522.1 5524.3 5529.6 4185.1 4230.8 4248.3 4286.0 4332.5 3869.9 3871.5 3876.1 3907.0 3907.7 5170.7 5173.5 5175.4 5185.9 5222.3 5393.1 5431.1 5488.1 5574.7 5585.3 5063.7 5066.3 5089.5 5091.8 5129.8 4795.3 4799.6 4800.2 4806.4 4845.1 5586.2 5695.7 5700.2 5708.3 5721.9 5500.7 5586.8 5589.7 5591.5 5633.2 5734.2 5734.9 5736.1 5737.0 5739.4 5314.2 5396.6 5403.1 5496.7 5512.7 5550.7 5589.9 5603.7 5609.5 5655.2 5337.7 5359.6 5365.3 5383.1 5389.6 5271.3 5346.8 5370.7 5398.1 5408.6 5374.6 5376.1 5381.7 5385.8 5390.8 5467.4 5477.4 5479.6 5480.8 5534.4 5211.2 5289.8 5296.5 5341.0 5432.1 22:02:52 INFO - PROCESS | 22987 | 22:02:52 INFO - PROCESS | 22987 | [#1] ext.html Cycles:180 Average:42371.56 Median:17977.31 stddev:67480.41 (375.4%) stddev-sans-first:67596.60 22:02:52 INFO - PROCESS | 22987 | Values: 535.4 568.7 591.0 594.7 600.7 29003.0 29815.9 29833.0 37227.0 37681.2 39933.2 40904.2 40935.0 40936.8 40944.6 8492.0 8642.8 8670.0 8673.9 8674.6 7538.6 7673.5 10319.5 10497.9 10544.8 10176.5 10240.8 10253.6 10256.5 10263.8 7426.4 7563.9 10201.1 10290.7 10300.4 10229.7 10420.4 10430.1 10437.5 10446.1 37104.3 37529.8 37554.0 37560.6 37650.4 3285.3 3297.3 3387.9 3438.5 3645.4 25139.2 25245.9 25450.0 26372.2 26643.5 3923.7 3968.1 3971.2 4033.6 4094.5 192484.0 193803.0 193841.0 194155.0 194318.0 54708.7 55497.7 60299.7 60673.0 60898.4 56569.0 56690.0 56915.7 56994.4 57004.2 13782.6 13968.4 14021.7 14029.7 14040.0 10251.9 10323.3 10367.1 10377.4 10381.1 19412.9 20283.0 20400.0 20542.8 20555.4 7222.3 7423.9 7504.5 7583.5 7584.5 923.4 943.5 961.2 985.7 1075.5 25810.4 26117.9 29161.7 29294.7 29983.0 964.0 1029.9 1054.1 1080.0 1084.7 13959.9 13960.2 13999.4 14150.9 14207.1 313726.0 319876.0 320174.0 320894.0 321933.0 53328.2 53576.0 53582.7 53648.5 53667.5 1310.2 1316.6 1321.5 1321.8 1329.9 25242.7 26640.9 27687.6 29078.7 29431.6 42016.0 42603.0 42613.1 42614.8 42632.4 245504.0 246517.0 246920.0 246938.0 247221.0 28236.4 28788.0 33980.3 34059.8 34430.7 40460.0 41024.4 41415.6 41471.4 41825.4 34064.3 35621.6 35735.3 35979.5 36500.5 35166.1 35946.5 36000.8 36092.5 36377.6 34642.3 35047.8 35405.5 35460.6 35579.5 30335.0 31507.4 32488.8 32661.7 32669.3 24687.0 25011.2 25067.0 25373.5 25379.6 22:02:52 INFO - PROCESS | 22987 | 22:02:52 INFO - PROCESS | 22987 | [#2] jquery.html Cycles:180 Average:24577.96 Median:346.20 stddev:68907.08 (19903.8%) stddev-sans-first:69076.33 22:02:52 INFO - PROCESS | 22987 | Values: 327.5 332.8 335.3 345.4 347.0 16139.4 16320.0 17749.3 18118.2 18122.3 16597.0 16930.4 17017.7 17218.0 17220.5 5171.6 5320.9 5372.3 5445.1 5446.0 5252.8 5271.6 5324.9 5331.0 5331.1 3912.9 4008.2 5283.4 5293.9 5712.1 5798.4 5817.7 5859.8 5864.2 5868.5 5032.6 5121.6 5134.9 5138.8 5156.6 15456.7 15889.3 18260.2 18875.9 19518.0 1941.9 2173.2 2190.1 2354.7 2375.9 13045.5 13054.5 13116.5 13170.1 13342.5 1827.8 1854.2 1876.6 1885.3 1977.8 58763.7 59134.4 60790.0 61147.0 61305.0 9388.3 9485.2 9735.4 9738.0 9804.1 12571.7 12681.0 12692.2 12718.3 12727.1 6917.1 7136.6 7147.5 7209.6 7213.0 6500.7 6553.4 6602.8 6773.0 6868.1 4327.1 4345.5 4351.5 4379.0 4389.0 1774.7 1786.5 1791.4 1819.1 1821.3 825.5 856.1 871.2 894.3 932.2 15258.4 16020.7 17108.5 17196.0 17315.7 827.9 920.7 932.9 933.9 1012.4 8874.5 9517.6 9576.3 10038.0 10427.3 380105.0 382564.0 387738.0 388251.0 547935.0 41258.8 41505.8 58545.1 64080.7 70218.3 1104.2 1121.9 1122.5 1126.8 1135.9 14906.3 15539.9 15554.5 15881.8 16172.7 32247.4 32283.2 32481.1 33426.2 35872.8 41794.8 43123.4 44278.1 44426.1 44490.8 9619.8 9714.3 9728.0 9812.9 9819.8 15126.3 17135.0 18217.5 18245.0 18462.7 10840.6 13872.5 14276.2 14430.1 14882.3 13615.7 13725.0 13881.9 14388.2 14451.0 15119.6 15149.8 15355.8 15641.9 15710.0 9095.8 9610.6 9791.6 9817.8 9849.3 10206.2 10242.4 13506.7 13959.5 14131.6 22:02:52 INFO - PROCESS | 22987 | 22:02:52 INFO - PROCESS | 22987 | [#3] mootools.html Cycles:180 Average:4784.65 Median:586.39 stddev:2354.17 (401.5%) stddev-sans-first:2346.26 22:02:52 INFO - PROCESS | 22987 | Values: 1306.5 1412.5 1422.3 1527.3 1711.2 6052.3 6581.7 6596.6 6660.0 6681.8 6532.2 6670.4 6678.1 6681.0 6682.8 1889.5 1926.0 2120.6 2121.1 2157.0 2175.9 2180.3 2183.2 2184.1 2184.2 2117.2 2171.5 2176.9 2177.3 2177.4 1886.1 1923.0 2114.7 2154.9 2166.2 2054.9 2059.4 2077.1 2081.7 2152.5 6671.6 6736.9 6744.6 6749.8 6750.5 4196.1 4253.4 4259.9 4266.3 4272.6 2804.6 2860.0 2882.7 2886.4 2937.0 978.9 995.5 1016.0 1017.3 1056.3 8776.9 8801.9 8809.7 8812.0 8849.5 3792.1 3903.5 3935.7 3961.0 3986.9 7664.8 7670.5 7672.1 7674.4 7681.0 4274.5 4300.1 4326.9 4329.8 4331.5 3972.3 3972.8 3973.3 3979.6 3981.4 3417.3 3422.4 3429.9 3430.5 3472.5 1111.8 1126.9 1130.5 1131.7 1132.3 954.5 1272.3 1273.4 1290.8 1294.6 5759.6 6454.7 6544.7 6558.0 6558.3 584.3 588.5 596.5 627.5 627.8 4995.5 5003.8 5011.7 5029.4 5037.0 7591.4 7628.3 7699.6 7718.0 7866.4 7723.7 7810.3 7827.4 7829.5 7829.5 6247.7 6283.1 6335.8 6365.7 6404.9 6400.2 6408.3 6446.2 6456.2 6456.8 7197.3 7237.9 7322.0 7338.3 7383.3 7114.5 7192.8 7193.7 7532.9 7547.1 6140.7 6161.3 6165.5 6198.7 6213.8 6546.4 6598.2 6633.0 6638.1 6656.5 6115.7 6206.4 6255.5 6277.8 6396.9 6261.5 6267.1 6294.6 6306.4 6423.4 5632.2 5723.2 6180.3 6187.0 6218.3 5668.6 5768.9 5785.9 5799.0 5801.2 5757.8 5764.7 5782.9 5783.1 5790.0 22:02:52 INFO - PROCESS | 22987 | 22:02:52 INFO - PROCESS | 22987 | [#4] prototype.html Cycles:180 Average:5343.77 Median:6018.32 stddev:1623.52 (27.0%) stddev-sans-first:1583.88 22:02:52 INFO - PROCESS | 22987 | Values: 331.3 333.4 341.2 344.2 346.9 5887.9 6001.0 6023.0 6054.1 6074.0 5802.7 5895.1 5918.8 5920.3 5970.8 4612.4 4615.2 4620.4 4622.5 4630.8 4408.9 4499.1 4505.0 4625.7 4635.8 4572.4 4584.9 4588.9 4600.8 4604.3 4575.6 4581.3 4595.9 4597.4 4614.1 4042.4 4051.9 4053.7 4058.8 4071.1 5621.5 5694.0 5696.8 5709.6 5736.8 5365.8 5381.1 5393.3 5395.2 5400.5 6048.9 6340.4 6368.9 6371.5 6378.1 4329.5 4347.3 4385.3 4402.2 4406.1 6551.1 6618.3 6619.8 6624.7 6629.2 4597.2 4599.1 4600.6 4600.8 4605.1 4341.7 4432.6 4459.9 4662.7 4671.8 5169.8 5203.2 5205.5 5213.3 5230.2 6407.6 6411.1 6411.6 6411.7 6416.7 1569.8 1604.9 1604.9 1605.4 1607.5 1038.8 1053.1 1054.5 1063.6 1093.8 6011.6 6021.3 6026.5 6035.3 6037.6 6596.9 6600.2 6601.6 6603.0 6604.1 5878.3 6007.9 6015.4 6040.9 6043.7 3479.9 3577.4 3578.1 3581.2 3585.5 6804.1 6810.9 6811.1 6900.8 6906.4 6806.0 6811.8 6811.9 6814.6 6820.5 6687.8 6921.8 6929.0 6932.0 6938.1 6396.0 6470.4 6556.4 6662.3 6663.5 6529.9 6576.1 6587.2 6605.2 6633.9 6886.2 6896.7 6904.0 6905.2 6910.9 4355.9 4456.2 4480.6 4508.4 4510.1 6557.3 6608.6 6614.8 6623.3 6628.7 6431.3 6456.4 6460.8 6465.7 6476.4 6301.7 6448.6 6456.9 6464.3 6504.8 6380.4 6384.7 6388.7 6390.8 6390.9 6521.0 6532.0 6534.2 6538.4 6538.9 6209.7 6344.4 6369.8 6373.5 6375.8 22:02:52 INFO - PROCESS | 22987 | 22:02:52 INFO - PROCESS | 22987 | [#5] yui.html Cycles:180 Average:13702.77 Median:44627.39 stddev:15531.98 (34.8%) stddev-sans-first:15545.24 22:02:52 INFO - PROCESS | 22987 | Values: 781.6 852.5 852.6 858.3 875.4 12739.3 12952.1 12980.7 12981.3 12990.0 12451.7 12846.0 12953.6 12990.6 12993.2 697.0 703.8 834.5 847.1 847.7 833.9 848.8 855.5 856.1 856.6 881.7 883.4 889.9 892.8 894.5 724.5 733.4 869.9 890.3 897.7 637.1 637.3 639.8 642.8 642.8 13639.1 13761.8 13769.4 13774.4 13784.9 12111.9 12117.0 12343.8 12761.7 13040.3 10430.1 10702.1 10763.5 10813.5 10963.4 3699.9 3772.7 3784.4 3814.6 3895.5 48866.8 49106.5 49720.0 49889.8 49919.8 10548.2 10860.8 10868.3 11016.3 11395.4 18837.9 18933.5 18948.3 18994.4 18996.6 7823.1 7833.6 7835.6 7889.5 7922.7 4205.4 4236.7 4240.2 4324.5 4337.2 3094.5 3119.8 3126.5 3134.3 3145.2 570.1 571.7 580.7 583.4 595.7 630.2 675.4 684.5 691.2 692.5 8178.0 8626.3 8908.7 9020.1 9166.1 536.2 552.5 553.7 604.8 620.0 3841.4 3908.6 3919.0 3989.7 4016.3 52587.5 52723.0 52911.0 53197.7 56297.7 47515.9 48771.3 49219.0 49471.3 49719.3 44356.3 44613.0 44641.8 44897.3 45466.8 8603.9 8803.3 8844.7 8876.8 9060.0 33733.3 34058.7 34273.0 34355.7 34473.1 45269.8 45863.3 45898.1 46068.3 46311.3 10901.7 11192.4 11310.9 11367.4 11448.6 12092.2 12337.9 12476.6 12554.1 12682.9 11691.6 11886.3 11958.0 12013.6 12272.3 10975.3 11447.7 11507.4 11755.8 11830.2 10562.0 10846.1 11084.2 11280.9 11449.4 9816.7 10038.5 10143.0 10391.7 10417.5 7932.2 7988.2 8296.6 8338.2 8657.8 22:02:52 INFO - PROCESS | 22987 | -------- Summary: end -------- 22:02:52 INFO - PROCESS | 22987 | 22:02:52 INFO - TEST-INFO | 22987: exit 0 22:02:52 INFO - TEST-OK | dromaeo_css | took 1112404ms 22:02:52 INFO - TEST-START | kraken 22:02:52 INFO - operating with platform_type : linux_ 22:02:52 INFO - Initialising browser for kraken test... 22:02:52 INFO - TEST-INFO | started process 23181 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCb1cFB/profile http://localhost:40375/getInfo.html) 22:02:56 INFO - PROCESS | 23181 | __metrics Screen width/height:1600/1200 22:02:56 INFO - PROCESS | 23181 | colorDepth:24 22:02:56 INFO - PROCESS | 23181 | Browser inner width/height: 1024/697 22:02:56 INFO - PROCESS | 23181 | __metrics 22:02:57 INFO - PROCESS | 23181 | 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:02:57 INFO - PROCESS | 23181 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:02:57 INFO - TEST-INFO | 23181: exit 0 22:02:57 INFO - Browser initialized. 22:02:57 INFO - Running cycle 1/1 for kraken test... 22:02:57 INFO - TEST-INFO | started process 23265 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCb1cFB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:03:09 INFO - PROCESS | 23265 | RSS: Main: 149983232 22:03:09 INFO - PROCESS | 23265 | 22:03:12 INFO - PROCESS | 23265 | Cycle 1(1): loaded http://localhost:40375/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40375/tests/kraken/driver.html?testName=audio-beat-detection) 22:03:12 INFO - PROCESS | 23265 | RSS: Main: 184037376 22:03:12 INFO - PROCESS | 23265 | 22:03:15 INFO - PROCESS | 23265 | Cycle 1(1): loaded http://localhost:40375/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40375/tests/kraken/driver.html?testName=audio-dft) 22:03:15 INFO - PROCESS | 23265 | RSS: Main: 174575616 22:03:15 INFO - PROCESS | 23265 | 22:03:18 INFO - PROCESS | 23265 | Cycle 1(1): loaded http://localhost:40375/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40375/tests/kraken/driver.html?testName=audio-fft) 22:03:19 INFO - PROCESS | 23265 | RSS: Main: 160718848 22:03:19 INFO - PROCESS | 23265 | 22:03:21 INFO - PROCESS | 23265 | Cycle 1(1): loaded http://localhost:40375/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40375/tests/kraken/driver.html?testName=audio-oscillator) 22:03:21 INFO - PROCESS | 23265 | RSS: Main: 162119680 22:03:21 INFO - PROCESS | 23265 | 22:03:24 INFO - PROCESS | 23265 | Cycle 1(1): loaded http://localhost:40375/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40375/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:03:24 INFO - PROCESS | 23265 | RSS: Main: 162881536 22:03:24 INFO - PROCESS | 23265 | 22:03:27 INFO - PROCESS | 23265 | Cycle 1(1): loaded http://localhost:40375/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40375/tests/kraken/driver.html?testName=imaging-darkroom) 22:03:28 INFO - PROCESS | 23265 | RSS: Main: 164397056 22:03:28 INFO - PROCESS | 23265 | 22:03:31 INFO - PROCESS | 23265 | Cycle 1(1): loaded http://localhost:40375/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40375/tests/kraken/driver.html?testName=imaging-desaturate) 22:03:32 INFO - PROCESS | 23265 | RSS: Main: 164790272 22:03:32 INFO - PROCESS | 23265 | 22:03:34 INFO - PROCESS | 23265 | Cycle 1(1): loaded http://localhost:40375/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40375/tests/kraken/driver.html?testName=json-parse-financial) 22:03:35 INFO - PROCESS | 23265 | RSS: Main: 166035456 22:03:35 INFO - PROCESS | 23265 | 22:03:37 INFO - PROCESS | 23265 | Cycle 1(1): loaded http://localhost:40375/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40375/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:03:37 INFO - PROCESS | 23265 | RSS: Main: 179322880 22:03:37 INFO - PROCESS | 23265 | 22:03:39 INFO - PROCESS | 23265 | Cycle 1(1): loaded http://localhost:40375/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40375/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:03:40 INFO - PROCESS | 23265 | RSS: Main: 172376064 22:03:40 INFO - PROCESS | 23265 | 22:03:42 INFO - PROCESS | 23265 | Cycle 1(1): loaded http://localhost:40375/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40375/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:03:42 INFO - PROCESS | 23265 | RSS: Main: 180375552 22:03:42 INFO - PROCESS | 23265 | 22:03:45 INFO - PROCESS | 23265 | Cycle 1(1): loaded http://localhost:40375/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40375/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:03:45 INFO - PROCESS | 23265 | RSS: Main: 188362752 22:03:45 INFO - PROCESS | 23265 | 22:03:48 INFO - PROCESS | 23265 | Cycle 1(1): loaded http://localhost:40375/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40375/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:03:48 INFO - PROCESS | 23265 | RSS: Main: 187359232 22:03:48 INFO - PROCESS | 23265 | 22:03:50 INFO - PROCESS | 23265 | Cycle 1(1): loaded http://localhost:40375/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40375/tests/kraken/driver.html?testName=ai-astar) 22:03:50 INFO - PROCESS | 23265 | RSS: Main: 246300672 22:03:50 INFO - PROCESS | 23265 | 22:03:50 INFO - PROCESS | 23265 | __start_tp_report 22:03:50 INFO - PROCESS | 23265 | _x_x_mozilla_page_load 22:03:50 INFO - PROCESS | 23265 | _x_x_mozilla_page_load_details 22:03:50 INFO - PROCESS | 23265 | |i|pagename|runs| 22:03:50 INFO - PROCESS | 23265 | |0;ai-astar;110;111;105;111;112;111;100;110;110;102 22:03:50 INFO - PROCESS | 23265 | |1;audio-beat-detection;153;124;146;166;124;153;154;127;164;127 22:03:50 INFO - PROCESS | 23265 | |2;audio-dft;161;160;161;158;160;160;160;159;161;163 22:03:50 INFO - PROCESS | 23265 | |3;audio-fft;72;73;86;103;70;73;72;105;93;72 22:03:50 INFO - PROCESS | 23265 | |4;audio-oscillator;97;96;139;95;97;97;141;96;96;137 22:03:50 INFO - PROCESS | 23265 | |5;imaging-gaussian-blur;108;109;109;110;109;109;109;110;109;109 22:03:50 INFO - PROCESS | 23265 | |6;imaging-darkroom;146;147;145;145;144;145;144;145;145;145 22:03:50 INFO - PROCESS | 23265 | |7;imaging-desaturate;95;95;95;95;95;96;95;95;95;95 22:03:50 INFO - PROCESS | 23265 | |8;json-parse-financial;59;59;59;58;59;59;58;66;56;58 22:03:50 INFO - PROCESS | 23265 | |9;json-stringify-tinderbox;67;67;67;67;67;68;68;66;68;67 22:03:50 INFO - PROCESS | 23265 | |10;stanford-crypto-aes;85;87;87;86;87;86;86;93;94;86 22:03:50 INFO - PROCESS | 23265 | |11;stanford-crypto-ccm;121;134;125;132;127;132;125;124;115;123 22:03:50 INFO - PROCESS | 23265 | |12;stanford-crypto-pbkdf2;142;150;147;149;149;149;148;147;152;139 22:03:50 INFO - PROCESS | 23265 | |13;stanford-crypto-sha256-iterative;69;68;67;66;66;68;66;68;70;67 22:03:50 INFO - PROCESS | 23265 | __end_tp_report 22:03:50 INFO - PROCESS | 23265 | __start_cc_report 22:03:50 INFO - PROCESS | 23265 | _x_x_mozilla_cycle_collect,933 22:03:50 INFO - PROCESS | 23265 | __end_cc_report 22:03:50 INFO - PROCESS | 23265 | __startTimestamp1451109830760__endTimestamp 22:03:50 INFO - PROCESS | 23265 | 22:03:50 INFO - PROCESS | 23265 | ------- Summary: start ------- 22:03:50 INFO - PROCESS | 23265 | Number of tests: 14 22:03:50 INFO - PROCESS | 23265 | 22:03:50 INFO - PROCESS | 23265 | [#0] ai-astar Cycles:10 Average:108.20 Median:110.50 stddev:4.26 (3.9%) stddev-sans-first:4.47 22:03:50 INFO - PROCESS | 23265 | Values: 110.0 111.0 105.0 111.0 112.0 111.0 100.0 110.0 110.0 102.0 22:03:50 INFO - PROCESS | 23265 | 22:03:50 INFO - PROCESS | 23265 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:153.00 stddev:16.76 (11.0%) stddev-sans-first:17.44 22:03:50 INFO - PROCESS | 23265 | Values: 153.0 124.0 146.0 166.0 124.0 153.0 154.0 127.0 164.0 127.0 22:03:50 INFO - PROCESS | 23265 | 22:03:50 INFO - PROCESS | 23265 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:1.34 (0.8%) stddev-sans-first:1.39 22:03:50 INFO - PROCESS | 23265 | Values: 161.0 160.0 161.0 158.0 160.0 160.0 160.0 159.0 161.0 163.0 22:03:50 INFO - PROCESS | 23265 | 22:03:50 INFO - PROCESS | 23265 | [#3] audio-fft Cycles:10 Average:81.90 Median:72.50 stddev:13.80 (19.0%) stddev-sans-first:14.16 22:03:50 INFO - PROCESS | 23265 | Values: 72.0 73.0 86.0 103.0 70.0 73.0 72.0 105.0 93.0 72.0 22:03:50 INFO - PROCESS | 23265 | 22:03:50 INFO - PROCESS | 23265 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:96.00 stddev:20.66 (21.5%) stddev-sans-first:21.45 22:03:50 INFO - PROCESS | 23265 | Values: 97.0 96.0 139.0 95.0 97.0 97.0 141.0 96.0 96.0 137.0 22:03:50 INFO - PROCESS | 23265 | 22:03:50 INFO - PROCESS | 23265 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 22:03:50 INFO - PROCESS | 23265 | Values: 108.0 109.0 109.0 110.0 109.0 109.0 109.0 110.0 109.0 109.0 22:03:50 INFO - PROCESS | 23265 | 22:03:50 INFO - PROCESS | 23265 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.88 (0.6%) stddev-sans-first:0.87 22:03:50 INFO - PROCESS | 23265 | Values: 146.0 147.0 145.0 145.0 144.0 145.0 144.0 145.0 145.0 145.0 22:03:50 INFO - PROCESS | 23265 | 22:03:50 INFO - PROCESS | 23265 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 22:03:50 INFO - PROCESS | 23265 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 22:03:50 INFO - PROCESS | 23265 | 22:03:50 INFO - PROCESS | 23265 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:59.00 stddev:2.60 (4.4%) stddev-sans-first:2.76 22:03:50 INFO - PROCESS | 23265 | Values: 59.0 59.0 59.0 58.0 59.0 59.0 58.0 66.0 56.0 58.0 22:03:50 INFO - PROCESS | 23265 | 22:03:50 INFO - PROCESS | 23265 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 22:03:50 INFO - PROCESS | 23265 | Values: 67.0 67.0 67.0 67.0 67.0 68.0 68.0 66.0 68.0 67.0 22:03:50 INFO - PROCESS | 23265 | 22:03:50 INFO - PROCESS | 23265 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:87.00 stddev:3.13 (3.6%) stddev-sans-first:3.16 22:03:50 INFO - PROCESS | 23265 | Values: 85.0 87.0 87.0 86.0 87.0 86.0 86.0 93.0 94.0 86.0 22:03:50 INFO - PROCESS | 23265 | 22:03:50 INFO - PROCESS | 23265 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:126.00 stddev:5.75 (4.6%) stddev-sans-first:5.83 22:03:50 INFO - PROCESS | 23265 | Values: 121.0 134.0 125.0 132.0 127.0 132.0 125.0 124.0 115.0 123.0 22:03:50 INFO - PROCESS | 23265 | 22:03:50 INFO - PROCESS | 23265 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.20 Median:149.00 stddev:3.88 (2.6%) stddev-sans-first:3.63 22:03:50 INFO - PROCESS | 23265 | Values: 142.0 150.0 147.0 149.0 149.0 149.0 148.0 147.0 152.0 139.0 22:03:50 INFO - PROCESS | 23265 | 22:03:50 INFO - PROCESS | 23265 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.35 (2.0%) stddev-sans-first:1.32 22:03:50 INFO - PROCESS | 23265 | Values: 69.0 68.0 67.0 66.0 66.0 68.0 66.0 68.0 70.0 67.0 22:03:50 INFO - PROCESS | 23265 | -------- Summary: end -------- 22:03:50 INFO - PROCESS | 23265 | 22:03:51 INFO - TEST-INFO | 23265: exit 0 22:03:51 INFO - TEST-OK | kraken | took 58821ms 22:03:51 INFO - TEST-START | v8_7 22:03:51 INFO - operating with platform_type : linux_ 22:03:51 INFO - Initialising browser for v8_7 test... 22:03:51 INFO - TEST-INFO | started process 23517 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVEMewV/profile http://localhost:40375/getInfo.html) 22:03:55 INFO - PROCESS | 23517 | __metrics Screen width/height:1600/1200 22:03:55 INFO - PROCESS | 23517 | colorDepth:24 22:03:55 INFO - PROCESS | 23517 | Browser inner width/height: 1024/697 22:03:55 INFO - PROCESS | 23517 | __metrics 22:03:55 INFO - PROCESS | 23517 | 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:03:55 INFO - PROCESS | 23517 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:03:57 INFO - TEST-INFO | 23517: exit 0 22:03:57 INFO - Browser initialized. 22:03:57 INFO - Running cycle 1/1 for v8_7 test... 22:03:57 INFO - TEST-INFO | started process 23600 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVEMewV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:04:08 INFO - PROCESS | 23600 | RSS: Main: 148303872 22:04:08 INFO - PROCESS | 23600 | 22:04:30 INFO - PROCESS | 23600 | Cycle 1(1): loaded http://localhost:40375/tests/v8_7/run.html (next: http://localhost:40375/tests/v8_7/run.html) 22:04:30 INFO - PROCESS | 23600 | RSS: Main: 603754496 22:04:30 INFO - PROCESS | 23600 | 22:04:30 INFO - PROCESS | 23600 | __start_tp_report 22:04:30 INFO - PROCESS | 23600 | _x_x_mozilla_page_load 22:04:30 INFO - PROCESS | 23600 | _x_x_mozilla_page_load_details 22:04:30 INFO - PROCESS | 23600 | |i|pagename|runs| 22:04:30 INFO - PROCESS | 23600 | |0;Richards;166.9449081803005 22:04:30 INFO - PROCESS | 23600 | |1;DeltaBlue;191.93857965451056 22:04:30 INFO - PROCESS | 23600 | |2;Encrypt;282.80542986425337 22:04:30 INFO - PROCESS | 23600 | |3;Decrypt;5175.257731958763 22:04:30 INFO - PROCESS | 23600 | |4;RayTrace;1106.1946902654868 22:04:30 INFO - PROCESS | 23600 | |5;Earley;790.5138339920949 22:04:30 INFO - PROCESS | 23600 | |6;Boyer;12353.658536585366 22:04:30 INFO - PROCESS | 23600 | |7;RegExp;26025.641025641027 22:04:30 INFO - PROCESS | 23600 | |8;Splay;663.5700066357001 22:04:30 INFO - PROCESS | 23600 | |9;NavierStokes;4887.804878048781 22:04:30 INFO - PROCESS | 23600 | __end_tp_report 22:04:30 INFO - PROCESS | 23600 | __startTimestamp1451109870455__endTimestamp 22:04:30 INFO - PROCESS | 23600 | 22:04:30 INFO - PROCESS | 23600 | ------- Summary: start ------- 22:04:30 INFO - PROCESS | 23600 | Number of tests: 10 22:04:30 INFO - PROCESS | 23600 | 22:04:30 INFO - PROCESS | 23600 | [#0] Richards Cycles:1 Average:166.94 Median:166.94 stddev:0.00 (0.0%) 22:04:30 INFO - PROCESS | 23600 | Values: 166.9 22:04:30 INFO - PROCESS | 23600 | 22:04:30 INFO - PROCESS | 23600 | [#1] DeltaBlue Cycles:1 Average:191.94 Median:191.94 stddev:0.00 (0.0%) 22:04:30 INFO - PROCESS | 23600 | Values: 191.9 22:04:30 INFO - PROCESS | 23600 | 22:04:30 INFO - PROCESS | 23600 | [#2] Encrypt Cycles:1 Average:282.81 Median:282.81 stddev:0.00 (0.0%) 22:04:30 INFO - PROCESS | 23600 | Values: 282.8 22:04:30 INFO - PROCESS | 23600 | 22:04:30 INFO - PROCESS | 23600 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 22:04:30 INFO - PROCESS | 23600 | Values: 5175.3 22:04:30 INFO - PROCESS | 23600 | 22:04:30 INFO - PROCESS | 23600 | [#4] RayTrace Cycles:1 Average:1106.19 Median:1106.19 stddev:0.00 (0.0%) 22:04:30 INFO - PROCESS | 23600 | Values: 1106.2 22:04:30 INFO - PROCESS | 23600 | 22:04:30 INFO - PROCESS | 23600 | [#5] Earley Cycles:1 Average:790.51 Median:790.51 stddev:0.00 (0.0%) 22:04:30 INFO - PROCESS | 23600 | Values: 790.5 22:04:30 INFO - PROCESS | 23600 | 22:04:30 INFO - PROCESS | 23600 | [#6] Boyer Cycles:1 Average:12353.66 Median:12353.66 stddev:0.00 (0.0%) 22:04:30 INFO - PROCESS | 23600 | Values: 12353.7 22:04:30 INFO - PROCESS | 23600 | 22:04:30 INFO - PROCESS | 23600 | [#7] RegExp Cycles:1 Average:26025.64 Median:26025.64 stddev:0.00 (0.0%) 22:04:30 INFO - PROCESS | 23600 | Values: 26025.6 22:04:30 INFO - PROCESS | 23600 | 22:04:30 INFO - PROCESS | 23600 | [#8] Splay Cycles:1 Average:663.57 Median:663.57 stddev:0.00 (0.0%) 22:04:30 INFO - PROCESS | 23600 | Values: 663.6 22:04:30 INFO - PROCESS | 23600 | 22:04:30 INFO - PROCESS | 23600 | [#9] NavierStokes Cycles:1 Average:4887.80 Median:4887.80 stddev:0.00 (0.0%) 22:04:30 INFO - PROCESS | 23600 | Values: 4887.8 22:04:30 INFO - PROCESS | 23600 | -------- Summary: end -------- 22:04:30 INFO - PROCESS | 23600 | 22:04:31 INFO - TEST-INFO | 23600: exit 0 22:04:31 INFO - TEST-OK | v8_7 | took 39674ms 22:04:31 INFO - SUITE-END | took 1210s 22:04:31 INFO - Completed test suite (00:20:11) 22:04:31 INFO - Working with test: dromaeo_css 22:04:31 INFO - Generating results file: dromaeo_css 22:04:31 INFO - Working with test: kraken 22:04:31 INFO - Generating results file: kraken 22:04:31 INFO - javascript benchmark 22:04:31 INFO - Working with test: v8_7 22:04:31 INFO - Generating results file: v8_7 22:04:31 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:04:31 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 22:04:31 INFO - process_Request line: dromaeo_css 6758.43 graph.html#tests=[[72,63,35]] 22:04:31 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:04:31 INFO - process_Request line: kraken 1507.10 graph.html#tests=[[232,63,35]] 22:04:31 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:04:31 INFO - process_Request line: v8_7 20719.33 graph.html#tests=[[230,63,35]] 22:04:31 INFO - RETURN: dromaeo_css: 6758.43 22:04:31 INFO - RETURN: kraken: 1507.10 22:04:31 INFO - RETURN: v8_7: 20719.33 22:04:31 INFO - javascript benchmark 22:04:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3062.9540556891643, 3087.3207894263255, 3131.6085489313837, 3135.1848519384966, 3163.256634690847, 5019.774110165043, 5084.822031228908, 5105.030044291587, 5111.6166287528395, 5140.408852981904, 5064.0, 5087.211482220253, 5105.438401775802, 5180.637355385115, 5259.789608415659, 4724.078804633098, 4745.240761478164, 4761.880952976186, 4803.63972702047, 4864.0, 375.58391211605056, 4564.292534657116, 4716.127516409475, 4742.099001189763, 4819.180739274314, 4645.488996210414, 4674.135284972274, 4754.0967216229155, 4776.9283460747765, 4780.3307536944685, 4721.622270218409, 4723.008168284664, 4725.10223057618, 4729.810807567693, 4766.6901651392545, 4554.3851580036935, 4694.906101877978, 4718.575328220442, 4721.6458765592715, 4766.189747742892, 4887.780049897728, 4932.284818701304, 4989.027139707759, 5008.699478031293, 5016.072026675077, 5541.667499950016, 5543.085390910495, 5549.472800083986, 5550.0, 5555.166724991243, 5291.1798671206025, 5570.415106413809, 5578.693171875545, 5585.832425027255, 5607.831765047055, 5132.820351287724, 5145.073886700392, 5243.737813109329, 5250.44870288618, 5256.789728410859, 5636.830895073154, 5637.830865073973, 5638.182463542763, 5651.745671444794, 5704.286964129484, 5424.294841670558, 5452.972735136299, 5453.23654688344, 5458.426865179178, 5498.147787093007, 5348.5186333230195, 5440.510354068153, 5488.094464413327, 5493.423190565013, 5574.832755017356, 5478.890422191534, 5524.66851988882, 5525.751341189656, 5560.388357280696, 5570.220169176318, 5513.9448605513435, 5518.66887986714, 5522.088855338824, 5524.33707955048, 5529.612927095145, 4185.142045880648, 4230.830766769356, 4248.299030659907, 4285.957140428618, 4332.458442694663, 3869.9226015479535, 3871.477350557695, 3876.127871228951, 3906.9609303906595, 3907.667848232932, 5170.71561064145, 5173.508516690908, 5175.353080864892, 5185.870353241124, 5222.3472065991755, 5393.110136827379, 5431.131019036935, 5488.094464413407, 5574.749136288877, 5585.301837270341, 5063.670861394071, 5066.290719299301, 5089.465606111379, 5091.7963281469065, 5129.769160387791, 4795.256735205979, 4799.592034677022, 4800.207965685692, 4806.375171227718, 4845.1278769821065, 5586.16207568868, 5695.686737229492, 5700.201971723962, 5708.286464191976, 5721.8569535761935, 5500.669959802424, 5586.804461843816, 5589.664620122806, 5591.4688104629995, 5633.211350410864, 5734.22587950638, 5734.885302294014, 5736.110902810071, 5737.0, 5739.397363276796, 5314.176302673091, 5396.568274537949, 5403.13549832025, 5496.697681627389, 5512.724363781875, 5550.722463876871, 5589.916151257816, 5603.663780173202, 5609.467100625434, 5655.179998900218, 5337.653052551572, 5359.624826262124, 5365.275687782256, 5383.084875571084, 5389.649672771257, 5271.288376069181, 5346.812861549983, 5370.704611246263, 5398.08232600451, 5408.648437851527, 5374.57003439716, 5376.1398176291605, 5381.704006279536, 5385.784568617368, 5390.757415916215, 5467.371252306036, 5477.397486276427, 5479.643823151642, 5480.761095156746, 5534.418886016911, 5211.218317252443, 5289.814856480005, 5296.523312901857, 5341.0, 5432.0765469871], "unit": "score", "name": "dojo.html", "value": 5070.614192034128}, {"lowerIsBetter": false, "replicates": [535.4077149147905, 568.690063915166, 590.9911351329728, 594.732370433305, 600.6546235914349, 29003.0, 29815.850920745394, 29833.0, 37227.0, 37681.246375072486, 39933.20133597327, 40904.18191636165, 40935.0, 40936.795316023454, 40944.59055409445, 8491.957540212306, 8642.827143457158, 8670.046294907586, 8673.913260867404, 8674.566271686423, 7538.623068846536, 7673.539587624732, 10319.48402579868, 10497.895021049806, 10544.841827372595, 10176.542055607479, 10240.846387304196, 10253.589856405735, 10256.53845576947, 10263.846042309371, 7426.405887528985, 7563.886541701879, 10201.132903703194, 10290.742731431737, 10300.433476158809, 10229.744256393575, 10420.426876521788, 10430.113440357578, 10437.478126093742, 10446.059854613046, 37104.25791484155, 37529.81235093807, 37554.0, 37560.62439375626, 37650.43524347137, 3285.2772390074147, 3297.3405318936307, 3387.9322413551836, 3438.535797667333, 3645.398509245971, 25139.24582262535, 25245.873770631213, 25450.0, 26372.208833735018, 26643.467130657278, 3923.7479036627633, 3968.1071758854314, 3971.185906889081, 4033.556308806029, 4094.529129150156, 192484.0375798112, 193803.0, 193841.0, 194155.02922485437, 194318.0, 54708.72645636826, 55497.72251138799, 60299.698501508086, 60673.0, 60898.39101609016, 56569.0, 56690.0, 56915.715421423454, 56994.43005569974, 57004.159500860165, 13782.586522404345, 13968.441262349392, 14021.719565608631, 14029.719405611831, 14040.0, 10251.897481025095, 10323.32898361604, 10367.118794902366, 10377.429241391796, 10381.11760500366, 19412.902935485232, 20283.0, 20400.0, 20542.79457205409, 20555.38333849987, 7222.349988501061, 7423.85152296951, 7504.474686771873, 7583.5070720403, 7584.5070070445245, 923.3859483443434, 943.4763706143157, 961.245422343457, 985.7190700650281, 1075.473018221066, 25810.354741131247, 26117.869410652824, 29161.708382916324, 29294.707052929625, 29983.0, 963.9518024098767, 1029.8661174047477, 1054.1040115901421, 1079.9794194486135, 1084.6800193942806, 13959.930200348934, 13960.162390256617, 13999.44002239899, 14150.858491414954, 14207.147571145764, 313726.0, 319876.0, 320174.0, 320894.0, 321933.0, 53328.20007699887, 53576.0, 53582.73208633932, 53648.46351536435, 53667.463325367025, 1310.168043292497, 1316.5721140629335, 1321.4582021371384, 1321.8017297405274, 1329.9202047877159, 25242.74757252404, 26640.866795665897, 27687.58468622932, 29078.7092129076, 29431.55852662169, 42016.0, 42603.0, 42613.14773704571, 42614.78692606517, 42632.36051459169, 245504.0, 246517.0, 246920.0, 246938.0, 247221.0, 28236.43527129405, 28788.0, 33980.32039359248, 34059.82970085134, 34430.65569344274, 40460.0, 41024.384634229915, 41415.58584414118, 41471.37792933169, 41825.372619410125, 34064.31871362509, 35621.64378356287, 35735.28529429449, 35979.46030809487, 36500.45249321315, 35166.12084697903, 35946.4608030885, 36000.8199959009, 36092.45861312135, 36377.636223637426, 34642.307153857284, 35047.824760877054, 35405.46891796677, 35460.64539354573, 35579.46630800592, 30335.0, 31507.36985260328, 32488.837555812068, 32661.673383265865, 32669.346613068083, 24687.0, 25011.249662510152, 25067.0, 25373.492530148924, 25379.61930571006], "unit": "score", "name": "ext.html", "value": 17948.9217799557}, {"lowerIsBetter": false, "replicates": [327.53653580184033, 332.76041250299784, 335.3377080266474, 345.4231433506046, 346.9791812491249, 16139.435119770811, 16320.0, 17749.290028398882, 18118.184681689323, 18122.275108995625, 16597.0, 16930.40743573975, 17017.744733829004, 17218.0, 17220.483385498424, 5171.637985341028, 5320.866978325544, 5372.301600791891, 5445.128779395298, 5446.0, 5252.8424147275455, 5271.551918086948, 5324.946750532503, 5331.040412725708, 5331.067063263933, 3912.8826135215845, 4008.2384346974127, 5283.392409872856, 5293.8941221175555, 5712.086066229404, 5798.362180160179, 5817.709114544298, 5859.824205273849, 5864.23764910561, 5868.471837534621, 5032.597392208614, 5121.641485096045, 5134.922976155361, 5138.845834624967, 5156.613254005964, 15456.690866182726, 15889.28498217583, 18260.178291976892, 18875.90562047181, 19518.0, 1941.8931958742264, 2173.217641649005, 2190.0582749417745, 2354.7409784923816, 2375.89520872795, 13045.54340598084, 13054.477820887154, 13116.540921067812, 13170.143940643828, 13342.533011344653, 1827.844633206179, 1854.2026928420773, 1876.6152938647544, 1885.3118611706766, 1977.821996020365, 58763.70618146882, 59134.40865591332, 60790.0, 61147.0, 61305.0, 9388.295877809192, 9485.193758530602, 9735.367201131903, 9738.0, 9804.117629413244, 12571.74856502883, 12681.0, 12692.238465692088, 12718.300493472763, 12727.10910236293, 6917.100776898971, 7136.607486588184, 7147.53541019832, 7209.6395180241825, 7213.0, 6500.70746816385, 6553.377429144223, 6602.8349291268105, 6772.966135169293, 6868.072810170563, 4327.069680018811, 4345.543717909574, 4351.4995775485595, 4379.0, 4388.978055109768, 1774.7071733164141, 1786.455131184975, 1791.3819732192374, 1819.1177279019664, 1821.2805941653237, 825.4551995682821, 856.1181982557976, 871.2333146830748, 894.280104515871, 932.1796818799548, 15258.389664413522, 16020.679586408207, 17108.48674539766, 17196.0, 17315.653686926442, 827.903640384968, 920.6961702638114, 932.883389576303, 933.8552524358736, 1012.377387906447, 8874.511901845332, 9517.5717092731, 9576.281778866613, 10038.0, 10427.322224055411, 380105.0, 382564.0, 387738.0, 388251.0, 547935.0, 41258.793706031276, 41505.792471038054, 58545.12182317269, 64080.679596601716, 70218.29781702219, 1104.17738784606, 1121.9495122719497, 1122.4948773052158, 1126.774645070989, 1135.8750537440874, 14906.32921518556, 15539.922300388425, 15554.533363999099, 15881.761773573637, 16172.676546468769, 32247.35505289834, 32283.19292017718, 32481.07384695254, 33426.16434589155, 35872.8206358977, 41794.79102604467, 43123.353149703406, 44278.11443771042, 44426.11147777091, 44490.77754611206, 9619.807603847745, 9714.3199976001, 9728.0, 9812.901870981199, 9819.803603927738, 15126.319315630602, 17135.0, 18217.544561386072, 18245.0, 18462.723059154392, 10840.566377345134, 13872.514461993782, 14276.21480818565, 14430.12408386903, 14882.330295136528, 13615.659608509866, 13725.0, 13881.861181388056, 14388.20864852443, 14451.0, 15119.622009449851, 15149.848501515286, 15355.769663454834, 15641.92179039143, 15710.0, 9095.818083638158, 9610.567524461556, 9791.559379828068, 9817.754556135867, 9849.26130540198, 10206.183505319408, 10242.436665983443, 13506.662333441349, 13959.511417100353, 14131.64670883195], "unit": "score", "name": "jquery.html", "value": 8627.27676062015}, {"lowerIsBetter": false, "replicates": [1306.5427100514828, 1412.4703236286393, 1422.2675322209063, 1527.3432424057657, 1711.152979275259, 6052.334243233241, 6581.70382332795, 6596.637184954826, 6659.966700166505, 6681.799546013622, 6532.183477065367, 6670.399664030237, 6678.065070890068, 6680.966595167018, 6682.766103186389, 1889.5370634194642, 1926.0, 2120.6076875777953, 2121.0561300221407, 2156.9892150539304, 2175.869447833135, 2180.3458962311324, 2183.224955140926, 2184.137265780016, 2184.159098746978, 2117.2272120676, 2171.5005548723802, 2176.880271585062, 2177.2814971059593, 2177.3685631167023, 1886.1041005522336, 1922.9903850480728, 2114.661654135331, 2154.91380344786, 2166.1876796201423, 2054.9178032878667, 2059.4439501334555, 2077.1276064053136, 2081.6773400123006, 2152.461884528868, 6671.5997040177745, 6736.865262694768, 6744.561603495807, 6749.763758268437, 6750.493712971547, 4196.139791342767, 4253.447051883235, 4259.914801703949, 4266.253405654029, 4272.636825869805, 2804.579313103051, 2860.0, 2882.7261410166, 2886.422715456917, 2936.9853150734325, 978.9412635241837, 995.5221493683073, 1015.9593616255415, 1017.2726500552067, 1056.2553399853084, 8776.868346974801, 8801.911980880237, 8809.691660791905, 8812.0, 8849.513276769776, 3792.1088544192094, 3903.4730311408166, 3935.704822138351, 3960.980195099006, 3986.880393588197, 7664.808379790438, 7670.501417407851, 7672.079350477867, 7674.386049116058, 7681.039870016248, 4274.487061552633, 4300.0969796343115, 4326.891827704332, 4329.826806927751, 4331.5451877552405, 3972.2651309507833, 3972.7616343019513, 3973.324534829086, 3979.641832235113, 3981.3828856527284, 3417.333619944087, 3422.418188907892, 3429.9314013720086, 3430.485427185942, 3472.5138480612736, 1111.766529028913, 1126.9211155219057, 1130.46867972053, 1131.7340425000118, 1132.2923173016864, 954.479808504353, 1272.3320256865036, 1273.3951373097889, 1290.832191815058, 1294.5533790842144, 5759.596828221985, 6454.741810327534, 6544.672766361663, 6557.967210163919, 6558.344165583403, 584.2647337407892, 588.5174157191148, 596.4900010491054, 627.4854619212293, 627.8399008252866, 4995.475475075064, 5003.7998480061115, 5011.7494125294315, 5029.446760856303, 5036.974815125901, 7591.354734847489, 7628.313451789255, 7699.576523291273, 7718.035245594301, 7866.410019248579, 7723.729669461542, 7810.258025487569, 7827.356255186361, 7829.491083079582, 7829.530228186327, 6247.687615619201, 6283.088952102011, 6335.841603959846, 6365.713542890581, 6404.935950640527, 6400.231972163184, 6408.327125651739, 6446.161998940108, 6456.160699109086, 6456.806295811133, 7197.280271972761, 7237.8914316284245, 7321.963390183015, 7338.266173382619, 7383.261673832574, 7114.537555058904, 7192.784216473514, 7193.676284567103, 7532.924670753222, 7547.0943486781935, 6140.662263575367, 6161.260648722182, 6165.506759459143, 6198.690065496798, 6213.813585592439, 6546.410823025951, 6598.175228096488, 6632.966835165793, 6638.070670106285, 6656.500762442739, 6115.663638499747, 6206.379362063757, 6255.46828519581, 6277.780277690442, 6396.872062558816, 6261.499080073674, 6267.122602835516, 6294.622322660472, 6306.432421082125, 6423.42189202974, 5632.183333416549, 5723.198752174782, 6180.258368995749, 6186.969065154645, 6218.253809542884, 5668.603197776116, 5768.94231057684, 5785.8553536161935, 5799.0, 5801.158831969256, 5757.769689212385, 5764.682942438206, 5782.913256301074, 5783.103618938903, 5789.9710501447225], "unit": "score", "name": "mootools.html", "value": 3976.3675914248843}, {"lowerIsBetter": false, "replicates": [331.28773137753825, 333.3782495645621, 341.249251646378, 344.1585323883106, 346.9028671971847, 5887.8528036799, 6000.969995150029, 6023.0, 6054.122152287916, 6074.0, 5802.65184088955, 5895.056790913454, 5918.7632494700265, 5920.289565252176, 5970.820875373734, 4612.446506419226, 4615.192341340269, 4620.399348084761, 4622.491525932145, 4630.819141119026, 4408.86773396797, 4499.1001799640035, 4505.031418245077, 4625.676202665814, 4635.837745678902, 4572.359869618256, 4584.908301833978, 4588.862334129982, 4600.769961501928, 4604.263317869141, 4575.633949284049, 4581.335706322598, 4595.862124136282, 4597.448306203243, 4614.100250451163, 4042.3532234842282, 4051.9392209116886, 4053.695972802022, 4058.7767672777986, 4071.1043570414463, 5621.494065534081, 5694.0, 5696.829095127153, 5709.600327977043, 5736.799212027559, 5365.7585408656705, 5381.112116500773, 5393.2719082923695, 5395.190721391783, 5400.487863398254, 6048.909266361008, 6340.3659634036685, 6368.872622547523, 6371.458426033792, 6378.138951241569, 4329.458817647794, 4347.304431290978, 4385.298352263622, 4402.163588918127, 4406.1187762447635, 6551.148350714424, 6618.271990081135, 6619.801405957781, 6624.701888415081, 6629.237637671633, 4597.172508948422, 4599.08018396322, 4600.5629465200755, 4600.769961501912, 4605.078984203173, 4341.6526677865695, 4432.556744325541, 4459.9331010034875, 4662.696924699883, 4671.789769460383, 5169.793208271627, 5203.245529398216, 5205.5315021647475, 5213.2701421800975, 5230.163173892159, 6407.615543067431, 6411.1024456576115, 6411.6153030818305, 6411.711472983727, 6416.711247993851, 1569.8351673074392, 1604.8796340274525, 1604.903705777657, 1605.4220480626966, 1607.4534658216028, 1038.7558923652934, 1053.0890779475699, 1054.4516851237313, 1063.6330465989377, 1093.781243751253, 6011.609245399035, 6021.277446706424, 6026.5178785697035, 6035.275766907999, 6037.63774173551, 6596.868062638816, 6600.2409722882485, 6601.636909969901, 6603.0, 6604.14146160996, 5878.29460464747, 6007.909881351783, 6015.368386319461, 6040.855496298751, 6043.7280322385595, 3479.860805567749, 3577.4276115821344, 3578.1054736315923, 3581.230035542371, 3585.462180672868, 6804.11546498952, 6810.9318906810295, 6811.080504131879, 6900.792976210621, 6906.37842594169, 6805.9659701701175, 6811.761588344384, 6811.897821532681, 6814.557053791487, 6820.454363650896, 6687.799366019027, 6921.826954326182, 6929.0, 6932.0, 6938.063361446241, 6396.008618664115, 6470.352964703492, 6556.377144171296, 6662.333766623493, 6663.533552651268, 6529.902051469327, 6576.079348891063, 6587.176602924635, 6605.174353205849, 6633.867322653424, 6886.208086070166, 6896.655167241517, 6903.965480172567, 6905.205901321412, 6910.861782764216, 4355.934660980024, 4456.220161471794, 4480.61914737251, 4508.413906192305, 4510.097980403998, 6557.311482294481, 6608.603483790988, 6614.801555953329, 6623.3376662333385, 6628.701708423229, 6431.260405053292, 6456.386643268882, 6460.838479038061, 6465.741370345321, 6476.417122459001, 6301.747930082745, 6448.580842245239, 6456.903146452713, 6464.321246269262, 6504.772332968323, 6380.425761681471, 6384.680765961776, 6388.680565971776, 6390.808275751735, 6390.90413643805, 6521.0, 6532.0, 6534.248561415498, 6538.378854008862, 6538.869222615616, 6209.720562574786, 6344.413896525869, 6369.777057802955, 6373.458256048288, 6375.776847810304], "unit": "score", "name": "prototype.html", "value": 4814.456554312441}, {"lowerIsBetter": false, "replicates": [781.6326326626483, 852.518327145163, 852.6163226548053, 858.3305022082774, 875.4003507597296, 12739.299338536377, 12952.093353465261, 12980.675483112927, 12981.286029268398, 12990.0, 12451.68870778231, 12846.0, 12953.611391658242, 12990.610281691565, 12993.220406775576, 696.9581825090486, 703.7994171661078, 834.4534330013851, 847.0597636623343, 847.6609356257485, 833.8832563441123, 848.817504236589, 855.482433127958, 856.1481326080559, 856.5588721808274, 881.6781874615751, 883.3860466975455, 889.89321281446, 892.848215803315, 894.5124906925741, 724.5290561135278, 733.4022771441258, 869.882565853608, 890.3366991591273, 897.712731925784, 637.1303171171364, 637.2957881540877, 639.7920675780343, 642.8328634555003, 642.8360768004129, 13639.113457625223, 13761.793573096411, 13769.380377883019, 13774.380152893144, 13784.931075344559, 12111.878881211163, 12117.0, 12343.814842777365, 12761.744765104646, 13040.282784446852, 10430.113440357578, 10702.143828493701, 10763.515641796137, 10813.513391897384, 10963.397013164273, 3699.907502312437, 3772.6604605585353, 3784.432335149722, 3814.6376094271, 3895.4935858338235, 48866.7556662218, 49106.50893491055, 49720.0, 49889.75055124737, 49919.75040124812, 10548.156147508182, 10860.782784344427, 10868.293560918673, 11016.283941543774, 11395.430228488542, 18837.905810471133, 18933.526661833563, 18948.336808211923, 18994.430167095008, 18996.62006759857, 7823.100343460461, 7833.64748586315, 7835.608219588998, 7889.526628402315, 7922.683092676343, 4205.3902184183125, 4236.661067114624, 4240.151969606091, 4324.459442569679, 4337.15425492026, 3094.4739394302574, 3119.750419966397, 3126.5466507356305, 3134.3104517006223, 3145.229418792365, 570.0622476026996, 571.6970005896882, 580.7473748919234, 583.381615487576, 595.7200115945499, 630.2059405149453, 675.3651567526509, 684.4626967830329, 691.2361840166644, 692.4771797293012, 8177.9591102044105, 8626.309895208367, 8908.73273801787, 9020.097990201059, 9166.069009482842, 536.2010604199714, 552.4696291560148, 553.748044639696, 604.7550741949517, 619.9597026193283, 3841.3853783394525, 3908.5700572936953, 3919.0, 3989.7007724420205, 4016.2569924563463, 52587.47412525826, 52723.0, 52911.0, 53197.734011329696, 56297.718511408, 47515.922293210235, 48771.26843097356, 49219.0, 49471.25793113106, 49719.25421118686, 44356.3346549802, 44613.0, 44641.77679111584, 44897.32654010192, 45466.77266613646, 8603.870941935751, 8803.295736341206, 8844.70859469748, 8876.822463550821, 9060.0, 33733.32533349368, 34058.65941340654, 34273.0, 34355.65644343525, 34473.138171545914, 45269.77365113285, 45863.31205031861, 45898.08203835972, 46068.30897536607, 46311.305330419396, 10901.65161419072, 11192.384418856715, 11310.886891130984, 11367.431628418712, 11448.599299024494, 12092.153549251469, 12337.93831030875, 12476.563320283747, 12554.121211515107, 12682.87317126817, 11691.590794322157, 11886.34625095628, 11958.0, 12013.63959081229, 12272.325022123869, 10975.341479511255, 11447.713807154554, 11507.424628768695, 11755.823662645238, 11830.231034982698, 10562.0, 10846.132309415385, 11084.224104312943, 11280.943595281971, 11449.42752862337, 9816.65641702537, 10038.498075096362, 10143.0, 10391.740206494898, 10417.531211095367, 7932.206779322021, 7988.201179881965, 8296.585170741559, 8338.166183381612, 8657.783555411164], "unit": "score", "name": "yui.html", "value": 6339.062060209933}], "name": "dromaeo_css", "value": 6758.42765307284}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 105.0, 111.0, 112.0, 111.0, 100.0, 110.0, 110.0, 102.0], "unit": "score", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [153.0, 124.0, 146.0, 166.0, 124.0, 153.0, 154.0, 127.0, 164.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 143.8}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 158.0, 160.0, 160.0, 160.0, 159.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 160.3}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 86.0, 103.0, 70.0, 73.0, 72.0, 105.0, 93.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.9}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 139.0, 95.0, 97.0, 97.0, 141.0, 96.0, 96.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [108.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 145.0, 145.0, 144.0, 145.0, 144.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 59.0, 58.0, 59.0, 59.0, 58.0, 66.0, 56.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 59.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 66.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 87.0, 86.0, 87.0, 86.0, 86.0, 93.0, 94.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.7}, {"lowerIsBetter": true, "replicates": [121.0, 134.0, 125.0, 132.0, 127.0, 132.0, 125.0, 124.0, 115.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.8}, {"lowerIsBetter": true, "replicates": [142.0, 150.0, 147.0, 149.0, 149.0, 149.0, 148.0, 147.0, 152.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.2}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 67.0, 66.0, 66.0, 68.0, 66.0, 68.0, 70.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.5}], "name": "kraken", "value": 1507.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.9449081803005], "unit": "score", "name": "Richards", "value": 211.45897999999997}, {"lowerIsBetter": false, "replicates": [191.93857965451056], "unit": "score", "name": "DeltaBlue", "value": 344.4747799999999}, {"lowerIsBetter": false, "replicates": [282.80542986425337], "unit": "score", "name": "Encrypt", "value": 941.2160160000003}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1106.1946902654868], "unit": "score", "name": "RayTrace", "value": 668.9500559999998}, {"lowerIsBetter": false, "replicates": [790.5138339920949], "unit": "score", "name": "Earley", "value": 843.0756950000003}, {"lowerIsBetter": false, "replicates": [12353.658536585366], "unit": "score", "name": "Boyer", "value": 53.948633761105626}, {"lowerIsBetter": false, "replicates": [26025.641025641027], "unit": "score", "name": "RegExp", "value": 35.003364532019674}, {"lowerIsBetter": false, "replicates": [663.5700066357001], "unit": "score", "name": "Splay", "value": 122.80693700000002}, {"lowerIsBetter": false, "replicates": [4887.804878048781], "unit": "score", "name": "NavierStokes", "value": 303.61277445109783}], "name": "v8_7", "value": 20719.32612325195}]} 22:04:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "20719.33"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1507.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6758.43"}}} 22:04:31 INFO - Return code: 0 22:04:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:04:31 INFO - # TBPL SUCCESS # 22:04:31 INFO - Running post-action listener: _resource_record_post_action 22:04:31 INFO - Running post-run listener: _resource_record_post_run 22:04:32 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 12288; Write bytes: 555413504; Read time: 508; Write time: 573872 22:04:32 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 246677504; Read time: 244; Write time: 300716 22:04:32 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 8192; Write bytes: 308461568; Read time: 264; Write time: 273132 22:04:32 INFO - Running post-run listener: _upload_blobber_files 22:04:32 INFO - Blob upload gear active. 22:04:32 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:04:32 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 22:04:32 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', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:04:32 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 Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:04:33 INFO - (blobuploader) - INFO - Open directory for files ... 22:04:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:04:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:04:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:04:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:04:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:04:33 INFO - (blobuploader) - INFO - Done attempting. 22:04:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:04:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:04:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:04:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:04:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:04:34 INFO - (blobuploader) - INFO - Done attempting. 22:04:34 INFO - (blobuploader) - INFO - Iteration through files over. 22:04:34 INFO - Return code: 0 22:04:34 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:04:34 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:04:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7f399febd0146b2e90dc25b52bbea6e525ab54460d52b563330651406ded556b20b60f2037acac71597c80aebf343111574aadd0391b40f998c6772e316c9255", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e916514791dddf3edb869cc3186a496c797721b41941b7f91ba65c1486365380dd4060d35ad45514a76223b1635eba646447b2eed927034a256a4ffc23706385"} 22:04:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:04:34 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:04:34 INFO - Contents: 22:04:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7f399febd0146b2e90dc25b52bbea6e525ab54460d52b563330651406ded556b20b60f2037acac71597c80aebf343111574aadd0391b40f998c6772e316c9255", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e916514791dddf3edb869cc3186a496c797721b41941b7f91ba65c1486365380dd4060d35ad45514a76223b1635eba646447b2eed927034a256a4ffc23706385"} 22:04:34 INFO - Copying logs to upload dir... 22:04:34 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1268.627294 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-25 22:04:34.538645) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-25 22:04:34.542470) ========= 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=7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7f399febd0146b2e90dc25b52bbea6e525ab54460d52b563330651406ded556b20b60f2037acac71597c80aebf343111574aadd0391b40f998c6772e316c9255", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e916514791dddf3edb869cc3186a496c797721b41941b7f91ba65c1486365380dd4060d35ad45514a76223b1635eba646447b2eed927034a256a4ffc23706385"} build_url:https://queue.taskcluster.net/v1/task/2867KV8kTemM-uOeolihJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011351 build_url: 'https://queue.taskcluster.net/v1/task/2867KV8kTemM-uOeolihJw/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/Mozilla-Inbound/sha512/7f399febd0146b2e90dc25b52bbea6e525ab54460d52b563330651406ded556b20b60f2037acac71597c80aebf343111574aadd0391b40f998c6772e316c9255", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e916514791dddf3edb869cc3186a496c797721b41941b7f91ba65c1486365380dd4060d35ad45514a76223b1635eba646447b2eed927034a256a4ffc23706385"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-25 22:04:34.567026) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 22:04:34.567341) ========= 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=7f67ac1ceef7774224e327f2000001f6-1451100383.617954-292283303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004554 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 22:04:34.653055) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-25 22:04:34.653364) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-25 22:04:34.653687) ========= ========= Total master_lag: 0.29 =========