builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1452300864.53 results: success (0) buildid: 20160108143011 builduid: a81d992e66de41b0aaca4a043fab8c33 revision: d49d52dba30dee18dbcc4d148a7a3cf7ed346710 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 16:54:24.532857) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 16:54:24.533884) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 16:54:24.534651) ========= 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=4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006255 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 16:54:24.573794) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 16:54:24.574099) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 16:54:24.603920) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 16:54:24.604245) ========= 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=4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004605 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 16:54:24.655596) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 16:54:24.655951) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 16:54:24.656361) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 16:54:24.656674) ========= 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=4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-08 16:54:24-- 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% 224M=0s 2016-01-08 16:54:24 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163211 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 16:54:24.834264) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 16:54:24.834799) ========= 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=4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022304 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 16:54:24.889555) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 16:54:24.890154) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev d49d52dba30dee18dbcc4d148a7a3cf7ed346710 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev d49d52dba30dee18dbcc4d148a7a3cf7ed346710 --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=4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-08 16:54:24,966 truncating revision to first 12 chars 2016-01-08 16:54:24,966 Setting DEBUG logging. 2016-01-08 16:54:24,966 attempt 1/10 2016-01-08 16:54:24,966 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/d49d52dba30d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-08 16:54:25,346 unpacking tar archive at: b2g-inbound-d49d52dba30d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649610 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 16:54:25.579203) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 16:54:25.579589) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 16:54:25.594848) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 16:54:25.595133) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 16:54:25.595587) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-08 16:54:25.595918) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:54:25 INFO - MultiFileLogger online at 20160108 16:54:25 in /builds/slave/test-pgo 16:54:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 16:54:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:54:25 INFO - {'append_to_log': False, 16:54:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:54:25 INFO - 'blob_upload_branch': 'B2G-Inbound', 16:54:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:54:25 INFO - 'branch': 'B2G-Inbound', 16:54:25 INFO - 'buildbot_json_path': 'buildprops.json', 16:54:25 INFO - 'config_files': ('talos/linux_config.py',), 16:54:25 INFO - 'default_actions': ('clobber', 16:54:25 INFO - 'read-buildbot-config', 16:54:25 INFO - 'download-and-extract', 16:54:25 INFO - 'populate-webroot', 16:54:25 INFO - 'create-virtualenv', 16:54:25 INFO - 'install', 16:54:25 INFO - 'run-tests'), 16:54:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:54:25 INFO - 'download_minidump_stackwalk': True, 16:54:25 INFO - 'download_symbols': 'ondemand', 16:54:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:54:25 INFO - 'tooltool.py': '/tools/tooltool.py', 16:54:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:54:25 INFO - '/tools/misc-python/virtualenv.py')}, 16:54:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:54:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:54:25 INFO - 'installer_path': 'installer.exe', 16:54:25 INFO - 'log_level': 'info', 16:54:25 INFO - 'log_name': 'talos', 16:54:25 INFO - 'log_to_console': True, 16:54:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:54:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:54:25 INFO - 'opt_config_files': (), 16:54:25 INFO - 'pip_index': False, 16:54:25 INFO - 'sps_profile': False, 16:54:25 INFO - 'sps_profile_interval': 0, 16:54:25 INFO - 'suite': 'dromaeojs', 16:54:25 INFO - 'system_bits': '32', 16:54:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:54:25 INFO - 'title': 'talos-linux64-ix-030', 16:54:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:54:25 INFO - 'use_talos_json': True, 16:54:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:54:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:54:25 INFO - 'work_dir': 'build'} 16:54:25 INFO - ##### 16:54:25 INFO - ##### Running clobber step. 16:54:25 INFO - ##### 16:54:25 INFO - Running pre-action listener: _resource_record_pre_action 16:54:25 INFO - Running main action method: clobber 16:54:25 INFO - rmtree: /builds/slave/test-pgo/build 16:54:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:54:26 INFO - Running post-action listener: _resource_record_post_action 16:54:26 INFO - ##### 16:54:26 INFO - ##### Running read-buildbot-config step. 16:54:26 INFO - ##### 16:54:26 INFO - Running pre-action listener: _resource_record_pre_action 16:54:26 INFO - Running main action method: read_buildbot_config 16:54:26 INFO - Using buildbot properties: 16:54:26 INFO - { 16:54:26 INFO - "project": "", 16:54:26 INFO - "product": "firefox", 16:54:26 INFO - "script_repo_revision": "production", 16:54:26 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 16:54:26 INFO - "repository": "", 16:54:26 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 16:54:26 INFO - "buildid": "20160108143011", 16:54:26 INFO - "pgo_build": "True", 16:54:26 INFO - "basedir": "/builds/slave/test-pgo", 16:54:26 INFO - "buildnumber": 1091, 16:54:26 INFO - "slavename": "talos-linux64-ix-030", 16:54:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:54:26 INFO - "platform": "ubuntu64_hw", 16:54:26 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 16:54:26 INFO - "branch": "b2g-inbound", 16:54:26 INFO - "repo_path": "integration/b2g-inbound", 16:54:26 INFO - "revision": "d49d52dba30dee18dbcc4d148a7a3cf7ed346710", 16:54:26 INFO - "stage_platform": "linux64-pgo", 16:54:26 INFO - "builduid": "a81d992e66de41b0aaca4a043fab8c33", 16:54:26 INFO - "slavebuilddir": "test" 16:54:26 INFO - } 16:54:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/RJ3XuWH3SRyWn0JssVKlDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:54:26 INFO - Running post-action listener: _resource_record_post_action 16:54:26 INFO - ##### 16:54:26 INFO - ##### Running download-and-extract step. 16:54:26 INFO - ##### 16:54:26 INFO - Running pre-action listener: _resource_record_pre_action 16:54:26 INFO - Running main action method: download_and_extract 16:54:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:54: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')]} 16:54:26 INFO - https://queue.taskcluster.net/v1/task/RJ3XuWH3SRyWn0JssVKlDg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:54:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ3XuWH3SRyWn0JssVKlDg/artifacts/public/build/test_packages.json 16:54:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ3XuWH3SRyWn0JssVKlDg/artifacts/public/build/test_packages.json 16:54:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ3XuWH3SRyWn0JssVKlDg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:54:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ3XuWH3SRyWn0JssVKlDg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:54:30 INFO - Downloaded 1302 bytes. 16:54:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:54:30 INFO - Using the following test package requirements: 16:54:30 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:54:30 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:54:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:54:30 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:54:30 INFO - u'jsshell-linux-x86_64.zip'], 16:54:30 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:54:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:54:30 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:54:30 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:54:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:54:30 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:54:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:54:30 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:54:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:54:30 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:54:30 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:54:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:54:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:54:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:30 INFO - https://queue.taskcluster.net/v1/task/RJ3XuWH3SRyWn0JssVKlDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:54:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ3XuWH3SRyWn0JssVKlDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:54:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ3XuWH3SRyWn0JssVKlDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:54:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ3XuWH3SRyWn0JssVKlDg/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 16:54:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ3XuWH3SRyWn0JssVKlDg/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 16:54:32 INFO - Downloaded 24028195 bytes. 16:54:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:54:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:54:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:54:33 INFO - Return code: 0 16:54:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:33 INFO - https://queue.taskcluster.net/v1/task/RJ3XuWH3SRyWn0JssVKlDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:54:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ3XuWH3SRyWn0JssVKlDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:54:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ3XuWH3SRyWn0JssVKlDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:54:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ3XuWH3SRyWn0JssVKlDg/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 16:54:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ3XuWH3SRyWn0JssVKlDg/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 16:54:35 INFO - Downloaded 24028195 bytes. 16:54:35 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 16:54:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:54:35 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 16:54:36 INFO - Return code: 0 16:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:36 INFO - https://queue.taskcluster.net/v1/task/RJ3XuWH3SRyWn0JssVKlDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:54:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ3XuWH3SRyWn0JssVKlDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:54:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ3XuWH3SRyWn0JssVKlDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:54:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ3XuWH3SRyWn0JssVKlDg/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 16:54:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ3XuWH3SRyWn0JssVKlDg/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 16:54:37 INFO - Downloaded 11132285 bytes. 16:54:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 16:54:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:54:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 16:54:38 INFO - Return code: 0 16:54: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')]} 16:54:38 INFO - https://queue.taskcluster.net/v1/task/RJ3XuWH3SRyWn0JssVKlDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:54:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ3XuWH3SRyWn0JssVKlDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:54:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ3XuWH3SRyWn0JssVKlDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:54:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ3XuWH3SRyWn0JssVKlDg/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 16:54:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ3XuWH3SRyWn0JssVKlDg/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 16:54:39 INFO - Downloaded 55916300 bytes. 16:54:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RJ3XuWH3SRyWn0JssVKlDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:54:39 INFO - mkdir: /builds/slave/test-pgo/properties 16:54:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:54:39 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:54:39 INFO - Contents: 16:54:39 INFO - build_url:https://queue.taskcluster.net/v1/task/RJ3XuWH3SRyWn0JssVKlDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:54:39 INFO - Running post-action listener: _resource_record_post_action 16:54:39 INFO - Running post-action listener: set_extra_try_arguments 16:54:39 INFO - ##### 16:54:39 INFO - ##### Running populate-webroot step. 16:54:39 INFO - ##### 16:54:39 INFO - Running pre-action listener: _resource_record_pre_action 16:54:39 INFO - Running main action method: populate_webroot 16:54:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:54:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:54:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:54:39 INFO - '--tppagecycles', 16:54:39 INFO - '7'], 16:54:39 INFO - 'tests': ['tsvgm']}}, 16:54:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:54:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:54:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:54:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:54:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:54:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:54:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:54:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:39 INFO - 'talos_options': ['--e10s'], 16:54:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:54:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:39 INFO - 'tests': ['damp', 'tps']}, 16:54:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:39 INFO - 'talos_options': ['--e10s'], 16:54:39 INFO - 'tests': ['damp', 'tps']}, 16:54:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:54:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:54:39 INFO - 'other': {'tests': ['a11yr', 16:54:39 INFO - 'ts_paint', 16:54:39 INFO - 'tpaint', 16:54:39 INFO - 'sessionrestore', 16:54:39 INFO - 'sessionrestore_no_auto_restore']}, 16:54:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:54:39 INFO - 'tests': ['a11yr', 16:54:39 INFO - 'ts_paint', 16:54:39 INFO - 'tpaint', 16:54:39 INFO - 'sessionrestore', 16:54:39 INFO - 'sessionrestore_no_auto_restore']}, 16:54:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:54:39 INFO - 'tests': ['a11yr', 16:54:39 INFO - 'ts_paint', 16:54:39 INFO - 'tpaint', 16:54:39 INFO - 'sessionrestore', 16:54:39 INFO - 'sessionrestore_no_auto_restore']}, 16:54:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:54:39 INFO - 'tests': ['a11yr', 16:54:39 INFO - 'ts_paint', 16:54:39 INFO - 'tpaint', 16:54:39 INFO - 'sessionrestore', 16:54:39 INFO - 'sessionrestore_no_auto_restore']}, 16:54:39 INFO - 'other_l64': {'tests': ['a11yr', 16:54:39 INFO - 'ts_paint', 16:54:39 INFO - 'tpaint', 16:54:39 INFO - 'sessionrestore', 16:54:39 INFO - 'sessionrestore_no_auto_restore']}, 16:54:39 INFO - 'other_nol64': {'tests': ['a11yr', 16:54:39 INFO - 'ts_paint', 16:54:39 INFO - 'tpaint', 16:54:39 INFO - 'sessionrestore', 16:54:39 INFO - 'sessionrestore_no_auto_restore']}, 16:54:39 INFO - 'svgr': {'tests': ['tsvgx', 16:54:39 INFO - 'tsvgr_opacity', 16:54:39 INFO - 'tart', 16:54:39 INFO - 'tscrollx', 16:54:39 INFO - 'cart']}, 16:54:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:54:39 INFO - 'tests': ['tsvgx', 16:54:39 INFO - 'tsvgr_opacity', 16:54:39 INFO - 'tart', 16:54:39 INFO - 'tscrollx', 16:54:39 INFO - 'cart']}, 16:54:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:39 INFO - 'tests': ['tp5o']}, 16:54:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:39 INFO - 'talos_options': ['--e10s'], 16:54:39 INFO - 'tests': ['tp5o']}, 16:54:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:39 INFO - 'talos_options': ['--xperf_path', 16:54:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:54:39 INFO - 'tests': ['tp5n']}, 16:54:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:39 INFO - 'talos_options': ['--e10s', 16:54:39 INFO - '--xperf_path', 16:54:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:54:39 INFO - 'tests': ['tp5n']}}, 16:54:39 INFO - 'talos.zip': {'path': '', 16:54:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:54:39 INFO - Running post-action listener: _resource_record_post_action 16:54:39 INFO - ##### 16:54:39 INFO - ##### Running create-virtualenv step. 16:54:39 INFO - ##### 16:54:39 INFO - Running pre-action listener: _resource_record_pre_action 16:54:39 INFO - Running main action method: create_virtualenv 16:54:39 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:54:39 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 16:54:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:54:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:54:39 INFO - Using real prefix '/usr' 16:54:39 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:54:40 INFO - Installing distribute.............................................................................................................................................................................................done. 16:54:42 INFO - Installing pip.................done. 16:54:42 INFO - Return code: 0 16:54:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:54: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')]} 16:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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')]} 16:54:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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 0x7fa025986f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2842840>, '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 0x27af6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27afb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712', '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 16:54: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 16:54: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 16:54:42 INFO - Using env: {'DISPLAY': ':0', 16:54:42 INFO - 'HOME': '/home/cltbld', 16:54:42 INFO - 'LANG': 'en_US.UTF-8', 16:54:42 INFO - 'LANGUAGE': 'en_US:en', 16:54:42 INFO - 'LOGNAME': 'cltbld', 16:54:42 INFO - 'MAIL': '/var/mail/cltbld', 16:54:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:42 INFO - 'MOZ_NO_REMOTE': '1', 16:54:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:42 INFO - 'NO_EM_RESTART': '1', 16:54:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:54:42 INFO - 'PWD': '/builds/slave/test-pgo', 16:54:42 INFO - 'SHELL': '/bin/bash', 16:54:42 INFO - 'SHLVL': '1', 16:54:42 INFO - 'TERM': 'linux', 16:54:42 INFO - 'TMOUT': '86400', 16:54:42 INFO - 'USER': 'cltbld', 16:54:42 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712', 16:54:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:42 INFO - '_': '/tools/buildbot/bin/python'} 16:54:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:42 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 16:54:42 INFO - Cleaning up... 16:54:42 INFO - Return code: 0 16:54:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:54: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')]} 16:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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')]} 16:54:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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', '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 0x7fa025986f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2842840>, '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 0x27af6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27afb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712', '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 16:54: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 16:54: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 psutil>=0.7.1 16:54:42 INFO - Using env: {'DISPLAY': ':0', 16:54:42 INFO - 'HOME': '/home/cltbld', 16:54:42 INFO - 'LANG': 'en_US.UTF-8', 16:54:42 INFO - 'LANGUAGE': 'en_US:en', 16:54:42 INFO - 'LOGNAME': 'cltbld', 16:54:42 INFO - 'MAIL': '/var/mail/cltbld', 16:54:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:42 INFO - 'MOZ_NO_REMOTE': '1', 16:54:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:42 INFO - 'NO_EM_RESTART': '1', 16:54:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:54:42 INFO - 'PWD': '/builds/slave/test-pgo', 16:54:42 INFO - 'SHELL': '/bin/bash', 16:54:42 INFO - 'SHLVL': '1', 16:54:42 INFO - 'TERM': 'linux', 16:54:42 INFO - 'TMOUT': '86400', 16:54:42 INFO - 'USER': 'cltbld', 16:54:42 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712', 16:54:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:42 INFO - '_': '/tools/buildbot/bin/python'} 16:54:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:42 INFO - Downloading/unpacking psutil>=0.7.1 16:54:42 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 16:54:42 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 16:54:42 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 16:54:42 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 16:54:42 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 16:54:42 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 16:54:44 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 16:54:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:54:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:54:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:54:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:54:44 INFO - Installing collected packages: psutil 16:54:44 INFO - Running setup.py install for psutil 16:54:44 INFO - building 'psutil._psutil_linux' extension 16:54:44 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 16:54:44 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 16:54:44 INFO - building 'psutil._psutil_posix' extension 16:54:44 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 16:54:44 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 16:54:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:54:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:54:45 INFO - Successfully installed psutil 16:54:45 INFO - Cleaning up... 16:54:45 INFO - Return code: 0 16:54:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:54: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')]} 16:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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')]} 16:54:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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 0x7fa025986f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2842840>, '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 0x27af6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27afb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712', '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 16:54: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 16:54: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 16:54:45 INFO - Using env: {'DISPLAY': ':0', 16:54:45 INFO - 'HOME': '/home/cltbld', 16:54:45 INFO - 'LANG': 'en_US.UTF-8', 16:54:45 INFO - 'LANGUAGE': 'en_US:en', 16:54:45 INFO - 'LOGNAME': 'cltbld', 16:54:45 INFO - 'MAIL': '/var/mail/cltbld', 16:54:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:45 INFO - 'MOZ_NO_REMOTE': '1', 16:54:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:45 INFO - 'NO_EM_RESTART': '1', 16:54:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:54:45 INFO - 'PWD': '/builds/slave/test-pgo', 16:54:45 INFO - 'SHELL': '/bin/bash', 16:54:45 INFO - 'SHLVL': '1', 16:54:45 INFO - 'TERM': 'linux', 16:54:45 INFO - 'TMOUT': '86400', 16:54:45 INFO - 'USER': 'cltbld', 16:54:45 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712', 16:54:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:45 INFO - '_': '/tools/buildbot/bin/python'} 16:54:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:54:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:54:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:54: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) 16:54:47 INFO - Installing collected packages: mozsystemmonitor 16:54:47 INFO - Running setup.py install for mozsystemmonitor 16:54:47 INFO - Successfully installed mozsystemmonitor 16:54:47 INFO - Cleaning up... 16:54:47 INFO - Return code: 0 16:54:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:54: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')]} 16:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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')]} 16:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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 0x7fa025986f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2842840>, '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 0x27af6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27afb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712', '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 16:54: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 16:54: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 16:54:47 INFO - Using env: {'DISPLAY': ':0', 16:54:47 INFO - 'HOME': '/home/cltbld', 16:54:47 INFO - 'LANG': 'en_US.UTF-8', 16:54:47 INFO - 'LANGUAGE': 'en_US:en', 16:54:47 INFO - 'LOGNAME': 'cltbld', 16:54:47 INFO - 'MAIL': '/var/mail/cltbld', 16:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:47 INFO - 'MOZ_NO_REMOTE': '1', 16:54:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:47 INFO - 'NO_EM_RESTART': '1', 16:54:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:54:47 INFO - 'PWD': '/builds/slave/test-pgo', 16:54:47 INFO - 'SHELL': '/bin/bash', 16:54:47 INFO - 'SHLVL': '1', 16:54:47 INFO - 'TERM': 'linux', 16:54:47 INFO - 'TMOUT': '86400', 16:54:47 INFO - 'USER': 'cltbld', 16:54:47 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712', 16:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:47 INFO - '_': '/tools/buildbot/bin/python'} 16:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:47 INFO - Downloading/unpacking blobuploader==1.2.4 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54:49 INFO - Downloading blobuploader-1.2.4.tar.gz 16:54:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:54:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:54:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:54:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:54:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54:49 INFO - Downloading docopt-0.6.1.tar.gz 16:54:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:54:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:54:49 INFO - Installing collected packages: blobuploader, requests, docopt 16:54:49 INFO - Running setup.py install for blobuploader 16:54:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:54:49 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:54:49 INFO - Running setup.py install for requests 16:54:50 INFO - Running setup.py install for docopt 16:54:50 INFO - Successfully installed blobuploader requests docopt 16:54:50 INFO - Cleaning up... 16:54:50 INFO - Return code: 0 16:54:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:54: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')]} 16:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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')]} 16:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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 0x7fa025986f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2842840>, '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 0x27af6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27afb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712', '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 16:54: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 16:54: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 16:54:50 INFO - Using env: {'DISPLAY': ':0', 16:54:50 INFO - 'HOME': '/home/cltbld', 16:54:50 INFO - 'LANG': 'en_US.UTF-8', 16:54:50 INFO - 'LANGUAGE': 'en_US:en', 16:54:50 INFO - 'LOGNAME': 'cltbld', 16:54:50 INFO - 'MAIL': '/var/mail/cltbld', 16:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:50 INFO - 'MOZ_NO_REMOTE': '1', 16:54:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:50 INFO - 'NO_EM_RESTART': '1', 16:54:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:54:50 INFO - 'PWD': '/builds/slave/test-pgo', 16:54:50 INFO - 'SHELL': '/bin/bash', 16:54:50 INFO - 'SHLVL': '1', 16:54:50 INFO - 'TERM': 'linux', 16:54:50 INFO - 'TMOUT': '86400', 16:54:50 INFO - 'USER': 'cltbld', 16:54:50 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712', 16:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:50 INFO - '_': '/tools/buildbot/bin/python'} 16:54:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:54:50 INFO - Running setup.py (path:/tmp/pip-Ny7459-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:54:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:54:50 INFO - Running setup.py (path:/tmp/pip-9fohRy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:54:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:54:50 INFO - Running setup.py (path:/tmp/pip-dm6h2Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:54:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:54:50 INFO - Running setup.py (path:/tmp/pip-Ziy6ym-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:54:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:54:50 INFO - Running setup.py (path:/tmp/pip-KldASJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:54:51 INFO - Running setup.py (path:/tmp/pip-gKMVHe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:54:51 INFO - Running setup.py (path:/tmp/pip-SdWmZ7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:54:51 INFO - Running setup.py (path:/tmp/pip-UQecB6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:54:51 INFO - Running setup.py (path:/tmp/pip-YhHsnn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:54:51 INFO - Running setup.py (path:/tmp/pip-grypQ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:54:51 INFO - Running setup.py (path:/tmp/pip-9XTBgi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:54:51 INFO - Running setup.py (path:/tmp/pip-38fVpJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:54:51 INFO - Running setup.py (path:/tmp/pip-Q35rJv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:54:51 INFO - Running setup.py (path:/tmp/pip-I1Jw2T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:54:51 INFO - Running setup.py (path:/tmp/pip-d8W_5z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:54:51 INFO - Running setup.py (path:/tmp/pip-69p16P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:54:51 INFO - Running setup.py (path:/tmp/pip-1rS7eo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:54:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:54:51 INFO - Running setup.py install for manifestparser 16:54:51 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:54:52 INFO - Running setup.py install for mozcrash 16:54:52 INFO - Running setup.py install for mozdebug 16:54:52 INFO - Running setup.py install for mozdevice 16:54:52 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:54:52 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:54:52 INFO - Running setup.py install for mozfile 16:54:52 INFO - Running setup.py install for mozhttpd 16:54:52 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:54:52 INFO - Running setup.py install for mozinfo 16:54:52 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:54:52 INFO - Running setup.py install for mozInstall 16:54:52 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:54:52 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:54:52 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:54:52 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:54:52 INFO - Running setup.py install for mozleak 16:54:52 INFO - Running setup.py install for mozlog 16:54:52 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:54:52 INFO - Running setup.py install for moznetwork 16:54:53 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:54:53 INFO - Running setup.py install for mozprocess 16:54:53 INFO - Running setup.py install for mozprofile 16:54:53 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:54:53 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:54:53 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:54:53 INFO - Running setup.py install for mozrunner 16:54:53 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:54:53 INFO - Running setup.py install for mozscreenshot 16:54:53 INFO - Running setup.py install for moztest 16:54:53 INFO - Running setup.py install for mozversion 16:54:53 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:54:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:54:53 INFO - Cleaning up... 16:54:53 INFO - Return code: 0 16:54:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:54:53 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')]} 16:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:53 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')]} 16:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:53 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 0x7fa025986f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2842840>, '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 0x27af6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27afb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712', '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 16:54:53 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 16:54:53 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 16:54:53 INFO - Using env: {'DISPLAY': ':0', 16:54:53 INFO - 'HOME': '/home/cltbld', 16:54:53 INFO - 'LANG': 'en_US.UTF-8', 16:54:53 INFO - 'LANGUAGE': 'en_US:en', 16:54:53 INFO - 'LOGNAME': 'cltbld', 16:54:53 INFO - 'MAIL': '/var/mail/cltbld', 16:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:53 INFO - 'MOZ_NO_REMOTE': '1', 16:54:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:53 INFO - 'NO_EM_RESTART': '1', 16:54:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:54:53 INFO - 'PWD': '/builds/slave/test-pgo', 16:54:53 INFO - 'SHELL': '/bin/bash', 16:54:53 INFO - 'SHLVL': '1', 16:54:53 INFO - 'TERM': 'linux', 16:54:53 INFO - 'TMOUT': '86400', 16:54:53 INFO - 'USER': 'cltbld', 16:54:53 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712', 16:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:53 INFO - '_': '/tools/buildbot/bin/python'} 16:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:54:53 INFO - Running setup.py (path:/tmp/pip-sIOjbp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:54:53 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)) 16:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:54:53 INFO - Running setup.py (path:/tmp/pip-WpFJRj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:54: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)) 16:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:54:54 INFO - Running setup.py (path:/tmp/pip-HJL_7v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:54: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)) 16:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:54:54 INFO - Running setup.py (path:/tmp/pip-bmNWH3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:54: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)) 16:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:54:54 INFO - Running setup.py (path:/tmp/pip-msVFli-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:54: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)) 16:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:54:54 INFO - Running setup.py (path:/tmp/pip-JKeaEf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:54: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)) 16:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:54:54 INFO - Running setup.py (path:/tmp/pip-MZPbX7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:54: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)) 16:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:54:54 INFO - Running setup.py (path:/tmp/pip-JT4ghY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:54: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)) 16:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:54:54 INFO - Running setup.py (path:/tmp/pip-Jc1OaL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:54: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)) 16:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:54:54 INFO - Running setup.py (path:/tmp/pip-lWac_G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:54: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)) 16:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:54:54 INFO - Running setup.py (path:/tmp/pip-SA4FYb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:54:54 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)) 16:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:54:54 INFO - Running setup.py (path:/tmp/pip-ms3ntp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:54:54 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)) 16:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:54:54 INFO - Running setup.py (path:/tmp/pip-8LDW7C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:54:54 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)) 16:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:54:54 INFO - Running setup.py (path:/tmp/pip-79xhiX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:54:54 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)) 16:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:54:54 INFO - Running setup.py (path:/tmp/pip-ukQowj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:54:54 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)) 16:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:54:54 INFO - Running setup.py (path:/tmp/pip-apRCdZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:54: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)) 16:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:54:55 INFO - Running setup.py (path:/tmp/pip-P8TuW0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:54: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)) 16:54: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)) 16:54: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)) 16:54: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)) 16:54: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)) 16:54: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)) 16:54:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54:56 INFO - Downloading blessings-1.5.1.tar.gz 16:54:56 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 16:54:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:54:56 INFO - Installing collected packages: blessings 16:54:56 INFO - Running setup.py install for blessings 16:54:57 INFO - Successfully installed blessings 16:54:57 INFO - Cleaning up... 16:54:57 INFO - Return code: 0 16:54:57 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:54:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:54:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:54:57 INFO - Reading from file tmpfile_stdout 16:54:57 INFO - Current package versions: 16:54:57 INFO - argparse == 1.2.1 16:54:57 INFO - blessings == 1.5.1 16:54:57 INFO - blobuploader == 1.2.4 16:54:57 INFO - docopt == 0.6.1 16:54:57 INFO - manifestparser == 1.1 16:54:57 INFO - mozInstall == 1.12 16:54:57 INFO - mozcrash == 0.16 16:54:57 INFO - mozdebug == 0.1 16:54:57 INFO - mozdevice == 0.47 16:54:57 INFO - mozfile == 1.2 16:54:57 INFO - mozhttpd == 0.7 16:54:57 INFO - mozinfo == 0.9 16:54:57 INFO - mozleak == 0.1 16:54:57 INFO - mozlog == 3.1 16:54:57 INFO - moznetwork == 0.27 16:54:57 INFO - mozprocess == 0.22 16:54:57 INFO - mozprofile == 0.28 16:54:57 INFO - mozrunner == 6.11 16:54:57 INFO - mozscreenshot == 0.1 16:54:57 INFO - mozsystemmonitor == 0.0 16:54:57 INFO - moztest == 0.7 16:54:57 INFO - mozversion == 1.4 16:54:57 INFO - psutil == 3.1.1 16:54:57 INFO - requests == 1.2.3 16:54:57 INFO - wsgiref == 0.1.2 16:54:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:54: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')]} 16:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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')]} 16:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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 0x7fa025986f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2842840>, '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 0x27af6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27afb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712', '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 16:54: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 16:54: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 16:54:57 INFO - Using env: {'DISPLAY': ':0', 16:54:57 INFO - 'HOME': '/home/cltbld', 16:54:57 INFO - 'LANG': 'en_US.UTF-8', 16:54:57 INFO - 'LANGUAGE': 'en_US:en', 16:54:57 INFO - 'LOGNAME': 'cltbld', 16:54:57 INFO - 'MAIL': '/var/mail/cltbld', 16:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:57 INFO - 'MOZ_NO_REMOTE': '1', 16:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:57 INFO - 'NO_EM_RESTART': '1', 16:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:54:57 INFO - 'PWD': '/builds/slave/test-pgo', 16:54:57 INFO - 'SHELL': '/bin/bash', 16:54:57 INFO - 'SHLVL': '1', 16:54:57 INFO - 'TERM': 'linux', 16:54:57 INFO - 'TMOUT': '86400', 16:54:57 INFO - 'USER': 'cltbld', 16:54:57 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712', 16:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:57 INFO - '_': '/tools/buildbot/bin/python'} 16:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54: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)) 16:54: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)) 16:54: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)) 16:54: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)) 16:54: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)) 16:54: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)) 16:54: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)) 16:54: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)) 16:54: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)) 16:54: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)) 16:54: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)) 16:54:57 INFO - Cleaning up... 16:54:57 INFO - Return code: 0 16:54:57 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:54: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')]} 16:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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')]} 16:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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 0x7fa025986f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2842840>, '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 0x27af6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27afb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712', '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 16:54: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 16:54: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 16:54:57 INFO - Using env: {'DISPLAY': ':0', 16:54:57 INFO - 'HOME': '/home/cltbld', 16:54:57 INFO - 'LANG': 'en_US.UTF-8', 16:54:57 INFO - 'LANGUAGE': 'en_US:en', 16:54:57 INFO - 'LOGNAME': 'cltbld', 16:54:57 INFO - 'MAIL': '/var/mail/cltbld', 16:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:57 INFO - 'MOZ_NO_REMOTE': '1', 16:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:57 INFO - 'NO_EM_RESTART': '1', 16:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:54:57 INFO - 'PWD': '/builds/slave/test-pgo', 16:54:57 INFO - 'SHELL': '/bin/bash', 16:54:57 INFO - 'SHLVL': '1', 16:54:57 INFO - 'TERM': 'linux', 16:54:57 INFO - 'TMOUT': '86400', 16:54:57 INFO - 'USER': 'cltbld', 16:54:57 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712', 16:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:57 INFO - '_': '/tools/buildbot/bin/python'} 16:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:57 INFO - Downloading/unpacking jsonschema 16:54:57 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 16:54:57 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 16:54:57 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 16:54:57 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 16:54:57 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 16:54:57 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 16:54:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:54: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 16:54:59 INFO - Downloading/unpacking functools32 (from jsonschema) 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54:59 INFO - Downloading functools32-3.2.3-2.tar.gz 16:54: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 16:54:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:54:59 INFO - warning: no files found matching '*.txt' 16:54:59 INFO - no previously-included directories found matching 'build' 16:54:59 INFO - no previously-included directories found matching 'dist' 16:54:59 INFO - no previously-included directories found matching '.git*' 16:54:59 INFO - Installing collected packages: jsonschema, functools32 16:54:59 INFO - Running setup.py install for functools32 16:54:59 INFO - warning: no files found matching '*.txt' 16:54:59 INFO - no previously-included directories found matching 'build' 16:54:59 INFO - no previously-included directories found matching 'dist' 16:54:59 INFO - no previously-included directories found matching '.git*' 16:54:59 INFO - Successfully installed jsonschema functools32 16:54:59 INFO - Cleaning up... 16:54:59 INFO - Return code: 0 16:54:59 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:59 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 0x7fa025986f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2842840>, '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 0x27af6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27afb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712', '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 16:54:59 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 16:54:59 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 16:54:59 INFO - Using env: {'DISPLAY': ':0', 16:54:59 INFO - 'HOME': '/home/cltbld', 16:54:59 INFO - 'LANG': 'en_US.UTF-8', 16:54:59 INFO - 'LANGUAGE': 'en_US:en', 16:54:59 INFO - 'LOGNAME': 'cltbld', 16:54:59 INFO - 'MAIL': '/var/mail/cltbld', 16:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:59 INFO - 'MOZ_NO_REMOTE': '1', 16:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:59 INFO - 'NO_EM_RESTART': '1', 16:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:54:59 INFO - 'PWD': '/builds/slave/test-pgo', 16:54:59 INFO - 'SHELL': '/bin/bash', 16:54:59 INFO - 'SHLVL': '1', 16:54:59 INFO - 'TERM': 'linux', 16:54:59 INFO - 'TMOUT': '86400', 16:54:59 INFO - 'USER': 'cltbld', 16:54:59 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712', 16:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:59 INFO - '_': '/tools/buildbot/bin/python'} 16:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:00 INFO - Downloading/unpacking flake8 16:55: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 16:55: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 16:55: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 16:55: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 16:55: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 16:55: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 16:55:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:55:01 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 16:55:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:55:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:55: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 16:55:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:55: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 16:55: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 16:55: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 16:55: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 16:55: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 16:55: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 16:55: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 16:55:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:55: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 16:55: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 16:55: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 16:55: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 16:55: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 16:55: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 16:55:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:55:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:55:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:55:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:55:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:55:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:55:02 INFO - no previously-included directories found matching 'docs/_build' 16:55:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:55:02 INFO - Running setup.py install for pep8 16:55:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:55:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:55:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:55:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:55:02 INFO - no previously-included directories found matching 'docs/_build' 16:55:02 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:55:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:55:02 INFO - Cleaning up... 16:55:02 INFO - Return code: 0 16:55:02 INFO - Running post-action listener: _resource_record_post_action 16:55:02 INFO - Running post-action listener: _start_resource_monitoring 16:55:02 INFO - Starting resource monitoring. 16:55:02 INFO - ##### 16:55:02 INFO - ##### Running install step. 16:55:02 INFO - ##### 16:55:02 INFO - Running pre-action listener: _resource_record_pre_action 16:55:02 INFO - Running main action method: install 16:55:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:55:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:55:02 INFO - Reading from file tmpfile_stdout 16:55:02 INFO - Detecting whether we're running mozinstall >=1.0... 16:55:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:55:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:55:03 INFO - Reading from file tmpfile_stdout 16:55:03 INFO - Output received: 16:55:03 INFO - Usage: mozinstall [options] installer 16:55:03 INFO - Options: 16:55:03 INFO - -h, --help show this help message and exit 16:55:03 INFO - -d DEST, --destination=DEST 16:55:03 INFO - Directory to install application into. [default: 16:55:03 INFO - "/builds/slave/test-pgo"] 16:55:03 INFO - --app=APP Application being installed. [default: firefox] 16:55:03 INFO - mkdir: /builds/slave/test-pgo/build/application 16:55: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'] 16:55: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 16:55:19 INFO - Reading from file tmpfile_stdout 16:55:19 INFO - Output received: 16:55:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:55:19 INFO - Running post-action listener: _resource_record_post_action 16:55:19 INFO - ##### 16:55:19 INFO - ##### Running run-tests step. 16:55:19 INFO - ##### 16:55:19 INFO - Running pre-action listener: _resource_record_pre_action 16:55:19 INFO - Running main action method: run_tests 16:55:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:55:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:55:19 INFO - Python 2.7.3 16:55:19 INFO - Return code: 0 16:55:19 INFO - grabbing minidump binary from tooltool 16:55: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')]} 16:55: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 0x2842840>, '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 0x27af6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27afb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:55: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 16:55: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 16:55:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:55:19 INFO - Return code: 0 16:55:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:55:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:55:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:55:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:55:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:55:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:55:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:55:20 INFO - Return code: 0 16:55:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RJ3XuWH3SRyWn0JssVKlDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 16:55:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RJ3XuWH3SRyWn0JssVKlDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 16:55:20 INFO - Using env: {'DISPLAY': ':0', 16:55:20 INFO - 'HOME': '/home/cltbld', 16:55:20 INFO - 'LANG': 'en_US.UTF-8', 16:55:20 INFO - 'LANGUAGE': 'en_US:en', 16:55:20 INFO - 'LOGNAME': 'cltbld', 16:55:20 INFO - 'MAIL': '/var/mail/cltbld', 16:55:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:55:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:55:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:20 INFO - 'MOZ_NO_REMOTE': '1', 16:55:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:55:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:20 INFO - 'NO_EM_RESTART': '1', 16:55:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:55:20 INFO - 'PWD': '/builds/slave/test-pgo', 16:55:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:55:20 INFO - 'SHELL': '/bin/bash', 16:55:20 INFO - 'SHLVL': '1', 16:55:20 INFO - 'TERM': 'linux', 16:55:20 INFO - 'TMOUT': '86400', 16:55:20 INFO - 'USER': 'cltbld', 16:55:20 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712', 16:55:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:20 INFO - '_': '/tools/buildbot/bin/python'} 16:55:20 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RJ3XuWH3SRyWn0JssVKlDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 16:55:20 INFO - mozversion application_buildid: 20160108143011 16:55:20 INFO - mozversion application_changeset: d49d52dba30dee18dbcc4d148a7a3cf7ed346710 16:55:20 INFO - mozversion application_display_name: Nightly 16:55:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:55:20 INFO - mozversion application_name: Firefox 16:55:20 INFO - mozversion application_remotingname: firefox 16:55:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 16:55:20 INFO - mozversion application_vendor: Mozilla 16:55:20 INFO - mozversion application_version: 46.0a1 16:55:20 INFO - mozversion platform_buildid: 20160108143011 16:55:20 INFO - mozversion platform_changeset: d49d52dba30dee18dbcc4d148a7a3cf7ed346710 16:55:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 16:55:20 INFO - mozversion platform_version: 46.0a1 16:55:20 INFO - using testdate: 1452300920 16:55:20 INFO - actual date: 1452300920 16:55:20 INFO - starting webserver on 'localhost:52696' 16:55:20 INFO - SUITE-START | Running 3 tests 16:55:20 INFO - TEST-START | dromaeo_css 16:55:20 INFO - operating with platform_type : linux_ 16:55:20 INFO - Initialising browser for dromaeo_css test... 16:55:20 INFO - TEST-INFO | started process 13734 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdcCNhC/profile http://localhost:52696/getInfo.html) 16:55:24 INFO - PROCESS | 13734 | __metrics Screen width/height:1600/1200 16:55:24 INFO - PROCESS | 13734 | colorDepth:24 16:55:24 INFO - PROCESS | 13734 | Browser inner width/height: 1024/697 16:55:24 INFO - PROCESS | 13734 | __metrics 16:55:24 INFO - PROCESS | 13734 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:55:24 INFO - PROCESS | 13734 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:55:25 INFO - TEST-INFO | 13734: exit 0 16:55:25 INFO - Browser initialized. 16:55:25 INFO - Running cycle 1/1 for dromaeo_css test... 16:55:25 INFO - TEST-INFO | started process 13827 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdcCNhC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:55:37 INFO - PROCESS | 13827 | RSS: Main: 148926464 16:55:37 INFO - PROCESS | 13827 | 16:56:28 INFO - PROCESS | 13827 | 1452300988744 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] 16:58:36 INFO - PROCESS | 13827 | Cycle 1(1): loaded http://localhost:52696/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52696/tests/dromaeo/cssquery-ext.html) 16:58:38 INFO - PROCESS | 13827 | RSS: Main: 339976192 16:58:38 INFO - PROCESS | 13827 | 17:01:41 INFO - PROCESS | 13827 | Cycle 1(1): loaded http://localhost:52696/tests/dromaeo/cssquery-ext.html (next: http://localhost:52696/tests/dromaeo/cssquery-jquery.html) 17:01:41 INFO - PROCESS | 13827 | RSS: Main: 239779840 17:01:41 INFO - PROCESS | 13827 | 17:04:44 INFO - PROCESS | 13827 | Cycle 1(1): loaded http://localhost:52696/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52696/tests/dromaeo/cssquery-mootools.html) 17:04:44 INFO - PROCESS | 13827 | RSS: Main: 246427648 17:04:44 INFO - PROCESS | 13827 | 17:07:46 INFO - PROCESS | 13827 | Cycle 1(1): loaded http://localhost:52696/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52696/tests/dromaeo/cssquery-prototype.html) 17:07:47 INFO - PROCESS | 13827 | RSS: Main: 217124864 17:07:47 INFO - PROCESS | 13827 | 17:10:49 INFO - PROCESS | 13827 | Cycle 1(1): loaded http://localhost:52696/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52696/tests/dromaeo/cssquery-yui.html) 17:10:50 INFO - PROCESS | 13827 | RSS: Main: 219508736 17:10:50 INFO - PROCESS | 13827 | 17:13:52 INFO - PROCESS | 13827 | Cycle 1(1): loaded http://localhost:52696/tests/dromaeo/cssquery-yui.html (next: http://localhost:52696/tests/dromaeo/cssquery-dojo.html) 17:13:53 INFO - PROCESS | 13827 | RSS: Main: 292290560 17:13:53 INFO - PROCESS | 13827 | 17:13:53 INFO - PROCESS | 13827 | __start_tp_report 17:13:53 INFO - PROCESS | 13827 | _x_x_mozilla_page_load 17:13:53 INFO - PROCESS | 13827 | _x_x_mozilla_page_load_details 17:13:53 INFO - PROCESS | 13827 | |i|pagename|runs| 17:13:53 INFO - PROCESS | 13827 | |0;dojo.html;3068.21760451085;3124.8750049998002;3162.3675264947015;3163.4938409854412;3194.361127774445;5018.121828679985;5165.845024649262;5176.378834539861;5188.16989281715;5239.659422137558;5127.025865085631;5152.355955505562;5165.509276618715;5265.341832270966;5291.68249905006;4729.21967875301;4816.133096042711;4836.347093142434;4875.926861097087;4912.140375434303;4688.859334219979;4786.7845946932475;4869.196582563891;4895.461499235099;4909.8772530686665;4678.789454474557;4785.114753770529;4853.927191092119;4860.416749989989;4896.706197628154;4726.409198850144;4751.121042607128;4754.215554433515;4758.976205118952;4766.022965292107;4734.242521196592;4742.881427964294;4747.287906813971;4751.263554149113;4754.619630429557;4957.5786058185095;5009.899802003976;5093.312402825608;5100.413452452978;5106.08090543702;5521.806736764194;5529.529989950859;5538;5546.69493177875;5550.69471179085;5521.254630624854;5556.583256255797;5561.443855614447;5572.3034620672415;5574.331080270353;5098.872528186825;5189.870253243661;5218.03466358721;5220.190870415092;5337.306150200449;5553.139263414178;5557.166425036277;5572.136318870582;5574.414686457944;5583.330000399978;5371.57027437804;5388.946110538923;5391.595630327741;5391.9460805391445;5394.433584473652;5414.133738601805;5426.403095659474;5526.917096243559;5533.087040638249;5537.197106419627;5568.303962004749;5573.498385145356;5575.972120139373;5580.581456390787;5593.972030139823;5526.50261476469;5538.9169162462595;5542.61201715876;5548.306461692288;5549.861253468695;4180.226658068267;4275.358696195595;4275.8075886585175;4385.407969924019;4391.055922976575;3837.865674701372;3846.0961674006585;3850.2876967761053;3892.4550562921213;3895.104126051024;5180.922286165711;5182.766775495036;5186.792528298901;5189.273501709764;5190.377154741455;5415.918761218585;5503.257060296889;5522.364928033247;5528.806491772769;5587.441255874462;5134.794608215704;5145.07388670043;5148.3564554430695;5158.406783219978;5158.638895277295;4740.928886066712;4744.335792988984;4748.430188377417;4786.617070634411;4793.1372352976105;5580.832575022756;5647.830565083054;5702.087665973424;5740.770369185186;5868.4424979626865;5574.27534420539;5586.413426590149;5590.524805391425;5593.356763972032;5597.440255974533;5768.538516918553;5776.797812076557;5777.566682498746;5778.479936805707;5781.306243250669;5340.279062326536;5435.673859568438;5448.5368743655645;5448.809291674773;5450;5455.972720136374;5485.259489968963;5512.173174023768;5512.862178445571;5516.834494965157;5320.14877619579;5387.461253874581;5387.488188622075;5389.056915039931;5391.7034563099405;5371.194320851903;5386.542143917654;5405.108157154183;5482.862928426821;5516.227728118147;5320.866978325573;5328.973355133199;5329.040772660958;5331.09371406854;5334.919976200283;5377.059014672495;5415.620906536505;5418.83743487696;5423.4034256231;5473.0969390050195;5166.225066240094;5305.257263983122;5350.1974703793185;5459.727013649381;5478.506934375925 17:13:53 INFO - PROCESS | 13827 | |1;ext.html;511.6188439612489;519.8492437193214;527.282895262443;539.4901817782197;550.4083110656045;27487.450250994993;27958.86020569897;27995.300117497074;35535.82232088842;35948.82025589875;38204;38459.423108653325;38960.80519597405;38965.61034389655;38978.22043559134;8325.58372081398;8524.445911015795;8525.275351595123;8525.403221774479;8526.445781024244;7401.555906645618;7583.886241706379;9879.604815807359;10026.248031397638;10099.29304948654;9784.36401633895;9856.655017074403;9864.90135098647;9866.112049915506;9871.457069861155;7421.9628901855685;7634.160242373335;9864;9984.650537231199;9995.70012899614;7468.365188958945;9923.55344009514;10195;10195.745106372326;10200.38797672142;35666;35911.10222244439;35960;35980.280394391964;36048;3078.846057697106;3103.8292893890825;3166.60417447819;3225.870965161414;3577.302426026926;27679;27736.722632773617;27792.861035694896;28039.158825235274;29443.852780736175;3696.131409118855;3762.9059273518105;3805.8667946622013;3810.314143454177;3943.5662077171487;268836;270418.64790676115;270757;270928;270987;54127.72936135294;56396.43603563994;56841.71579142161;56886.14670779942;56945.715271423374;49700;60998;61947.38052619506;61992.69003654953;62006;12644.114911956258;12922.870771292166;12951.222926624432;12995.870041299655;13018.349082545836;9648.855267170999;9678.70963871085;9679.612815487302;9694.51527423626;9703;18225.45323640293;18282.360117395827;18338.63322733538;18450.538736531693;18787.436376908714;6956.826079348057;7118.216996130525;7155.284471552803;7160.386458942448;7239.457040721967;835.2983493865182;839.2195258409738;911.8601747815231;958.7315551645551;992.6525715999487;27694.307642309104;27892.44215115686;27922.72077279201;28280.434391312057;28326.291842704097;999.435319044752;1005.7887843552936;1024.1704219582161;1027.5170669785189;1131.0781712903956;12848;12957.805632915513;13090.410931508104;13152.802707959388;13206.603801885958;315919;321567;322202;322944;323623;50600.24099638508;50784.238236426485;50839.49160508347;50851;50898.74550627297;1180.8523934508187;1184.2894263441865;1253.179167645194;1275.5991828192773;1279.8080287956882;25195.370115747253;26228.475430491664;26234.4753104933;26281.73718262793;26345.604815927392;42389.78805105955;43051.784741076095;47686.76156619334;48743.5125648739;49091.26363104628;199042;199653;201907;202329;202919;27139;27650.170494885184;28649.14052578426;29042.854785725936;29042.85478572678;41392;41929.580704192565;42059.36910946277;42288.78855605825;42348.78825605976;31780;33183.336333273684;33495.49756753699;33727.49408758822;35495.64504354924;30524.236894077825;30795;31136.688633114285;31258.843705781324;31381.843090785314;31414.842925785226;31837.36325273528;32203.677963220067;32260.677393226706;32270;27453.002300308624;30735.516497681965;31097.09232105197;31222.375552489277;31257.8437107813;23706.407339816644;23804;23820.404489887198;24057.398565035313;24077.157299494433 17:13:53 INFO - PROCESS | 13827 | |2;jquery.html;357.9463080537919;362.0225391443104;362.9836657350419;366.159663572102;371.45581722776126;13380.72527670296;13643.590692279222;16150.515484535468;16325;17105.14474276286;14296.642583935407;14932.328045237964;15392.461263855766;15397.769033464507;15648.139352335616;5208.218767184915;5408.756605952722;5412.4858138476975;5415.187721841716;5425.3489581250105;4006.3790112532606;4162.771047592381;5297.947020529803;5424.267723857288;5784.2769653793275;5704.172894930232;5959.731812068468;5966.075258334965;5969.462748352647;5980;5811.6803575803315;5848.327442344143;5859.209006784072;5863.618864773797;5867.589268751189;4902.558769710743;5120.92318615221;5132.897342053138;5173.81891633791;5194.740262986873;12444.875551244462;12559.811602825965;12565.371731413485;16114.355425783071;18104.185311661007;1836.164545131975;1860.474391058554;1911.550785565391;1930.1700268884374;1930.2279088364626;8947.150020748084;9102.362834601581;9162.267018638493;9254.259659227246;9356.578953947088;1727.0673836128476;1774.9822501774945;1785.9285628574842;1810.1763697517729;1867.906604669761;52010.739946300404;52743.73628131873;53793.46206537924;54233.72883135559;55174;9799;9972.900270997343;10027.849582256273;10059.195264378832;10125.493725313705;13063.934680326538;13132.737345253041;13161;13172.143810652276;13172.341382930816;6697.464202863759;6738;6741.932580674131;6772.932270677329;6800.387965083166;5965.612235204698;6011.5190784737115;6027.758889644453;6249.062640603855;6481.351864813481;4322.978385108117;4341.153475072394;4363;4369.148016136886;4383.3863259143745;1710.4697543761474;1773.6098058427126;2779.610854480374;2790.7209279072335;2814.183886672842;428.05186511875723;442.40938347306064;467.2967184387543;850.9021462531888;861.2851333393269;9837.508124593885;9970.102690757867;10397.948010260052;10455.68632941013;10655.413952232546;429.76792532032977;441.96464282857295;442.09811983553834;445.1120015568961;450.41671036007796;5854.970725146432;5930.911036334458;5957.195778569838;6009.128676341993;6017.458428741346;502815;514149;522223;523659;528840;71141.2885871145;72946.63526682333;73192.63403682948;74004;74085.62957185287;484.5445281435439;490.9950900491021;493.4448745161693;494.1426624805959;494.3425244424906;10025.74935626586;10103.696889093046;10152.137068349273;10347.948260258952;10427.895721042996;33526;33738.325233495685;34736.30527389488;35078.29843403168;35220.64779352173;44610.330845036704;45353.54646453625;45811.083778324915;45888.54111458976;49057.754711227644;6163.106349579376;7285.4900156990625;7382.926170738224;7387.298206670358;7426.665800039119;8873.64505419776;10768.192385570957;10920;11171;11343.20597558163;6816.488763342868;6974.6861391238535;7387;7408.777736667908;9586.90413095888;7086.751963681247;7238.77874345911;7363.263673632594;7483.176850546544;7531.209223031503;6356.7775127872155;6405.487560995202;6971.337722916315;7254.746083887249;7568.5458872467825;8872.77818054528;9077.818443631222;9320.533973301443;9362.20421264173;9365.672201472917;6698.497612679166;6719.966400167968;6806.18325800907;6930.3762661360715;7289.671964761705 17:13:53 INFO - PROCESS | 13827 | |3;mootools.html;1321.5506727712575;1455.6215384000157;1455.9126452412852;1614.6124930016792;1788.0612678343869;7017.894731579024;7641.8853717194215;7834.451588388815;7842.215778422169;7852.803679907998;7619.885701714478;7807.21927807219;7820.608969551528;7822.295993360596;7826.0999985001745;1982.2863769043206;2025.250657256817;2270.965935510969;2285.828562857784;2310.202979971907;2312.502811895442;2317.374308936586;2318.3045086474076;2319.0260090761835;2320.5474932388192;2238.55228954209;2306.054517647765;2307.526956973816;2307.665388518664;2308.272894038381;2252.5945329840624;2290.141197051106;2316.5598536278053;2316.66408370787;2318.119114736406;2293.3120063980905;2302.1366987379733;2315.3401280635107;2318.8376813623054;2348.612478940973;8036.116027236999;8100.959495202545;8105.27052565272;8106.513609183409;8112.351011919032;4731.550502702238;4843.539863712942;4844.75776211188;4845.345878306419;4845.442774080955;3011.9698803011906;3048.2074660588187;3107.8135311881133;3163.2408222026547;3188.713015828587;991.6777047459533;999.5701848205268;999.8500224966241;1025.1132770153763;1027.8098551767946;11250.718732031683;11279.43602819864;11285.717857053558;11302.265352752045;11314.37770922599;4388.1223755249075;4421.867343979621;4497.168023915586;4502.234620114523;4545.36364908913;9658.082482164184;9676.70969870905;9680.128788408936;9686.128248457673;9705.708828735149;4849.684770489906;4855.854324370274;4881;4885.8289959851945;4886.315915771795;4389.692721509464;4417.785109094961;4430.579094985971;4431.933520997188;4438.17893689662;3423.1613254752747;3472.9305413892084;3643.071016890729;3649.251903359858;3698.519192505011;1211.2913945341897;1230.944607492665;1236.4250623460134;1237.672016915518;1257.1011726615513;1296.9805452918213;1306.562301628946;1313.7897936330141;1323.5367621332648;1324.278268343755;7521.398288137046;7575.166731659513;7593.088829340514;7594.354479869163;7597.050368703912;1100.3782862682558;1101.251149218523;1108.9390083545482;1120.3725913488472;1134.8467956825723;5687.971560142173;5755.6834374108985;5765.221695071195;5776.5089967352405;5777.913331300034;9566.665166719271;9738.220942324597;9904.65333713331;10002.649907253211;10003.79992400148;9864.556094975744;9873.963233860484;9893.505324733735;9896;9911.355761875599;7186.784396468114;7433.293837085468;7436.330730234305;7441.255874412515;7670.156282808886;7350.963245183953;7375.704971801068;7443.739469118555;7458.105027396748;7462.067241594801;8582.356323275655;8733.170348816851;8807.427517211361;8938.910610893809;8963.641454342014;8915;9060.501672408082;9224.446533208029;9239.630414783602;9254.537273136451;6355.300916899045;7100.573965562083;7209.423246140401;7223.891641625275;7224.494285400182;6747.865042699217;7087.433005359456;7235.819104522429;7315.707371705073;7323.890141647773;6816.829579260559;6830.59016459014;6872.896906546506;6874.931250687429;6910.827229319308;6898.620575868375;6911.412529935012;7065.187503437171;7091;7109.360157585842;7098.964505177441;7115.786526404217;7118.430525557839;7153.248908864494;7160.820979475555;6450.741970321323;6518.413342799171;6520.673966301761;6529.118568993125;6539.6076235424125;6589.538732288694;6633.800985970429;6658.933410665832;6701.932980670131;6703.631300278532 17:13:53 INFO - PROCESS | 13827 | |4;prototype.html;334.5066027609278;336.4179968654228;339.70615417663714;344.746611240738;350.0670712551051;5763.164341170528;5893;5915.378885217049;5930.88138237235;5946.008087290757;5683;5824.126381042845;5848.883022339562;5877.3241077276125;5877.9412205877925;4520.660950428714;4550.180967425862;4551.840685576006;4556.589906908378;4563.452385713719;4365.956340436603;4450.176717307292;4451.109778044388;4554.294084416921;4562.634989200856;4493.752843593601;4500.347449619803;4506.8422605208825;4518.254488009475;4527.841525546606;4489.551044895517;4503.864884053483;4504.256797628404;4525.162844873709;4544.454665440136;4010.9197816043807;4011.7191796574252;4014.8996275093064;4016.136530645896;4021.678265738734;5430.348358197002;5600.52395546379;5602.691851948141;5610.074337734269;5619.887602247973;5219.217117432378;5227.503387178212;5240.187770895517;5241.475852414766;5243.082460569385;5924.081767326028;6255.96872015637;6264.27960784511;6269.247690277196;6274.372562743734;4264.168487145008;4266.57334266574;4368.89077773055;4376.234159022159;4378.058717375779;6461.095446637474;6505.251896031969;6538.313477084933;6552.312007239267;6604.900926486107;4423.646108311327;4460.330950357472;4461.866144015685;4465.732056076646;4480.350349199348;4433.866983990485;4483.484399294058;4510.616597589176;4523.7285762854335;4528.615067719281;5202.97398513005;5203.973980130075;5207.973960130175;5230.163173892159;5231.372235331784;6292.402221788922;6299.433051025429;6299.842503937438;6304.621722696653;6305.936940630535;1571.1908367190906;1593.2670971353307;1593.3467278415794;1594.378192504924;1594.936202551885;1052.1425038593675;1054.3252318516156;1055.889131641182;1058.1534772182224;1085.5440714899762;5989.31122920861;5995.5803093783015;5995.910061349084;5997.250343707036;6003.909941350883;6486.318936511692;6493.870122597522;6500.349965003462;6506.837329066717;6512.5766825156215;5990.400959903975;5992.34084250732;5993.430624090704;5993.730282137314;5993.790217342372;3401.3027329397414;3507.8421471033353;3513.543239378864;3516;3522.5949015862993;6753.932460675429;6764.154480689914;6802.115724955724;6839.658017099126;6848.417884479875;6691.5315927884585;6695.163104611924;6707.832304192434;6708.094407255056;6708.329167083252;6618.371254730889;6817.625030623363;6827.556208846409;6832.624205668736;6836.760713375107;6382.32985536512;6554.082428460115;6559.311272316529;6559.770408035696;6571.638559879252;6344.841378965562;6390.488760899024;6483.319251478715;6566.9014964776525;6570.145881035435;6795.626240556817;6801.89797153053;6803.319668033157;6804.489663275175;6814.420774234246;4470.329450582439;4488.39406680094;4508.368828363966;4518.728876267434;4546.068056048436;6586.341365863375;6588.308227636221;6590.373914478117;6594.967025165035;6595;6403.679816009274;6412.519061070531;6414.198225221848;6415.967920160369;6416.262129854939;6235.75056997715;6397.616143031433;6404.935950640434;6405.327440618668;6406.359364063556;6187.876242475215;6264.561480696308;6277.18396608438;6283.685815709287;6286.308506064238;6438.645874476949;6441.066045423481;6441.645709486023;6444.355564443518;6444.774432895014;6069.089636554552;6283.434490895841;6285.905711414424;6286.5599408041;6289.056641503811 17:13:53 INFO - PROCESS | 13827 | |5;yui.html;714.7069701422417;801.5030680977791;810.0397039165223;816.1878930464181;827.8923739913811;13449.529266475676;13596.796048059276;13605.591832245049;13620.318984050808;13621.114627549203;13249.735005299888;13257.46970121194;13341.599752007456;13344.2660653664;13366.866331336683;646.3536463536464;654.9803505894831;777.2654841175092;792.9008873890764;794.9682012719484;777.6889244302267;785.1245860865151;789.5933594198992;790.8339248757768;790.9683612655516;818.4761752478419;820.1060843680388;820.1716266570747;820.7414664380731;821;684.5379368925979;685.266764561919;806.8547661421001;815.7226542975387;819.7540737778643;600.0039933710063;600.069891667913;600.5285850607296;601.714185761764;601.9729112189962;13055.86944130556;13104.410301536454;13114.344282785918;13118.081734278605;13140.145890517182;11763;12107.091968102428;12141.271523708605;12144.3320617366;12662.936685316607;9594.952025239829;9831.754206144904;9917.553710083064;10254.077133058061;10286.434246116462;3517.6482351764876;3604.0629436346476;3615.7107431405425;3618.3306088373733;3691.8523259069607;43879;44028.33957490608;44036.779816100716;44117;44270.77864610688;8677.869831952527;9008.41445306053;9097.40866843653;9171.58727857248;9217.170454659114;16406.261718222708;16441;16479.34082636681;16496.25766840495;16507.33970641161;7046;7060;7182.892256616155;7193.784186474414;7386.113666360071;4245.80893859777;4363.847265345697;4377.058932329564;4401.471823381215;4439.289713645801;2989.7458716009382;3005.6242969628797;3008.6540047894337;3008.819470831757;3011.081620105845;535.3067777228498;538.8302684654321;543.622182583101;547.0481362429424;569.5329829539737;568.0456832521404;615.7875532941129;648.5687018132983;649.078308801503;679.5073571660605;7931.920680793233;7966.561839098789;8172;8175;8288.46125001885;552.1685254027261;562.8339639806267;607.9270487541523;610.6702380714364;618.3198481670127;3603.981980090135;3780.640839120279;3897.9610203898164;3921.3529767588598;4110.260153172458;52143.73928130411;56488.717556412776;56552.43447565554;56570.717146414005;56681.433185667614;47669.52330476651;47930.281045784344;48265;48528.7573562137;50435.74782126139;39904.40143397851;39937.2012559753;42220.57779422228;43132.784336078745;46967.29549056767;7983.361331093614;8135.30849877767;8168.550729709686;8227.13615070433;8331.6667333306;33694.49458258177;34008;34751.13122171966;35178.296434071686;36298.092547686516;43437.34843977406;43914.78042609766;44166.33750493809;44210;44874.551254488346;9868;10162.745931351776;10199.286049976727;10407.84388234162;10512.526936288039;11035.889641103486;11178.385188814693;11283.323000619988;11378.943105284752;11604.477798499256;10372.636957706745;10649.254552181274;10672.62645807393;10738.355698658106;10796.946015269874;9921.206303495559;9940.652077177265;10186.337888037255;10286;10534.841977370192;10534.683959481228;10547.472626368497;10578.312409693346;10654.62708805188;10780.784384312426;8726.607302671267;8980;9277.16505514507;9341.2994025447;9496.952515237379;8314.958425208077;8403.11968545322;8404.789880252798;8715;8791.164839340252 17:13:53 INFO - PROCESS | 13827 | __end_tp_report 17:13:53 INFO - PROCESS | 13827 | __start_cc_report 17:13:53 INFO - PROCESS | 13827 | _x_x_mozilla_cycle_collect,1576 17:13:53 INFO - PROCESS | 13827 | __end_cc_report 17:13:53 INFO - PROCESS | 13827 | __startTimestamp1452302033036__endTimestamp 17:13:53 INFO - PROCESS | 13827 | 17:13:53 INFO - PROCESS | 13827 | ------- Summary: start ------- 17:13:53 INFO - PROCESS | 13827 | Number of tests: 6 17:13:53 INFO - PROCESS | 13827 | 17:13:53 INFO - PROCESS | 13827 | [#0] dojo.html Cycles:165 Average:5153.95 Median:5337.31 stddev:546.17 (10.2%) stddev-sans-first:522.76 17:13:53 INFO - PROCESS | 13827 | Values: 3068.2 3124.9 3162.4 3163.5 3194.4 5018.1 5165.8 5176.4 5188.2 5239.7 5127.0 5152.4 5165.5 5265.3 5291.7 4729.2 4816.1 4836.3 4875.9 4912.1 4688.9 4786.8 4869.2 4895.5 4909.9 4678.8 4785.1 4853.9 4860.4 4896.7 4726.4 4751.1 4754.2 4759.0 4766.0 4734.2 4742.9 4747.3 4751.3 4754.6 4957.6 5009.9 5093.3 5100.4 5106.1 5521.8 5529.5 5538.0 5546.7 5550.7 5521.3 5556.6 5561.4 5572.3 5574.3 5098.9 5189.9 5218.0 5220.2 5337.3 5553.1 5557.2 5572.1 5574.4 5583.3 5371.6 5388.9 5391.6 5391.9 5394.4 5414.1 5426.4 5526.9 5533.1 5537.2 5568.3 5573.5 5576.0 5580.6 5594.0 5526.5 5538.9 5542.6 5548.3 5549.9 4180.2 4275.4 4275.8 4385.4 4391.1 3837.9 3846.1 3850.3 3892.5 3895.1 5180.9 5182.8 5186.8 5189.3 5190.4 5415.9 5503.3 5522.4 5528.8 5587.4 5134.8 5145.1 5148.4 5158.4 5158.6 4740.9 4744.3 4748.4 4786.6 4793.1 5580.8 5647.8 5702.1 5740.8 5868.4 5574.3 5586.4 5590.5 5593.4 5597.4 5768.5 5776.8 5777.6 5778.5 5781.3 5340.3 5435.7 5448.5 5448.8 5450.0 5456.0 5485.3 5512.2 5512.9 5516.8 5320.1 5387.5 5387.5 5389.1 5391.7 5371.2 5386.5 5405.1 5482.9 5516.2 5320.9 5329.0 5329.0 5331.1 5334.9 5377.1 5415.6 5418.8 5423.4 5473.1 5166.2 5305.3 5350.2 5459.7 5478.5 17:13:53 INFO - PROCESS | 13827 | 17:13:53 INFO - PROCESS | 13827 | [#1] ext.html Cycles:180 Average:42559.30 Median:323283.50 stddev:70410.37 (21.8%) stddev-sans-first:70537.11 17:13:53 INFO - PROCESS | 13827 | Values: 511.6 519.8 527.3 539.5 550.4 27487.5 27958.9 27995.3 35535.8 35948.8 38204.0 38459.4 38960.8 38965.6 38978.2 8325.6 8524.4 8525.3 8525.4 8526.4 7401.6 7583.9 9879.6 10026.2 10099.3 9784.4 9856.7 9864.9 9866.1 9871.5 7422.0 7634.2 9864.0 9984.7 9995.7 7468.4 9923.6 10195.0 10195.7 10200.4 35666.0 35911.1 35960.0 35980.3 36048.0 3078.8 3103.8 3166.6 3225.9 3577.3 27679.0 27736.7 27792.9 28039.2 29443.9 3696.1 3762.9 3805.9 3810.3 3943.6 268836.0 270418.6 270757.0 270928.0 270987.0 54127.7 56396.4 56841.7 56886.1 56945.7 49700.0 60998.0 61947.4 61992.7 62006.0 12644.1 12922.9 12951.2 12995.9 13018.3 9648.9 9678.7 9679.6 9694.5 9703.0 18225.5 18282.4 18338.6 18450.5 18787.4 6956.8 7118.2 7155.3 7160.4 7239.5 835.3 839.2 911.9 958.7 992.7 27694.3 27892.4 27922.7 28280.4 28326.3 999.4 1005.8 1024.2 1027.5 1131.1 12848.0 12957.8 13090.4 13152.8 13206.6 315919.0 321567.0 322202.0 322944.0 323623.0 50600.2 50784.2 50839.5 50851.0 50898.7 1180.9 1184.3 1253.2 1275.6 1279.8 25195.4 26228.5 26234.5 26281.7 26345.6 42389.8 43051.8 47686.8 48743.5 49091.3 199042.0 199653.0 201907.0 202329.0 202919.0 27139.0 27650.2 28649.1 29042.9 29042.9 41392.0 41929.6 42059.4 42288.8 42348.8 31780.0 33183.3 33495.5 33727.5 35495.6 30524.2 30795.0 31136.7 31258.8 31381.8 31414.8 31837.4 32203.7 32260.7 32270.0 27453.0 30735.5 31097.1 31222.4 31257.8 23706.4 23804.0 23820.4 24057.4 24077.2 17:13:53 INFO - PROCESS | 13827 | 17:13:53 INFO - PROCESS | 13827 | [#2] jquery.html Cycles:180 Average:26035.29 Median:5184.28 stddev:84874.25 (1637.1%) stddev-sans-first:85090.45 17:13:53 INFO - PROCESS | 13827 | Values: 357.9 362.0 363.0 366.2 371.5 13380.7 13643.6 16150.5 16325.0 17105.1 14296.6 14932.3 15392.5 15397.8 15648.1 5208.2 5408.8 5412.5 5415.2 5425.3 4006.4 4162.8 5297.9 5424.3 5784.3 5704.2 5959.7 5966.1 5969.5 5980.0 5811.7 5848.3 5859.2 5863.6 5867.6 4902.6 5120.9 5132.9 5173.8 5194.7 12444.9 12559.8 12565.4 16114.4 18104.2 1836.2 1860.5 1911.6 1930.2 1930.2 8947.2 9102.4 9162.3 9254.3 9356.6 1727.1 1775.0 1785.9 1810.2 1867.9 52010.7 52743.7 53793.5 54233.7 55174.0 9799.0 9972.9 10027.8 10059.2 10125.5 13063.9 13132.7 13161.0 13172.1 13172.3 6697.5 6738.0 6741.9 6772.9 6800.4 5965.6 6011.5 6027.8 6249.1 6481.4 4323.0 4341.2 4363.0 4369.1 4383.4 1710.5 1773.6 2779.6 2790.7 2814.2 428.1 442.4 467.3 850.9 861.3 9837.5 9970.1 10397.9 10455.7 10655.4 429.8 442.0 442.1 445.1 450.4 5855.0 5930.9 5957.2 6009.1 6017.5 502815.0 514149.0 522223.0 523659.0 528840.0 71141.3 72946.6 73192.6 74004.0 74085.6 484.5 491.0 493.4 494.1 494.3 10025.7 10103.7 10152.1 10347.9 10427.9 33526.0 33738.3 34736.3 35078.3 35220.6 44610.3 45353.5 45811.1 45888.5 49057.8 6163.1 7285.5 7382.9 7387.3 7426.7 8873.6 10768.2 10920.0 11171.0 11343.2 6816.5 6974.7 7387.0 7408.8 9586.9 7086.8 7238.8 7363.3 7483.2 7531.2 6356.8 6405.5 6971.3 7254.7 7568.5 8872.8 9077.8 9320.5 9362.2 9365.7 6698.5 6720.0 6806.2 6930.4 7289.7 17:13:53 INFO - PROCESS | 13827 | 17:13:53 INFO - PROCESS | 13827 | [#3] mootools.html Cycles:180 Average:5598.27 Median:6484.58 stddev:2947.85 (45.5%) stddev-sans-first:2938.59 17:13:53 INFO - PROCESS | 13827 | Values: 1321.6 1455.6 1455.9 1614.6 1788.1 7017.9 7641.9 7834.5 7842.2 7852.8 7619.9 7807.2 7820.6 7822.3 7826.1 1982.3 2025.3 2271.0 2285.8 2310.2 2312.5 2317.4 2318.3 2319.0 2320.5 2238.6 2306.1 2307.5 2307.7 2308.3 2252.6 2290.1 2316.6 2316.7 2318.1 2293.3 2302.1 2315.3 2318.8 2348.6 8036.1 8101.0 8105.3 8106.5 8112.4 4731.6 4843.5 4844.8 4845.3 4845.4 3012.0 3048.2 3107.8 3163.2 3188.7 991.7 999.6 999.9 1025.1 1027.8 11250.7 11279.4 11285.7 11302.3 11314.4 4388.1 4421.9 4497.2 4502.2 4545.4 9658.1 9676.7 9680.1 9686.1 9705.7 4849.7 4855.9 4881.0 4885.8 4886.3 4389.7 4417.8 4430.6 4431.9 4438.2 3423.2 3472.9 3643.1 3649.3 3698.5 1211.3 1230.9 1236.4 1237.7 1257.1 1297.0 1306.6 1313.8 1323.5 1324.3 7521.4 7575.2 7593.1 7594.4 7597.1 1100.4 1101.3 1108.9 1120.4 1134.8 5688.0 5755.7 5765.2 5776.5 5777.9 9566.7 9738.2 9904.7 10002.6 10003.8 9864.6 9874.0 9893.5 9896.0 9911.4 7186.8 7433.3 7436.3 7441.3 7670.2 7351.0 7375.7 7443.7 7458.1 7462.1 8582.4 8733.2 8807.4 8938.9 8963.6 8915.0 9060.5 9224.4 9239.6 9254.5 6355.3 7100.6 7209.4 7223.9 7224.5 6747.9 7087.4 7235.8 7315.7 7323.9 6816.8 6830.6 6872.9 6874.9 6910.8 6898.6 6911.4 7065.2 7091.0 7109.4 7099.0 7115.8 7118.4 7153.2 7160.8 6450.7 6518.4 6520.7 6529.1 6539.6 6589.5 6633.8 6658.9 6701.9 6703.6 17:13:53 INFO - PROCESS | 13827 | 17:13:53 INFO - PROCESS | 13827 | [#4] prototype.html Cycles:180 Average:5277.83 Median:5967.66 stddev:1602.11 (26.8%) stddev-sans-first:1563.05 17:13:53 INFO - PROCESS | 13827 | Values: 334.5 336.4 339.7 344.7 350.1 5763.2 5893.0 5915.4 5930.9 5946.0 5683.0 5824.1 5848.9 5877.3 5877.9 4520.7 4550.2 4551.8 4556.6 4563.5 4366.0 4450.2 4451.1 4554.3 4562.6 4493.8 4500.3 4506.8 4518.3 4527.8 4489.6 4503.9 4504.3 4525.2 4544.5 4010.9 4011.7 4014.9 4016.1 4021.7 5430.3 5600.5 5602.7 5610.1 5619.9 5219.2 5227.5 5240.2 5241.5 5243.1 5924.1 6256.0 6264.3 6269.2 6274.4 4264.2 4266.6 4368.9 4376.2 4378.1 6461.1 6505.3 6538.3 6552.3 6604.9 4423.6 4460.3 4461.9 4465.7 4480.4 4433.9 4483.5 4510.6 4523.7 4528.6 5203.0 5204.0 5208.0 5230.2 5231.4 6292.4 6299.4 6299.8 6304.6 6305.9 1571.2 1593.3 1593.3 1594.4 1594.9 1052.1 1054.3 1055.9 1058.2 1085.5 5989.3 5995.6 5995.9 5997.3 6003.9 6486.3 6493.9 6500.3 6506.8 6512.6 5990.4 5992.3 5993.4 5993.7 5993.8 3401.3 3507.8 3513.5 3516.0 3522.6 6753.9 6764.2 6802.1 6839.7 6848.4 6691.5 6695.2 6707.8 6708.1 6708.3 6618.4 6817.6 6827.6 6832.6 6836.8 6382.3 6554.1 6559.3 6559.8 6571.6 6344.8 6390.5 6483.3 6566.9 6570.1 6795.6 6801.9 6803.3 6804.5 6814.4 4470.3 4488.4 4508.4 4518.7 4546.1 6586.3 6588.3 6590.4 6595.0 6595.0 6403.7 6412.5 6414.2 6416.0 6416.3 6235.8 6397.6 6404.9 6405.3 6406.4 6187.9 6264.6 6277.2 6283.7 6286.3 6438.6 6441.1 6441.6 6444.4 6444.8 6069.1 6283.4 6285.9 6286.6 6289.1 17:13:53 INFO - PROCESS | 13827 | 17:13:53 INFO - PROCESS | 13827 | [#5] yui.html Cycles:180 Average:13125.33 Median:48097.64 stddev:15195.17 (31.6%) stddev-sans-first:15209.21 17:13:53 INFO - PROCESS | 13827 | Values: 714.7 801.5 810.0 816.2 827.9 13449.5 13596.8 13605.6 13620.3 13621.1 13249.7 13257.5 13341.6 13344.3 13366.9 646.4 655.0 777.3 792.9 795.0 777.7 785.1 789.6 790.8 791.0 818.5 820.1 820.2 820.7 821.0 684.5 685.3 806.9 815.7 819.8 600.0 600.1 600.5 601.7 602.0 13055.9 13104.4 13114.3 13118.1 13140.1 11763.0 12107.1 12141.3 12144.3 12662.9 9595.0 9831.8 9917.6 10254.1 10286.4 3517.6 3604.1 3615.7 3618.3 3691.9 43879.0 44028.3 44036.8 44117.0 44270.8 8677.9 9008.4 9097.4 9171.6 9217.2 16406.3 16441.0 16479.3 16496.3 16507.3 7046.0 7060.0 7182.9 7193.8 7386.1 4245.8 4363.8 4377.1 4401.5 4439.3 2989.7 3005.6 3008.7 3008.8 3011.1 535.3 538.8 543.6 547.0 569.5 568.0 615.8 648.6 649.1 679.5 7931.9 7966.6 8172.0 8175.0 8288.5 552.2 562.8 607.9 610.7 618.3 3604.0 3780.6 3898.0 3921.4 4110.3 52143.7 56488.7 56552.4 56570.7 56681.4 47669.5 47930.3 48265.0 48528.8 50435.7 39904.4 39937.2 42220.6 43132.8 46967.3 7983.4 8135.3 8168.6 8227.1 8331.7 33694.5 34008.0 34751.1 35178.3 36298.1 43437.3 43914.8 44166.3 44210.0 44874.6 9868.0 10162.7 10199.3 10407.8 10512.5 11035.9 11178.4 11283.3 11378.9 11604.5 10372.6 10649.3 10672.6 10738.4 10796.9 9921.2 9940.7 10186.3 10286.0 10534.8 10534.7 10547.5 10578.3 10654.6 10780.8 8726.6 8980.0 9277.2 9341.3 9497.0 8315.0 8403.1 8404.8 8715.0 8791.2 17:13:53 INFO - PROCESS | 13827 | -------- Summary: end -------- 17:13:53 INFO - PROCESS | 13827 | 17:13:53 INFO - TEST-INFO | 13827: exit 0 17:13:53 INFO - TEST-OK | dromaeo_css | took 1113403ms 17:13:53 INFO - TEST-START | kraken 17:13:53 INFO - operating with platform_type : linux_ 17:13:53 INFO - Initialising browser for kraken test... 17:13:53 INFO - TEST-INFO | started process 14017 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0X9xwL/profile http://localhost:52696/getInfo.html) 17:13:57 INFO - PROCESS | 14017 | __metrics Screen width/height:1600/1200 17:13:57 INFO - PROCESS | 14017 | colorDepth:24 17:13:57 INFO - PROCESS | 14017 | Browser inner width/height: 1024/697 17:13:57 INFO - PROCESS | 14017 | __metrics 17:13:57 INFO - PROCESS | 14017 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:13:57 INFO - PROCESS | 14017 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:13:58 INFO - TEST-INFO | 14017: exit 0 17:13:58 INFO - Browser initialized. 17:13:58 INFO - Running cycle 1/1 for kraken test... 17:13:58 INFO - TEST-INFO | started process 14100 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0X9xwL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:14:10 INFO - PROCESS | 14100 | RSS: Main: 148586496 17:14:10 INFO - PROCESS | 14100 | 17:14:13 INFO - PROCESS | 14100 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52696/tests/kraken/driver.html?testName=audio-beat-detection) 17:14:13 INFO - PROCESS | 14100 | RSS: Main: 186470400 17:14:13 INFO - PROCESS | 14100 | 17:14:16 INFO - PROCESS | 14100 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52696/tests/kraken/driver.html?testName=audio-dft) 17:14:16 INFO - PROCESS | 14100 | RSS: Main: 177020928 17:14:16 INFO - PROCESS | 14100 | 17:14:19 INFO - PROCESS | 14100 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52696/tests/kraken/driver.html?testName=audio-fft) 17:14:20 INFO - PROCESS | 14100 | RSS: Main: 161456128 17:14:20 INFO - PROCESS | 14100 | 17:14:22 INFO - PROCESS | 14100 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52696/tests/kraken/driver.html?testName=audio-oscillator) 17:14:22 INFO - PROCESS | 14100 | RSS: Main: 163348480 17:14:22 INFO - PROCESS | 14100 | 17:14:24 INFO - PROCESS | 14100 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52696/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:14:25 INFO - PROCESS | 14100 | RSS: Main: 165232640 17:14:25 INFO - PROCESS | 14100 | 17:14:28 INFO - PROCESS | 14100 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52696/tests/kraken/driver.html?testName=imaging-darkroom) 17:14:29 INFO - PROCESS | 14100 | RSS: Main: 165486592 17:14:29 INFO - PROCESS | 14100 | 17:14:32 INFO - PROCESS | 14100 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52696/tests/kraken/driver.html?testName=imaging-desaturate) 17:14:32 INFO - PROCESS | 14100 | RSS: Main: 166510592 17:14:32 INFO - PROCESS | 14100 | 17:14:35 INFO - PROCESS | 14100 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52696/tests/kraken/driver.html?testName=json-parse-financial) 17:14:36 INFO - PROCESS | 14100 | RSS: Main: 166502400 17:14:36 INFO - PROCESS | 14100 | 17:14:37 INFO - PROCESS | 14100 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52696/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:14:38 INFO - PROCESS | 14100 | RSS: Main: 175087616 17:14:38 INFO - PROCESS | 14100 | 17:14:40 INFO - PROCESS | 14100 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52696/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:14:40 INFO - PROCESS | 14100 | RSS: Main: 171859968 17:14:40 INFO - PROCESS | 14100 | 17:14:42 INFO - PROCESS | 14100 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52696/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:14:43 INFO - PROCESS | 14100 | RSS: Main: 186081280 17:14:43 INFO - PROCESS | 14100 | 17:14:45 INFO - PROCESS | 14100 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52696/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:14:46 INFO - PROCESS | 14100 | RSS: Main: 191651840 17:14:46 INFO - PROCESS | 14100 | 17:14:49 INFO - PROCESS | 14100 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52696/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:14:49 INFO - PROCESS | 14100 | RSS: Main: 191508480 17:14:49 INFO - PROCESS | 14100 | 17:14:51 INFO - PROCESS | 14100 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52696/tests/kraken/driver.html?testName=ai-astar) 17:14:51 INFO - PROCESS | 14100 | RSS: Main: 249647104 17:14:51 INFO - PROCESS | 14100 | 17:14:51 INFO - PROCESS | 14100 | __start_tp_report 17:14:51 INFO - PROCESS | 14100 | _x_x_mozilla_page_load 17:14:51 INFO - PROCESS | 14100 | _x_x_mozilla_page_load_details 17:14:51 INFO - PROCESS | 14100 | |i|pagename|runs| 17:14:51 INFO - PROCESS | 14100 | |0;ai-astar;111;114;105;111;111;113;100;110;111;119 17:14:51 INFO - PROCESS | 14100 | |1;audio-beat-detection;153;128;148;161;127;152;147;124;167;129 17:14:51 INFO - PROCESS | 14100 | |2;audio-dft;160;160;162;159;160;161;160;163;163;162 17:14:51 INFO - PROCESS | 14100 | |3;audio-fft;73;73;83;93;71;71;72;121;91;74 17:14:51 INFO - PROCESS | 14100 | |4;audio-oscillator;96;97;141;96;95;96;150;96;96;137 17:14:51 INFO - PROCESS | 14100 | |5;imaging-gaussian-blur;109;110;109;109;109;109;109;109;109;109 17:14:51 INFO - PROCESS | 14100 | |6;imaging-darkroom;146;145;146;147;146;146;146;147;147;146 17:14:51 INFO - PROCESS | 14100 | |7;imaging-desaturate;95;96;95;95;95;96;96;96;95;95 17:14:51 INFO - PROCESS | 14100 | |8;json-parse-financial;57;57;56;57;55;56;57;64;54;55 17:14:51 INFO - PROCESS | 14100 | |9;json-stringify-tinderbox;67;68;67;68;67;70;67;67;68;67 17:14:51 INFO - PROCESS | 14100 | |10;stanford-crypto-aes;86;84;87;86;85;86;86;86;85;87 17:14:51 INFO - PROCESS | 14100 | |11;stanford-crypto-ccm;115;122;136;113;118;124;126;117;118;127 17:14:51 INFO - PROCESS | 14100 | |12;stanford-crypto-pbkdf2;152;145;153;154;155;146;155;151;151;139 17:14:51 INFO - PROCESS | 14100 | |13;stanford-crypto-sha256-iterative;68;68;71;70;67;69;69;68;68;66 17:14:51 INFO - PROCESS | 14100 | __end_tp_report 17:14:51 INFO - PROCESS | 14100 | __start_cc_report 17:14:51 INFO - PROCESS | 14100 | _x_x_mozilla_cycle_collect,928 17:14:51 INFO - PROCESS | 14100 | __end_cc_report 17:14:51 INFO - PROCESS | 14100 | __startTimestamp1452302091604__endTimestamp 17:14:51 INFO - PROCESS | 14100 | 17:14:51 INFO - PROCESS | 14100 | ------- Summary: start ------- 17:14:51 INFO - PROCESS | 14100 | Number of tests: 14 17:14:51 INFO - PROCESS | 14100 | 17:14:51 INFO - PROCESS | 14100 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:5.08 (4.6%) stddev-sans-first:5.39 17:14:51 INFO - PROCESS | 14100 | Values: 111.0 114.0 105.0 111.0 111.0 113.0 100.0 110.0 111.0 119.0 17:14:51 INFO - PROCESS | 14100 | 17:14:51 INFO - PROCESS | 14100 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:150.00 stddev:15.48 (10.3%) stddev-sans-first:16.04 17:14:51 INFO - PROCESS | 14100 | Values: 153.0 128.0 148.0 161.0 127.0 152.0 147.0 124.0 167.0 129.0 17:14:51 INFO - PROCESS | 14100 | 17:14:51 INFO - PROCESS | 14100 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.41 (0.9%) stddev-sans-first:1.45 17:14:51 INFO - PROCESS | 14100 | Values: 160.0 160.0 162.0 159.0 160.0 161.0 160.0 163.0 163.0 162.0 17:14:51 INFO - PROCESS | 14100 | 17:14:51 INFO - PROCESS | 14100 | [#3] audio-fft Cycles:10 Average:82.20 Median:73.50 stddev:15.96 (21.7%) stddev-sans-first:16.57 17:14:51 INFO - PROCESS | 14100 | Values: 73.0 73.0 83.0 93.0 71.0 71.0 72.0 121.0 91.0 74.0 17:14:51 INFO - PROCESS | 14100 | 17:14:51 INFO - PROCESS | 14100 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:96.00 stddev:22.76 (23.7%) stddev-sans-first:23.57 17:14:51 INFO - PROCESS | 14100 | Values: 96.0 97.0 141.0 96.0 95.0 96.0 150.0 96.0 96.0 137.0 17:14:51 INFO - PROCESS | 14100 | 17:14:51 INFO - PROCESS | 14100 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:14:51 INFO - PROCESS | 14100 | Values: 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 17:14:51 INFO - PROCESS | 14100 | 17:14:51 INFO - PROCESS | 14100 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 17:14:51 INFO - PROCESS | 14100 | Values: 146.0 145.0 146.0 147.0 146.0 146.0 146.0 147.0 147.0 146.0 17:14:51 INFO - PROCESS | 14100 | 17:14:51 INFO - PROCESS | 14100 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:14:51 INFO - PROCESS | 14100 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 17:14:51 INFO - PROCESS | 14100 | 17:14:51 INFO - PROCESS | 14100 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:57.00 stddev:2.74 (4.8%) stddev-sans-first:2.91 17:14:51 INFO - PROCESS | 14100 | Values: 57.0 57.0 56.0 57.0 55.0 56.0 57.0 64.0 54.0 55.0 17:14:51 INFO - PROCESS | 14100 | 17:14:51 INFO - PROCESS | 14100 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:67.50 stddev:0.97 (1.4%) stddev-sans-first:1.00 17:14:51 INFO - PROCESS | 14100 | Values: 67.0 68.0 67.0 68.0 67.0 70.0 67.0 67.0 68.0 67.0 17:14:51 INFO - PROCESS | 14100 | 17:14:51 INFO - PROCESS | 14100 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:86.00 stddev:0.92 (1.1%) stddev-sans-first:0.97 17:14:51 INFO - PROCESS | 14100 | Values: 86.0 84.0 87.0 86.0 85.0 86.0 86.0 86.0 85.0 87.0 17:14:51 INFO - PROCESS | 14100 | 17:14:51 INFO - PROCESS | 14100 | [#11] stanford-crypto-ccm Cycles:10 Average:121.60 Median:123.00 stddev:6.88 (5.6%) stddev-sans-first:6.87 17:14:51 INFO - PROCESS | 14100 | Values: 115.0 122.0 136.0 113.0 118.0 124.0 126.0 117.0 118.0 127.0 17:14:51 INFO - PROCESS | 14100 | 17:14:51 INFO - PROCESS | 14100 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.10 Median:152.50 stddev:5.20 (3.4%) stddev-sans-first:5.46 17:14:51 INFO - PROCESS | 14100 | Values: 152.0 145.0 153.0 154.0 155.0 146.0 155.0 151.0 151.0 139.0 17:14:51 INFO - PROCESS | 14100 | 17:14:51 INFO - PROCESS | 14100 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.43 (2.1%) stddev-sans-first:1.51 17:14:51 INFO - PROCESS | 14100 | Values: 68.0 68.0 71.0 70.0 67.0 69.0 69.0 68.0 68.0 66.0 17:14:51 INFO - PROCESS | 14100 | -------- Summary: end -------- 17:14:51 INFO - PROCESS | 14100 | 17:14:52 INFO - TEST-INFO | 14100: exit 0 17:14:52 INFO - TEST-OK | kraken | took 58734ms 17:14:52 INFO - TEST-START | v8_7 17:14:52 INFO - operating with platform_type : linux_ 17:14:52 INFO - Initialising browser for v8_7 test... 17:14:52 INFO - TEST-INFO | started process 14347 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXie0xc/profile http://localhost:52696/getInfo.html) 17:14:56 INFO - PROCESS | 14347 | __metrics Screen width/height:1600/1200 17:14:56 INFO - PROCESS | 14347 | colorDepth:24 17:14:56 INFO - PROCESS | 14347 | Browser inner width/height: 1024/697 17:14:56 INFO - PROCESS | 14347 | __metrics 17:14:56 INFO - PROCESS | 14347 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:14:56 INFO - PROCESS | 14347 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:14:57 INFO - TEST-INFO | 14347: exit 0 17:14:57 INFO - Browser initialized. 17:14:57 INFO - Running cycle 1/1 for v8_7 test... 17:14:57 INFO - TEST-INFO | started process 14430 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXie0xc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:15:09 INFO - PROCESS | 14430 | RSS: Main: 148828160 17:15:09 INFO - PROCESS | 14430 | 17:15:31 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:52696/tests/v8_7/run.html (next: http://localhost:52696/tests/v8_7/run.html) 17:15:31 INFO - PROCESS | 14430 | RSS: Main: 557903872 17:15:31 INFO - PROCESS | 14430 | 17:15:31 INFO - PROCESS | 14430 | __start_tp_report 17:15:31 INFO - PROCESS | 14430 | _x_x_mozilla_page_load 17:15:31 INFO - PROCESS | 14430 | _x_x_mozilla_page_load_details 17:15:31 INFO - PROCESS | 14430 | |i|pagename|runs| 17:15:31 INFO - PROCESS | 14430 | |0;Richards;166.9449081803005 17:15:31 INFO - PROCESS | 14430 | |1;DeltaBlue;192.01228878648234 17:15:31 INFO - PROCESS | 14430 | |2;Encrypt;287.5215641173088 17:15:31 INFO - PROCESS | 14430 | |3;Decrypt;5263.1578947368425 17:15:31 INFO - PROCESS | 14430 | |4;RayTrace;1104.9723756906078 17:15:31 INFO - PROCESS | 14430 | |5;Earley;799.3605115907275 17:15:31 INFO - PROCESS | 14430 | |6;Boyer;12358.024691358025 17:15:31 INFO - PROCESS | 14430 | |7;RegExp;41510.204081632655 17:15:31 INFO - PROCESS | 14430 | |8;Splay;578.3410138248848 17:15:31 INFO - PROCESS | 14430 | |9;NavierStokes;4830.917874396136 17:15:31 INFO - PROCESS | 14430 | __end_tp_report 17:15:31 INFO - PROCESS | 14430 | __startTimestamp1452302131986__endTimestamp 17:15:31 INFO - PROCESS | 14430 | 17:15:31 INFO - PROCESS | 14430 | ------- Summary: start ------- 17:15:31 INFO - PROCESS | 14430 | Number of tests: 10 17:15:31 INFO - PROCESS | 14430 | 17:15:31 INFO - PROCESS | 14430 | [#0] Richards Cycles:1 Average:166.94 Median:166.94 stddev:0.00 (0.0%) 17:15:31 INFO - PROCESS | 14430 | Values: 166.9 17:15:31 INFO - PROCESS | 14430 | 17:15:31 INFO - PROCESS | 14430 | [#1] DeltaBlue Cycles:1 Average:192.01 Median:192.01 stddev:0.00 (0.0%) 17:15:31 INFO - PROCESS | 14430 | Values: 192.0 17:15:31 INFO - PROCESS | 14430 | 17:15:31 INFO - PROCESS | 14430 | [#2] Encrypt Cycles:1 Average:287.52 Median:287.52 stddev:0.00 (0.0%) 17:15:31 INFO - PROCESS | 14430 | Values: 287.5 17:15:31 INFO - PROCESS | 14430 | 17:15:31 INFO - PROCESS | 14430 | [#3] Decrypt Cycles:1 Average:5263.16 Median:5263.16 stddev:0.00 (0.0%) 17:15:31 INFO - PROCESS | 14430 | Values: 5263.2 17:15:31 INFO - PROCESS | 14430 | 17:15:31 INFO - PROCESS | 14430 | [#4] RayTrace Cycles:1 Average:1104.97 Median:1104.97 stddev:0.00 (0.0%) 17:15:31 INFO - PROCESS | 14430 | Values: 1105.0 17:15:31 INFO - PROCESS | 14430 | 17:15:31 INFO - PROCESS | 14430 | [#5] Earley Cycles:1 Average:799.36 Median:799.36 stddev:0.00 (0.0%) 17:15:31 INFO - PROCESS | 14430 | Values: 799.4 17:15:31 INFO - PROCESS | 14430 | 17:15:31 INFO - PROCESS | 14430 | [#6] Boyer Cycles:1 Average:12358.02 Median:12358.02 stddev:0.00 (0.0%) 17:15:31 INFO - PROCESS | 14430 | Values: 12358.0 17:15:31 INFO - PROCESS | 14430 | 17:15:31 INFO - PROCESS | 14430 | [#7] RegExp Cycles:1 Average:41510.20 Median:41510.20 stddev:0.00 (0.0%) 17:15:31 INFO - PROCESS | 14430 | Values: 41510.2 17:15:31 INFO - PROCESS | 14430 | 17:15:31 INFO - PROCESS | 14430 | [#8] Splay Cycles:1 Average:578.34 Median:578.34 stddev:0.00 (0.0%) 17:15:31 INFO - PROCESS | 14430 | Values: 578.3 17:15:31 INFO - PROCESS | 14430 | 17:15:31 INFO - PROCESS | 14430 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 17:15:31 INFO - PROCESS | 14430 | Values: 4830.9 17:15:31 INFO - PROCESS | 14430 | -------- Summary: end -------- 17:15:31 INFO - PROCESS | 14430 | 17:15:32 INFO - TEST-INFO | 14430: exit 0 17:15:32 INFO - TEST-OK | v8_7 | took 40419ms 17:15:32 INFO - SUITE-END | took 1212s 17:15:33 INFO - Completed test suite (00:20:12) 17:15:33 INFO - Working with test: dromaeo_css 17:15:33 INFO - Generating results file: dromaeo_css 17:15:33 INFO - Working with test: kraken 17:15:33 INFO - Generating results file: kraken 17:15:33 INFO - javascript benchmark 17:15:33 INFO - Working with test: v8_7 17:15:33 INFO - Generating results file: v8_7 17:15:33 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:15:33 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 17:15:33 INFO - process_Request line: dromaeo_css 6600.47 graph.html#tests=[[72,201,35]] 17:15:33 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:15:33 INFO - process_Request line: kraken 1508.30 graph.html#tests=[[232,201,35]] 17:15:33 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:15:33 INFO - process_Request line: v8_7 20011.00 graph.html#tests=[[230,201,35]] 17:15:33 INFO - RETURN: dromaeo_css: 6600.47 17:15:33 INFO - RETURN: kraken: 1508.30 17:15:33 INFO - RETURN: v8_7: 20011.00 17:15:33 INFO - javascript benchmark 17:15:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3068.21760451085, 3124.8750049998002, 3162.3675264947015, 3163.4938409854412, 3194.361127774445, 5018.121828679985, 5165.845024649262, 5176.378834539861, 5188.16989281715, 5239.659422137558, 5127.025865085631, 5152.355955505562, 5165.509276618715, 5265.341832270966, 5291.68249905006, 4729.21967875301, 4816.133096042711, 4836.347093142434, 4875.926861097087, 4912.140375434303, 4688.859334219979, 4786.7845946932475, 4869.196582563891, 4895.461499235099, 4909.8772530686665, 4678.789454474557, 4785.114753770529, 4853.927191092119, 4860.416749989989, 4896.706197628154, 4726.409198850144, 4751.121042607128, 4754.215554433515, 4758.976205118952, 4766.022965292107, 4734.242521196592, 4742.881427964294, 4747.287906813971, 4751.263554149113, 4754.619630429557, 4957.5786058185095, 5009.899802003976, 5093.312402825608, 5100.413452452978, 5106.08090543702, 5521.806736764194, 5529.529989950859, 5538.0, 5546.69493177875, 5550.69471179085, 5521.254630624854, 5556.583256255797, 5561.443855614447, 5572.3034620672415, 5574.331080270353, 5098.872528186825, 5189.870253243661, 5218.03466358721, 5220.190870415092, 5337.306150200449, 5553.139263414178, 5557.166425036277, 5572.136318870582, 5574.414686457944, 5583.330000399978, 5371.57027437804, 5388.946110538923, 5391.595630327741, 5391.9460805391445, 5394.433584473652, 5414.133738601805, 5426.403095659474, 5526.917096243559, 5533.087040638249, 5537.197106419627, 5568.303962004749, 5573.498385145356, 5575.972120139373, 5580.581456390787, 5593.972030139823, 5526.50261476469, 5538.9169162462595, 5542.61201715876, 5548.306461692288, 5549.861253468695, 4180.226658068267, 4275.358696195595, 4275.8075886585175, 4385.407969924019, 4391.055922976575, 3837.865674701372, 3846.0961674006585, 3850.2876967761053, 3892.4550562921213, 3895.104126051024, 5180.922286165711, 5182.766775495036, 5186.792528298901, 5189.273501709764, 5190.377154741455, 5415.918761218585, 5503.257060296889, 5522.364928033247, 5528.806491772769, 5587.441255874462, 5134.794608215704, 5145.07388670043, 5148.3564554430695, 5158.406783219978, 5158.638895277295, 4740.928886066712, 4744.335792988984, 4748.430188377417, 4786.617070634411, 4793.1372352976105, 5580.832575022756, 5647.830565083054, 5702.087665973424, 5740.770369185186, 5868.4424979626865, 5574.27534420539, 5586.413426590149, 5590.524805391425, 5593.356763972032, 5597.440255974533, 5768.538516918553, 5776.797812076557, 5777.566682498746, 5778.479936805707, 5781.306243250669, 5340.279062326536, 5435.673859568438, 5448.5368743655645, 5448.809291674773, 5450.0, 5455.972720136374, 5485.259489968963, 5512.173174023768, 5512.862178445571, 5516.834494965157, 5320.14877619579, 5387.461253874581, 5387.488188622075, 5389.056915039931, 5391.7034563099405, 5371.194320851903, 5386.542143917654, 5405.108157154183, 5482.862928426821, 5516.227728118147, 5320.866978325573, 5328.973355133199, 5329.040772660958, 5331.09371406854, 5334.919976200283, 5377.059014672495, 5415.620906536505, 5418.83743487696, 5423.4034256231, 5473.0969390050195, 5166.225066240094, 5305.257263983122, 5350.1974703793185, 5459.727013649381, 5478.506934375925], "unit": "score", "name": "dojo.html", "value": 5120.104309164088}, {"lowerIsBetter": false, "replicates": [511.6188439612489, 519.8492437193214, 527.282895262443, 539.4901817782197, 550.4083110656045, 27487.450250994993, 27958.86020569897, 27995.300117497074, 35535.82232088842, 35948.82025589875, 38204.0, 38459.423108653325, 38960.80519597405, 38965.61034389655, 38978.22043559134, 8325.58372081398, 8524.445911015795, 8525.275351595123, 8525.403221774479, 8526.445781024244, 7401.555906645618, 7583.886241706379, 9879.604815807359, 10026.248031397638, 10099.29304948654, 9784.36401633895, 9856.655017074403, 9864.90135098647, 9866.112049915506, 9871.457069861155, 7421.9628901855685, 7634.160242373335, 9864.0, 9984.650537231199, 9995.70012899614, 7468.365188958945, 9923.55344009514, 10195.0, 10195.745106372326, 10200.38797672142, 35666.0, 35911.10222244439, 35960.0, 35980.280394391964, 36048.0, 3078.846057697106, 3103.8292893890825, 3166.60417447819, 3225.870965161414, 3577.302426026926, 27679.0, 27736.722632773617, 27792.861035694896, 28039.158825235274, 29443.852780736175, 3696.131409118855, 3762.9059273518105, 3805.8667946622013, 3810.314143454177, 3943.5662077171487, 268836.0, 270418.64790676115, 270757.0, 270928.0, 270987.0, 54127.72936135294, 56396.43603563994, 56841.71579142161, 56886.14670779942, 56945.715271423374, 49700.0, 60998.0, 61947.38052619506, 61992.69003654953, 62006.0, 12644.114911956258, 12922.870771292166, 12951.222926624432, 12995.870041299655, 13018.349082545836, 9648.855267170999, 9678.70963871085, 9679.612815487302, 9694.51527423626, 9703.0, 18225.45323640293, 18282.360117395827, 18338.63322733538, 18450.538736531693, 18787.436376908714, 6956.826079348057, 7118.216996130525, 7155.284471552803, 7160.386458942448, 7239.457040721967, 835.2983493865182, 839.2195258409738, 911.8601747815231, 958.7315551645551, 992.6525715999487, 27694.307642309104, 27892.44215115686, 27922.72077279201, 28280.434391312057, 28326.291842704097, 999.435319044752, 1005.7887843552936, 1024.1704219582161, 1027.5170669785189, 1131.0781712903956, 12848.0, 12957.805632915513, 13090.410931508104, 13152.802707959388, 13206.603801885958, 315919.0, 321567.0, 322202.0, 322944.0, 323623.0, 50600.24099638508, 50784.238236426485, 50839.49160508347, 50851.0, 50898.74550627297, 1180.8523934508187, 1184.2894263441865, 1253.179167645194, 1275.5991828192773, 1279.8080287956882, 25195.370115747253, 26228.475430491664, 26234.4753104933, 26281.73718262793, 26345.604815927392, 42389.78805105955, 43051.784741076095, 47686.76156619334, 48743.5125648739, 49091.26363104628, 199042.0, 199653.0, 201907.0, 202329.0, 202919.0, 27139.0, 27650.170494885184, 28649.14052578426, 29042.854785725936, 29042.85478572678, 41392.0, 41929.580704192565, 42059.36910946277, 42288.78855605825, 42348.78825605976, 31780.0, 33183.336333273684, 33495.49756753699, 33727.49408758822, 35495.64504354924, 30524.236894077825, 30795.0, 31136.688633114285, 31258.843705781324, 31381.843090785314, 31414.842925785226, 31837.36325273528, 32203.677963220067, 32260.677393226706, 32270.0, 27453.002300308624, 30735.516497681965, 31097.09232105197, 31222.375552489277, 31257.8437107813, 23706.407339816644, 23804.0, 23820.404489887198, 24057.398565035313, 24077.157299494433], "unit": "score", "name": "ext.html", "value": 17293.86216662899}, {"lowerIsBetter": false, "replicates": [357.9463080537919, 362.0225391443104, 362.9836657350419, 366.159663572102, 371.45581722776126, 13380.72527670296, 13643.590692279222, 16150.515484535468, 16325.0, 17105.14474276286, 14296.642583935407, 14932.328045237964, 15392.461263855766, 15397.769033464507, 15648.139352335616, 5208.218767184915, 5408.756605952722, 5412.4858138476975, 5415.187721841716, 5425.3489581250105, 4006.3790112532606, 4162.771047592381, 5297.947020529803, 5424.267723857288, 5784.2769653793275, 5704.172894930232, 5959.731812068468, 5966.075258334965, 5969.462748352647, 5980.0, 5811.6803575803315, 5848.327442344143, 5859.209006784072, 5863.618864773797, 5867.589268751189, 4902.558769710743, 5120.92318615221, 5132.897342053138, 5173.81891633791, 5194.740262986873, 12444.875551244462, 12559.811602825965, 12565.371731413485, 16114.355425783071, 18104.185311661007, 1836.164545131975, 1860.474391058554, 1911.550785565391, 1930.1700268884374, 1930.2279088364626, 8947.150020748084, 9102.362834601581, 9162.267018638493, 9254.259659227246, 9356.578953947088, 1727.0673836128476, 1774.9822501774945, 1785.9285628574842, 1810.1763697517729, 1867.906604669761, 52010.739946300404, 52743.73628131873, 53793.46206537924, 54233.72883135559, 55174.0, 9799.0, 9972.900270997343, 10027.849582256273, 10059.195264378832, 10125.493725313705, 13063.934680326538, 13132.737345253041, 13161.0, 13172.143810652276, 13172.341382930816, 6697.464202863759, 6738.0, 6741.932580674131, 6772.932270677329, 6800.387965083166, 5965.612235204698, 6011.5190784737115, 6027.758889644453, 6249.062640603855, 6481.351864813481, 4322.978385108117, 4341.153475072394, 4363.0, 4369.148016136886, 4383.3863259143745, 1710.4697543761474, 1773.6098058427126, 2779.610854480374, 2790.7209279072335, 2814.183886672842, 428.05186511875723, 442.40938347306064, 467.2967184387543, 850.9021462531888, 861.2851333393269, 9837.508124593885, 9970.102690757867, 10397.948010260052, 10455.68632941013, 10655.413952232546, 429.76792532032977, 441.96464282857295, 442.09811983553834, 445.1120015568961, 450.41671036007796, 5854.970725146432, 5930.911036334458, 5957.195778569838, 6009.128676341993, 6017.458428741346, 502815.0, 514149.0, 522223.0, 523659.0, 528840.0, 71141.2885871145, 72946.63526682333, 73192.63403682948, 74004.0, 74085.62957185287, 484.5445281435439, 490.9950900491021, 493.4448745161693, 494.1426624805959, 494.3425244424906, 10025.74935626586, 10103.696889093046, 10152.137068349273, 10347.948260258952, 10427.895721042996, 33526.0, 33738.325233495685, 34736.30527389488, 35078.29843403168, 35220.64779352173, 44610.330845036704, 45353.54646453625, 45811.083778324915, 45888.54111458976, 49057.754711227644, 6163.106349579376, 7285.4900156990625, 7382.926170738224, 7387.298206670358, 7426.665800039119, 8873.64505419776, 10768.192385570957, 10920.0, 11171.0, 11343.20597558163, 6816.488763342868, 6974.6861391238535, 7387.0, 7408.777736667908, 9586.90413095888, 7086.751963681247, 7238.77874345911, 7363.263673632594, 7483.176850546544, 7531.209223031503, 6356.7775127872155, 6405.487560995202, 6971.337722916315, 7254.746083887249, 7568.5458872467825, 8872.77818054528, 9077.818443631222, 9320.533973301443, 9362.20421264173, 9365.672201472917, 6698.497612679166, 6719.966400167968, 6806.18325800907, 6930.3762661360715, 7289.671964761705], "unit": "score", "name": "jquery.html", "value": 7123.611890729093}, {"lowerIsBetter": false, "replicates": [1321.5506727712575, 1455.6215384000157, 1455.9126452412852, 1614.6124930016792, 1788.0612678343869, 7017.894731579024, 7641.8853717194215, 7834.451588388815, 7842.215778422169, 7852.803679907998, 7619.885701714478, 7807.21927807219, 7820.608969551528, 7822.295993360596, 7826.0999985001745, 1982.2863769043206, 2025.250657256817, 2270.965935510969, 2285.828562857784, 2310.202979971907, 2312.502811895442, 2317.374308936586, 2318.3045086474076, 2319.0260090761835, 2320.5474932388192, 2238.55228954209, 2306.054517647765, 2307.526956973816, 2307.665388518664, 2308.272894038381, 2252.5945329840624, 2290.141197051106, 2316.5598536278053, 2316.66408370787, 2318.119114736406, 2293.3120063980905, 2302.1366987379733, 2315.3401280635107, 2318.8376813623054, 2348.612478940973, 8036.116027236999, 8100.959495202545, 8105.27052565272, 8106.513609183409, 8112.351011919032, 4731.550502702238, 4843.539863712942, 4844.75776211188, 4845.345878306419, 4845.442774080955, 3011.9698803011906, 3048.2074660588187, 3107.8135311881133, 3163.2408222026547, 3188.713015828587, 991.6777047459533, 999.5701848205268, 999.8500224966241, 1025.1132770153763, 1027.8098551767946, 11250.718732031683, 11279.43602819864, 11285.717857053558, 11302.265352752045, 11314.37770922599, 4388.1223755249075, 4421.867343979621, 4497.168023915586, 4502.234620114523, 4545.36364908913, 9658.082482164184, 9676.70969870905, 9680.128788408936, 9686.128248457673, 9705.708828735149, 4849.684770489906, 4855.854324370274, 4881.0, 4885.8289959851945, 4886.315915771795, 4389.692721509464, 4417.785109094961, 4430.579094985971, 4431.933520997188, 4438.17893689662, 3423.1613254752747, 3472.9305413892084, 3643.071016890729, 3649.251903359858, 3698.519192505011, 1211.2913945341897, 1230.944607492665, 1236.4250623460134, 1237.672016915518, 1257.1011726615513, 1296.9805452918213, 1306.562301628946, 1313.7897936330141, 1323.5367621332648, 1324.278268343755, 7521.398288137046, 7575.166731659513, 7593.088829340514, 7594.354479869163, 7597.050368703912, 1100.3782862682558, 1101.251149218523, 1108.9390083545482, 1120.3725913488472, 1134.8467956825723, 5687.971560142173, 5755.6834374108985, 5765.221695071195, 5776.5089967352405, 5777.913331300034, 9566.665166719271, 9738.220942324597, 9904.65333713331, 10002.649907253211, 10003.79992400148, 9864.556094975744, 9873.963233860484, 9893.505324733735, 9896.0, 9911.355761875599, 7186.784396468114, 7433.293837085468, 7436.330730234305, 7441.255874412515, 7670.156282808886, 7350.963245183953, 7375.704971801068, 7443.739469118555, 7458.105027396748, 7462.067241594801, 8582.356323275655, 8733.170348816851, 8807.427517211361, 8938.910610893809, 8963.641454342014, 8915.0, 9060.501672408082, 9224.446533208029, 9239.630414783602, 9254.537273136451, 6355.300916899045, 7100.573965562083, 7209.423246140401, 7223.891641625275, 7224.494285400182, 6747.865042699217, 7087.433005359456, 7235.819104522429, 7315.707371705073, 7323.890141647773, 6816.829579260559, 6830.59016459014, 6872.896906546506, 6874.931250687429, 6910.827229319308, 6898.620575868375, 6911.412529935012, 7065.187503437171, 7091.0, 7109.360157585842, 7098.964505177441, 7115.786526404217, 7118.430525557839, 7153.248908864494, 7160.820979475555, 6450.741970321323, 6518.413342799171, 6520.673966301761, 6529.118568993125, 6539.6076235424125, 6589.538732288694, 6633.800985970429, 6658.933410665832, 6701.932980670131, 6703.631300278532], "unit": "score", "name": "mootools.html", "value": 4586.905334743456}, {"lowerIsBetter": false, "replicates": [334.5066027609278, 336.4179968654228, 339.70615417663714, 344.746611240738, 350.0670712551051, 5763.164341170528, 5893.0, 5915.378885217049, 5930.88138237235, 5946.008087290757, 5683.0, 5824.126381042845, 5848.883022339562, 5877.3241077276125, 5877.9412205877925, 4520.660950428714, 4550.180967425862, 4551.840685576006, 4556.589906908378, 4563.452385713719, 4365.956340436603, 4450.176717307292, 4451.109778044388, 4554.294084416921, 4562.634989200856, 4493.752843593601, 4500.347449619803, 4506.8422605208825, 4518.254488009475, 4527.841525546606, 4489.551044895517, 4503.864884053483, 4504.256797628404, 4525.162844873709, 4544.454665440136, 4010.9197816043807, 4011.7191796574252, 4014.8996275093064, 4016.136530645896, 4021.678265738734, 5430.348358197002, 5600.52395546379, 5602.691851948141, 5610.074337734269, 5619.887602247973, 5219.217117432378, 5227.503387178212, 5240.187770895517, 5241.475852414766, 5243.082460569385, 5924.081767326028, 6255.96872015637, 6264.27960784511, 6269.247690277196, 6274.372562743734, 4264.168487145008, 4266.57334266574, 4368.89077773055, 4376.234159022159, 4378.058717375779, 6461.095446637474, 6505.251896031969, 6538.313477084933, 6552.312007239267, 6604.900926486107, 4423.646108311327, 4460.330950357472, 4461.866144015685, 4465.732056076646, 4480.350349199348, 4433.866983990485, 4483.484399294058, 4510.616597589176, 4523.7285762854335, 4528.615067719281, 5202.97398513005, 5203.973980130075, 5207.973960130175, 5230.163173892159, 5231.372235331784, 6292.402221788922, 6299.433051025429, 6299.842503937438, 6304.621722696653, 6305.936940630535, 1571.1908367190906, 1593.2670971353307, 1593.3467278415794, 1594.378192504924, 1594.936202551885, 1052.1425038593675, 1054.3252318516156, 1055.889131641182, 1058.1534772182224, 1085.5440714899762, 5989.31122920861, 5995.5803093783015, 5995.910061349084, 5997.250343707036, 6003.909941350883, 6486.318936511692, 6493.870122597522, 6500.349965003462, 6506.837329066717, 6512.5766825156215, 5990.400959903975, 5992.34084250732, 5993.430624090704, 5993.730282137314, 5993.790217342372, 3401.3027329397414, 3507.8421471033353, 3513.543239378864, 3516.0, 3522.5949015862993, 6753.932460675429, 6764.154480689914, 6802.115724955724, 6839.658017099126, 6848.417884479875, 6691.5315927884585, 6695.163104611924, 6707.832304192434, 6708.094407255056, 6708.329167083252, 6618.371254730889, 6817.625030623363, 6827.556208846409, 6832.624205668736, 6836.760713375107, 6382.32985536512, 6554.082428460115, 6559.311272316529, 6559.770408035696, 6571.638559879252, 6344.841378965562, 6390.488760899024, 6483.319251478715, 6566.9014964776525, 6570.145881035435, 6795.626240556817, 6801.89797153053, 6803.319668033157, 6804.489663275175, 6814.420774234246, 4470.329450582439, 4488.39406680094, 4508.368828363966, 4518.728876267434, 4546.068056048436, 6586.341365863375, 6588.308227636221, 6590.373914478117, 6594.967025165035, 6595.0, 6403.679816009274, 6412.519061070531, 6414.198225221848, 6415.967920160369, 6416.262129854939, 6235.75056997715, 6397.616143031433, 6404.935950640434, 6405.327440618668, 6406.359364063556, 6187.876242475215, 6264.561480696308, 6277.18396608438, 6283.685815709287, 6286.308506064238, 6438.645874476949, 6441.066045423481, 6441.645709486023, 6444.355564443518, 6444.774432895014, 6069.089636554552, 6283.434490895841, 6285.905711414424, 6286.5599408041, 6289.056641503811], "unit": "score", "name": "prototype.html", "value": 4758.912716082116}, {"lowerIsBetter": false, "replicates": [714.7069701422417, 801.5030680977791, 810.0397039165223, 816.1878930464181, 827.8923739913811, 13449.529266475676, 13596.796048059276, 13605.591832245049, 13620.318984050808, 13621.114627549203, 13249.735005299888, 13257.46970121194, 13341.599752007456, 13344.2660653664, 13366.866331336683, 646.3536463536464, 654.9803505894831, 777.2654841175092, 792.9008873890764, 794.9682012719484, 777.6889244302267, 785.1245860865151, 789.5933594198992, 790.8339248757768, 790.9683612655516, 818.4761752478419, 820.1060843680388, 820.1716266570747, 820.7414664380731, 821.0, 684.5379368925979, 685.266764561919, 806.8547661421001, 815.7226542975387, 819.7540737778643, 600.0039933710063, 600.069891667913, 600.5285850607296, 601.714185761764, 601.9729112189962, 13055.86944130556, 13104.410301536454, 13114.344282785918, 13118.081734278605, 13140.145890517182, 11763.0, 12107.091968102428, 12141.271523708605, 12144.3320617366, 12662.936685316607, 9594.952025239829, 9831.754206144904, 9917.553710083064, 10254.077133058061, 10286.434246116462, 3517.6482351764876, 3604.0629436346476, 3615.7107431405425, 3618.3306088373733, 3691.8523259069607, 43879.0, 44028.33957490608, 44036.779816100716, 44117.0, 44270.77864610688, 8677.869831952527, 9008.41445306053, 9097.40866843653, 9171.58727857248, 9217.170454659114, 16406.261718222708, 16441.0, 16479.34082636681, 16496.25766840495, 16507.33970641161, 7046.0, 7060.0, 7182.892256616155, 7193.784186474414, 7386.113666360071, 4245.80893859777, 4363.847265345697, 4377.058932329564, 4401.471823381215, 4439.289713645801, 2989.7458716009382, 3005.6242969628797, 3008.6540047894337, 3008.819470831757, 3011.081620105845, 535.3067777228498, 538.8302684654321, 543.622182583101, 547.0481362429424, 569.5329829539737, 568.0456832521404, 615.7875532941129, 648.5687018132983, 649.078308801503, 679.5073571660605, 7931.920680793233, 7966.561839098789, 8172.0, 8175.0, 8288.46125001885, 552.1685254027261, 562.8339639806267, 607.9270487541523, 610.6702380714364, 618.3198481670127, 3603.981980090135, 3780.640839120279, 3897.9610203898164, 3921.3529767588598, 4110.260153172458, 52143.73928130411, 56488.717556412776, 56552.43447565554, 56570.717146414005, 56681.433185667614, 47669.52330476651, 47930.281045784344, 48265.0, 48528.7573562137, 50435.74782126139, 39904.40143397851, 39937.2012559753, 42220.57779422228, 43132.784336078745, 46967.29549056767, 7983.361331093614, 8135.30849877767, 8168.550729709686, 8227.13615070433, 8331.6667333306, 33694.49458258177, 34008.0, 34751.13122171966, 35178.296434071686, 36298.092547686516, 43437.34843977406, 43914.78042609766, 44166.33750493809, 44210.0, 44874.551254488346, 9868.0, 10162.745931351776, 10199.286049976727, 10407.84388234162, 10512.526936288039, 11035.889641103486, 11178.385188814693, 11283.323000619988, 11378.943105284752, 11604.477798499256, 10372.636957706745, 10649.254552181274, 10672.62645807393, 10738.355698658106, 10796.946015269874, 9921.206303495559, 9940.652077177265, 10186.337888037255, 10286.0, 10534.841977370192, 10534.683959481228, 10547.472626368497, 10578.312409693346, 10654.62708805188, 10780.784384312426, 8726.607302671267, 8980.0, 9277.16505514507, 9341.2994025447, 9496.952515237379, 8314.958425208077, 8403.11968545322, 8404.789880252798, 8715.0, 8791.164839340252], "unit": "score", "name": "yui.html", "value": 6005.044420594071}], "name": "dromaeo_css", "value": 6600.469978723565}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 114.0, 105.0, 111.0, 111.0, 113.0, 100.0, 110.0, 111.0, 119.0], "unit": "score", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [153.0, 128.0, 148.0, 161.0, 127.0, 152.0, 147.0, 124.0, 167.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 143.6}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 162.0, 159.0, 160.0, 161.0, 160.0, 163.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 83.0, 93.0, 71.0, 71.0, 72.0, 121.0, 91.0, 74.0], "unit": "score", "name": "audio-fft", "value": 82.2}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 141.0, 96.0, 95.0, 96.0, 150.0, 96.0, 96.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 56.0, 57.0, 55.0, 56.0, 57.0, 64.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 67.0, 70.0, 67.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 87.0, 86.0, 85.0, 86.0, 86.0, 86.0, 85.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.8}, {"lowerIsBetter": true, "replicates": [115.0, 122.0, 136.0, 113.0, 118.0, 124.0, 126.0, 117.0, 118.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.6}, {"lowerIsBetter": true, "replicates": [152.0, 145.0, 153.0, 154.0, 155.0, 146.0, 155.0, 151.0, 151.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 71.0, 70.0, 67.0, 69.0, 69.0, 68.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1508.2999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.9449081803005], "unit": "score", "name": "Richards", "value": 211.45897999999997}, {"lowerIsBetter": false, "replicates": [192.01228878648234], "unit": "score", "name": "DeltaBlue", "value": 344.3425439999999}, {"lowerIsBetter": false, "replicates": [287.5215641173088], "unit": "score", "name": "Encrypt", "value": 925.777518}, {"lowerIsBetter": false, "replicates": [5263.1578947368425], "unit": "score", "name": "Decrypt", "value": 50.57439}, {"lowerIsBetter": false, "replicates": [1104.9723756906078], "unit": "score", "name": "RayTrace", "value": 669.6900450000003}, {"lowerIsBetter": false, "replicates": [799.3605115907275], "unit": "score", "name": "Earley", "value": 833.7452129999997}, {"lowerIsBetter": false, "replicates": [12358.024691358025], "unit": "score", "name": "Boyer", "value": 53.929573426573455}, {"lowerIsBetter": false, "replicates": [41510.204081632655], "unit": "score", "name": "RegExp", "value": 21.946049655850537}, {"lowerIsBetter": false, "replicates": [578.3410138248848], "unit": "score", "name": "Splay", "value": 140.90475697211156}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20011.003415733187}]} 17:15:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20011.00"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1508.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6600.47"}}} 17:15:33 INFO - Return code: 0 17:15:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:15:33 INFO - # TBPL SUCCESS # 17:15:33 INFO - Running post-action listener: _resource_record_post_action 17:15:33 INFO - Running post-run listener: _resource_record_post_run 17:15:34 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 567468032; Read time: 0; Write time: 456728 17:15:34 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 255758336; Read time: 0; Write time: 243968 17:15:34 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 311435264; Read time: 0; Write time: 212740 17:15:34 INFO - Running post-run listener: _upload_blobber_files 17:15:34 INFO - Blob upload gear active. 17:15:34 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:15:34 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 17:15:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:15:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:15:35 INFO - (blobuploader) - INFO - Open directory for files ... 17:15:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:15:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:15:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:15:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:15:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:15:36 INFO - (blobuploader) - INFO - Done attempting. 17:15:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:15:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:15:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:15:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:15:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:15:36 INFO - (blobuploader) - INFO - Done attempting. 17:15:36 INFO - (blobuploader) - INFO - Iteration through files over. 17:15:36 INFO - Return code: 0 17:15:36 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:15:36 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:15:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/4d4d55b173307933c1e3b281dfe9ef717c4b495e5338ed1d8252d09c723df1975c56babf48bfed7acfeea977a0f7b718e61f58c6888f48510a6478f379c12001", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/aad43dded70be953ce26d6ebb30163348d233ce5a1a07b794bc3496df0a8bf7656e2ecc74f84f1a58687aa27c39b36fea9852abeccda6a1a5fd17492fe0ab5fc"} 17:15:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:15:36 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:15:36 INFO - Contents: 17:15:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/4d4d55b173307933c1e3b281dfe9ef717c4b495e5338ed1d8252d09c723df1975c56babf48bfed7acfeea977a0f7b718e61f58c6888f48510a6478f379c12001", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/aad43dded70be953ce26d6ebb30163348d233ce5a1a07b794bc3496df0a8bf7656e2ecc74f84f1a58687aa27c39b36fea9852abeccda6a1a5fd17492fe0ab5fc"} 17:15:36 INFO - Copying logs to upload dir... 17:15:36 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1271.225460 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-08 17:15:36.849066) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 17:15:36.852165) ========= 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=4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/4d4d55b173307933c1e3b281dfe9ef717c4b495e5338ed1d8252d09c723df1975c56babf48bfed7acfeea977a0f7b718e61f58c6888f48510a6478f379c12001", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/aad43dded70be953ce26d6ebb30163348d233ce5a1a07b794bc3496df0a8bf7656e2ecc74f84f1a58687aa27c39b36fea9852abeccda6a1a5fd17492fe0ab5fc"} build_url:https://queue.taskcluster.net/v1/task/RJ3XuWH3SRyWn0JssVKlDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011430 build_url: 'https://queue.taskcluster.net/v1/task/RJ3XuWH3SRyWn0JssVKlDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/4d4d55b173307933c1e3b281dfe9ef717c4b495e5338ed1d8252d09c723df1975c56babf48bfed7acfeea977a0f7b718e61f58c6888f48510a6478f379c12001", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/aad43dded70be953ce26d6ebb30163348d233ce5a1a07b794bc3496df0a8bf7656e2ecc74f84f1a58687aa27c39b36fea9852abeccda6a1a5fd17492fe0ab5fc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 17:15:36.876573) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 17:15:36.876911) ========= 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=4ac8d263c7293b36a1be1aed000001be-1452298203.164108-446557712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 17:15:36.959644) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 17:15:36.959977) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 17:15:36.960288) ========= ========= Total master_lag: 0.28 =========