builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-024 starttime: 1452571348.63 results: success (0) buildid: 20160111173003 builduid: dfb4d4f0b0284abba9f4171d16ea3291 revision: 2300f7506a8c3c8a685dcbb1a430aad134b8ede8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 20:02:28.635644) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 20:02:28.636151) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 20:02:28.636457) ========= 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=4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006485 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 20:02:28.669138) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 20:02:28.669471) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 20:02:28.687308) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 20:02:28.687577) ========= 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=4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 20:02:28.736711) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 20:02:28.737005) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 20:02:28.737395) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 20:02:28.737702) ========= 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=4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-11 20:02:28-- 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% 84.4M=0s 2016-01-11 20:02:29 (84.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.315760 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 20:02:29.067172) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 20:02:29.067519) ========= 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=4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016820 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 20:02:29.118331) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 20:02:29.118733) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 2300f7506a8c3c8a685dcbb1a430aad134b8ede8 --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 2300f7506a8c3c8a685dcbb1a430aad134b8ede8 --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=4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-11 20:02:29,370 truncating revision to first 12 chars 2016-01-11 20:02:29,370 Setting DEBUG logging. 2016-01-11 20:02:29,370 attempt 1/10 2016-01-11 20:02:29,370 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/2300f7506a8c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-11 20:02:29,851 unpacking tar archive at: b2g-inbound-2300f7506a8c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.791291 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 20:02:29.922986) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 20:02:29.923298) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 20:02:29.931118) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 20:02:29.931402) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 20:02:29.931799) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-01-11 20:02:29.932091) ========= /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=4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:02:30 INFO - MultiFileLogger online at 20160111 20:02:30 in /builds/slave/test-pgo 20:02:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 20:02:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 20:02:30 INFO - {'append_to_log': False, 20:02:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 20:02:30 INFO - 'blob_upload_branch': 'B2G-Inbound', 20:02:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 20:02:30 INFO - 'branch': 'B2G-Inbound', 20:02:30 INFO - 'buildbot_json_path': 'buildprops.json', 20:02:30 INFO - 'config_files': ('talos/linux_config.py',), 20:02:30 INFO - 'default_actions': ('clobber', 20:02:30 INFO - 'read-buildbot-config', 20:02:30 INFO - 'download-and-extract', 20:02:30 INFO - 'populate-webroot', 20:02:30 INFO - 'create-virtualenv', 20:02:30 INFO - 'install', 20:02:30 INFO - 'run-tests'), 20:02:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:02:30 INFO - 'download_minidump_stackwalk': True, 20:02:30 INFO - 'download_symbols': 'ondemand', 20:02:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:02:30 INFO - 'tooltool.py': '/tools/tooltool.py', 20:02:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:02:30 INFO - '/tools/misc-python/virtualenv.py')}, 20:02:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:02:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:02:30 INFO - 'installer_path': 'installer.exe', 20:02:30 INFO - 'log_level': 'info', 20:02:30 INFO - 'log_name': 'talos', 20:02:30 INFO - 'log_to_console': True, 20:02:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:02:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:02:30 INFO - 'opt_config_files': (), 20:02:30 INFO - 'pip_index': False, 20:02:30 INFO - 'sps_profile': False, 20:02:30 INFO - 'sps_profile_interval': 0, 20:02:30 INFO - 'suite': 'dromaeojs', 20:02:30 INFO - 'system_bits': '32', 20:02:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:02:30 INFO - 'title': 'talos-linux64-ix-024', 20:02:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:02:30 INFO - 'use_talos_json': True, 20:02:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 20:02:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:02:30 INFO - 'work_dir': 'build'} 20:02:30 INFO - ##### 20:02:30 INFO - ##### Running clobber step. 20:02:30 INFO - ##### 20:02:30 INFO - Running pre-action listener: _resource_record_pre_action 20:02:30 INFO - Running main action method: clobber 20:02:30 INFO - rmtree: /builds/slave/test-pgo/build 20:02:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 20:02:30 INFO - Running post-action listener: _resource_record_post_action 20:02:30 INFO - ##### 20:02:30 INFO - ##### Running read-buildbot-config step. 20:02:30 INFO - ##### 20:02:30 INFO - Running pre-action listener: _resource_record_pre_action 20:02:30 INFO - Running main action method: read_buildbot_config 20:02:30 INFO - Using buildbot properties: 20:02:30 INFO - { 20:02:30 INFO - "project": "", 20:02:30 INFO - "product": "firefox", 20:02:30 INFO - "script_repo_revision": "production", 20:02:30 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 20:02:30 INFO - "repository": "", 20:02:30 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 20:02:30 INFO - "buildid": "20160111173003", 20:02:30 INFO - "pgo_build": "True", 20:02:30 INFO - "basedir": "/builds/slave/test-pgo", 20:02:30 INFO - "buildnumber": 1101, 20:02:30 INFO - "slavename": "talos-linux64-ix-024", 20:02:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:02:30 INFO - "platform": "ubuntu64_hw", 20:02:30 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 20:02:30 INFO - "branch": "b2g-inbound", 20:02:30 INFO - "repo_path": "integration/b2g-inbound", 20:02:30 INFO - "revision": "2300f7506a8c3c8a685dcbb1a430aad134b8ede8", 20:02:30 INFO - "stage_platform": "linux64-pgo", 20:02:30 INFO - "builduid": "dfb4d4f0b0284abba9f4171d16ea3291", 20:02:30 INFO - "slavebuilddir": "test" 20:02:30 INFO - } 20:02:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/O3Y_be_WQ8eeUe0s725p1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 20:02:30 INFO - Running post-action listener: _resource_record_post_action 20:02:30 INFO - ##### 20:02:30 INFO - ##### Running download-and-extract step. 20:02:30 INFO - ##### 20:02:30 INFO - Running pre-action listener: _resource_record_pre_action 20:02:30 INFO - Running main action method: download_and_extract 20:02:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 20:02: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')]} 20:02:30 INFO - https://queue.taskcluster.net/v1/task/O3Y_be_WQ8eeUe0s725p1Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:02:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3Y_be_WQ8eeUe0s725p1Q/artifacts/public/build/test_packages.json 20:02:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3Y_be_WQ8eeUe0s725p1Q/artifacts/public/build/test_packages.json 20:02:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3Y_be_WQ8eeUe0s725p1Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 20:02:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3Y_be_WQ8eeUe0s725p1Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 20:02:33 INFO - Downloaded 1302 bytes. 20:02:34 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 20:02:34 INFO - Using the following test package requirements: 20:02:34 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:02:34 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:02:34 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:34 INFO - u'jsshell-linux-x86_64.zip'], 20:02:34 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:02:34 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:02:34 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:02:34 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:02:34 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:02:34 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:02:34 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:02:34 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:02:34 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')]} 20:02:34 INFO - https://queue.taskcluster.net/v1/task/O3Y_be_WQ8eeUe0s725p1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:02:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3Y_be_WQ8eeUe0s725p1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:02:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3Y_be_WQ8eeUe0s725p1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:02:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3Y_be_WQ8eeUe0s725p1Q/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 20:02:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3Y_be_WQ8eeUe0s725p1Q/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 20:02:37 INFO - Downloaded 24028582 bytes. 20:02:37 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 20:02:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:02:37 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 20:02:38 INFO - Return code: 0 20:02:38 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 20:02: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')]} 20:02:38 INFO - https://queue.taskcluster.net/v1/task/O3Y_be_WQ8eeUe0s725p1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:02:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3Y_be_WQ8eeUe0s725p1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:02:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3Y_be_WQ8eeUe0s725p1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:02:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3Y_be_WQ8eeUe0s725p1Q/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 20:02:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3Y_be_WQ8eeUe0s725p1Q/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 20:02:43 INFO - Downloaded 24028582 bytes. 20:02:43 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 20:02:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:02:43 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 20:02:45 INFO - Return code: 0 20:02: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')]} 20:02:45 INFO - https://queue.taskcluster.net/v1/task/O3Y_be_WQ8eeUe0s725p1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:02:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3Y_be_WQ8eeUe0s725p1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:02:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3Y_be_WQ8eeUe0s725p1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:02:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3Y_be_WQ8eeUe0s725p1Q/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 20:02:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3Y_be_WQ8eeUe0s725p1Q/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 20:02:47 INFO - Downloaded 11132285 bytes. 20:02:47 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 20:02:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:02:47 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 20:02:48 INFO - Return code: 0 20:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:48 INFO - https://queue.taskcluster.net/v1/task/O3Y_be_WQ8eeUe0s725p1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:02:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3Y_be_WQ8eeUe0s725p1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:02:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3Y_be_WQ8eeUe0s725p1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:02:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3Y_be_WQ8eeUe0s725p1Q/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 20:02:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3Y_be_WQ8eeUe0s725p1Q/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 20:02:55 INFO - Downloaded 55925235 bytes. 20:02:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O3Y_be_WQ8eeUe0s725p1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:02:55 INFO - mkdir: /builds/slave/test-pgo/properties 20:02:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 20:02:55 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 20:02:55 INFO - Contents: 20:02:55 INFO - build_url:https://queue.taskcluster.net/v1/task/O3Y_be_WQ8eeUe0s725p1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:02:55 INFO - Running post-action listener: _resource_record_post_action 20:02:55 INFO - Running post-action listener: set_extra_try_arguments 20:02:55 INFO - ##### 20:02:55 INFO - ##### Running populate-webroot step. 20:02:55 INFO - ##### 20:02:55 INFO - Running pre-action listener: _resource_record_pre_action 20:02:55 INFO - Running main action method: populate_webroot 20:02:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:02:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:02:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:02:55 INFO - '--tppagecycles', 20:02:55 INFO - '7'], 20:02:55 INFO - 'tests': ['tsvgm']}}, 20:02:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:02:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:02:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:02:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:02:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:02:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:02:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:02:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:55 INFO - 'talos_options': ['--e10s'], 20:02:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:02:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:55 INFO - 'tests': ['damp', 'tps']}, 20:02:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:55 INFO - 'talos_options': ['--e10s'], 20:02:55 INFO - 'tests': ['damp', 'tps']}, 20:02:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:02:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:02:55 INFO - 'other': {'tests': ['a11yr', 20:02:55 INFO - 'ts_paint', 20:02:55 INFO - 'tpaint', 20:02:55 INFO - 'sessionrestore', 20:02:55 INFO - 'sessionrestore_no_auto_restore']}, 20:02:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:02:55 INFO - 'tests': ['a11yr', 20:02:55 INFO - 'ts_paint', 20:02:55 INFO - 'tpaint', 20:02:55 INFO - 'sessionrestore', 20:02:55 INFO - 'sessionrestore_no_auto_restore']}, 20:02:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:02:55 INFO - 'tests': ['a11yr', 20:02:55 INFO - 'ts_paint', 20:02:55 INFO - 'tpaint', 20:02:55 INFO - 'sessionrestore', 20:02:55 INFO - 'sessionrestore_no_auto_restore']}, 20:02:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:02:55 INFO - 'tests': ['a11yr', 20:02:55 INFO - 'ts_paint', 20:02:55 INFO - 'tpaint', 20:02:55 INFO - 'sessionrestore', 20:02:55 INFO - 'sessionrestore_no_auto_restore']}, 20:02:55 INFO - 'other_l64': {'tests': ['a11yr', 20:02:55 INFO - 'ts_paint', 20:02:55 INFO - 'tpaint', 20:02:55 INFO - 'sessionrestore', 20:02:55 INFO - 'sessionrestore_no_auto_restore']}, 20:02:55 INFO - 'other_nol64': {'tests': ['a11yr', 20:02:55 INFO - 'ts_paint', 20:02:55 INFO - 'tpaint', 20:02:55 INFO - 'sessionrestore', 20:02:55 INFO - 'sessionrestore_no_auto_restore']}, 20:02:55 INFO - 'svgr': {'tests': ['tsvgx', 20:02:55 INFO - 'tsvgr_opacity', 20:02:55 INFO - 'tart', 20:02:55 INFO - 'tscrollx', 20:02:55 INFO - 'cart']}, 20:02:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:02:55 INFO - 'tests': ['tsvgx', 20:02:55 INFO - 'tsvgr_opacity', 20:02:55 INFO - 'tart', 20:02:55 INFO - 'tscrollx', 20:02:55 INFO - 'cart']}, 20:02:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:55 INFO - 'tests': ['tp5o']}, 20:02:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:55 INFO - 'talos_options': ['--e10s'], 20:02:55 INFO - 'tests': ['tp5o']}, 20:02:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:55 INFO - 'talos_options': ['--xperf_path', 20:02:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:02:55 INFO - 'tests': ['tp5n']}, 20:02:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:55 INFO - 'talos_options': ['--e10s', 20:02:55 INFO - '--xperf_path', 20:02:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:02:55 INFO - 'tests': ['tp5n']}}, 20:02:55 INFO - 'talos.zip': {'path': '', 20:02:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:02:55 INFO - Running post-action listener: _resource_record_post_action 20:02:55 INFO - ##### 20:02:55 INFO - ##### Running create-virtualenv step. 20:02:55 INFO - ##### 20:02:55 INFO - Running pre-action listener: _resource_record_pre_action 20:02:55 INFO - Running main action method: create_virtualenv 20:02:55 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 20:02:55 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 20:02:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 20:02:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:02:55 INFO - Using real prefix '/usr' 20:02:55 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 20:02:56 INFO - Installing distribute.............................................................................................................................................................................................done. 20:02:58 INFO - Installing pip.................done. 20:02:58 INFO - Return code: 0 20:02:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 20:02:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa64d80df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1482630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1513840>, '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 0x14806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1480b60>, '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': '4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584', '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 20:02:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 20:02:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:02:58 INFO - Using env: {'DISPLAY': ':0', 20:02:58 INFO - 'HOME': '/home/cltbld', 20:02:58 INFO - 'LANG': 'en_US.UTF-8', 20:02:58 INFO - 'LANGUAGE': 'en_US:en', 20:02:58 INFO - 'LOGNAME': 'cltbld', 20:02:58 INFO - 'MAIL': '/var/mail/cltbld', 20:02:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:58 INFO - 'MOZ_NO_REMOTE': '1', 20:02:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:58 INFO - 'NO_EM_RESTART': '1', 20:02:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:02:58 INFO - 'PWD': '/builds/slave/test-pgo', 20:02:58 INFO - 'SHELL': '/bin/bash', 20:02:58 INFO - 'SHLVL': '1', 20:02:58 INFO - 'TERM': 'linux', 20:02:58 INFO - 'TMOUT': '86400', 20:02:58 INFO - 'USER': 'cltbld', 20:02:58 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584', 20:02:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:58 INFO - '_': '/tools/buildbot/bin/python'} 20:02:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:58 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 20:02:58 INFO - Cleaning up... 20:02:58 INFO - Return code: 0 20:02:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 20:02:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa64d80df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1482630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1513840>, '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 0x14806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1480b60>, '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': '4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584', '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 20:02:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 20:02:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:02:58 INFO - Using env: {'DISPLAY': ':0', 20:02:58 INFO - 'HOME': '/home/cltbld', 20:02:58 INFO - 'LANG': 'en_US.UTF-8', 20:02:58 INFO - 'LANGUAGE': 'en_US:en', 20:02:58 INFO - 'LOGNAME': 'cltbld', 20:02:58 INFO - 'MAIL': '/var/mail/cltbld', 20:02:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:58 INFO - 'MOZ_NO_REMOTE': '1', 20:02:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:58 INFO - 'NO_EM_RESTART': '1', 20:02:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:02:58 INFO - 'PWD': '/builds/slave/test-pgo', 20:02:58 INFO - 'SHELL': '/bin/bash', 20:02:58 INFO - 'SHLVL': '1', 20:02:58 INFO - 'TERM': 'linux', 20:02:58 INFO - 'TMOUT': '86400', 20:02:58 INFO - 'USER': 'cltbld', 20:02:58 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584', 20:02:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:58 INFO - '_': '/tools/buildbot/bin/python'} 20:02:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:58 INFO - Downloading/unpacking psutil>=0.7.1 20:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:00 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 20:03:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 20:03:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 20:03:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:03:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:03:00 INFO - Installing collected packages: psutil 20:03:00 INFO - Running setup.py install for psutil 20:03:00 INFO - building 'psutil._psutil_linux' extension 20:03:00 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 20:03:00 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 20:03:00 INFO - building 'psutil._psutil_posix' extension 20:03:00 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 20:03:00 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 20:03:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:03:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:03:00 INFO - Successfully installed psutil 20:03:00 INFO - Cleaning up... 20:03:00 INFO - Return code: 0 20:03:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 20:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa64d80df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1482630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1513840>, '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 0x14806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1480b60>, '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': '4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584', '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 20:03:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 20:03:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 20:03:00 INFO - Using env: {'DISPLAY': ':0', 20:03:00 INFO - 'HOME': '/home/cltbld', 20:03:00 INFO - 'LANG': 'en_US.UTF-8', 20:03:00 INFO - 'LANGUAGE': 'en_US:en', 20:03:00 INFO - 'LOGNAME': 'cltbld', 20:03:00 INFO - 'MAIL': '/var/mail/cltbld', 20:03:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:00 INFO - 'MOZ_NO_REMOTE': '1', 20:03:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:00 INFO - 'NO_EM_RESTART': '1', 20:03:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:00 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:00 INFO - 'SHELL': '/bin/bash', 20:03:00 INFO - 'SHLVL': '1', 20:03:00 INFO - 'TERM': 'linux', 20:03:00 INFO - 'TMOUT': '86400', 20:03:00 INFO - 'USER': 'cltbld', 20:03:00 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584', 20:03:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:00 INFO - '_': '/tools/buildbot/bin/python'} 20:03:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:03: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 20:03: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 20:03: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 20:03: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 20:03: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 20:03: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 20:03:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:03:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 20:03:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:03:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:03:02 INFO - Installing collected packages: mozsystemmonitor 20:03:02 INFO - Running setup.py install for mozsystemmonitor 20:03:02 INFO - Successfully installed mozsystemmonitor 20:03:02 INFO - Cleaning up... 20:03:02 INFO - Return code: 0 20:03:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 20:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa64d80df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1482630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1513840>, '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 0x14806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1480b60>, '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': '4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584', '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 20:03:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 20:03:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:03:02 INFO - Using env: {'DISPLAY': ':0', 20:03:02 INFO - 'HOME': '/home/cltbld', 20:03:02 INFO - 'LANG': 'en_US.UTF-8', 20:03:02 INFO - 'LANGUAGE': 'en_US:en', 20:03:02 INFO - 'LOGNAME': 'cltbld', 20:03:02 INFO - 'MAIL': '/var/mail/cltbld', 20:03:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:02 INFO - 'MOZ_NO_REMOTE': '1', 20:03:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:02 INFO - 'NO_EM_RESTART': '1', 20:03:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:02 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:02 INFO - 'SHELL': '/bin/bash', 20:03:02 INFO - 'SHLVL': '1', 20:03:02 INFO - 'TERM': 'linux', 20:03:02 INFO - 'TMOUT': '86400', 20:03:02 INFO - 'USER': 'cltbld', 20:03:02 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584', 20:03:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:02 INFO - '_': '/tools/buildbot/bin/python'} 20:03:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:03 INFO - Downloading/unpacking blobuploader==1.2.4 20:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:04 INFO - Downloading blobuploader-1.2.4.tar.gz 20:03:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 20:03:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:03:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:03:04 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 20:03:04 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 20:03:04 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 20:03:04 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 20:03:04 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 20:03:04 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 20:03:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 20:03:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 20:03:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:05 INFO - Downloading docopt-0.6.1.tar.gz 20:03:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 20:03:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 20:03:05 INFO - Installing collected packages: blobuploader, requests, docopt 20:03:05 INFO - Running setup.py install for blobuploader 20:03:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:03:05 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 20:03:05 INFO - Running setup.py install for requests 20:03:06 INFO - Running setup.py install for docopt 20:03:06 INFO - Successfully installed blobuploader requests docopt 20:03:06 INFO - Cleaning up... 20:03:06 INFO - Return code: 0 20:03:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:03:06 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')]} 20:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:06 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')]} 20:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:06 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 0x7fa64d80df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1482630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1513840>, '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 0x14806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1480b60>, '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': '4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584', '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 20:03:06 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 20:03:06 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 20:03:06 INFO - Using env: {'DISPLAY': ':0', 20:03:06 INFO - 'HOME': '/home/cltbld', 20:03:06 INFO - 'LANG': 'en_US.UTF-8', 20:03:06 INFO - 'LANGUAGE': 'en_US:en', 20:03:06 INFO - 'LOGNAME': 'cltbld', 20:03:06 INFO - 'MAIL': '/var/mail/cltbld', 20:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:06 INFO - 'MOZ_NO_REMOTE': '1', 20:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:06 INFO - 'NO_EM_RESTART': '1', 20:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:06 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:06 INFO - 'SHELL': '/bin/bash', 20:03:06 INFO - 'SHLVL': '1', 20:03:06 INFO - 'TERM': 'linux', 20:03:06 INFO - 'TMOUT': '86400', 20:03:06 INFO - 'USER': 'cltbld', 20:03:06 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584', 20:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:06 INFO - '_': '/tools/buildbot/bin/python'} 20:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:03:06 INFO - Running setup.py (path:/tmp/pip-TmoXJC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:03:06 INFO - Running setup.py (path:/tmp/pip-PgNCrU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:03:06 INFO - Running setup.py (path:/tmp/pip-AXiJ3F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:03:06 INFO - Running setup.py (path:/tmp/pip-Cn2VMs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:03:06 INFO - Running setup.py (path:/tmp/pip-cHhBSE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:03:06 INFO - Running setup.py (path:/tmp/pip-OVdcij-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:03:06 INFO - Running setup.py (path:/tmp/pip-1DuQK9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:03:06 INFO - Running setup.py (path:/tmp/pip-YXcFY_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:03:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:03:07 INFO - Running setup.py (path:/tmp/pip-FRmHxt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:03:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:03:07 INFO - Running setup.py (path:/tmp/pip-yKgnD2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:03:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:03:07 INFO - Running setup.py (path:/tmp/pip-Rw_EQR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:03:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:03:07 INFO - Running setup.py (path:/tmp/pip-oFNsFK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:03:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:03:07 INFO - Running setup.py (path:/tmp/pip-dfLrza-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:03:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:03:07 INFO - Running setup.py (path:/tmp/pip-mB_Cze-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:03:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:03:07 INFO - Running setup.py (path:/tmp/pip-pUo8HE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:03:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:03:07 INFO - Running setup.py (path:/tmp/pip-vcA0AW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:03:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:03:07 INFO - Running setup.py (path:/tmp/pip-1iEY9J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:03:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:03:07 INFO - Running setup.py install for manifestparser 20:03:07 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 20:03:07 INFO - Running setup.py install for mozcrash 20:03:07 INFO - Running setup.py install for mozdebug 20:03:07 INFO - Running setup.py install for mozdevice 20:03:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 20:03:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 20:03:08 INFO - Running setup.py install for mozfile 20:03:08 INFO - Running setup.py install for mozhttpd 20:03:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 20:03:08 INFO - Running setup.py install for mozinfo 20:03:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 20:03:08 INFO - Running setup.py install for mozInstall 20:03:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 20:03:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 20:03:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 20:03:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 20:03:08 INFO - Running setup.py install for mozleak 20:03:08 INFO - Running setup.py install for mozlog 20:03:08 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 20:03:08 INFO - Running setup.py install for moznetwork 20:03:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 20:03:08 INFO - Running setup.py install for mozprocess 20:03:08 INFO - Running setup.py install for mozprofile 20:03:08 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 20:03:08 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 20:03:08 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 20:03:09 INFO - Running setup.py install for mozrunner 20:03:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 20:03:09 INFO - Running setup.py install for mozscreenshot 20:03:09 INFO - Running setup.py install for moztest 20:03:09 INFO - Running setup.py install for mozversion 20:03:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 20:03:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:03:09 INFO - Cleaning up... 20:03:09 INFO - Return code: 0 20:03:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:03:09 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')]} 20:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:09 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')]} 20:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:09 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 0x7fa64d80df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1482630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1513840>, '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 0x14806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1480b60>, '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': '4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584', '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 20:03:09 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 20:03:09 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 20:03:09 INFO - Using env: {'DISPLAY': ':0', 20:03:09 INFO - 'HOME': '/home/cltbld', 20:03:09 INFO - 'LANG': 'en_US.UTF-8', 20:03:09 INFO - 'LANGUAGE': 'en_US:en', 20:03:09 INFO - 'LOGNAME': 'cltbld', 20:03:09 INFO - 'MAIL': '/var/mail/cltbld', 20:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:09 INFO - 'MOZ_NO_REMOTE': '1', 20:03:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:09 INFO - 'NO_EM_RESTART': '1', 20:03:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:09 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:09 INFO - 'SHELL': '/bin/bash', 20:03:09 INFO - 'SHLVL': '1', 20:03:09 INFO - 'TERM': 'linux', 20:03:09 INFO - 'TMOUT': '86400', 20:03:09 INFO - 'USER': 'cltbld', 20:03:09 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584', 20:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:09 INFO - '_': '/tools/buildbot/bin/python'} 20:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:03:09 INFO - Running setup.py (path:/tmp/pip-OtizoQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:03:09 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)) 20:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:03:09 INFO - Running setup.py (path:/tmp/pip-oOIc3K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:03:09 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)) 20:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:03:09 INFO - Running setup.py (path:/tmp/pip-NNuFEC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:03:09 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)) 20:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:03:09 INFO - Running setup.py (path:/tmp/pip-no5lrp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:03:09 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)) 20:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:03:09 INFO - Running setup.py (path:/tmp/pip-1EoZiE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:03:10 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)) 20:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:03:10 INFO - Running setup.py (path:/tmp/pip-sRtmCj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:03:10 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)) 20:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:03:10 INFO - Running setup.py (path:/tmp/pip-VCFyog-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:03:10 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)) 20:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:03:10 INFO - Running setup.py (path:/tmp/pip-ieHmXT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:03:10 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)) 20:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:03:10 INFO - Running setup.py (path:/tmp/pip-hGTYu3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:03:10 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)) 20:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:03:10 INFO - Running setup.py (path:/tmp/pip-Ye7nbd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:03:10 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)) 20:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:03:10 INFO - Running setup.py (path:/tmp/pip-hw7wy6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:03:10 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)) 20:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:03:10 INFO - Running setup.py (path:/tmp/pip-dnzRZO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:03:10 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)) 20:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:03:10 INFO - Running setup.py (path:/tmp/pip-YMJe5V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:03:10 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)) 20:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:03:10 INFO - Running setup.py (path:/tmp/pip-cY8ppL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:03:10 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)) 20:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:03:10 INFO - Running setup.py (path:/tmp/pip-coX23U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:03:10 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)) 20:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:03:10 INFO - Running setup.py (path:/tmp/pip-e6YlkP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:03:10 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)) 20:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:03:10 INFO - Running setup.py (path:/tmp/pip-ZfAleh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:03:10 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)) 20:03:10 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)) 20:03:10 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)) 20:03:10 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)) 20:03:10 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)) 20:03:10 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)) 20:03:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:12 INFO - Downloading blessings-1.5.1.tar.gz 20:03:12 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 20:03:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 20:03:12 INFO - Installing collected packages: blessings 20:03:12 INFO - Running setup.py install for blessings 20:03:12 INFO - Successfully installed blessings 20:03:12 INFO - Cleaning up... 20:03:12 INFO - Return code: 0 20:03:12 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 20:03:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:03:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:03:13 INFO - Reading from file tmpfile_stdout 20:03:13 INFO - Current package versions: 20:03:13 INFO - argparse == 1.2.1 20:03:13 INFO - blessings == 1.5.1 20:03:13 INFO - blobuploader == 1.2.4 20:03:13 INFO - docopt == 0.6.1 20:03:13 INFO - manifestparser == 1.1 20:03:13 INFO - mozInstall == 1.12 20:03:13 INFO - mozcrash == 0.16 20:03:13 INFO - mozdebug == 0.1 20:03:13 INFO - mozdevice == 0.47 20:03:13 INFO - mozfile == 1.2 20:03:13 INFO - mozhttpd == 0.7 20:03:13 INFO - mozinfo == 0.9 20:03:13 INFO - mozleak == 0.1 20:03:13 INFO - mozlog == 3.1 20:03:13 INFO - moznetwork == 0.27 20:03:13 INFO - mozprocess == 0.22 20:03:13 INFO - mozprofile == 0.28 20:03:13 INFO - mozrunner == 6.11 20:03:13 INFO - mozscreenshot == 0.1 20:03:13 INFO - mozsystemmonitor == 0.0 20:03:13 INFO - moztest == 0.7 20:03:13 INFO - mozversion == 1.4 20:03:13 INFO - psutil == 3.1.1 20:03:13 INFO - requests == 1.2.3 20:03:13 INFO - wsgiref == 0.1.2 20:03:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:03:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fa64d80df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1482630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1513840>, '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 0x14806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1480b60>, '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': '4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584', '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 20:03:13 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 20:03:13 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 20:03:13 INFO - Using env: {'DISPLAY': ':0', 20:03:13 INFO - 'HOME': '/home/cltbld', 20:03:13 INFO - 'LANG': 'en_US.UTF-8', 20:03:13 INFO - 'LANGUAGE': 'en_US:en', 20:03:13 INFO - 'LOGNAME': 'cltbld', 20:03:13 INFO - 'MAIL': '/var/mail/cltbld', 20:03:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:13 INFO - 'MOZ_NO_REMOTE': '1', 20:03:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:13 INFO - 'NO_EM_RESTART': '1', 20:03:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:13 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:13 INFO - 'SHELL': '/bin/bash', 20:03:13 INFO - 'SHLVL': '1', 20:03:13 INFO - 'TERM': 'linux', 20:03:13 INFO - 'TMOUT': '86400', 20:03:13 INFO - 'USER': 'cltbld', 20:03:13 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584', 20:03:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:13 INFO - '_': '/tools/buildbot/bin/python'} 20:03:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:13 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)) 20:03:13 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)) 20:03:13 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)) 20:03:13 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)) 20:03:13 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)) 20:03:13 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)) 20:03:13 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)) 20:03:13 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)) 20:03:13 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)) 20:03:13 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)) 20:03:13 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)) 20:03:13 INFO - Cleaning up... 20:03:13 INFO - Return code: 0 20:03:13 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 20:03:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa64d80df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1482630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1513840>, '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 0x14806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1480b60>, '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': '4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584', '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 20:03:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 20:03:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:03:13 INFO - Using env: {'DISPLAY': ':0', 20:03:13 INFO - 'HOME': '/home/cltbld', 20:03:13 INFO - 'LANG': 'en_US.UTF-8', 20:03:13 INFO - 'LANGUAGE': 'en_US:en', 20:03:13 INFO - 'LOGNAME': 'cltbld', 20:03:13 INFO - 'MAIL': '/var/mail/cltbld', 20:03:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:13 INFO - 'MOZ_NO_REMOTE': '1', 20:03:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:13 INFO - 'NO_EM_RESTART': '1', 20:03:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:13 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:13 INFO - 'SHELL': '/bin/bash', 20:03:13 INFO - 'SHLVL': '1', 20:03:13 INFO - 'TERM': 'linux', 20:03:13 INFO - 'TMOUT': '86400', 20:03:13 INFO - 'USER': 'cltbld', 20:03:13 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584', 20:03:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:13 INFO - '_': '/tools/buildbot/bin/python'} 20:03:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:13 INFO - Downloading/unpacking jsonschema 20:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:03:15 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 20:03:15 INFO - Downloading/unpacking functools32 (from jsonschema) 20:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:15 INFO - Downloading functools32-3.2.3-2.tar.gz 20:03:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 20:03:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 20:03:15 INFO - warning: no files found matching '*.txt' 20:03:15 INFO - no previously-included directories found matching 'build' 20:03:15 INFO - no previously-included directories found matching 'dist' 20:03:15 INFO - no previously-included directories found matching '.git*' 20:03:15 INFO - Installing collected packages: jsonschema, functools32 20:03:15 INFO - Running setup.py install for functools32 20:03:15 INFO - warning: no files found matching '*.txt' 20:03:15 INFO - no previously-included directories found matching 'build' 20:03:15 INFO - no previously-included directories found matching 'dist' 20:03:15 INFO - no previously-included directories found matching '.git*' 20:03:15 INFO - Successfully installed jsonschema functools32 20:03:15 INFO - Cleaning up... 20:03:15 INFO - Return code: 0 20:03:15 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 20:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fa64d80df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1482630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1513840>, '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 0x14806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1480b60>, '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': '4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584', '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 20:03:15 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 20:03:15 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 20:03:15 INFO - Using env: {'DISPLAY': ':0', 20:03:15 INFO - 'HOME': '/home/cltbld', 20:03:15 INFO - 'LANG': 'en_US.UTF-8', 20:03:15 INFO - 'LANGUAGE': 'en_US:en', 20:03:15 INFO - 'LOGNAME': 'cltbld', 20:03:15 INFO - 'MAIL': '/var/mail/cltbld', 20:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:15 INFO - 'MOZ_NO_REMOTE': '1', 20:03:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:15 INFO - 'NO_EM_RESTART': '1', 20:03:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:15 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:15 INFO - 'SHELL': '/bin/bash', 20:03:15 INFO - 'SHLVL': '1', 20:03:15 INFO - 'TERM': 'linux', 20:03:15 INFO - 'TMOUT': '86400', 20:03:15 INFO - 'USER': 'cltbld', 20:03:15 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584', 20:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:15 INFO - '_': '/tools/buildbot/bin/python'} 20:03:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:15 INFO - Downloading/unpacking flake8 20:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:03:17 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 20:03:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:03:17 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 20:03:17 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 20:03:17 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 20:03:17 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 20:03:17 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 20:03:17 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 20:03:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:03:17 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 20:03:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:03:17 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 20:03:17 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 20:03:17 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 20:03:17 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 20:03:17 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 20:03:17 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 20:03:17 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 20:03:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:03:17 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 20:03:17 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 20:03:17 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 20:03:17 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 20:03:17 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 20:03:17 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 20:03:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 20:03:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 20:03:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:03:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:03:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:03:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:03:18 INFO - no previously-included directories found matching 'docs/_build' 20:03:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:03:18 INFO - Running setup.py install for pep8 20:03:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:03:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:03:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:03:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:03:18 INFO - no previously-included directories found matching 'docs/_build' 20:03:18 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 20:03:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:03:18 INFO - Cleaning up... 20:03:18 INFO - Return code: 0 20:03:18 INFO - Running post-action listener: _resource_record_post_action 20:03:18 INFO - Running post-action listener: _start_resource_monitoring 20:03:18 INFO - Starting resource monitoring. 20:03:18 INFO - ##### 20:03:18 INFO - ##### Running install step. 20:03:18 INFO - ##### 20:03:18 INFO - Running pre-action listener: _resource_record_pre_action 20:03:18 INFO - Running main action method: install 20:03:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:03:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:03:18 INFO - Reading from file tmpfile_stdout 20:03:18 INFO - Detecting whether we're running mozinstall >=1.0... 20:03:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 20:03:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 20:03:18 INFO - Reading from file tmpfile_stdout 20:03:18 INFO - Output received: 20:03:18 INFO - Usage: mozinstall [options] installer 20:03:18 INFO - Options: 20:03:18 INFO - -h, --help show this help message and exit 20:03:18 INFO - -d DEST, --destination=DEST 20:03:18 INFO - Directory to install application into. [default: 20:03:18 INFO - "/builds/slave/test-pgo"] 20:03:18 INFO - --app=APP Application being installed. [default: firefox] 20:03:18 INFO - mkdir: /builds/slave/test-pgo/build/application 20:03:18 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'] 20:03:18 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 20:03:34 INFO - Reading from file tmpfile_stdout 20:03:34 INFO - Output received: 20:03:34 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 20:03:34 INFO - Running post-action listener: _resource_record_post_action 20:03:34 INFO - ##### 20:03:34 INFO - ##### Running run-tests step. 20:03:34 INFO - ##### 20:03:34 INFO - Running pre-action listener: _resource_record_pre_action 20:03:34 INFO - Running main action method: run_tests 20:03:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 20:03:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 20:03:34 INFO - Python 2.7.3 20:03:34 INFO - Return code: 0 20:03:34 INFO - grabbing minidump binary from tooltool 20:03:34 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')]} 20:03:34 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 0x1513840>, '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 0x14806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1480b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 20:03:34 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 20:03:34 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 20:03:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:03:34 INFO - Return code: 0 20:03:34 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 20:03:34 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 20:03:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 20:03:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 20:03:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 20:03:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 20:03:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 20:03:35 INFO - Return code: 0 20:03:35 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/O3Y_be_WQ8eeUe0s725p1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 20:03:35 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/O3Y_be_WQ8eeUe0s725p1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 20:03:35 INFO - Using env: {'DISPLAY': ':0', 20:03:35 INFO - 'HOME': '/home/cltbld', 20:03:35 INFO - 'LANG': 'en_US.UTF-8', 20:03:35 INFO - 'LANGUAGE': 'en_US:en', 20:03:35 INFO - 'LOGNAME': 'cltbld', 20:03:35 INFO - 'MAIL': '/var/mail/cltbld', 20:03:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:03:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 20:03:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:35 INFO - 'MOZ_NO_REMOTE': '1', 20:03:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:03:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:35 INFO - 'NO_EM_RESTART': '1', 20:03:35 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:35 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:35 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 20:03:35 INFO - 'SHELL': '/bin/bash', 20:03:35 INFO - 'SHLVL': '1', 20:03:35 INFO - 'TERM': 'linux', 20:03:35 INFO - 'TMOUT': '86400', 20:03:35 INFO - 'USER': 'cltbld', 20:03:35 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584', 20:03:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:35 INFO - '_': '/tools/buildbot/bin/python'} 20:03:35 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/O3Y_be_WQ8eeUe0s725p1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 20:03:36 INFO - mozversion application_buildid: 20160111173003 20:03:36 INFO - mozversion application_changeset: 2300f7506a8c3c8a685dcbb1a430aad134b8ede8 20:03:36 INFO - mozversion application_display_name: Nightly 20:03:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:03:36 INFO - mozversion application_name: Firefox 20:03:36 INFO - mozversion application_remotingname: firefox 20:03:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 20:03:36 INFO - mozversion application_vendor: Mozilla 20:03:36 INFO - mozversion application_version: 46.0a1 20:03:36 INFO - mozversion platform_buildid: 20160111173003 20:03:36 INFO - mozversion platform_changeset: 2300f7506a8c3c8a685dcbb1a430aad134b8ede8 20:03:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 20:03:36 INFO - mozversion platform_version: 46.0a1 20:03:36 INFO - using testdate: 1452571416 20:03:36 INFO - actual date: 1452571416 20:03:36 INFO - starting webserver on 'localhost:34287' 20:03:36 INFO - SUITE-START | Running 3 tests 20:03:36 INFO - TEST-START | dromaeo_css 20:03:36 INFO - operating with platform_type : linux_ 20:03:36 INFO - Initialising browser for dromaeo_css test... 20:03:36 INFO - TEST-INFO | started process 27487 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpT7IIx0/profile http://localhost:34287/getInfo.html) 20:03:40 INFO - PROCESS | 27487 | __metrics Screen width/height:1600/1200 20:03:40 INFO - PROCESS | 27487 | colorDepth:24 20:03:40 INFO - PROCESS | 27487 | Browser inner width/height: 1024/697 20:03:40 INFO - PROCESS | 27487 | __metrics 20:03:40 INFO - PROCESS | 27487 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:03:40 INFO - PROCESS | 27487 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:03:41 INFO - TEST-INFO | 27487: exit 0 20:03:41 INFO - Browser initialized. 20:03:41 INFO - Running cycle 1/1 for dromaeo_css test... 20:03:41 INFO - TEST-INFO | started process 27582 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpT7IIx0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:03:53 INFO - PROCESS | 27582 | RSS: Main: 148963328 20:03:53 INFO - PROCESS | 27582 | 20:04:44 INFO - PROCESS | 27582 | 1452571484650 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] 20:06:53 INFO - PROCESS | 27582 | Cycle 1(1): loaded http://localhost:34287/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34287/tests/dromaeo/cssquery-ext.html) 20:06:54 INFO - PROCESS | 27582 | RSS: Main: 260886528 20:06:54 INFO - PROCESS | 27582 | 20:09:56 INFO - PROCESS | 27582 | Cycle 1(1): loaded http://localhost:34287/tests/dromaeo/cssquery-ext.html (next: http://localhost:34287/tests/dromaeo/cssquery-jquery.html) 20:09:57 INFO - PROCESS | 27582 | RSS: Main: 233779200 20:09:57 INFO - PROCESS | 27582 | 20:12:59 INFO - PROCESS | 27582 | Cycle 1(1): loaded http://localhost:34287/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34287/tests/dromaeo/cssquery-mootools.html) 20:12:59 INFO - PROCESS | 27582 | RSS: Main: 230326272 20:12:59 INFO - PROCESS | 27582 | 20:16:01 INFO - PROCESS | 27582 | Cycle 1(1): loaded http://localhost:34287/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34287/tests/dromaeo/cssquery-prototype.html) 20:16:02 INFO - PROCESS | 27582 | RSS: Main: 219234304 20:16:02 INFO - PROCESS | 27582 | 20:19:05 INFO - PROCESS | 27582 | Cycle 1(1): loaded http://localhost:34287/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34287/tests/dromaeo/cssquery-yui.html) 20:19:05 INFO - PROCESS | 27582 | RSS: Main: 219566080 20:19:05 INFO - PROCESS | 27582 | 20:22:08 INFO - PROCESS | 27582 | Cycle 1(1): loaded http://localhost:34287/tests/dromaeo/cssquery-yui.html (next: http://localhost:34287/tests/dromaeo/cssquery-dojo.html) 20:22:08 INFO - PROCESS | 27582 | RSS: Main: 266031104 20:22:08 INFO - PROCESS | 27582 | 20:22:08 INFO - PROCESS | 27582 | __start_tp_report 20:22:08 INFO - PROCESS | 27582 | _x_x_mozilla_page_load 20:22:08 INFO - PROCESS | 27582 | _x_x_mozilla_page_load_details 20:22:08 INFO - PROCESS | 27582 | |i|pagename|runs| 20:22:08 INFO - PROCESS | 27582 | |0;dojo.html;3113.953290700639;3178.07835727639;3219.871205151794;3224.6614105518906;3243.9943617478584;5062.26597143414;5117.130087885059;5134.178531434971;5135.178371460563;5160.587153027758;5066.594672426207;5137.614678899088;5156.381234251886;5189.117849965505;5195.454477279888;4477.776111194444;4677.579017888389;4680.976595117037;4711.458182309027;4785.880352991168;4786.880327991793;4806.519348065201;4818.10864989978;4863.513648635126;4878.829240976566;4611.5619016193405;4659.32439796231;4701.78841952113;4739.218029025206;4747.074320507502;4684.625229981593;4686.203345431285;4688.601468875149;4701.294805779126;4720.457147428056;4716.575508204244;4722.150012997659;4731.219348807443;4733.266343716729;4751.857444276678;4876.439209490883;4946.653734238605;4946.703197808143;4953.826616068456;4957.305977163164;5442.2380866678695;5456;5505.091659876116;5506.669599824023;5510.889782204334;5526.751296191641;5533.474319939599;5534.308211473566;5537.861553461155;5548.14003829403;5164.302819119408;5173.22401639757;5173.689578625294;5182.1579865437325;5182.352205974215;5379.946200537945;5587.357453892773;5591.804286849941;5635.098384258499;5657.57568182388;5429.294191755125;5437.972810136003;5443.863903402446;5447.509724124848;5481.260029895992;5452.809151679672;5516.062269414209;5517.806876759374;5521.668699878021;5581.441855814386;5279.41926388097;5429.267048948342;5449.918251226235;5503.587230957694;5526.861828454321;5496.532794712414;5500.42245564218;5502.8349149525575;5508.944910550923;5511.559075273968;4319.460067491564;4337.652987760972;4344.674149438804;4377.277749171351;4380.824767009284;3764.9811750941617;3826.9234615308096;3868.226354729009;3930.1353702185475;3935.980320098381;5155.252488389237;5157.613179011514;5180.119379705459;5182.222666600041;5233.842984710464;5429;5558.888822223533;5569.805056823073;5570.108782594765;5570.41510641385;5063.645544811828;5078.5175408336145;5156.5616922562;5193.740312984336;5259.973700131552;4779.163646361872;4780.4741478437345;4791.161546729309;4791.928121078186;4824.107540105022;5581.776728930798;5759.510441612426;5771.365149833515;5771.480566748929;5776.451237132465;5473.28847249855;5512.310961129859;5521.171824226398;5534.52956498686;5571.0807716726285;5749.13762935563;5773;5777.653340799566;5777.94222057774;5781.739821707949;5345.118055520796;5452;5489.478499542537;5504.91742623869;5505.917411238915;5446.046941785093;5551.611387203018;5562.16567514876;5579.972100139474;5626.971865140648;5409.810656626999;5426.728663566727;5448.83653490396;5456.672599643875;5456.672599644034;5288.81489147878;5376.919346209888;5427.782888684566;5427.891442171055;5486;5270.7101109439345;5316.7075810830775;5371.248025276543;5401.864953376197;5435.266239057677;5424.728763561727;5443.237946687388;5443.7278136092245;5444.727763611724;5500.889982200253;5174.249733788504;5291.126964050888;5348.839534813962;5353.036453438419;5358.758855851418 20:22:08 INFO - PROCESS | 27582 | |1;ext.html;534.5376249544145;542.059526721139;545.0488896874951;558.9944100558995;564.0523919814709;28088;28571.999999999975;28665.283367915814;35060.29879402411;35693.643063569354;37940.05149871254;38326.42510362347;38331.23337533248;38358.4246236306;38468.80765596168;8264.83470330593;8462.957685211566;8465.873011904827;8468.068512463624;8468.491890486559;7300.4524660650395;7454.739084132057;9757.365771224882;10000.099991000809;10007.349522281065;9833.623292739023;9844.753881152992;9927.354721943087;9928.305018648698;9942.65200717975;7324.48728588999;7499;9698.418094914328;9712.125908668184;9795.06946840049;7306.81732956675;9733.17268032218;9920.057594528509;9941.80116397668;9944.154746846527;35754;36140.81929590362;36229.27541449183;36267;36317;3335.216224187314;3372.9325413491592;3428.0447558546366;3772.4529943158363;3960.7821569813937;27237.863810681018;27510.724892751216;27671.86164069187;27704.72295277062;30689.69310306891;3928.508936382952;3937.7834219117935;3958.2083583283456;4076.1643863008308;4094.7747873866924;274757;275434;275435.6228218866;275458;275488;50239;56716.71641641765;57028;57052.71473642605;57127.42872571221;46082;62582;63652;63758.6812065946;63792;12803.423845926956;13010.154339967872;13018.349082545836;13071.673208169872;13081.41133648988;9821.312508124505;9850.261230407605;9937.900620993842;9953.203743700487;9967.601295948225;18425.539361515803;18602.44192674222;18602.627947440975;18627.813721862607;19331.903340483488;7142.785716428515;7196.784096477114;7255.274472552703;7314.451416143704;7377.704891804375;948.5148909856221;952.9047095290554;955.8040601676639;960.2510042167121;1031.7162780235494;27658.585121223197;27683;28300.575491367646;28604.14187574376;29162.562561561594;1026.296986564206;1040.287403128859;1046.5656752447649;1090.55287332195;1093.0217455377551;14671.633209169857;15035.248237588077;15168;15207.543773686808;15212.391504339703;328332;337441;338043;338602;338824;51020;51323.23015154776;51454.48545514572;51568.22647660288;51725.48274517282;1165.1377980294521;1242.5526810348267;1277.7891647877996;1286.3761075878192;1330.9933450332687;26382.604260936485;27426.5886011714;27552.724472755817;27564.724352757017;27706.307342316602;38705.6129438702;39177.6082239174;39296.2140757189;39915.40126898041;41869.37195942002;222020;311154;313125;313427;313598;29190.854045730484;29958;29965.850170749007;29966.85016574903;29972.400551989274;40627;41397.37903931383;41490.2658760713;41981.79009104935;42006.579934200265;35218.47172292366;35528.289434211685;35635.64364356427;35893.64106358903;36202;35143.824280878434;35658;35859;35934;35978.28043439169;33813.66186338105;34838.65161348354;34909;35164.47253291152;35189.47215791714;29510.852445737633;31415.21461963469;31834.522482162323;32235.677643224204;32241.51637725389;24861.751382485945;24929.875350623857;24930.37674058163;24958.251252462454;25263.87368063148 20:22:08 INFO - PROCESS | 27582 | |2;jquery.html;354.7233158136653;356.7698834251909;359.6529349178044;361.0504373497704;361.10806308418205;13412.26232557209;13787.379567919443;15998.680026399465;16541.586460338498;17746.733798993024;14373.634504722035;14934.701305973902;15494.5351639451;15498.070115793033;15515.922420387911;5083.898322033567;5264.894702105956;5268.604854635918;5269.446708095652;5271;4019.658329042035;4142.150859073882;5175.792968281283;5254;5666.744996475148;5685.602007859451;5789.363170051291;5836.445537673935;5837.124431335291;5839.357670656224;5644.153376993463;5742.511886489653;5765.827025189209;5765.971170144144;5771.336296325934;4905.583025442842;5034.496550344937;5057.367829021372;5057.822976195852;5062.2406639004075;17354.826451735575;17996.460106196835;18011.639767204582;19689.409317720492;19893.10481028357;2058.269314393384;2061.597988392264;2106.9129360883226;2134.4983928776724;2145.9356219313445;9604.951975240148;9646.131848133631;10200.591976321013;10806.243562950596;13050.804237936438;1806.1962426720115;1860.4139695995718;1878.5773201029795;1887.1224880430666;1895.668258054835;52772;54930.176047359324;55666;56061.43938560603;56918.43081569214;9507;9521.428714277166;9528.142467177848;9529.904700952902;9555.856662150074;12466.87533124657;12630.81053784194;12631.052671049709;12633.368331583384;12650.620481385573;6807.353301436356;6838.281980391987;6850.349216824394;6915.412189963909;6917.377436030681;6461.7738379157445;6480.092787009822;6500.187476565429;6544;6550.639714815636;4100.2414553307735;4105.4662893823615;4108.198901214235;4137.358709400048;4140.585941405896;1667.5164202381416;1726.240454200148;1727.8790484665953;1767.3549154558493;1796.9910150449164;425.79561810331217;877.4822854515738;951.357833462424;965.2567523007245;974.0648976982035;9525;9867.309288349747;9980.251481138943;10016;10095.394276343442;415.4246368779263;415.8960259935016;420.3316726405031;422.5352112676032;430.9224339618836;5299.178627312773;5653;5655.660660360391;5656.434356564393;5704.657720536781;356245;509490;528304;528787;541912;52045.7397713009;64483.677581611795;64916.67541662356;66469;67571.66214168996;471.82070813090803;490.5143907531518;490.7300984458605;491.1184423959002;494.51043466967445;9842.852357214791;10009.749756256151;11141.88858111441;13416.39626216842;13487.797683034958;32610.347793043533;32988.34023319472;33230.83384583062;33464.832675836464;34021;37125.071873203386;38079.80960095182;41672.37491437692;41912.580874192085;42888.35667464928;6890.793276201722;7282.4902256841515;7369.889451658122;7479.065116860393;7515.924840751742;3837.9040523987123;5142.1258386073705;9922.652707155215;10356.430396328275;10910.23628346008;3245.7403407727797;7035.417031168151;9306.953465232631;9481.620735170516;9638.903610964082;9344.252459803336;9392.95303523478;9692.224622030362;9828.11546960777;9910.405375677483;3305.818180000123;8282.308249818954;9455.870607028699;9587.664431744855;9673.854892176481;7146.964265178641;7161.176464706626;7272.854542909006;7279.199288078201;7331.926680733338;9075.410098343587;9479.28905332089;9488.098630630078;9624.566894489624;9917.65288214909 20:22:08 INFO - PROCESS | 27582 | |3;mootools.html;1353.6548180214045;1471.0732238689625;1492.507472534064;1650.9752353714696;1800.50486116318;6894.13823272091;7281.45389095818;7480.850382992344;7504.924950750491;7513.887291690616;7537.585432801194;7564.96217518913;7580.545167289966;7638.465307428482;7653.617319134035;2011.5474018345901;2057.77364489906;2282.8173746100315;2304.8617082975074;2309.734380546242;2274.8748818815043;2325.023490134148;2328.3247858121126;2328.3364241191266;2330.627099664054;2244.607193741089;2247.2471721973075;2320.6983092197993;2321.361625552978;2322.3033090072995;2275.6017696902977;2294.19703103914;2303.1248125712204;2304.596695578267;2305.953880922389;2296.368498662881;2303.884805759722;2307.1002309099463;2315.895784689693;2327.8719670418122;7863.56750378729;7921.603919804044;7928;7928.643211055516;7938.880916786253;4718.905621887578;4794.065157294329;4825.951740482586;4827.348307978413;4831.275308703687;3235.854386552611;3267.1668724475344;3322.401967645823;3369.4608862582113;3376.831158442068;1120.2550304047797;1200.2738343302265;1211.945462454183;1211.9818202726967;1230.846144231971;10596.152307815357;10611.930673518667;10619.36283822973;10624.468776561142;10635.52140153695;4334.631556317685;4369.47566292047;4426.380306757057;4427.845025424094;4436.3567282743825;9070.86393704095;9099.998000439893;9134.725958221265;9149.588268527932;9154.26765858743;4765.070811191785;4766.713997160182;4771.379720636295;4772.76136193189;4779.06808172403;4324.221640104748;4334.393184954109;4340.52254252032;4342.5006124296115;4345.869623911288;3464.5149679044953;3527.065327688165;3710.777353358807;3745.101175717808;3805.06775839921;1179.7581495793343;1218.1899037140379;1231.199720181871;1231.3043130631165;1242.8881400673984;1300.5318085489216;1313.8686131386976;1326.7014921642747;1359.238826257299;1383.4604504243152;7370.078740157481;7448.255174482509;7503.962480187564;7509.91106289585;7515.286047825448;1102.7408558988632;1105.2649987758211;1113.7215696075982;1114.3536748685742;1114.765899161169;5855;5923.644581325134;5926.67403292823;5934.7922822701;5940.70296485174;9009.954950225207;9145.0397708241;9246.815063698688;9282.535873206312;9488.95255523718;9102.544872756469;9188.448693078437;9206.907930920604;9237;9253.95373023144;7367.705291788268;7375.668094935741;7535.585542795089;7622.69509219625;7635;7513.474056816189;7527.172011078667;7604;7617.047869016373;7631.54210747357;8444.831103378021;8464.195901389357;8642.78393040179;8711.825763484821;8712.869306960527;8626.223639872442;8703.216710496086;8817.16236957488;8819;8829.205371516595;6917.13535808024;7100.147982242164;7103.218645949045;7109.182444019004;7111.2533184017;6725.361090696376;6862.828429289108;6976.407005404598;7218.530795498275;7222.74720384784;6654.546360172457;6763.966180169067;6862.210845752802;6872.003559483946;6890.586564806128;6632.303608121078;6684.799456016327;6717.1267735194115;6806.591604503746;6815.352541508549;6720.428763554957;6998.475114366544;7003.859922801617;7008.894866577108;7019.157701075904;6169.598976066542;6215.65813880241;6266.749330026748;6488.837779055561;6492.902606461002;6482.546221764431;6564.8358791030605;6574.506911981525;6584.572002819801;6591.967040164768 20:22:08 INFO - PROCESS | 27582 | |4;prototype.html;321.95331676906846;329.1376593325485;330.4019724299019;331.15390178094964;336.94103531881916;5685.317761868571;5839.591228613998;5846;5888.970555147223;5912.526997840173;5680.630759000673;5782.335031471382;5782.3639399666;5822.475977162065;5835.299764028323;4474.105178964204;4476.2390393632995;4522.6155776759015;4530.864074077783;4531.614812740921;4287.892802679927;4360.803763830635;4520.54794520547;4534;4538.773061346936;4404.757738324391;4426.269665505188;4453.888652783674;4473.575010374026;4480.327950807372;4438.622717069069;4444.866654000385;4447.688661793676;4448.466184057901;4448.888777780549;3922.882313530599;3930.489036425275;3932.351162058257;3932.4101384792225;3935.3900145477496;5422.728863556807;5498.120300751861;5504.422035686235;5535.501804837584;5564.4713752193475;5106.693598384109;5111.488851114896;5113.207452844815;5116.667416617908;5118.053160165344;6194.535409844235;6195.535334849859;6201.720922558496;6201.844953876144;6209.937900620981;4092.4679791627195;4153.231652144363;4191.622753952129;4230;4281.957180428187;6389.520785941027;6402.647854368008;6415;6444.226692796848;6452.9354706452805;4381.67137464685;4383.364412160219;4383.802728877208;4386.12277544486;4399.274119770202;4434.7560884151035;4434.977825110854;4435.312526558324;4438.267685831802;4439.067795762861;4956.677815941952;5104.846854594368;5114.309568208244;5121.436641969381;5135.743212839343;6226.128342032119;6236.719347629368;6237.438630523275;6240.063990401385;6242.781502647385;1546.9303881325368;1571.3714514194414;1571.6463795646116;1572.4653617770014;1576.6216108134195;1046.424466543398;1053.3627155570769;1057.8519007338978;1068.3429690740138;1080.6703955293553;5879.794207202727;5879.970600146972;5884.293884733774;5886.087656413263;5898.233229680114;6373.936260637427;6374.426301632875;6375.6174629522375;6380.3619638035825;6382.776602818972;5858.238429004202;5893.793717219876;5896.113243762041;5896.852578685567;5897.410258974069;3323.986184213838;3456.879009234715;3458.412069948115;3459.135216195951;3461.1866211440292;6641.070250164981;6656.633885136364;6666.2333831609985;6668.86662266752;6673.699683514254;6479.416852483299;6505.707243174069;6535.934640653532;6545.247296560957;6555.80332590023;6448.613083215022;6643.701033453506;6646.468282537386;6677.09859169006;6753.12209412783;6428.710708018057;6462.289148193789;6466.870662586816;6479.546431749733;6483.157189565326;6137.3248942617165;6199.628022318675;6234.376562343729;6397.168368112116;6398.264199616918;6704.396604305636;6716.5634233774645;6716.966415167893;6727.394534491919;6727.865442691216;4413.602775750198;4421.071574969293;4444.955550444583;4447.777611119366;4448.5551444855255;6267.185265915402;6427.357264273535;6443.6133831968355;6448.5486015980305;6451.838704032437;6265.467435268053;6285.088662143872;6292.339304373158;6296.779612713533;6297.874042519215;6257.124002639725;6258.968705156445;6261.154744109487;6273.71768270438;6274.968625156845;5966.612170208922;6150.938490615036;6153.538484613582;6163.8150855474405;6174.135621013152;6311.65285909261;6314.210723659543;6319.083732858801;6326.683665816783;6337.2395312562785;6165.815025549241;6169.2288463942;6176.073588961692;6182.258129024366;6184.938150618436 20:22:08 INFO - PROCESS | 27582 | |5;yui.html;759.3659294489103;778.5640041576718;819.1235378145383;833.2917020532552;850.4529478738675;12367.628971130858;12411.007119430447;12478.625641230778;12498.250104993707;12527.937360313197;11713.297202167876;12262.81605775914;12646.430910609022;12657.62027139185;12713.364331783398;790.1703211627796;800.65171650332;802.2298593350362;802.7591722483261;803.0363563723525;793.0285400384512;795.9084705258882;796.3828033274201;797.103258833812;797.4258533855643;822.0341099208406;822.411975437562;823.4441751817529;823.6993497373476;823.7858156879224;815.213319147023;817.7832874288289;818.2472125644392;819.9180081991813;819.9836003279961;602.6805792929754;606.3118360660637;607.3835057416726;608.1637748096367;608.6713174885557;12052.698682532919;12063.336516491589;12080.87919120815;12088.15382923187;12093.516259349615;11044.668659940215;11187.272827266203;11245.269057511236;11346.48940797666;11433.085353171726;9508.667196648154;9558.474283914382;9631.614735410576;9724.27067969898;9729.951350243275;3538.4692296155526;3598.082488965323;3604.9098772530633;3609.079684680416;3621.4748861414946;41302.58697413017;43177.56822431767;43517;45647.77176114132;50519.23182688588;10132.797344053077;10196.796064078826;10201.336913100624;10381.2214083944;10391.817718279246;18051.819481805276;18077.819221807877;18102.90948545249;18110.90944545269;18112.909435452737;6194.332176537501;6451.483881289486;7456.701731930771;7582.052243469567;8004.359651227888;4354.303311470149;4396.626286765661;4453.977730111329;4458.818413120525;4494.16857881293;2947.7641788656856;2980.344324248662;2984.686607906182;2986;2993.0721476342405;585.3064119018891;591.6006695480534;596.0671549025761;599.8800239952027;602.5932495565476;514.0797971630814;555.4140381897138;606.8755905039457;609.7621927448299;620.9844753881189;9188.540572971458;9662;9681.612735490502;9724.222062235005;9822.214222862154;549.7278846970775;649.5388274325187;656.3895577113235;659.3439527669999;679.5005670831935;3876.341022026262;3997.6601988831276;4115.36211887158;4143.6892233082635;4190.171619259475;53681.1947820783;59736.70131649314;60469.69765151146;61422.69288653528;61633.69183154056;43140.85730546897;46293.30560041602;46634.76682616565;46987;48919;41033.589664102976;42893.78553107277;44839.32741008822;44849.32726009112;45609;9063.864042039506;9096.090390960851;9170.908290917272;9213.76965575866;9443.480608566595;31402.685973139975;31423.685763142075;34047;34293;34736.30527389488;43575.56424435715;43973.56026439695;44085.77957110194;44241.11517769691;44688.77655611701;10876.619318323821;10962.232643714864;10984.835227471754;11170.441477925908;11218;11368.261063030877;11416.94291528537;12187.695307617027;12282.324472154118;12942.67643308887;11707.824382634437;11814.586489472827;11924.344161070878;12238.797016537108;12504.562340318045;11127.554897803997;11453.083753299883;11468.197226194086;11496.770064598493;11524.94237528807;11199.944000280273;11387.43062846871;11507.42462876836;11786.351750653454;11911.3448760319;9072.085281762827;9209.493477858514;9303.76740581491;9351.48566828831;9595.664151754934;9210.95394523023;9323.906760932305;9350.485723285285;9420;9425.764355891157 20:22:08 INFO - PROCESS | 27582 | __end_tp_report 20:22:08 INFO - PROCESS | 27582 | __start_cc_report 20:22:08 INFO - PROCESS | 27582 | _x_x_mozilla_cycle_collect,927 20:22:08 INFO - PROCESS | 27582 | __end_cc_report 20:22:08 INFO - PROCESS | 27582 | __startTimestamp1452572528367__endTimestamp 20:22:08 INFO - PROCESS | 27582 | 20:22:08 INFO - PROCESS | 27582 | ------- Summary: start ------- 20:22:08 INFO - PROCESS | 27582 | Number of tests: 6 20:22:08 INFO - PROCESS | 27582 | 20:22:08 INFO - PROCESS | 27582 | [#0] dojo.html Cycles:165 Average:5138.55 Median:5348.84 stddev:544.83 (10.2%) stddev-sans-first:522.84 20:22:08 INFO - PROCESS | 27582 | Values: 3114.0 3178.1 3219.9 3224.7 3244.0 5062.3 5117.1 5134.2 5135.2 5160.6 5066.6 5137.6 5156.4 5189.1 5195.5 4477.8 4677.6 4681.0 4711.5 4785.9 4786.9 4806.5 4818.1 4863.5 4878.8 4611.6 4659.3 4701.8 4739.2 4747.1 4684.6 4686.2 4688.6 4701.3 4720.5 4716.6 4722.2 4731.2 4733.3 4751.9 4876.4 4946.7 4946.7 4953.8 4957.3 5442.2 5456.0 5505.1 5506.7 5510.9 5526.8 5533.5 5534.3 5537.9 5548.1 5164.3 5173.2 5173.7 5182.2 5182.4 5379.9 5587.4 5591.8 5635.1 5657.6 5429.3 5438.0 5443.9 5447.5 5481.3 5452.8 5516.1 5517.8 5521.7 5581.4 5279.4 5429.3 5449.9 5503.6 5526.9 5496.5 5500.4 5502.8 5508.9 5511.6 4319.5 4337.7 4344.7 4377.3 4380.8 3765.0 3826.9 3868.2 3930.1 3936.0 5155.3 5157.6 5180.1 5182.2 5233.8 5429.0 5558.9 5569.8 5570.1 5570.4 5063.6 5078.5 5156.6 5193.7 5260.0 4779.2 4780.5 4791.2 4791.9 4824.1 5581.8 5759.5 5771.4 5771.5 5776.5 5473.3 5512.3 5521.2 5534.5 5571.1 5749.1 5773.0 5777.7 5777.9 5781.7 5345.1 5452.0 5489.5 5504.9 5505.9 5446.0 5551.6 5562.2 5580.0 5627.0 5409.8 5426.7 5448.8 5456.7 5456.7 5288.8 5376.9 5427.8 5427.9 5486.0 5270.7 5316.7 5371.2 5401.9 5435.3 5424.7 5443.2 5443.7 5444.7 5500.9 5174.2 5291.1 5348.8 5353.0 5358.8 20:22:08 INFO - PROCESS | 27582 | 20:22:08 INFO - PROCESS | 27582 | [#1] ext.html Cycles:180 Average:46031.93 Median:35723.82 stddev:79655.67 (223.0%) stddev-sans-first:79805.88 20:22:08 INFO - PROCESS | 27582 | Values: 534.5 542.1 545.0 559.0 564.1 28088.0 28572.0 28665.3 35060.3 35693.6 37940.1 38326.4 38331.2 38358.4 38468.8 8264.8 8463.0 8465.9 8468.1 8468.5 7300.5 7454.7 9757.4 10000.1 10007.3 9833.6 9844.8 9927.4 9928.3 9942.7 7324.5 7499.0 9698.4 9712.1 9795.1 7306.8 9733.2 9920.1 9941.8 9944.2 35754.0 36140.8 36229.3 36267.0 36317.0 3335.2 3372.9 3428.0 3772.5 3960.8 27237.9 27510.7 27671.9 27704.7 30689.7 3928.5 3937.8 3958.2 4076.2 4094.8 274757.0 275434.0 275435.6 275458.0 275488.0 50239.0 56716.7 57028.0 57052.7 57127.4 46082.0 62582.0 63652.0 63758.7 63792.0 12803.4 13010.2 13018.3 13071.7 13081.4 9821.3 9850.3 9937.9 9953.2 9967.6 18425.5 18602.4 18602.6 18627.8 19331.9 7142.8 7196.8 7255.3 7314.5 7377.7 948.5 952.9 955.8 960.3 1031.7 27658.6 27683.0 28300.6 28604.1 29162.6 1026.3 1040.3 1046.6 1090.6 1093.0 14671.6 15035.2 15168.0 15207.5 15212.4 328332.0 337441.0 338043.0 338602.0 338824.0 51020.0 51323.2 51454.5 51568.2 51725.5 1165.1 1242.6 1277.8 1286.4 1331.0 26382.6 27426.6 27552.7 27564.7 27706.3 38705.6 39177.6 39296.2 39915.4 41869.4 222020.0 311154.0 313125.0 313427.0 313598.0 29190.9 29958.0 29965.9 29966.9 29972.4 40627.0 41397.4 41490.3 41981.8 42006.6 35218.5 35528.3 35635.6 35893.6 36202.0 35143.8 35658.0 35859.0 35934.0 35978.3 33813.7 34838.7 34909.0 35164.5 35189.5 29510.9 31415.2 31834.5 32235.7 32241.5 24861.8 24929.9 24930.4 24958.3 25263.9 20:22:08 INFO - PROCESS | 27582 | 20:22:08 INFO - PROCESS | 27582 | [#2] jquery.html Cycles:180 Average:25097.32 Median:5158.96 stddev:81384.77 (1577.5%) stddev-sans-first:81591.87 20:22:08 INFO - PROCESS | 27582 | Values: 354.7 356.8 359.7 361.1 361.1 13412.3 13787.4 15998.7 16541.6 17746.7 14373.6 14934.7 15494.5 15498.1 15515.9 5083.9 5264.9 5268.6 5269.4 5271.0 4019.7 4142.2 5175.8 5254.0 5666.7 5685.6 5789.4 5836.4 5837.1 5839.4 5644.2 5742.5 5765.8 5766.0 5771.3 4905.6 5034.5 5057.4 5057.8 5062.2 17354.8 17996.5 18011.6 19689.4 19893.1 2058.3 2061.6 2106.9 2134.5 2145.9 9605.0 9646.1 10200.6 10806.2 13050.8 1806.2 1860.4 1878.6 1887.1 1895.7 52772.0 54930.2 55666.0 56061.4 56918.4 9507.0 9521.4 9528.1 9529.9 9555.9 12466.9 12630.8 12631.1 12633.4 12650.6 6807.4 6838.3 6850.3 6915.4 6917.4 6461.8 6480.1 6500.2 6544.0 6550.6 4100.2 4105.5 4108.2 4137.4 4140.6 1667.5 1726.2 1727.9 1767.4 1797.0 425.8 877.5 951.4 965.3 974.1 9525.0 9867.3 9980.3 10016.0 10095.4 415.4 415.9 420.3 422.5 430.9 5299.2 5653.0 5655.7 5656.4 5704.7 356245.0 509490.0 528304.0 528787.0 541912.0 52045.7 64483.7 64916.7 66469.0 67571.7 471.8 490.5 490.7 491.1 494.5 9842.9 10009.7 11141.9 13416.4 13487.8 32610.3 32988.3 33230.8 33464.8 34021.0 37125.1 38079.8 41672.4 41912.6 42888.4 6890.8 7282.5 7369.9 7479.1 7515.9 3837.9 5142.1 9922.7 10356.4 10910.2 3245.7 7035.4 9307.0 9481.6 9638.9 9344.3 9393.0 9692.2 9828.1 9910.4 3305.8 8282.3 9455.9 9587.7 9673.9 7147.0 7161.2 7272.9 7279.2 7331.9 9075.4 9479.3 9488.1 9624.6 9917.7 20:22:08 INFO - PROCESS | 27582 | 20:22:08 INFO - PROCESS | 27582 | [#3] mootools.html Cycles:180 Average:5482.97 Median:6192.63 stddev:2785.91 (45.0%) stddev-sans-first:2776.43 20:22:08 INFO - PROCESS | 27582 | Values: 1353.7 1471.1 1492.5 1651.0 1800.5 6894.1 7281.5 7480.9 7504.9 7513.9 7537.6 7565.0 7580.5 7638.5 7653.6 2011.5 2057.8 2282.8 2304.9 2309.7 2274.9 2325.0 2328.3 2328.3 2330.6 2244.6 2247.2 2320.7 2321.4 2322.3 2275.6 2294.2 2303.1 2304.6 2306.0 2296.4 2303.9 2307.1 2315.9 2327.9 7863.6 7921.6 7928.0 7928.6 7938.9 4718.9 4794.1 4826.0 4827.3 4831.3 3235.9 3267.2 3322.4 3369.5 3376.8 1120.3 1200.3 1211.9 1212.0 1230.8 10596.2 10611.9 10619.4 10624.5 10635.5 4334.6 4369.5 4426.4 4427.8 4436.4 9070.9 9100.0 9134.7 9149.6 9154.3 4765.1 4766.7 4771.4 4772.8 4779.1 4324.2 4334.4 4340.5 4342.5 4345.9 3464.5 3527.1 3710.8 3745.1 3805.1 1179.8 1218.2 1231.2 1231.3 1242.9 1300.5 1313.9 1326.7 1359.2 1383.5 7370.1 7448.3 7504.0 7509.9 7515.3 1102.7 1105.3 1113.7 1114.4 1114.8 5855.0 5923.6 5926.7 5934.8 5940.7 9010.0 9145.0 9246.8 9282.5 9489.0 9102.5 9188.4 9206.9 9237.0 9254.0 7367.7 7375.7 7535.6 7622.7 7635.0 7513.5 7527.2 7604.0 7617.0 7631.5 8444.8 8464.2 8642.8 8711.8 8712.9 8626.2 8703.2 8817.2 8819.0 8829.2 6917.1 7100.1 7103.2 7109.2 7111.3 6725.4 6862.8 6976.4 7218.5 7222.7 6654.5 6764.0 6862.2 6872.0 6890.6 6632.3 6684.8 6717.1 6806.6 6815.4 6720.4 6998.5 7003.9 7008.9 7019.2 6169.6 6215.7 6266.7 6488.8 6492.9 6482.5 6564.8 6574.5 6584.6 6592.0 20:22:08 INFO - PROCESS | 27582 | 20:22:08 INFO - PROCESS | 27582 | [#4] prototype.html Cycles:180 Average:5189.00 Median:5882.13 stddev:1571.93 (26.7%) stddev-sans-first:1533.30 20:22:08 INFO - PROCESS | 27582 | Values: 322.0 329.1 330.4 331.2 336.9 5685.3 5839.6 5846.0 5889.0 5912.5 5680.6 5782.3 5782.4 5822.5 5835.3 4474.1 4476.2 4522.6 4530.9 4531.6 4287.9 4360.8 4520.5 4534.0 4538.8 4404.8 4426.3 4453.9 4473.6 4480.3 4438.6 4444.9 4447.7 4448.5 4448.9 3922.9 3930.5 3932.4 3932.4 3935.4 5422.7 5498.1 5504.4 5535.5 5564.5 5106.7 5111.5 5113.2 5116.7 5118.1 6194.5 6195.5 6201.7 6201.8 6209.9 4092.5 4153.2 4191.6 4230.0 4282.0 6389.5 6402.6 6415.0 6444.2 6452.9 4381.7 4383.4 4383.8 4386.1 4399.3 4434.8 4435.0 4435.3 4438.3 4439.1 4956.7 5104.8 5114.3 5121.4 5135.7 6226.1 6236.7 6237.4 6240.1 6242.8 1546.9 1571.4 1571.6 1572.5 1576.6 1046.4 1053.4 1057.9 1068.3 1080.7 5879.8 5880.0 5884.3 5886.1 5898.2 6373.9 6374.4 6375.6 6380.4 6382.8 5858.2 5893.8 5896.1 5896.9 5897.4 3324.0 3456.9 3458.4 3459.1 3461.2 6641.1 6656.6 6666.2 6668.9 6673.7 6479.4 6505.7 6535.9 6545.2 6555.8 6448.6 6643.7 6646.5 6677.1 6753.1 6428.7 6462.3 6466.9 6479.5 6483.2 6137.3 6199.6 6234.4 6397.2 6398.3 6704.4 6716.6 6717.0 6727.4 6727.9 4413.6 4421.1 4445.0 4447.8 4448.6 6267.2 6427.4 6443.6 6448.5 6451.8 6265.5 6285.1 6292.3 6296.8 6297.9 6257.1 6259.0 6261.2 6273.7 6275.0 5966.6 6150.9 6153.5 6163.8 6174.1 6311.7 6314.2 6319.1 6326.7 6337.2 6165.8 6169.2 6176.1 6182.3 6184.9 20:22:08 INFO - PROCESS | 27582 | 20:22:08 INFO - PROCESS | 27582 | [#5] yui.html Cycles:180 Average:13393.14 Median:44844.33 stddev:15387.62 (34.3%) stddev-sans-first:15401.53 20:22:08 INFO - PROCESS | 27582 | Values: 759.4 778.6 819.1 833.3 850.5 12367.6 12411.0 12478.6 12498.3 12527.9 11713.3 12262.8 12646.4 12657.6 12713.4 790.2 800.7 802.2 802.8 803.0 793.0 795.9 796.4 797.1 797.4 822.0 822.4 823.4 823.7 823.8 815.2 817.8 818.2 819.9 820.0 602.7 606.3 607.4 608.2 608.7 12052.7 12063.3 12080.9 12088.2 12093.5 11044.7 11187.3 11245.3 11346.5 11433.1 9508.7 9558.5 9631.6 9724.3 9730.0 3538.5 3598.1 3604.9 3609.1 3621.5 41302.6 43177.6 43517.0 45647.8 50519.2 10132.8 10196.8 10201.3 10381.2 10391.8 18051.8 18077.8 18102.9 18110.9 18112.9 6194.3 6451.5 7456.7 7582.1 8004.4 4354.3 4396.6 4454.0 4458.8 4494.2 2947.8 2980.3 2984.7 2986.0 2993.1 585.3 591.6 596.1 599.9 602.6 514.1 555.4 606.9 609.8 621.0 9188.5 9662.0 9681.6 9724.2 9822.2 549.7 649.5 656.4 659.3 679.5 3876.3 3997.7 4115.4 4143.7 4190.2 53681.2 59736.7 60469.7 61422.7 61633.7 43140.9 46293.3 46634.8 46987.0 48919.0 41033.6 42893.8 44839.3 44849.3 45609.0 9063.9 9096.1 9170.9 9213.8 9443.5 31402.7 31423.7 34047.0 34293.0 34736.3 43575.6 43973.6 44085.8 44241.1 44688.8 10876.6 10962.2 10984.8 11170.4 11218.0 11368.3 11416.9 12187.7 12282.3 12942.7 11707.8 11814.6 11924.3 12238.8 12504.6 11127.6 11453.1 11468.2 11496.8 11524.9 11199.9 11387.4 11507.4 11786.4 11911.3 9072.1 9209.5 9303.8 9351.5 9595.7 9211.0 9323.9 9350.5 9420.0 9425.8 20:22:08 INFO - PROCESS | 27582 | -------- Summary: end -------- 20:22:08 INFO - PROCESS | 27582 | 20:22:09 INFO - TEST-INFO | 27582: exit 0 20:22:09 INFO - TEST-OK | dromaeo_css | took 1112959ms 20:22:09 INFO - TEST-START | kraken 20:22:09 INFO - operating with platform_type : linux_ 20:22:09 INFO - Initialising browser for kraken test... 20:22:09 INFO - TEST-INFO | started process 27778 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMilMvP/profile http://localhost:34287/getInfo.html) 20:22:12 INFO - PROCESS | 27778 | __metrics Screen width/height:1600/1200 20:22:12 INFO - PROCESS | 27778 | colorDepth:24 20:22:12 INFO - PROCESS | 27778 | Browser inner width/height: 1024/697 20:22:12 INFO - PROCESS | 27778 | __metrics 20:22:12 INFO - PROCESS | 27778 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:22:12 INFO - PROCESS | 27778 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:22:13 INFO - TEST-INFO | 27778: exit 0 20:22:13 INFO - Browser initialized. 20:22:13 INFO - Running cycle 1/1 for kraken test... 20:22:13 INFO - TEST-INFO | started process 27858 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMilMvP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:22:25 INFO - PROCESS | 27858 | RSS: Main: 149024768 20:22:25 INFO - PROCESS | 27858 | 20:22:28 INFO - PROCESS | 27858 | Cycle 1(1): loaded http://localhost:34287/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34287/tests/kraken/driver.html?testName=audio-beat-detection) 20:22:28 INFO - PROCESS | 27858 | RSS: Main: 185659392 20:22:28 INFO - PROCESS | 27858 | 20:22:31 INFO - PROCESS | 27858 | Cycle 1(1): loaded http://localhost:34287/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34287/tests/kraken/driver.html?testName=audio-dft) 20:22:31 INFO - PROCESS | 27858 | RSS: Main: 177115136 20:22:31 INFO - PROCESS | 27858 | 20:22:34 INFO - PROCESS | 27858 | Cycle 1(1): loaded http://localhost:34287/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34287/tests/kraken/driver.html?testName=audio-fft) 20:22:35 INFO - PROCESS | 27858 | RSS: Main: 159666176 20:22:35 INFO - PROCESS | 27858 | 20:22:37 INFO - PROCESS | 27858 | Cycle 1(1): loaded http://localhost:34287/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34287/tests/kraken/driver.html?testName=audio-oscillator) 20:22:37 INFO - PROCESS | 27858 | RSS: Main: 163205120 20:22:37 INFO - PROCESS | 27858 | 20:22:40 INFO - PROCESS | 27858 | Cycle 1(1): loaded http://localhost:34287/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34287/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:22:40 INFO - PROCESS | 27858 | RSS: Main: 164909056 20:22:40 INFO - PROCESS | 27858 | 20:22:43 INFO - PROCESS | 27858 | Cycle 1(1): loaded http://localhost:34287/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34287/tests/kraken/driver.html?testName=imaging-darkroom) 20:22:44 INFO - PROCESS | 27858 | RSS: Main: 163987456 20:22:44 INFO - PROCESS | 27858 | 20:22:47 INFO - PROCESS | 27858 | Cycle 1(1): loaded http://localhost:34287/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34287/tests/kraken/driver.html?testName=imaging-desaturate) 20:22:48 INFO - PROCESS | 27858 | RSS: Main: 165007360 20:22:48 INFO - PROCESS | 27858 | 20:22:50 INFO - PROCESS | 27858 | Cycle 1(1): loaded http://localhost:34287/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34287/tests/kraken/driver.html?testName=json-parse-financial) 20:22:51 INFO - PROCESS | 27858 | RSS: Main: 165924864 20:22:51 INFO - PROCESS | 27858 | 20:22:52 INFO - PROCESS | 27858 | Cycle 1(1): loaded http://localhost:34287/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34287/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:22:53 INFO - PROCESS | 27858 | RSS: Main: 175927296 20:22:53 INFO - PROCESS | 27858 | 20:22:55 INFO - PROCESS | 27858 | Cycle 1(1): loaded http://localhost:34287/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34287/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:22:55 INFO - PROCESS | 27858 | RSS: Main: 172875776 20:22:55 INFO - PROCESS | 27858 | 20:22:57 INFO - PROCESS | 27858 | Cycle 1(1): loaded http://localhost:34287/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34287/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:22:58 INFO - PROCESS | 27858 | RSS: Main: 180236288 20:22:58 INFO - PROCESS | 27858 | 20:23:00 INFO - PROCESS | 27858 | Cycle 1(1): loaded http://localhost:34287/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34287/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:23:01 INFO - PROCESS | 27858 | RSS: Main: 189050880 20:23:01 INFO - PROCESS | 27858 | 20:23:04 INFO - PROCESS | 27858 | Cycle 1(1): loaded http://localhost:34287/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34287/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:23:04 INFO - PROCESS | 27858 | RSS: Main: 189718528 20:23:04 INFO - PROCESS | 27858 | 20:23:06 INFO - PROCESS | 27858 | Cycle 1(1): loaded http://localhost:34287/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34287/tests/kraken/driver.html?testName=ai-astar) 20:23:06 INFO - PROCESS | 27858 | RSS: Main: 247095296 20:23:06 INFO - PROCESS | 27858 | 20:23:06 INFO - PROCESS | 27858 | __start_tp_report 20:23:06 INFO - PROCESS | 27858 | _x_x_mozilla_page_load 20:23:06 INFO - PROCESS | 27858 | _x_x_mozilla_page_load_details 20:23:06 INFO - PROCESS | 27858 | |i|pagename|runs| 20:23:06 INFO - PROCESS | 27858 | |0;ai-astar;111;109;104;109;110;110;101;110;111;111 20:23:06 INFO - PROCESS | 27858 | |1;audio-beat-detection;161;122;151;165;124;147;158;126;170;122 20:23:06 INFO - PROCESS | 27858 | |2;audio-dft;160;162;160;160;161;164;160;165;159;162 20:23:06 INFO - PROCESS | 27858 | |3;audio-fft;71;72;87;92;71;71;72;125;91;71 20:23:06 INFO - PROCESS | 27858 | |4;audio-oscillator;96;97;146;96;97;96;145;96;96;148 20:23:06 INFO - PROCESS | 27858 | |5;imaging-gaussian-blur;109;108;109;109;108;109;109;109;109;109 20:23:06 INFO - PROCESS | 27858 | |6;imaging-darkroom;145;145;145;146;145;145;146;146;145;146 20:23:06 INFO - PROCESS | 27858 | |7;imaging-desaturate;95;96;95;96;96;95;95;95;96;95 20:23:06 INFO - PROCESS | 27858 | |8;json-parse-financial;56;53;56;54;54;54;55;63;52;53 20:23:06 INFO - PROCESS | 27858 | |9;json-stringify-tinderbox;68;68;68;68;69;68;69;68;68;67 20:23:06 INFO - PROCESS | 27858 | |10;stanford-crypto-aes;83;85;85;85;85;84;85;85;86;85 20:23:06 INFO - PROCESS | 27858 | |11;stanford-crypto-ccm;115;115;118;121;116;123;123;116;116;120 20:23:06 INFO - PROCESS | 27858 | |12;stanford-crypto-pbkdf2;139;148;152;147;149;138;147;142;147;138 20:23:06 INFO - PROCESS | 27858 | |13;stanford-crypto-sha256-iterative;67;71;67;67;68;68;70;68;67;69 20:23:06 INFO - PROCESS | 27858 | __end_tp_report 20:23:06 INFO - PROCESS | 27858 | __start_cc_report 20:23:06 INFO - PROCESS | 27858 | _x_x_mozilla_cycle_collect,934 20:23:06 INFO - PROCESS | 27858 | __end_cc_report 20:23:06 INFO - PROCESS | 27858 | __startTimestamp1452572586580__endTimestamp 20:23:06 INFO - PROCESS | 27858 | 20:23:06 INFO - PROCESS | 27858 | ------- Summary: start ------- 20:23:06 INFO - PROCESS | 27858 | Number of tests: 14 20:23:06 INFO - PROCESS | 27858 | 20:23:06 INFO - PROCESS | 27858 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:3.37 (3.1%) stddev-sans-first:3.46 20:23:06 INFO - PROCESS | 27858 | Values: 111.0 109.0 104.0 109.0 110.0 110.0 101.0 110.0 111.0 111.0 20:23:06 INFO - PROCESS | 27858 | 20:23:06 INFO - PROCESS | 27858 | [#1] audio-beat-detection Cycles:10 Average:144.60 Median:154.50 stddev:19.29 (12.5%) stddev-sans-first:19.52 20:23:06 INFO - PROCESS | 27858 | Values: 161.0 122.0 151.0 165.0 124.0 147.0 158.0 126.0 170.0 122.0 20:23:06 INFO - PROCESS | 27858 | 20:23:06 INFO - PROCESS | 27858 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.95 (1.2%) stddev-sans-first:2.01 20:23:06 INFO - PROCESS | 27858 | Values: 160.0 162.0 160.0 160.0 161.0 164.0 160.0 165.0 159.0 162.0 20:23:06 INFO - PROCESS | 27858 | 20:23:06 INFO - PROCESS | 27858 | [#3] audio-fft Cycles:10 Average:82.30 Median:72.00 stddev:17.44 (24.2%) stddev-sans-first:18.01 20:23:06 INFO - PROCESS | 27858 | Values: 71.0 72.0 87.0 92.0 71.0 71.0 72.0 125.0 91.0 71.0 20:23:06 INFO - PROCESS | 27858 | 20:23:06 INFO - PROCESS | 27858 | [#4] audio-oscillator Cycles:10 Average:111.30 Median:96.00 stddev:24.19 (25.2%) stddev-sans-first:25.01 20:23:06 INFO - PROCESS | 27858 | Values: 96.0 97.0 146.0 96.0 97.0 96.0 145.0 96.0 96.0 148.0 20:23:06 INFO - PROCESS | 27858 | 20:23:06 INFO - PROCESS | 27858 | [#5] imaging-gaussian-blur Cycles:10 Average:108.80 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:23:06 INFO - PROCESS | 27858 | Values: 109.0 108.0 109.0 109.0 108.0 109.0 109.0 109.0 109.0 109.0 20:23:06 INFO - PROCESS | 27858 | 20:23:06 INFO - PROCESS | 27858 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:23:06 INFO - PROCESS | 27858 | Values: 145.0 145.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 146.0 20:23:06 INFO - PROCESS | 27858 | 20:23:06 INFO - PROCESS | 27858 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 20:23:06 INFO - PROCESS | 27858 | Values: 95.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 20:23:06 INFO - PROCESS | 27858 | 20:23:06 INFO - PROCESS | 27858 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:54.50 stddev:3.09 (5.7%) stddev-sans-first:3.26 20:23:06 INFO - PROCESS | 27858 | Values: 56.0 53.0 56.0 54.0 54.0 54.0 55.0 63.0 52.0 53.0 20:23:06 INFO - PROCESS | 27858 | 20:23:06 INFO - PROCESS | 27858 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 20:23:06 INFO - PROCESS | 27858 | Values: 68.0 68.0 68.0 68.0 69.0 68.0 69.0 68.0 68.0 67.0 20:23:06 INFO - PROCESS | 27858 | 20:23:06 INFO - PROCESS | 27858 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.00 stddev:0.79 (0.9%) stddev-sans-first:0.50 20:23:06 INFO - PROCESS | 27858 | Values: 83.0 85.0 85.0 85.0 85.0 84.0 85.0 85.0 86.0 85.0 20:23:06 INFO - PROCESS | 27858 | 20:23:06 INFO - PROCESS | 27858 | [#11] stanford-crypto-ccm Cycles:10 Average:118.30 Median:119.00 stddev:3.20 (2.7%) stddev-sans-first:3.16 20:23:06 INFO - PROCESS | 27858 | Values: 115.0 115.0 118.0 121.0 116.0 123.0 123.0 116.0 116.0 120.0 20:23:06 INFO - PROCESS | 27858 | 20:23:06 INFO - PROCESS | 27858 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.70 Median:147.00 stddev:5.03 (3.4%) stddev-sans-first:4.90 20:23:06 INFO - PROCESS | 27858 | Values: 139.0 148.0 152.0 147.0 149.0 138.0 147.0 142.0 147.0 138.0 20:23:06 INFO - PROCESS | 27858 | 20:23:06 INFO - PROCESS | 27858 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.40 (2.1%) stddev-sans-first:1.41 20:23:06 INFO - PROCESS | 27858 | Values: 67.0 71.0 67.0 67.0 68.0 68.0 70.0 68.0 67.0 69.0 20:23:06 INFO - PROCESS | 27858 | -------- Summary: end -------- 20:23:06 INFO - PROCESS | 27858 | 20:23:07 INFO - TEST-INFO | 27858: exit 0 20:23:07 INFO - TEST-OK | kraken | took 58339ms 20:23:07 INFO - TEST-START | v8_7 20:23:07 INFO - operating with platform_type : linux_ 20:23:07 INFO - Initialising browser for v8_7 test... 20:23:07 INFO - TEST-INFO | started process 28109 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdtKtxX/profile http://localhost:34287/getInfo.html) 20:23:11 INFO - PROCESS | 28109 | __metrics Screen width/height:1600/1200 20:23:11 INFO - PROCESS | 28109 | colorDepth:24 20:23:11 INFO - PROCESS | 28109 | Browser inner width/height: 1024/697 20:23:11 INFO - PROCESS | 28109 | __metrics 20:23:11 INFO - PROCESS | 28109 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:23:11 INFO - PROCESS | 28109 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:23:11 INFO - PROCESS | 28109 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 20:23:12 INFO - TEST-INFO | 28109: exit 0 20:23:12 INFO - Browser initialized. 20:23:12 INFO - Running cycle 1/1 for v8_7 test... 20:23:12 INFO - TEST-INFO | started process 28194 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdtKtxX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:23:24 INFO - PROCESS | 28194 | RSS: Main: 147779584 20:23:24 INFO - PROCESS | 28194 | 20:23:46 INFO - PROCESS | 28194 | Cycle 1(1): loaded http://localhost:34287/tests/v8_7/run.html (next: http://localhost:34287/tests/v8_7/run.html) 20:23:46 INFO - PROCESS | 28194 | RSS: Main: 508997632 20:23:46 INFO - PROCESS | 28194 | 20:23:46 INFO - PROCESS | 28194 | __start_tp_report 20:23:46 INFO - PROCESS | 28194 | _x_x_mozilla_page_load 20:23:46 INFO - PROCESS | 28194 | _x_x_mozilla_page_load_details 20:23:46 INFO - PROCESS | 28194 | |i|pagename|runs| 20:23:46 INFO - PROCESS | 28194 | |0;Richards;166.5001665001665 20:23:46 INFO - PROCESS | 28194 | |1;DeltaBlue;189.465706707086 20:23:46 INFO - PROCESS | 28194 | |2;Encrypt;279.87685418415896 20:23:46 INFO - PROCESS | 28194 | |3;Decrypt;5175.257731958763 20:23:46 INFO - PROCESS | 28194 | |4;RayTrace;1994.0239043824702 20:23:46 INFO - PROCESS | 28194 | |5;Earley;801.924619085806 20:23:46 INFO - PROCESS | 28194 | |6;Boyer;12048.192771084337 20:23:46 INFO - PROCESS | 28194 | |7;RegExp;42638.29787234042 20:23:46 INFO - PROCESS | 28194 | |8;Splay;600.9615384615385 20:23:46 INFO - PROCESS | 28194 | |9;NavierStokes;4840.579710144928 20:23:46 INFO - PROCESS | 28194 | __end_tp_report 20:23:46 INFO - PROCESS | 28194 | __startTimestamp1452572626617__endTimestamp 20:23:46 INFO - PROCESS | 28194 | 20:23:46 INFO - PROCESS | 28194 | ------- Summary: start ------- 20:23:46 INFO - PROCESS | 28194 | Number of tests: 10 20:23:46 INFO - PROCESS | 28194 | 20:23:46 INFO - PROCESS | 28194 | [#0] Richards Cycles:1 Average:166.50 Median:166.50 stddev:0.00 (0.0%) 20:23:46 INFO - PROCESS | 28194 | Values: 166.5 20:23:46 INFO - PROCESS | 28194 | 20:23:46 INFO - PROCESS | 28194 | [#1] DeltaBlue Cycles:1 Average:189.47 Median:189.47 stddev:0.00 (0.0%) 20:23:46 INFO - PROCESS | 28194 | Values: 189.5 20:23:46 INFO - PROCESS | 28194 | 20:23:46 INFO - PROCESS | 28194 | [#2] Encrypt Cycles:1 Average:279.88 Median:279.88 stddev:0.00 (0.0%) 20:23:46 INFO - PROCESS | 28194 | Values: 279.9 20:23:46 INFO - PROCESS | 28194 | 20:23:46 INFO - PROCESS | 28194 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 20:23:46 INFO - PROCESS | 28194 | Values: 5175.3 20:23:46 INFO - PROCESS | 28194 | 20:23:46 INFO - PROCESS | 28194 | [#4] RayTrace Cycles:1 Average:1994.02 Median:1994.02 stddev:0.00 (0.0%) 20:23:46 INFO - PROCESS | 28194 | Values: 1994.0 20:23:46 INFO - PROCESS | 28194 | 20:23:46 INFO - PROCESS | 28194 | [#5] Earley Cycles:1 Average:801.92 Median:801.92 stddev:0.00 (0.0%) 20:23:46 INFO - PROCESS | 28194 | Values: 801.9 20:23:46 INFO - PROCESS | 28194 | 20:23:46 INFO - PROCESS | 28194 | [#6] Boyer Cycles:1 Average:12048.19 Median:12048.19 stddev:0.00 (0.0%) 20:23:46 INFO - PROCESS | 28194 | Values: 12048.2 20:23:46 INFO - PROCESS | 28194 | 20:23:46 INFO - PROCESS | 28194 | [#7] RegExp Cycles:1 Average:42638.30 Median:42638.30 stddev:0.00 (0.0%) 20:23:46 INFO - PROCESS | 28194 | Values: 42638.3 20:23:46 INFO - PROCESS | 28194 | 20:23:46 INFO - PROCESS | 28194 | [#8] Splay Cycles:1 Average:600.96 Median:600.96 stddev:0.00 (0.0%) 20:23:46 INFO - PROCESS | 28194 | Values: 601.0 20:23:46 INFO - PROCESS | 28194 | 20:23:46 INFO - PROCESS | 28194 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 20:23:46 INFO - PROCESS | 28194 | Values: 4840.6 20:23:46 INFO - PROCESS | 28194 | -------- Summary: end -------- 20:23:46 INFO - PROCESS | 28194 | 20:23:47 INFO - TEST-INFO | 28194: exit 0 20:23:47 INFO - TEST-OK | v8_7 | took 39898ms 20:23:47 INFO - SUITE-END | took 1211s 20:23:47 INFO - Completed test suite (00:20:11) 20:23:47 INFO - Working with test: dromaeo_css 20:23:47 INFO - Generating results file: dromaeo_css 20:23:47 INFO - Working with test: kraken 20:23:47 INFO - Generating results file: kraken 20:23:47 INFO - javascript benchmark 20:23:47 INFO - Working with test: v8_7 20:23:47 INFO - Generating results file: v8_7 20:23:47 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:23:47 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 20:23:47 INFO - process_Request line: dromaeo_css 6649.51 graph.html#tests=[[72,201,35]] 20:23:47 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:23:47 INFO - process_Request line: kraken 1496.80 graph.html#tests=[[232,201,35]] 20:23:47 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:23:47 INFO - process_Request line: v8_7 18889.69 graph.html#tests=[[230,201,35]] 20:23:47 INFO - RETURN: dromaeo_css: 6649.51 20:23:47 INFO - RETURN: kraken: 1496.80 20:23:47 INFO - RETURN: v8_7: 18889.69 20:23:47 INFO - javascript benchmark 20:23:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3113.953290700639, 3178.07835727639, 3219.871205151794, 3224.6614105518906, 3243.9943617478584, 5062.26597143414, 5117.130087885059, 5134.178531434971, 5135.178371460563, 5160.587153027758, 5066.594672426207, 5137.614678899088, 5156.381234251886, 5189.117849965505, 5195.454477279888, 4477.776111194444, 4677.579017888389, 4680.976595117037, 4711.458182309027, 4785.880352991168, 4786.880327991793, 4806.519348065201, 4818.10864989978, 4863.513648635126, 4878.829240976566, 4611.5619016193405, 4659.32439796231, 4701.78841952113, 4739.218029025206, 4747.074320507502, 4684.625229981593, 4686.203345431285, 4688.601468875149, 4701.294805779126, 4720.457147428056, 4716.575508204244, 4722.150012997659, 4731.219348807443, 4733.266343716729, 4751.857444276678, 4876.439209490883, 4946.653734238605, 4946.703197808143, 4953.826616068456, 4957.305977163164, 5442.2380866678695, 5456.0, 5505.091659876116, 5506.669599824023, 5510.889782204334, 5526.751296191641, 5533.474319939599, 5534.308211473566, 5537.861553461155, 5548.14003829403, 5164.302819119408, 5173.22401639757, 5173.689578625294, 5182.1579865437325, 5182.352205974215, 5379.946200537945, 5587.357453892773, 5591.804286849941, 5635.098384258499, 5657.57568182388, 5429.294191755125, 5437.972810136003, 5443.863903402446, 5447.509724124848, 5481.260029895992, 5452.809151679672, 5516.062269414209, 5517.806876759374, 5521.668699878021, 5581.441855814386, 5279.41926388097, 5429.267048948342, 5449.918251226235, 5503.587230957694, 5526.861828454321, 5496.532794712414, 5500.42245564218, 5502.8349149525575, 5508.944910550923, 5511.559075273968, 4319.460067491564, 4337.652987760972, 4344.674149438804, 4377.277749171351, 4380.824767009284, 3764.9811750941617, 3826.9234615308096, 3868.226354729009, 3930.1353702185475, 3935.980320098381, 5155.252488389237, 5157.613179011514, 5180.119379705459, 5182.222666600041, 5233.842984710464, 5429.0, 5558.888822223533, 5569.805056823073, 5570.108782594765, 5570.41510641385, 5063.645544811828, 5078.5175408336145, 5156.5616922562, 5193.740312984336, 5259.973700131552, 4779.163646361872, 4780.4741478437345, 4791.161546729309, 4791.928121078186, 4824.107540105022, 5581.776728930798, 5759.510441612426, 5771.365149833515, 5771.480566748929, 5776.451237132465, 5473.28847249855, 5512.310961129859, 5521.171824226398, 5534.52956498686, 5571.0807716726285, 5749.13762935563, 5773.0, 5777.653340799566, 5777.94222057774, 5781.739821707949, 5345.118055520796, 5452.0, 5489.478499542537, 5504.91742623869, 5505.917411238915, 5446.046941785093, 5551.611387203018, 5562.16567514876, 5579.972100139474, 5626.971865140648, 5409.810656626999, 5426.728663566727, 5448.83653490396, 5456.672599643875, 5456.672599644034, 5288.81489147878, 5376.919346209888, 5427.782888684566, 5427.891442171055, 5486.0, 5270.7101109439345, 5316.7075810830775, 5371.248025276543, 5401.864953376197, 5435.266239057677, 5424.728763561727, 5443.237946687388, 5443.7278136092245, 5444.727763611724, 5500.889982200253, 5174.249733788504, 5291.126964050888, 5348.839534813962, 5353.036453438419, 5358.758855851418], "unit": "score", "name": "dojo.html", "value": 5105.298742856228}, {"lowerIsBetter": false, "replicates": [534.5376249544145, 542.059526721139, 545.0488896874951, 558.9944100558995, 564.0523919814709, 28088.0, 28571.999999999975, 28665.283367915814, 35060.29879402411, 35693.643063569354, 37940.05149871254, 38326.42510362347, 38331.23337533248, 38358.4246236306, 38468.80765596168, 8264.83470330593, 8462.957685211566, 8465.873011904827, 8468.068512463624, 8468.491890486559, 7300.4524660650395, 7454.739084132057, 9757.365771224882, 10000.099991000809, 10007.349522281065, 9833.623292739023, 9844.753881152992, 9927.354721943087, 9928.305018648698, 9942.65200717975, 7324.48728588999, 7499.0, 9698.418094914328, 9712.125908668184, 9795.06946840049, 7306.81732956675, 9733.17268032218, 9920.057594528509, 9941.80116397668, 9944.154746846527, 35754.0, 36140.81929590362, 36229.27541449183, 36267.0, 36317.0, 3335.216224187314, 3372.9325413491592, 3428.0447558546366, 3772.4529943158363, 3960.7821569813937, 27237.863810681018, 27510.724892751216, 27671.86164069187, 27704.72295277062, 30689.69310306891, 3928.508936382952, 3937.7834219117935, 3958.2083583283456, 4076.1643863008308, 4094.7747873866924, 274757.0, 275434.0, 275435.6228218866, 275458.0, 275488.0, 50239.0, 56716.71641641765, 57028.0, 57052.71473642605, 57127.42872571221, 46082.0, 62582.0, 63652.0, 63758.6812065946, 63792.0, 12803.423845926956, 13010.154339967872, 13018.349082545836, 13071.673208169872, 13081.41133648988, 9821.312508124505, 9850.261230407605, 9937.900620993842, 9953.203743700487, 9967.601295948225, 18425.539361515803, 18602.44192674222, 18602.627947440975, 18627.813721862607, 19331.903340483488, 7142.785716428515, 7196.784096477114, 7255.274472552703, 7314.451416143704, 7377.704891804375, 948.5148909856221, 952.9047095290554, 955.8040601676639, 960.2510042167121, 1031.7162780235494, 27658.585121223197, 27683.0, 28300.575491367646, 28604.14187574376, 29162.562561561594, 1026.296986564206, 1040.287403128859, 1046.5656752447649, 1090.55287332195, 1093.0217455377551, 14671.633209169857, 15035.248237588077, 15168.0, 15207.543773686808, 15212.391504339703, 328332.0, 337441.0, 338043.0, 338602.0, 338824.0, 51020.0, 51323.23015154776, 51454.48545514572, 51568.22647660288, 51725.48274517282, 1165.1377980294521, 1242.5526810348267, 1277.7891647877996, 1286.3761075878192, 1330.9933450332687, 26382.604260936485, 27426.5886011714, 27552.724472755817, 27564.724352757017, 27706.307342316602, 38705.6129438702, 39177.6082239174, 39296.2140757189, 39915.40126898041, 41869.37195942002, 222020.0, 311154.0, 313125.0, 313427.0, 313598.0, 29190.854045730484, 29958.0, 29965.850170749007, 29966.85016574903, 29972.400551989274, 40627.0, 41397.37903931383, 41490.2658760713, 41981.79009104935, 42006.579934200265, 35218.47172292366, 35528.289434211685, 35635.64364356427, 35893.64106358903, 36202.0, 35143.824280878434, 35658.0, 35859.0, 35934.0, 35978.28043439169, 33813.66186338105, 34838.65161348354, 34909.0, 35164.47253291152, 35189.47215791714, 29510.852445737633, 31415.21461963469, 31834.522482162323, 32235.677643224204, 32241.51637725389, 24861.751382485945, 24929.875350623857, 24930.37674058163, 24958.251252462454, 25263.87368063148], "unit": "score", "name": "ext.html", "value": 17890.50675806032}, {"lowerIsBetter": false, "replicates": [354.7233158136653, 356.7698834251909, 359.6529349178044, 361.0504373497704, 361.10806308418205, 13412.26232557209, 13787.379567919443, 15998.680026399465, 16541.586460338498, 17746.733798993024, 14373.634504722035, 14934.701305973902, 15494.5351639451, 15498.070115793033, 15515.922420387911, 5083.898322033567, 5264.894702105956, 5268.604854635918, 5269.446708095652, 5271.0, 4019.658329042035, 4142.150859073882, 5175.792968281283, 5254.0, 5666.744996475148, 5685.602007859451, 5789.363170051291, 5836.445537673935, 5837.124431335291, 5839.357670656224, 5644.153376993463, 5742.511886489653, 5765.827025189209, 5765.971170144144, 5771.336296325934, 4905.583025442842, 5034.496550344937, 5057.367829021372, 5057.822976195852, 5062.2406639004075, 17354.826451735575, 17996.460106196835, 18011.639767204582, 19689.409317720492, 19893.10481028357, 2058.269314393384, 2061.597988392264, 2106.9129360883226, 2134.4983928776724, 2145.9356219313445, 9604.951975240148, 9646.131848133631, 10200.591976321013, 10806.243562950596, 13050.804237936438, 1806.1962426720115, 1860.4139695995718, 1878.5773201029795, 1887.1224880430666, 1895.668258054835, 52772.0, 54930.176047359324, 55666.0, 56061.43938560603, 56918.43081569214, 9507.0, 9521.428714277166, 9528.142467177848, 9529.904700952902, 9555.856662150074, 12466.87533124657, 12630.81053784194, 12631.052671049709, 12633.368331583384, 12650.620481385573, 6807.353301436356, 6838.281980391987, 6850.349216824394, 6915.412189963909, 6917.377436030681, 6461.7738379157445, 6480.092787009822, 6500.187476565429, 6544.0, 6550.639714815636, 4100.2414553307735, 4105.4662893823615, 4108.198901214235, 4137.358709400048, 4140.585941405896, 1667.5164202381416, 1726.240454200148, 1727.8790484665953, 1767.3549154558493, 1796.9910150449164, 425.79561810331217, 877.4822854515738, 951.357833462424, 965.2567523007245, 974.0648976982035, 9525.0, 9867.309288349747, 9980.251481138943, 10016.0, 10095.394276343442, 415.4246368779263, 415.8960259935016, 420.3316726405031, 422.5352112676032, 430.9224339618836, 5299.178627312773, 5653.0, 5655.660660360391, 5656.434356564393, 5704.657720536781, 356245.0, 509490.0, 528304.0, 528787.0, 541912.0, 52045.7397713009, 64483.677581611795, 64916.67541662356, 66469.0, 67571.66214168996, 471.82070813090803, 490.5143907531518, 490.7300984458605, 491.1184423959002, 494.51043466967445, 9842.852357214791, 10009.749756256151, 11141.88858111441, 13416.39626216842, 13487.797683034958, 32610.347793043533, 32988.34023319472, 33230.83384583062, 33464.832675836464, 34021.0, 37125.071873203386, 38079.80960095182, 41672.37491437692, 41912.580874192085, 42888.35667464928, 6890.793276201722, 7282.4902256841515, 7369.889451658122, 7479.065116860393, 7515.924840751742, 3837.9040523987123, 5142.1258386073705, 9922.652707155215, 10356.430396328275, 10910.23628346008, 3245.7403407727797, 7035.417031168151, 9306.953465232631, 9481.620735170516, 9638.903610964082, 9344.252459803336, 9392.95303523478, 9692.224622030362, 9828.11546960777, 9910.405375677483, 3305.818180000123, 8282.308249818954, 9455.870607028699, 9587.664431744855, 9673.854892176481, 7146.964265178641, 7161.176464706626, 7272.854542909006, 7279.199288078201, 7331.926680733338, 9075.410098343587, 9479.28905332089, 9488.098630630078, 9624.566894489624, 9917.65288214909], "unit": "score", "name": "jquery.html", "value": 7181.28479161038}, {"lowerIsBetter": false, "replicates": [1353.6548180214045, 1471.0732238689625, 1492.507472534064, 1650.9752353714696, 1800.50486116318, 6894.13823272091, 7281.45389095818, 7480.850382992344, 7504.924950750491, 7513.887291690616, 7537.585432801194, 7564.96217518913, 7580.545167289966, 7638.465307428482, 7653.617319134035, 2011.5474018345901, 2057.77364489906, 2282.8173746100315, 2304.8617082975074, 2309.734380546242, 2274.8748818815043, 2325.023490134148, 2328.3247858121126, 2328.3364241191266, 2330.627099664054, 2244.607193741089, 2247.2471721973075, 2320.6983092197993, 2321.361625552978, 2322.3033090072995, 2275.6017696902977, 2294.19703103914, 2303.1248125712204, 2304.596695578267, 2305.953880922389, 2296.368498662881, 2303.884805759722, 2307.1002309099463, 2315.895784689693, 2327.8719670418122, 7863.56750378729, 7921.603919804044, 7928.0, 7928.643211055516, 7938.880916786253, 4718.905621887578, 4794.065157294329, 4825.951740482586, 4827.348307978413, 4831.275308703687, 3235.854386552611, 3267.1668724475344, 3322.401967645823, 3369.4608862582113, 3376.831158442068, 1120.2550304047797, 1200.2738343302265, 1211.945462454183, 1211.9818202726967, 1230.846144231971, 10596.152307815357, 10611.930673518667, 10619.36283822973, 10624.468776561142, 10635.52140153695, 4334.631556317685, 4369.47566292047, 4426.380306757057, 4427.845025424094, 4436.3567282743825, 9070.86393704095, 9099.998000439893, 9134.725958221265, 9149.588268527932, 9154.26765858743, 4765.070811191785, 4766.713997160182, 4771.379720636295, 4772.76136193189, 4779.06808172403, 4324.221640104748, 4334.393184954109, 4340.52254252032, 4342.5006124296115, 4345.869623911288, 3464.5149679044953, 3527.065327688165, 3710.777353358807, 3745.101175717808, 3805.06775839921, 1179.7581495793343, 1218.1899037140379, 1231.199720181871, 1231.3043130631165, 1242.8881400673984, 1300.5318085489216, 1313.8686131386976, 1326.7014921642747, 1359.238826257299, 1383.4604504243152, 7370.078740157481, 7448.255174482509, 7503.962480187564, 7509.91106289585, 7515.286047825448, 1102.7408558988632, 1105.2649987758211, 1113.7215696075982, 1114.3536748685742, 1114.765899161169, 5855.0, 5923.644581325134, 5926.67403292823, 5934.7922822701, 5940.70296485174, 9009.954950225207, 9145.0397708241, 9246.815063698688, 9282.535873206312, 9488.95255523718, 9102.544872756469, 9188.448693078437, 9206.907930920604, 9237.0, 9253.95373023144, 7367.705291788268, 7375.668094935741, 7535.585542795089, 7622.69509219625, 7635.0, 7513.474056816189, 7527.172011078667, 7604.0, 7617.047869016373, 7631.54210747357, 8444.831103378021, 8464.195901389357, 8642.78393040179, 8711.825763484821, 8712.869306960527, 8626.223639872442, 8703.216710496086, 8817.16236957488, 8819.0, 8829.205371516595, 6917.13535808024, 7100.147982242164, 7103.218645949045, 7109.182444019004, 7111.2533184017, 6725.361090696376, 6862.828429289108, 6976.407005404598, 7218.530795498275, 7222.74720384784, 6654.546360172457, 6763.966180169067, 6862.210845752802, 6872.003559483946, 6890.586564806128, 6632.303608121078, 6684.799456016327, 6717.1267735194115, 6806.591604503746, 6815.352541508549, 6720.428763554957, 6998.475114366544, 7003.859922801617, 7008.894866577108, 7019.157701075904, 6169.598976066542, 6215.65813880241, 6266.749330026748, 6488.837779055561, 6492.902606461002, 6482.546221764431, 6564.8358791030605, 6574.506911981525, 6584.572002819801, 6591.967040164768], "unit": "score", "name": "mootools.html", "value": 4551.738287677491}, {"lowerIsBetter": false, "replicates": [321.95331676906846, 329.1376593325485, 330.4019724299019, 331.15390178094964, 336.94103531881916, 5685.317761868571, 5839.591228613998, 5846.0, 5888.970555147223, 5912.526997840173, 5680.630759000673, 5782.335031471382, 5782.3639399666, 5822.475977162065, 5835.299764028323, 4474.105178964204, 4476.2390393632995, 4522.6155776759015, 4530.864074077783, 4531.614812740921, 4287.892802679927, 4360.803763830635, 4520.54794520547, 4534.0, 4538.773061346936, 4404.757738324391, 4426.269665505188, 4453.888652783674, 4473.575010374026, 4480.327950807372, 4438.622717069069, 4444.866654000385, 4447.688661793676, 4448.466184057901, 4448.888777780549, 3922.882313530599, 3930.489036425275, 3932.351162058257, 3932.4101384792225, 3935.3900145477496, 5422.728863556807, 5498.120300751861, 5504.422035686235, 5535.501804837584, 5564.4713752193475, 5106.693598384109, 5111.488851114896, 5113.207452844815, 5116.667416617908, 5118.053160165344, 6194.535409844235, 6195.535334849859, 6201.720922558496, 6201.844953876144, 6209.937900620981, 4092.4679791627195, 4153.231652144363, 4191.622753952129, 4230.0, 4281.957180428187, 6389.520785941027, 6402.647854368008, 6415.0, 6444.226692796848, 6452.9354706452805, 4381.67137464685, 4383.364412160219, 4383.802728877208, 4386.12277544486, 4399.274119770202, 4434.7560884151035, 4434.977825110854, 4435.312526558324, 4438.267685831802, 4439.067795762861, 4956.677815941952, 5104.846854594368, 5114.309568208244, 5121.436641969381, 5135.743212839343, 6226.128342032119, 6236.719347629368, 6237.438630523275, 6240.063990401385, 6242.781502647385, 1546.9303881325368, 1571.3714514194414, 1571.6463795646116, 1572.4653617770014, 1576.6216108134195, 1046.424466543398, 1053.3627155570769, 1057.8519007338978, 1068.3429690740138, 1080.6703955293553, 5879.794207202727, 5879.970600146972, 5884.293884733774, 5886.087656413263, 5898.233229680114, 6373.936260637427, 6374.426301632875, 6375.6174629522375, 6380.3619638035825, 6382.776602818972, 5858.238429004202, 5893.793717219876, 5896.113243762041, 5896.852578685567, 5897.410258974069, 3323.986184213838, 3456.879009234715, 3458.412069948115, 3459.135216195951, 3461.1866211440292, 6641.070250164981, 6656.633885136364, 6666.2333831609985, 6668.86662266752, 6673.699683514254, 6479.416852483299, 6505.707243174069, 6535.934640653532, 6545.247296560957, 6555.80332590023, 6448.613083215022, 6643.701033453506, 6646.468282537386, 6677.09859169006, 6753.12209412783, 6428.710708018057, 6462.289148193789, 6466.870662586816, 6479.546431749733, 6483.157189565326, 6137.3248942617165, 6199.628022318675, 6234.376562343729, 6397.168368112116, 6398.264199616918, 6704.396604305636, 6716.5634233774645, 6716.966415167893, 6727.394534491919, 6727.865442691216, 4413.602775750198, 4421.071574969293, 4444.955550444583, 4447.777611119366, 4448.5551444855255, 6267.185265915402, 6427.357264273535, 6443.6133831968355, 6448.5486015980305, 6451.838704032437, 6265.467435268053, 6285.088662143872, 6292.339304373158, 6296.779612713533, 6297.874042519215, 6257.124002639725, 6258.968705156445, 6261.154744109487, 6273.71768270438, 6274.968625156845, 5966.612170208922, 6150.938490615036, 6153.538484613582, 6163.8150855474405, 6174.135621013152, 6311.65285909261, 6314.210723659543, 6319.083732858801, 6326.683665816783, 6337.2395312562785, 6165.815025549241, 6169.2288463942, 6176.073588961692, 6182.258129024366, 6184.938150618436], "unit": "score", "name": "prototype.html", "value": 4679.243389043141}, {"lowerIsBetter": false, "replicates": [759.3659294489103, 778.5640041576718, 819.1235378145383, 833.2917020532552, 850.4529478738675, 12367.628971130858, 12411.007119430447, 12478.625641230778, 12498.250104993707, 12527.937360313197, 11713.297202167876, 12262.81605775914, 12646.430910609022, 12657.62027139185, 12713.364331783398, 790.1703211627796, 800.65171650332, 802.2298593350362, 802.7591722483261, 803.0363563723525, 793.0285400384512, 795.9084705258882, 796.3828033274201, 797.103258833812, 797.4258533855643, 822.0341099208406, 822.411975437562, 823.4441751817529, 823.6993497373476, 823.7858156879224, 815.213319147023, 817.7832874288289, 818.2472125644392, 819.9180081991813, 819.9836003279961, 602.6805792929754, 606.3118360660637, 607.3835057416726, 608.1637748096367, 608.6713174885557, 12052.698682532919, 12063.336516491589, 12080.87919120815, 12088.15382923187, 12093.516259349615, 11044.668659940215, 11187.272827266203, 11245.269057511236, 11346.48940797666, 11433.085353171726, 9508.667196648154, 9558.474283914382, 9631.614735410576, 9724.27067969898, 9729.951350243275, 3538.4692296155526, 3598.082488965323, 3604.9098772530633, 3609.079684680416, 3621.4748861414946, 41302.58697413017, 43177.56822431767, 43517.0, 45647.77176114132, 50519.23182688588, 10132.797344053077, 10196.796064078826, 10201.336913100624, 10381.2214083944, 10391.817718279246, 18051.819481805276, 18077.819221807877, 18102.90948545249, 18110.90944545269, 18112.909435452737, 6194.332176537501, 6451.483881289486, 7456.701731930771, 7582.052243469567, 8004.359651227888, 4354.303311470149, 4396.626286765661, 4453.977730111329, 4458.818413120525, 4494.16857881293, 2947.7641788656856, 2980.344324248662, 2984.686607906182, 2986.0, 2993.0721476342405, 585.3064119018891, 591.6006695480534, 596.0671549025761, 599.8800239952027, 602.5932495565476, 514.0797971630814, 555.4140381897138, 606.8755905039457, 609.7621927448299, 620.9844753881189, 9188.540572971458, 9662.0, 9681.612735490502, 9724.222062235005, 9822.214222862154, 549.7278846970775, 649.5388274325187, 656.3895577113235, 659.3439527669999, 679.5005670831935, 3876.341022026262, 3997.6601988831276, 4115.36211887158, 4143.6892233082635, 4190.171619259475, 53681.1947820783, 59736.70131649314, 60469.69765151146, 61422.69288653528, 61633.69183154056, 43140.85730546897, 46293.30560041602, 46634.76682616565, 46987.0, 48919.0, 41033.589664102976, 42893.78553107277, 44839.32741008822, 44849.32726009112, 45609.0, 9063.864042039506, 9096.090390960851, 9170.908290917272, 9213.76965575866, 9443.480608566595, 31402.685973139975, 31423.685763142075, 34047.0, 34293.0, 34736.30527389488, 43575.56424435715, 43973.56026439695, 44085.77957110194, 44241.11517769691, 44688.77655611701, 10876.619318323821, 10962.232643714864, 10984.835227471754, 11170.441477925908, 11218.0, 11368.261063030877, 11416.94291528537, 12187.695307617027, 12282.324472154118, 12942.67643308887, 11707.824382634437, 11814.586489472827, 11924.344161070878, 12238.797016537108, 12504.562340318045, 11127.554897803997, 11453.083753299883, 11468.197226194086, 11496.770064598493, 11524.94237528807, 11199.944000280273, 11387.43062846871, 11507.42462876836, 11786.351750653454, 11911.3448760319, 9072.085281762827, 9209.493477858514, 9303.76740581491, 9351.48566828831, 9595.664151754934, 9210.95394523023, 9323.906760932305, 9350.485723285285, 9420.0, 9425.764355891157], "unit": "score", "name": "yui.html", "value": 6187.3250640035485}], "name": "dromaeo_css", "value": 6649.510755317308}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 104.0, 109.0, 110.0, 110.0, 101.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [161.0, 122.0, 151.0, 165.0, 124.0, 147.0, 158.0, 126.0, 170.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 144.6}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 160.0, 160.0, 161.0, 164.0, 160.0, 165.0, 159.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 87.0, 92.0, 71.0, 71.0, 72.0, 125.0, 91.0, 71.0], "unit": "score", "name": "audio-fft", "value": 82.3}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 146.0, 96.0, 97.0, 96.0, 145.0, 96.0, 96.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 111.3}, {"lowerIsBetter": true, "replicates": [109.0, 108.0, 109.0, 109.0, 108.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.8}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [56.0, 53.0, 56.0, 54.0, 54.0, 54.0, 55.0, 63.0, 52.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 69.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [115.0, 115.0, 118.0, 121.0, 116.0, 123.0, 123.0, 116.0, 116.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.3}, {"lowerIsBetter": true, "replicates": [139.0, 148.0, 152.0, 147.0, 149.0, 138.0, 147.0, 142.0, 147.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.7}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 67.0, 67.0, 68.0, 68.0, 70.0, 68.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1496.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.5001665001665], "unit": "score", "name": "Richards", "value": 212.02381199999994}, {"lowerIsBetter": false, "replicates": [189.465706707086], "unit": "score", "name": "DeltaBlue", "value": 348.97080399999993}, {"lowerIsBetter": false, "replicates": [279.87685418415896], "unit": "score", "name": "Encrypt", "value": 951.0647130000004}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1994.0239043824702], "unit": "score", "name": "RayTrace", "value": 371.1033746253746}, {"lowerIsBetter": false, "replicates": [801.924619085806], "unit": "score", "name": "Earley", "value": 831.079361}, {"lowerIsBetter": false, "replicates": [12048.192771084337], "unit": "score", "name": "Boyer", "value": 55.31642899999996}, {"lowerIsBetter": false, "replicates": [42638.29787234042], "unit": "score", "name": "RegExp", "value": 21.365416666666672}, {"lowerIsBetter": false, "replicates": [600.9615384615385], "unit": "score", "name": "Splay", "value": 135.60102399999994}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 18889.693412630266}]} 20:23:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "18889.69"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1496.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6649.51"}}} 20:23:47 INFO - Return code: 0 20:23:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:23:47 INFO - # TBPL SUCCESS # 20:23:47 INFO - Running post-action listener: _resource_record_post_action 20:23:47 INFO - Running post-run listener: _resource_record_post_run 20:23:49 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543141888; Read time: 124; Write time: 516384 20:23:49 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 164077568; Read time: 0; Write time: 253396 20:23:49 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 311750656; Read time: 124; Write time: 222912 20:23:49 INFO - Running post-run listener: _upload_blobber_files 20:23:49 INFO - Blob upload gear active. 20:23:49 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:23:49 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 20:23:49 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'] 20:23:49 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 20:23:49 INFO - (blobuploader) - INFO - Open directory for files ... 20:23:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:23:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:23:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:23:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:23:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:23:50 INFO - (blobuploader) - INFO - Done attempting. 20:23:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:23:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:23:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:23:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:23:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:23:51 INFO - (blobuploader) - INFO - Done attempting. 20:23:51 INFO - (blobuploader) - INFO - Iteration through files over. 20:23:51 INFO - Return code: 0 20:23:51 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:23:51 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:23:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ab4958ab341a4e36da4deb9157b616f5a75c3d97e6980354a14f5c0a7a4f521cc6c87cc729545c89bc198d8095ed45d6066833550bbd6ed837f389c755a842d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e0c64c3306e1a0756b7494e06f1a6ccdd3b778c88bac82951849d1291cc63ae19ec3139a788b5c133ccc9adcf2ade3c04a646d36e0e96f90c940fc166236e934"} 20:23:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:23:51 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:23:51 INFO - Contents: 20:23:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ab4958ab341a4e36da4deb9157b616f5a75c3d97e6980354a14f5c0a7a4f521cc6c87cc729545c89bc198d8095ed45d6066833550bbd6ed837f389c755a842d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e0c64c3306e1a0756b7494e06f1a6ccdd3b778c88bac82951849d1291cc63ae19ec3139a788b5c133ccc9adcf2ade3c04a646d36e0e96f90c940fc166236e934"} 20:23:51 INFO - Copying logs to upload dir... 20:23:51 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1281.093531 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-01-11 20:23:51.045923) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 20:23:51.049578) ========= 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=4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584 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/ab4958ab341a4e36da4deb9157b616f5a75c3d97e6980354a14f5c0a7a4f521cc6c87cc729545c89bc198d8095ed45d6066833550bbd6ed837f389c755a842d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e0c64c3306e1a0756b7494e06f1a6ccdd3b778c88bac82951849d1291cc63ae19ec3139a788b5c133ccc9adcf2ade3c04a646d36e0e96f90c940fc166236e934"} build_url:https://queue.taskcluster.net/v1/task/O3Y_be_WQ8eeUe0s725p1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011300 build_url: 'https://queue.taskcluster.net/v1/task/O3Y_be_WQ8eeUe0s725p1Q/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/ab4958ab341a4e36da4deb9157b616f5a75c3d97e6980354a14f5c0a7a4f521cc6c87cc729545c89bc198d8095ed45d6066833550bbd6ed837f389c755a842d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e0c64c3306e1a0756b7494e06f1a6ccdd3b778c88bac82951849d1291cc63ae19ec3139a788b5c133ccc9adcf2ade3c04a646d36e0e96f90c940fc166236e934"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 20:23:51.074287) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 20:23:51.074594) ========= 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=4dd8011cc2821079d74a932a000001ae-1452571032.155590-794909584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004736 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 20:23:51.159488) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 20:23:51.159813) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 20:23:51.160137) ========= ========= Total master_lag: 0.25 =========