builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1450778249.07 results: success (0) buildid: 20151221233003 builduid: 8f641a9196c2454eb253e94cf7e77bec revision: d99479b6d7f8d60943f40f11a4d5c21d551741b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 01:57:29.070089) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 01:57:29.070511) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 01:57:29.070801) ========= 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=5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006322 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 01:57:29.108588) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 01:57:29.109028) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 01:57:29.168002) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 01:57:29.168464) ========= 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=5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004725 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 01:57:29.222460) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 01:57:29.222923) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 01:57:29.223523) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 01:57:29.223975) ========= 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=5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 01:57:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 74.3M=0s 2015-12-22 01:57:30 (74.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176455 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 01:57:29.415420) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 01:57:29.415892) ========= 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=5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015557 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 01:57:29.468674) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 01:57:29.469139) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev d99479b6d7f8d60943f40f11a4d5c21d551741b1 --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 d99479b6d7f8d60943f40f11a4d5c21d551741b1 --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=5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 01:57:30,471 truncating revision to first 12 chars 2015-12-22 01:57:30,471 Setting DEBUG logging. 2015-12-22 01:57:30,471 attempt 1/10 2015-12-22 01:57:30,471 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/d99479b6d7f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-22 01:57:30,717 unpacking tar archive at: b2g-inbound-d99479b6d7f8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.840913 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 01:57:30.322996) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 01:57:30.323320) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 01:57:30.330080) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 01:57:30.330393) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 01:57:30.330787) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-22 01:57:30.331080) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --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', '--system-bits', '64', '--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=5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:57:31 INFO - MultiFileLogger online at 20151222 01:57:31 in /builds/slave/test-pgo 01:57:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 01:57:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:57:31 INFO - {'append_to_log': False, 01:57:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:57:31 INFO - 'blob_upload_branch': 'B2G-Inbound', 01:57:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:57:31 INFO - 'branch': 'B2G-Inbound', 01:57:31 INFO - 'buildbot_json_path': 'buildprops.json', 01:57:31 INFO - 'config_files': ('talos/linux_config.py',), 01:57:31 INFO - 'default_actions': ('clobber', 01:57:31 INFO - 'read-buildbot-config', 01:57:31 INFO - 'download-and-extract', 01:57:31 INFO - 'populate-webroot', 01:57:31 INFO - 'create-virtualenv', 01:57:31 INFO - 'install', 01:57:31 INFO - 'run-tests'), 01:57:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:57:31 INFO - 'download_minidump_stackwalk': True, 01:57:31 INFO - 'download_symbols': 'ondemand', 01:57:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:57:31 INFO - 'tooltool.py': '/tools/tooltool.py', 01:57:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:57:31 INFO - '/tools/misc-python/virtualenv.py')}, 01:57:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:57:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:57:31 INFO - 'installer_path': 'installer.exe', 01:57:31 INFO - 'log_level': 'info', 01:57:31 INFO - 'log_name': 'talos', 01:57:31 INFO - 'log_to_console': True, 01:57:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:57:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:57:31 INFO - 'opt_config_files': (), 01:57:31 INFO - 'pip_index': False, 01:57:31 INFO - 'sps_profile': False, 01:57:31 INFO - 'sps_profile_interval': 0, 01:57:31 INFO - 'suite': 'dromaeojs', 01:57:31 INFO - 'system_bits': '64', 01:57:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:57:31 INFO - 'title': 'talos-linux64-ix-059', 01:57:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:57:31 INFO - 'use_talos_json': True, 01:57:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:57:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:57:31 INFO - 'work_dir': 'build'} 01:57:31 INFO - ##### 01:57:31 INFO - ##### Running clobber step. 01:57:31 INFO - ##### 01:57:31 INFO - Running pre-action listener: _resource_record_pre_action 01:57:31 INFO - Running main action method: clobber 01:57:31 INFO - rmtree: /builds/slave/test-pgo/build 01:57:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:57:31 INFO - Running post-action listener: _resource_record_post_action 01:57:31 INFO - ##### 01:57:31 INFO - ##### Running read-buildbot-config step. 01:57:31 INFO - ##### 01:57:31 INFO - Running pre-action listener: _resource_record_pre_action 01:57:31 INFO - Running main action method: read_buildbot_config 01:57:31 INFO - Using buildbot properties: 01:57:31 INFO - { 01:57:31 INFO - "project": "", 01:57:31 INFO - "product": "firefox", 01:57:31 INFO - "script_repo_revision": "production", 01:57:31 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 01:57:31 INFO - "repository": "", 01:57:31 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 01:57:31 INFO - "buildid": "20151221233003", 01:57:31 INFO - "pgo_build": "True", 01:57:31 INFO - "basedir": "/builds/slave/test-pgo", 01:57:31 INFO - "buildnumber": 142, 01:57:31 INFO - "slavename": "talos-linux64-ix-059", 01:57:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:57:31 INFO - "platform": "ubuntu64_hw", 01:57:31 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 01:57:31 INFO - "branch": "b2g-inbound", 01:57:31 INFO - "repo_path": "integration/b2g-inbound", 01:57:31 INFO - "revision": "d99479b6d7f8d60943f40f11a4d5c21d551741b1", 01:57:31 INFO - "stage_platform": "linux64-pgo", 01:57:31 INFO - "builduid": "8f641a9196c2454eb253e94cf7e77bec", 01:57:31 INFO - "slavebuilddir": "test" 01:57:31 INFO - } 01:57:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/pPWBpeJDRhKNLqzVbD2N8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 01:57:31 INFO - Running post-action listener: _resource_record_post_action 01:57:31 INFO - ##### 01:57:31 INFO - ##### Running download-and-extract step. 01:57:31 INFO - ##### 01:57:31 INFO - Running pre-action listener: _resource_record_pre_action 01:57:31 INFO - Running main action method: download_and_extract 01:57:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:31 INFO - https://queue.taskcluster.net/v1/task/pPWBpeJDRhKNLqzVbD2N8g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:57:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pPWBpeJDRhKNLqzVbD2N8g/artifacts/public/build/test_packages.json 01:57:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pPWBpeJDRhKNLqzVbD2N8g/artifacts/public/build/test_packages.json 01:57:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pPWBpeJDRhKNLqzVbD2N8g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:57:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pPWBpeJDRhKNLqzVbD2N8g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:57:33 INFO - Downloaded 1302 bytes. 01:57:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:57:33 INFO - Using the following test package requirements: 01:57:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:57:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:57:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:57:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:57:33 INFO - u'jsshell-linux-x86_64.zip'], 01:57:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:57:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:57:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:57:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:57:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:57:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:57:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:57:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:57:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:57:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:57:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:57:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:57:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:33 INFO - https://queue.taskcluster.net/v1/task/pPWBpeJDRhKNLqzVbD2N8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:57:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pPWBpeJDRhKNLqzVbD2N8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:57:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pPWBpeJDRhKNLqzVbD2N8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:57:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pPWBpeJDRhKNLqzVbD2N8g/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 01:57:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pPWBpeJDRhKNLqzVbD2N8g/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 01:57:34 INFO - Downloaded 23175249 bytes. 01:57:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 01:57:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:57:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:57:35 INFO - Return code: 0 01:57:35 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 01:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:35 INFO - https://queue.taskcluster.net/v1/task/pPWBpeJDRhKNLqzVbD2N8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:57:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pPWBpeJDRhKNLqzVbD2N8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:57:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pPWBpeJDRhKNLqzVbD2N8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:57:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pPWBpeJDRhKNLqzVbD2N8g/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 01:57:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pPWBpeJDRhKNLqzVbD2N8g/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 01:57:39 INFO - Downloaded 23175249 bytes. 01:57:39 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 01:57:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:57:39 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 01:57:40 INFO - Return code: 0 01:57:40 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')]} 01:57:40 INFO - https://queue.taskcluster.net/v1/task/pPWBpeJDRhKNLqzVbD2N8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:57:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pPWBpeJDRhKNLqzVbD2N8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:57:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pPWBpeJDRhKNLqzVbD2N8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:57:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pPWBpeJDRhKNLqzVbD2N8g/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 01:57:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pPWBpeJDRhKNLqzVbD2N8g/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 01:57:41 INFO - Downloaded 11132277 bytes. 01:57:41 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 01:57:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:57:41 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 01:57:42 INFO - Return code: 0 01:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:42 INFO - https://queue.taskcluster.net/v1/task/pPWBpeJDRhKNLqzVbD2N8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:57:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pPWBpeJDRhKNLqzVbD2N8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:57:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pPWBpeJDRhKNLqzVbD2N8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:57:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pPWBpeJDRhKNLqzVbD2N8g/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 01:57:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pPWBpeJDRhKNLqzVbD2N8g/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 01:57:43 INFO - Downloaded 54932394 bytes. 01:57:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/pPWBpeJDRhKNLqzVbD2N8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:57:43 INFO - mkdir: /builds/slave/test-pgo/properties 01:57:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:57:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:57:43 INFO - Contents: 01:57:43 INFO - build_url:https://queue.taskcluster.net/v1/task/pPWBpeJDRhKNLqzVbD2N8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:57:43 INFO - Running post-action listener: _resource_record_post_action 01:57:43 INFO - Running post-action listener: set_extra_try_arguments 01:57:43 INFO - ##### 01:57:43 INFO - ##### Running populate-webroot step. 01:57:43 INFO - ##### 01:57:43 INFO - Running pre-action listener: _resource_record_pre_action 01:57:43 INFO - Running main action method: populate_webroot 01:57:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:57:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:57:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:57:43 INFO - '--tppagecycles', 01:57:43 INFO - '7'], 01:57:43 INFO - 'tests': ['tsvgm']}}, 01:57:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:57:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:57:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:57:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:57:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:57:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:57:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:57:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:43 INFO - 'talos_options': ['--e10s'], 01:57:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:57:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:43 INFO - 'tests': ['damp', 'tps']}, 01:57:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:43 INFO - 'talos_options': ['--e10s'], 01:57:43 INFO - 'tests': ['damp', 'tps']}, 01:57:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:57:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:57:43 INFO - 'other': {'tests': ['a11yr', 01:57:43 INFO - 'ts_paint', 01:57:43 INFO - 'tpaint', 01:57:43 INFO - 'sessionrestore', 01:57:43 INFO - 'sessionrestore_no_auto_restore']}, 01:57:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:57:43 INFO - 'tests': ['a11yr', 01:57:43 INFO - 'ts_paint', 01:57:43 INFO - 'tpaint', 01:57:43 INFO - 'sessionrestore', 01:57:43 INFO - 'sessionrestore_no_auto_restore']}, 01:57:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:57:43 INFO - 'tests': ['a11yr', 01:57:43 INFO - 'ts_paint', 01:57:43 INFO - 'tpaint', 01:57:43 INFO - 'sessionrestore', 01:57:43 INFO - 'sessionrestore_no_auto_restore']}, 01:57:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:57:43 INFO - 'tests': ['a11yr', 01:57:43 INFO - 'ts_paint', 01:57:43 INFO - 'tpaint', 01:57:43 INFO - 'sessionrestore', 01:57:43 INFO - 'sessionrestore_no_auto_restore']}, 01:57:43 INFO - 'other_l64': {'tests': ['a11yr', 01:57:43 INFO - 'ts_paint', 01:57:43 INFO - 'tpaint', 01:57:43 INFO - 'sessionrestore', 01:57:43 INFO - 'sessionrestore_no_auto_restore']}, 01:57:43 INFO - 'other_nol64': {'tests': ['a11yr', 01:57:43 INFO - 'ts_paint', 01:57:43 INFO - 'tpaint', 01:57:43 INFO - 'sessionrestore', 01:57:43 INFO - 'sessionrestore_no_auto_restore']}, 01:57:43 INFO - 'svgr': {'tests': ['tsvgx', 01:57:43 INFO - 'tsvgr_opacity', 01:57:43 INFO - 'tart', 01:57:43 INFO - 'tscrollx', 01:57:43 INFO - 'cart']}, 01:57:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:57:43 INFO - 'tests': ['tsvgx', 01:57:43 INFO - 'tsvgr_opacity', 01:57:43 INFO - 'tart', 01:57:43 INFO - 'tscrollx', 01:57:43 INFO - 'cart']}, 01:57:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:43 INFO - 'tests': ['tp5o']}, 01:57:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:43 INFO - 'talos_options': ['--e10s'], 01:57:43 INFO - 'tests': ['tp5o']}, 01:57:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:43 INFO - 'talos_options': ['--xperf_path', 01:57:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:57:43 INFO - 'tests': ['tp5n']}, 01:57:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:43 INFO - 'talos_options': ['--e10s', 01:57:43 INFO - '--xperf_path', 01:57:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:57:43 INFO - 'tests': ['tp5n']}}, 01:57:43 INFO - 'talos.zip': {'path': '', 01:57:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:57:43 INFO - Running post-action listener: _resource_record_post_action 01:57:43 INFO - ##### 01:57:43 INFO - ##### Running create-virtualenv step. 01:57:43 INFO - ##### 01:57:43 INFO - Running pre-action listener: _resource_record_pre_action 01:57:43 INFO - Running main action method: create_virtualenv 01:57:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:57:43 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 01:57:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:57:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:57:43 INFO - Using real prefix '/usr' 01:57:43 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:57:44 INFO - Installing distribute.............................................................................................................................................................................................done. 01:57:46 INFO - Installing pip.................done. 01:57:46 INFO - Return code: 0 01:57:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:57:46 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')]} 01:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:46 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')]} 01:57:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:46 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 0x7fe50e2f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b66630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf7840>, '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 0x1b646b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b64b60>, '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': '5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069', '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 01:57:46 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 01:57:46 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 01:57:46 INFO - Using env: {'DISPLAY': ':0', 01:57:46 INFO - 'HOME': '/home/cltbld', 01:57:46 INFO - 'LANG': 'en_US.UTF-8', 01:57:46 INFO - 'LANGUAGE': 'en_US:en', 01:57:46 INFO - 'LOGNAME': 'cltbld', 01:57:46 INFO - 'MAIL': '/var/mail/cltbld', 01:57:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:46 INFO - 'MOZ_NO_REMOTE': '1', 01:57:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:46 INFO - 'NO_EM_RESTART': '1', 01:57:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:57:46 INFO - 'PWD': '/builds/slave/test-pgo', 01:57:46 INFO - 'SHELL': '/bin/bash', 01:57:46 INFO - 'SHLVL': '1', 01:57:46 INFO - 'TERM': 'linux', 01:57:46 INFO - 'TMOUT': '86400', 01:57:46 INFO - 'USER': 'cltbld', 01:57:46 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069', 01:57:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:46 INFO - '_': '/tools/buildbot/bin/python'} 01:57:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:46 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 01:57:46 INFO - Cleaning up... 01:57:46 INFO - Return code: 0 01:57:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:57:46 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')]} 01:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:46 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')]} 01:57:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:46 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 0x7fe50e2f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b66630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf7840>, '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 0x1b646b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b64b60>, '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': '5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069', '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 01:57:46 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 01:57:46 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 01:57:46 INFO - Using env: {'DISPLAY': ':0', 01:57:46 INFO - 'HOME': '/home/cltbld', 01:57:46 INFO - 'LANG': 'en_US.UTF-8', 01:57:46 INFO - 'LANGUAGE': 'en_US:en', 01:57:46 INFO - 'LOGNAME': 'cltbld', 01:57:46 INFO - 'MAIL': '/var/mail/cltbld', 01:57:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:46 INFO - 'MOZ_NO_REMOTE': '1', 01:57:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:46 INFO - 'NO_EM_RESTART': '1', 01:57:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:57:46 INFO - 'PWD': '/builds/slave/test-pgo', 01:57:46 INFO - 'SHELL': '/bin/bash', 01:57:46 INFO - 'SHLVL': '1', 01:57:46 INFO - 'TERM': 'linux', 01:57:46 INFO - 'TMOUT': '86400', 01:57:46 INFO - 'USER': 'cltbld', 01:57:46 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069', 01:57:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:46 INFO - '_': '/tools/buildbot/bin/python'} 01:57:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:46 INFO - Downloading/unpacking psutil>=0.7.1 01:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:48 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 01:57:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:57:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:57:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:57:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:57:48 INFO - Installing collected packages: psutil 01:57:48 INFO - Running setup.py install for psutil 01:57:48 INFO - building 'psutil._psutil_linux' extension 01:57:48 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 01:57:48 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 01:57:48 INFO - building 'psutil._psutil_posix' extension 01:57:48 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 01:57:48 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 01:57:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:57:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:57:49 INFO - Successfully installed psutil 01:57:49 INFO - Cleaning up... 01:57:49 INFO - Return code: 0 01:57:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:57:49 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')]} 01:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:49 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')]} 01:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:49 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 0x7fe50e2f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b66630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf7840>, '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 0x1b646b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b64b60>, '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': '5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069', '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 01:57:49 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 01:57:49 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 01:57:49 INFO - Using env: {'DISPLAY': ':0', 01:57:49 INFO - 'HOME': '/home/cltbld', 01:57:49 INFO - 'LANG': 'en_US.UTF-8', 01:57:49 INFO - 'LANGUAGE': 'en_US:en', 01:57:49 INFO - 'LOGNAME': 'cltbld', 01:57:49 INFO - 'MAIL': '/var/mail/cltbld', 01:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:49 INFO - 'MOZ_NO_REMOTE': '1', 01:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:49 INFO - 'NO_EM_RESTART': '1', 01:57:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:57:49 INFO - 'PWD': '/builds/slave/test-pgo', 01:57:49 INFO - 'SHELL': '/bin/bash', 01:57:49 INFO - 'SHLVL': '1', 01:57:49 INFO - 'TERM': 'linux', 01:57:49 INFO - 'TMOUT': '86400', 01:57:49 INFO - 'USER': 'cltbld', 01:57:49 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069', 01:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:49 INFO - '_': '/tools/buildbot/bin/python'} 01:57:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:57:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:57:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:57:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:57:51 INFO - Installing collected packages: mozsystemmonitor 01:57:51 INFO - Running setup.py install for mozsystemmonitor 01:57:51 INFO - Successfully installed mozsystemmonitor 01:57:51 INFO - Cleaning up... 01:57:51 INFO - Return code: 0 01:57:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:57:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:51 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 0x7fe50e2f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b66630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf7840>, '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 0x1b646b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b64b60>, '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': '5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069', '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 01:57:51 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 01:57:51 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 01:57:51 INFO - Using env: {'DISPLAY': ':0', 01:57:51 INFO - 'HOME': '/home/cltbld', 01:57:51 INFO - 'LANG': 'en_US.UTF-8', 01:57:51 INFO - 'LANGUAGE': 'en_US:en', 01:57:51 INFO - 'LOGNAME': 'cltbld', 01:57:51 INFO - 'MAIL': '/var/mail/cltbld', 01:57:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:51 INFO - 'MOZ_NO_REMOTE': '1', 01:57:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:51 INFO - 'NO_EM_RESTART': '1', 01:57:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:57:51 INFO - 'PWD': '/builds/slave/test-pgo', 01:57:51 INFO - 'SHELL': '/bin/bash', 01:57:51 INFO - 'SHLVL': '1', 01:57:51 INFO - 'TERM': 'linux', 01:57:51 INFO - 'TMOUT': '86400', 01:57:51 INFO - 'USER': 'cltbld', 01:57:51 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069', 01:57:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:51 INFO - '_': '/tools/buildbot/bin/python'} 01:57:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:51 INFO - Downloading/unpacking blobuploader==1.2.4 01:57:51 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 01:57:51 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 01:57:51 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 01:57:51 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 01:57:51 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 01:57:51 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 01:57:53 INFO - Downloading blobuploader-1.2.4.tar.gz 01:57:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:57:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:57:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:57:53 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 01:57:53 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 01:57:53 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 01:57:53 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 01:57:53 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 01:57:53 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 01:57:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:57:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:57:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:57:53 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 01:57:53 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 01:57:53 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 01:57:53 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 01:57:53 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 01:57:53 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 01:57:53 INFO - Downloading docopt-0.6.1.tar.gz 01:57:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:57:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:57:53 INFO - Installing collected packages: blobuploader, requests, docopt 01:57:53 INFO - Running setup.py install for blobuploader 01:57:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:57:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:57:53 INFO - Running setup.py install for requests 01:57:54 INFO - Running setup.py install for docopt 01:57:54 INFO - Successfully installed blobuploader requests docopt 01:57:54 INFO - Cleaning up... 01:57:54 INFO - Return code: 0 01:57:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:54 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 0x7fe50e2f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b66630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf7840>, '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 0x1b646b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b64b60>, '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': '5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069', '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 01:57:54 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 01:57:54 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 01:57:54 INFO - Using env: {'DISPLAY': ':0', 01:57:54 INFO - 'HOME': '/home/cltbld', 01:57:54 INFO - 'LANG': 'en_US.UTF-8', 01:57:54 INFO - 'LANGUAGE': 'en_US:en', 01:57:54 INFO - 'LOGNAME': 'cltbld', 01:57:54 INFO - 'MAIL': '/var/mail/cltbld', 01:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:54 INFO - 'MOZ_NO_REMOTE': '1', 01:57:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:54 INFO - 'NO_EM_RESTART': '1', 01:57:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:57:54 INFO - 'PWD': '/builds/slave/test-pgo', 01:57:54 INFO - 'SHELL': '/bin/bash', 01:57:54 INFO - 'SHLVL': '1', 01:57:54 INFO - 'TERM': 'linux', 01:57:54 INFO - 'TMOUT': '86400', 01:57:54 INFO - 'USER': 'cltbld', 01:57:54 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069', 01:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:54 INFO - '_': '/tools/buildbot/bin/python'} 01:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:57:54 INFO - Running setup.py (path:/tmp/pip-NojQBs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:57:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:57:54 INFO - Running setup.py (path:/tmp/pip-Hpwt62-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:57:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:57:54 INFO - Running setup.py (path:/tmp/pip-jQD9Pm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:57:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:57:54 INFO - Running setup.py (path:/tmp/pip-TvUaP8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:57:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:57:54 INFO - Running setup.py (path:/tmp/pip-7KmzVA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:57:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:57:54 INFO - Running setup.py (path:/tmp/pip-Rjk5pg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:57:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:57:55 INFO - Running setup.py (path:/tmp/pip-45m_5B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:57:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:57:55 INFO - Running setup.py (path:/tmp/pip-F2TC25-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:57:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:57:55 INFO - Running setup.py (path:/tmp/pip-5aSRgb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:57:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:57:55 INFO - Running setup.py (path:/tmp/pip-mLDpPv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:57:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:57:55 INFO - Running setup.py (path:/tmp/pip-gSr0Ue-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:57:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:57:55 INFO - Running setup.py (path:/tmp/pip-9KBjcD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:57:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:57:55 INFO - Running setup.py (path:/tmp/pip-gW4QFb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:57:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:57:55 INFO - Running setup.py (path:/tmp/pip-Kvc5Pr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:57:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:57:55 INFO - Running setup.py (path:/tmp/pip-TZPIgl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:57:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:57:55 INFO - Running setup.py (path:/tmp/pip-5NukyX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:57:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:57:55 INFO - Running setup.py (path:/tmp/pip-u4AxVZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:57:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:57:55 INFO - Running setup.py install for manifestparser 01:57:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:57:55 INFO - Running setup.py install for mozcrash 01:57:56 INFO - Running setup.py install for mozdebug 01:57:56 INFO - Running setup.py install for mozdevice 01:57:56 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:57:56 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:57:56 INFO - Running setup.py install for mozfile 01:57:56 INFO - Running setup.py install for mozhttpd 01:57:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:57:56 INFO - Running setup.py install for mozinfo 01:57:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:57:56 INFO - Running setup.py install for mozInstall 01:57:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:57:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:57:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:57:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:57:56 INFO - Running setup.py install for mozleak 01:57:56 INFO - Running setup.py install for mozlog 01:57:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:57:56 INFO - Running setup.py install for moznetwork 01:57:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:57:56 INFO - Running setup.py install for mozprocess 01:57:57 INFO - Running setup.py install for mozprofile 01:57:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:57:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:57:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:57:57 INFO - Running setup.py install for mozrunner 01:57:57 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:57:57 INFO - Running setup.py install for mozscreenshot 01:57:57 INFO - Running setup.py install for moztest 01:57:57 INFO - Running setup.py install for mozversion 01:57:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:57:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:57:57 INFO - Cleaning up... 01:57:57 INFO - Return code: 0 01:57:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fe50e2f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b66630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf7840>, '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 0x1b646b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b64b60>, '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': '5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069', '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 01:57:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 01:57:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 01:57:57 INFO - Using env: {'DISPLAY': ':0', 01:57:57 INFO - 'HOME': '/home/cltbld', 01:57:57 INFO - 'LANG': 'en_US.UTF-8', 01:57:57 INFO - 'LANGUAGE': 'en_US:en', 01:57:57 INFO - 'LOGNAME': 'cltbld', 01:57:57 INFO - 'MAIL': '/var/mail/cltbld', 01:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:57 INFO - 'MOZ_NO_REMOTE': '1', 01:57:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:57 INFO - 'NO_EM_RESTART': '1', 01:57:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:57:57 INFO - 'PWD': '/builds/slave/test-pgo', 01:57:57 INFO - 'SHELL': '/bin/bash', 01:57:57 INFO - 'SHLVL': '1', 01:57:57 INFO - 'TERM': 'linux', 01:57:57 INFO - 'TMOUT': '86400', 01:57:57 INFO - 'USER': 'cltbld', 01:57:57 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069', 01:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:57 INFO - '_': '/tools/buildbot/bin/python'} 01:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:57:57 INFO - Running setup.py (path:/tmp/pip-oQxPf8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:57:57 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)) 01:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:57:57 INFO - Running setup.py (path:/tmp/pip-gY3w2e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:57:57 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)) 01:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:57:57 INFO - Running setup.py (path:/tmp/pip-7qHRuU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:57:58 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)) 01:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:57:58 INFO - Running setup.py (path:/tmp/pip-bNnloA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:57:58 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)) 01:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:57:58 INFO - Running setup.py (path:/tmp/pip-RiJtoI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:57:58 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)) 01:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:57:58 INFO - Running setup.py (path:/tmp/pip-7y8wv6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:57:58 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)) 01:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:57:58 INFO - Running setup.py (path:/tmp/pip-2sF3gd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:57:58 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)) 01:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:57:58 INFO - Running setup.py (path:/tmp/pip-GWuhAd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:57:58 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)) 01:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:57:58 INFO - Running setup.py (path:/tmp/pip-8pEn8L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:57:58 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)) 01:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:57:58 INFO - Running setup.py (path:/tmp/pip-R5FAQE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:57:58 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)) 01:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:57:58 INFO - Running setup.py (path:/tmp/pip-EKgulz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:57:58 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)) 01:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:57:58 INFO - Running setup.py (path:/tmp/pip-lPLvXY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:57:58 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)) 01:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:57:58 INFO - Running setup.py (path:/tmp/pip-LseN1P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:57:58 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)) 01:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:57:58 INFO - Running setup.py (path:/tmp/pip-ijkIJP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:57:58 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)) 01:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:57:58 INFO - Running setup.py (path:/tmp/pip-heAz1w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:57:58 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)) 01:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:57:58 INFO - Running setup.py (path:/tmp/pip-hf7xJd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:57:58 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)) 01:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:57:58 INFO - Running setup.py (path:/tmp/pip-XnalF1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:57:59 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)) 01:57:59 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)) 01:57:59 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)) 01:57:59 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)) 01:57:59 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)) 01:57:59 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)) 01:57:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:00 INFO - Downloading blessings-1.5.1.tar.gz 01:58:00 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 01:58:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:58:00 INFO - Installing collected packages: blessings 01:58:00 INFO - Running setup.py install for blessings 01:58:00 INFO - Successfully installed blessings 01:58:00 INFO - Cleaning up... 01:58:00 INFO - Return code: 0 01:58:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:58:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:58:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:58:01 INFO - Reading from file tmpfile_stdout 01:58:01 INFO - Current package versions: 01:58:01 INFO - argparse == 1.2.1 01:58:01 INFO - blessings == 1.5.1 01:58:01 INFO - blobuploader == 1.2.4 01:58:01 INFO - docopt == 0.6.1 01:58:01 INFO - manifestparser == 1.1 01:58:01 INFO - mozInstall == 1.12 01:58:01 INFO - mozcrash == 0.16 01:58:01 INFO - mozdebug == 0.1 01:58:01 INFO - mozdevice == 0.47 01:58:01 INFO - mozfile == 1.2 01:58:01 INFO - mozhttpd == 0.7 01:58:01 INFO - mozinfo == 0.9 01:58:01 INFO - mozleak == 0.1 01:58:01 INFO - mozlog == 3.1 01:58:01 INFO - moznetwork == 0.27 01:58:01 INFO - mozprocess == 0.22 01:58:01 INFO - mozprofile == 0.28 01:58:01 INFO - mozrunner == 6.11 01:58:01 INFO - mozscreenshot == 0.1 01:58:01 INFO - mozsystemmonitor == 0.0 01:58:01 INFO - moztest == 0.7 01:58:01 INFO - mozversion == 1.4 01:58:01 INFO - psutil == 3.1.1 01:58:01 INFO - requests == 1.2.3 01:58:01 INFO - wsgiref == 0.1.2 01:58:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fe50e2f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b66630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf7840>, '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 0x1b646b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b64b60>, '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': '5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069', '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 01:58:01 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 01:58:01 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 01:58:01 INFO - Using env: {'DISPLAY': ':0', 01:58:01 INFO - 'HOME': '/home/cltbld', 01:58:01 INFO - 'LANG': 'en_US.UTF-8', 01:58:01 INFO - 'LANGUAGE': 'en_US:en', 01:58:01 INFO - 'LOGNAME': 'cltbld', 01:58:01 INFO - 'MAIL': '/var/mail/cltbld', 01:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:01 INFO - 'MOZ_NO_REMOTE': '1', 01:58:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:01 INFO - 'NO_EM_RESTART': '1', 01:58:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:58:01 INFO - 'PWD': '/builds/slave/test-pgo', 01:58:01 INFO - 'SHELL': '/bin/bash', 01:58:01 INFO - 'SHLVL': '1', 01:58:01 INFO - 'TERM': 'linux', 01:58:01 INFO - 'TMOUT': '86400', 01:58:01 INFO - 'USER': 'cltbld', 01:58:01 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069', 01:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:01 INFO - '_': '/tools/buildbot/bin/python'} 01:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:01 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)) 01:58:01 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)) 01:58:01 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)) 01:58:01 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)) 01:58:01 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)) 01:58:01 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)) 01:58:01 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)) 01:58:01 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)) 01:58:01 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)) 01:58:01 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)) 01:58:01 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)) 01:58:01 INFO - Cleaning up... 01:58:01 INFO - Return code: 0 01:58:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 01:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe50e2f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b66630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf7840>, '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 0x1b646b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b64b60>, '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': '5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069', '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 01:58:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 01:58:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:58:01 INFO - Using env: {'DISPLAY': ':0', 01:58:01 INFO - 'HOME': '/home/cltbld', 01:58:01 INFO - 'LANG': 'en_US.UTF-8', 01:58:01 INFO - 'LANGUAGE': 'en_US:en', 01:58:01 INFO - 'LOGNAME': 'cltbld', 01:58:01 INFO - 'MAIL': '/var/mail/cltbld', 01:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:01 INFO - 'MOZ_NO_REMOTE': '1', 01:58:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:01 INFO - 'NO_EM_RESTART': '1', 01:58:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:58:01 INFO - 'PWD': '/builds/slave/test-pgo', 01:58:01 INFO - 'SHELL': '/bin/bash', 01:58:01 INFO - 'SHLVL': '1', 01:58:01 INFO - 'TERM': 'linux', 01:58:01 INFO - 'TMOUT': '86400', 01:58:01 INFO - 'USER': 'cltbld', 01:58:01 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069', 01:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:01 INFO - '_': '/tools/buildbot/bin/python'} 01:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:01 INFO - Downloading/unpacking jsonschema 01:58: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 01:58: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 01:58: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 01:58: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 01:58: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 01:58: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 01:58:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:58:03 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 01:58:03 INFO - Downloading/unpacking functools32 (from jsonschema) 01:58: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 01:58: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 01:58: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 01:58: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 01:58: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 01:58: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 01:58:03 INFO - Downloading functools32-3.2.3-2.tar.gz 01:58:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 01:58:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:58:03 INFO - warning: no files found matching '*.txt' 01:58:03 INFO - no previously-included directories found matching 'build' 01:58:03 INFO - no previously-included directories found matching 'dist' 01:58:03 INFO - no previously-included directories found matching '.git*' 01:58:03 INFO - Installing collected packages: jsonschema, functools32 01:58:03 INFO - Running setup.py install for functools32 01:58:03 INFO - warning: no files found matching '*.txt' 01:58:03 INFO - no previously-included directories found matching 'build' 01:58:03 INFO - no previously-included directories found matching 'dist' 01:58:03 INFO - no previously-included directories found matching '.git*' 01:58:03 INFO - Successfully installed jsonschema functools32 01:58:03 INFO - Cleaning up... 01:58:03 INFO - Return code: 0 01:58:03 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 01:58:03 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')]} 01:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:03 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')]} 01:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:03 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 0x7fe50e2f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b66630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf7840>, '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 0x1b646b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b64b60>, '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': '5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069', '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 01:58:03 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 01:58:03 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 01:58:03 INFO - Using env: {'DISPLAY': ':0', 01:58:03 INFO - 'HOME': '/home/cltbld', 01:58:03 INFO - 'LANG': 'en_US.UTF-8', 01:58:03 INFO - 'LANGUAGE': 'en_US:en', 01:58:03 INFO - 'LOGNAME': 'cltbld', 01:58:03 INFO - 'MAIL': '/var/mail/cltbld', 01:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:03 INFO - 'MOZ_NO_REMOTE': '1', 01:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:03 INFO - 'NO_EM_RESTART': '1', 01:58:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:58:03 INFO - 'PWD': '/builds/slave/test-pgo', 01:58:03 INFO - 'SHELL': '/bin/bash', 01:58:03 INFO - 'SHLVL': '1', 01:58:03 INFO - 'TERM': 'linux', 01:58:03 INFO - 'TMOUT': '86400', 01:58:03 INFO - 'USER': 'cltbld', 01:58:03 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069', 01:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:03 INFO - '_': '/tools/buildbot/bin/python'} 01:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:03 INFO - Downloading/unpacking flake8 01:58: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 01:58: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 01:58: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 01:58: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 01:58: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 01:58: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 01:58:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:58:05 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 01:58:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:58: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 01:58: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 01:58: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 01:58: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 01:58: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 01:58: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 01:58:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:58:05 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 01:58:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:58: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 01:58: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 01:58: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 01:58: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 01:58: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 01:58: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 01:58:06 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 01:58:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:58:06 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 01:58:06 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 01:58:06 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 01:58:06 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 01:58:06 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 01:58:06 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 01:58:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 01:58:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 01:58:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:58:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:58:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:58:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:58:06 INFO - no previously-included directories found matching 'docs/_build' 01:58:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:58:06 INFO - Running setup.py install for pep8 01:58:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:58:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:58:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:58:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:58:06 INFO - no previously-included directories found matching 'docs/_build' 01:58:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 01:58:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:58:06 INFO - Cleaning up... 01:58:06 INFO - Return code: 0 01:58:06 INFO - Running post-action listener: _resource_record_post_action 01:58:06 INFO - Running post-action listener: _start_resource_monitoring 01:58:06 INFO - Starting resource monitoring. 01:58:06 INFO - ##### 01:58:06 INFO - ##### Running install step. 01:58:06 INFO - ##### 01:58:06 INFO - Running pre-action listener: _resource_record_pre_action 01:58:06 INFO - Running main action method: install 01:58:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:58:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:58:06 INFO - Reading from file tmpfile_stdout 01:58:06 INFO - Detecting whether we're running mozinstall >=1.0... 01:58:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:58:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:58:06 INFO - Reading from file tmpfile_stdout 01:58:06 INFO - Output received: 01:58:06 INFO - Usage: mozinstall [options] installer 01:58:06 INFO - Options: 01:58:06 INFO - -h, --help show this help message and exit 01:58:06 INFO - -d DEST, --destination=DEST 01:58:06 INFO - Directory to install application into. [default: 01:58:06 INFO - "/builds/slave/test-pgo"] 01:58:06 INFO - --app=APP Application being installed. [default: firefox] 01:58:06 INFO - mkdir: /builds/slave/test-pgo/build/application 01:58:06 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'] 01:58:06 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 01:58:22 INFO - Reading from file tmpfile_stdout 01:58:22 INFO - Output received: 01:58:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:58:22 INFO - Running post-action listener: _resource_record_post_action 01:58:22 INFO - ##### 01:58:22 INFO - ##### Running run-tests step. 01:58:22 INFO - ##### 01:58:22 INFO - Running pre-action listener: _resource_record_pre_action 01:58:22 INFO - Running main action method: run_tests 01:58:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:58:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:58:22 INFO - Python 2.7.3 01:58:22 INFO - Return code: 0 01:58:22 INFO - grabbing minidump binary from tooltool 01:58:22 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')]} 01:58:22 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 0x1bf7840>, '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 0x1b646b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b64b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:58:22 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 01:58:22 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 01:58:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:58:22 INFO - Return code: 0 01:58:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:58:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:58:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:58:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:58:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:58:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 01:58:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 01:58:23 INFO - Return code: 0 01:58:23 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/pPWBpeJDRhKNLqzVbD2N8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 01:58:23 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/pPWBpeJDRhKNLqzVbD2N8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 01:58:23 INFO - Using env: {'DISPLAY': ':0', 01:58:23 INFO - 'HOME': '/home/cltbld', 01:58:23 INFO - 'LANG': 'en_US.UTF-8', 01:58:23 INFO - 'LANGUAGE': 'en_US:en', 01:58:23 INFO - 'LOGNAME': 'cltbld', 01:58:23 INFO - 'MAIL': '/var/mail/cltbld', 01:58:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:58:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:23 INFO - 'MOZ_NO_REMOTE': '1', 01:58:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:58:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:23 INFO - 'NO_EM_RESTART': '1', 01:58:23 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:58:23 INFO - 'PWD': '/builds/slave/test-pgo', 01:58:23 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:58:23 INFO - 'SHELL': '/bin/bash', 01:58:23 INFO - 'SHLVL': '1', 01:58:23 INFO - 'TERM': 'linux', 01:58:23 INFO - 'TMOUT': '86400', 01:58:23 INFO - 'USER': 'cltbld', 01:58:23 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069', 01:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:23 INFO - '_': '/tools/buildbot/bin/python'} 01:58:23 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/pPWBpeJDRhKNLqzVbD2N8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 01:58:23 INFO - mozversion application_buildid: 20151221233003 01:58:23 INFO - mozversion application_changeset: d99479b6d7f8d60943f40f11a4d5c21d551741b1 01:58:23 INFO - mozversion application_display_name: Nightly 01:58:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:58:23 INFO - mozversion application_name: Firefox 01:58:23 INFO - mozversion application_remotingname: firefox 01:58:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 01:58:23 INFO - mozversion application_vendor: Mozilla 01:58:23 INFO - mozversion application_version: 46.0a1 01:58:23 INFO - mozversion platform_buildid: 20151221233003 01:58:23 INFO - mozversion platform_changeset: d99479b6d7f8d60943f40f11a4d5c21d551741b1 01:58:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 01:58:23 INFO - mozversion platform_version: 46.0a1 01:58:23 INFO - using testdate: 1450778303 01:58:23 INFO - actual date: 1450778303 01:58:23 INFO - starting webserver on 'localhost:49827' 01:58:23 INFO - SUITE-START | Running 3 tests 01:58:23 INFO - TEST-START | dromaeo_css 01:58:23 INFO - operating with platform_type : linux_ 01:58:23 INFO - Initialising browser for dromaeo_css test... 01:58:23 INFO - TEST-INFO | started process 22108 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEuheOn/profile http://localhost:49827/getInfo.html) 01:58:27 INFO - PROCESS | 22108 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 01:58:27 INFO - PROCESS | 22108 | __metrics Screen width/height:1600/1200 01:58:27 INFO - PROCESS | 22108 | colorDepth:24 01:58:27 INFO - PROCESS | 22108 | Browser inner width/height: 1024/697 01:58:27 INFO - PROCESS | 22108 | __metrics 01:58:28 INFO - PROCESS | 22108 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:58:28 INFO - PROCESS | 22108 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:58:28 INFO - TEST-INFO | 22108: exit 0 01:58:28 INFO - Browser initialized. 01:58:28 INFO - Running cycle 1/1 for dromaeo_css test... 01:58:28 INFO - TEST-INFO | started process 22200 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEuheOn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:58:40 INFO - PROCESS | 22200 | RSS: Main: 149856256 01:58:40 INFO - PROCESS | 22200 | 01:59:32 INFO - PROCESS | 22200 | 1450778372423 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] 02:01:40 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:49827/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49827/tests/dromaeo/cssquery-ext.html) 02:01:42 INFO - PROCESS | 22200 | RSS: Main: 248307712 02:01:42 INFO - PROCESS | 22200 | 02:04:44 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:49827/tests/dromaeo/cssquery-ext.html (next: http://localhost:49827/tests/dromaeo/cssquery-jquery.html) 02:04:45 INFO - PROCESS | 22200 | RSS: Main: 243744768 02:04:45 INFO - PROCESS | 22200 | 02:07:47 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:49827/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49827/tests/dromaeo/cssquery-mootools.html) 02:07:47 INFO - PROCESS | 22200 | RSS: Main: 235945984 02:07:47 INFO - PROCESS | 22200 | 02:10:49 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:49827/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49827/tests/dromaeo/cssquery-prototype.html) 02:10:49 INFO - PROCESS | 22200 | RSS: Main: 218558464 02:10:49 INFO - PROCESS | 22200 | 02:13:52 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:49827/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49827/tests/dromaeo/cssquery-yui.html) 02:13:53 INFO - PROCESS | 22200 | RSS: Main: 220016640 02:13:53 INFO - PROCESS | 22200 | 02:16:55 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:49827/tests/dromaeo/cssquery-yui.html (next: http://localhost:49827/tests/dromaeo/cssquery-dojo.html) 02:16:55 INFO - PROCESS | 22200 | RSS: Main: 276832256 02:16:55 INFO - PROCESS | 22200 | 02:16:55 INFO - PROCESS | 22200 | __start_tp_report 02:16:55 INFO - PROCESS | 22200 | _x_x_mozilla_page_load 02:16:55 INFO - PROCESS | 22200 | _x_x_mozilla_page_load_details 02:16:55 INFO - PROCESS | 22200 | |i|pagename|runs| 02:16:55 INFO - PROCESS | 22200 | |0;dojo.html;3142.2772762264676;3188.665190155035;3232.1596384939908;3235.854386552605;3249.805011699298;5072.13773658478;5162.870928226796;5375.817320189557;5384.649997750148;5429.511343979037;5263.789448422059;5298.178782288752;5324.520793128618;5390.838274851751;5391.757370918308;4758.619310455155;4760.928586071203;4777.450593181794;4821.421429428474;4958.231474121517;4965.503449655042;4969.155243608595;5021.1213037718435;5033.471485494026;5042.268871013701;4752.12085764133;4797.280407938802;4850.8059677612855;4861.052094841507;4882.41411030675;4851.345068415754;4939.629527785394;4949.851504454872;4959.925601115986;4980.800767969277;4922.975385123052;4941.431735350445;4957.5786058185095;4965.627577931669;4969.155243608595;5008.899822003539;5101.795928162869;5143.845684629429;5243.449437809013;5348.224507446437;5851.590388672795;5872.882542349129;5874.618149820248;5882.735276912549;5887.8528036799;5888.263967004124;5921.289445266596;5929.288485381739;5936.436038576328;5939.079442686348;5352.866178345534;5411.188321751769;5419.105847535152;5426.240326354314;5554.416786237387;5816.156657284755;5842.8539286517325;5846.444587764156;5850.678212698257;5896.204012458349;5655.4910058094965;5659.3208814941645;5659.547236221175;5661.150827375926;5668.489835914787;5514.751836167382;5571.721413929287;5617.354004289559;5772.509336706427;5917.763289468373;5820.330661973842;5838.416158384128;5841.795537156179;5849.532037436995;5879.059350503899;5866;5874.060150375919;5880.323762767251;5882.264716910387;5888.087346461305;4353.521112677603;4412.977935110304;4426.402435671208;4488.977555112204;4492.9550704493195;3914.823832927525;3914.921701565953;3937.488126543531;3987.980060099681;4062.1875624875142;5350.839474815762;5358.33020872391;5360.014293371492;5385.219143224211;5402.243685883979;5753.05074662676;5826.446487583673;5899.321578018497;5943.435373639497;5951.404859514014;5347.812826551052;5422.864428389322;5432.59255555827;5446.046941785251;5475.06923822951;4978.5270399312;4994.40067191932;5008.899822003539;5030.622703297267;5044.066847633199;5751.539876809845;5792.855178620568;5827.125931110368;5871.089981052944;5890.558208134321;5661.2923384576925;5683.545316374597;5694.544436444991;5704.486596206361;5768.134779783066;5878.147668588116;5922.3485416605;5937.990541607851;5941.049432090845;5948.702564871825;5592.496675299242;5758.337791153904;5770.221020162392;5775.682337471311;5784.913226301693;5717.056685646988;5848.56135789826;5887.558433117619;5892;5905.4685078343155;5684.488396044376;5686.374498805046;5712.685802280915;5782.797602083907;5813.651180929158;5769.884602308014;5778.104393818965;5790;5790.884182316414;5794.0439827428;5336.893262134813;5449.291592093161;5546.916796248141;5679.801206957902;5702.201691763239;5534.308211473566;5610.158476228435;5611.242333419371;5616.747246373841;5634.802781902614;5602.215689803512;5641.294838145232;5645.520130788765;5646.265985421869;5652.293463317085 02:16:55 INFO - PROCESS | 22200 | |1;ext.html;596.7732261740539;610.1031483718932;615.1603061820615;618.8700372921686;628.136312570216;30318.393632127343;38080.61919380805;38558;38737.225255494945;38747.806260968726;42976.57023429765;43349.133017339635;43495.13009739811;43594;43611.78194109025;7520.210377910295;8623.223909848128;8796.076411976746;8801.207891289783;8852.159044890757;7635.198304178037;7741.071071471403;7741.419393545507;10386.27296089274;10531.420771857545;10157.18742500602;10262;10308;10364.948175259113;10372.429516376596;10167.59329626814;10266.538005789682;10267.897321026843;10277.280590358641;10286.53710583018;7631.046119235096;7786.7663970080985;10025.949870250603;10251.948740256326;10584.629537966212;40182.196356072716;40682.593174068475;40701.185976280605;40726.79636601828;40755.796221019;3361.680640339164;3431.9485207721655;3488.6162522122545;3715.692057559521;3826.4069069294305;30600.8469957651;30833.69166308353;30989.690103099132;31097.844510777526;31132.688673113207;3944.8224829882724;4016.2770701273757;4058.350663893763;4061.591171666464;4172.415861779354;270558;272866;273345;273458;274675.6266218676;54836.725816370665;56166.719166403906;61871;62155;62224;69958.65020674966;71281;71300;71990.64004679942;72030.63984680043;15048;15269.160196189316;15285.159316237492;15288.694226115414;15300.311485983157;11278.774424511465;11357;11372;11382.032527235278;11384.918432748877;20048.799512004985;20200.29298974529;20239.797602024086;20364.741641337314;20378.89810550938;7841.098273698598;8086.5148091114725;8091.109977902426;8158.673653053811;8178.877316840252;898.9235914947172;918.5453200665713;1004.1213937804421;1005.1857995024054;1010.9789112995927;28047.859760701474;28424.857875710488;28768.71231287702;29123.12630621085;33276.168095797315;1005.1154983614373;1019.918406527476;1039.896010398954;1077.2459278505078;1173.7535117625393;14472.348744306531;14597.708045839025;14653.633659158393;14814.555563333117;14896.0317579357;410041;414739;415043;416144;417375;55383.446165537825;55616.72191639016;55822.441775582534;55936.44063559312;55979.44020559742;1328.7076843094503;1341.805438211454;1353.8104665346661;1357.5587933921515;1359.1029920252784;27285;28298;28382.148535543965;33097.83451082729;33406.498902515996;50335.74832125816;50850.74574627103;50861.237081444546;50957.74521127371;51053.23420148775;302695;305599;306163;306484;307313;36538.451923221706;38137.237255254186;38607;42747.5725242756;45050.77474612737;44209;44299.33550996802;44893.32660010037;45127.54872451365;45141;35175.47236791399;37119.257614848095;37789.43315850209;38502.22995540129;38647.42028869625;30633.83438424486;37073.814630926674;38136.809315953244;38571.80714096411;42678.359824602034;35416.64583354237;35893.641063590076;36341.45487817632;36436.45345319875;36758.63241367552;33332;33936.32127357488;34081.829590851885;34457.65542344645;34619;23541;23721.288361349187;23816.832054390066;23953.880230599432;23969.640455392833 02:16:55 INFO - PROCESS | 22200 | |2;jquery.html;343.71299964529635;358.8223829204544;360.31360258707156;361.0522378755766;361.3712140874877;13862.4455021799;14320.570382888503;16489.83510164898;17169.399071032516;18015.099245037727;14149;14405;16103.758443623356;16181.676366472664;16670.49988500344;5216.061109000379;5353.705546194958;5355.009323275207;5358.732063396834;5368.677879327233;3938.3304838177437;3999.94001589579;5156.845294641148;5242.737863106849;5375.19372094187;5649.519790817785;5781.39295373986;5801.506871915871;5821;5823.126531020339;5351.785928562853;5368.731563421813;5531.640443371188;5770.365259821417;5777.855553611152;5102.285680004765;5110.591152707774;5123.3339665843205;5147.871303217412;5190.610704197163;20030.39908802738;20116.698249526267;20125.698114528295;20511.077001534966;20816.063277152563;2214.125420458926;2230.4535388829677;2293.564222797663;2647.874653272371;2688.5160671079198;13237.73524529504;13316.334183290797;13337.399817008161;13470.663233419145;13490.797638035438;1807.7469154318405;1824.7536582561318;1866.9813301866943;1874.6157037807218;1874.8875067495994;58485;61306.69346653238;61381.69309153515;61569.692151538955;61647.691761541355;9636.75908102289;9720.805583888425;9854.704358869245;9964.352317099365;9992.15066719337;13167.60497185086;13170.670733231746;13203.66990825237;13210.141340812816;13216.603501894959;7318.780436586911;7361.963190184015;7446.73936412223;7477.588732619758;7603.315701586773;7129.821754456077;7143.607101609357;7183.89224161638;7192.496525243183;7210.1708303545765;5872.677002764889;5897.76408943646;6001.909971350433;6002;6052.243469566304;1544.2047345617016;1606.2932309783657;1720.6472673101985;1728.2568495546784;1756.5872020075271;834.3116928533984;921.7695576105973;935.9719208423758;1011.7976404719086;1092;16825.831741682672;17606.503805842247;18541.44375668732;18660;18720.438386848415;805.9838803223903;943.5093751249312;963.6482683820356;967;1028.619410818002;8312.916870831214;9864.256558601606;10040.14658754014;10167.644132455329;10367.844482332772;575323;591836;595178;599452;641001;77865;78572;80885;81869;82117.17882821214;1109.1681239070697;1124.359115304285;1124.7862906047824;1134.9445016135073;1152.0725815718426;15260.313285901939;15431.15128667889;15433.768493472382;15640.139792311533;15965.361385544447;31748;32047.839760801045;33069.83465082659;33385.499217512246;33801.661983379854;38077.428838568;39907.80046099751;40608.59391406048;42291.788541057096;43481.130377391644;9801.950990245003;9922.156616687662;10088.243381746252;10119.139873110573;10228.693139205836;17544;17994.370197043565;18068.096595170453;18228.270869165615;18294;14759.704805903608;14893.553193404216;15101.697966040838;15289.694206115593;15300.617484562976;13862.237576933365;13932.721345572829;14474.85525144735;14664.633384165481;14666.26668666541;12040.096992725405;15198.544043678707;15286.235688215767;15418.845811542189;15693.253680606076;8232.670693172446;9371.203447707021;9527.714168574954;9613.711588652352;9663.082007209305;10130.138938190335;10246.948765256126;11286.717832054264;13990.860091398956;14499.92750036243 02:16:55 INFO - PROCESS | 22200 | |3;mootools.html;1294.7798874191387;1350.183139200784;1366.139332220701;1463.7584798508246;1736.7134422820227;6493.675316234187;7022.227554968956;7179.82050448739;7184.964075179623;7198.388137008361;7078.929210707892;7201.207867134611;7219.81950451239;7264.237255088219;7280.927190728091;2167.4798048468333;2201.0755482697227;2201.625723626987;2202.4053505553493;2203.6584329428883;2233.832462565306;2267.6031694453486;2292.128990983424;2292.4612716011725;2293.3463962770616;2131.8507704460694;2165.1339464214284;2176.706144670473;2205.371469131298;2207.558488302338;2152.9354119376444;2160.5246845693923;2185.4754858833926;2185.595664802017;2186.355025267542;2243.955120897589;2260.6382978723327;2267.807236384909;2272.3750968483632;2275.7838005389463;7090.326418990187;7148.177959534668;7149.571025738473;7150.10623672041;7168.784936451915;4489.506154323022;4565.383673204108;4588.311753237008;4592.33411155384;4593.655475839292;2968.1392396205074;3106.9689303106907;3113.501839705636;3133.8433078345993;3138.0585824252635;974.9171320437771;979.4466126638426;982.882054153499;1012.8430093335545;1022.4018948914894;9878.110970012733;9892.703218903445;9921.851172232422;9933.106020458194;9942.602295908227;4049.372347286175;4069.491313585802;4107.424960505532;4111.321631930698;4111.321631930758;8635.093315201939;8642.654293828302;8643.91356086431;8656.177663121993;8657.523836188944;4512.548745125527;4532.138893610204;4546.818127274938;4549.044700612908;4553.590176884097;3650.762700424464;3783.243351329745;4113.259613269581;4144.316187828975;4153.086321009373;3664.2121943782213;3675.779453232761;3679.466477360768;3691.778493290411;3724.8696295629525;1193.8806119387991;1212.1817773003363;1212.9818052729215;1222.2544248008708;1224.161449407159;1282.1537785061814;1282.8396450443695;1288.3429450980068;1290.470906928155;1308.188922867809;6881.243063263037;7060.082189315459;7077.610731409822;7083.610401427868;7106.502544821917;1036.3056751976194;1052.1582733812918;1117.3519358771894;1136.4942600542845;1158.9420528973517;5628.380878103405;5668.461496157858;5672.546196304285;5674.943250567524;5681.346645135863;8627.784305392415;8632.525211113323;8827.16141966512;8832.293416526663;8969.282457403391;8844.33667474942;8912.509811960404;8916.108389161032;8923.15230053144;8936.8659470108;6851.143607049119;6926.896096558556;6954.721811127498;7016.999999999898;7075.575465472089;6766.221884483348;6771.187457505131;6798.388145066968;6799.762008329685;6804.217514985642;7296.927030729625;7462.067241594801;7488.251174882468;7526.360259378014;7891.605419729105;7709.3447057000785;7794.6882124714375;7907.802304942423;7951.880721789062;7960.363170946426;5874.471297583238;5910.320313164041;5980.641161530322;6437.742490300336;6515.446187074152;7084.043654106629;7116.359527642537;7143.749968751069;7143.785686429415;7153.964230178815;6587.736490540325;6734.797956061326;6763.797086087426;6780.355866192704;6834.179898412222;6635.900461493178;6662.233843108104;6703.66481675924;6747.898781518379;6762.256151823197;6618.900716489353;6632.071509988509;6673.499487538357;6676.866462670622;6678.699458524476;6126.356732543019;6188.628682279078;6190.102435146969;6202.224721909762;6202.317745048132;6219.378062193744;6318.6840657965995;6331.9050214247745;6337.397947195009;6340.207474065742 02:16:55 INFO - PROCESS | 22200 | |4;prototype.html;322.3520723346075;336.27532667102395;339.3772427595362;342.14634486955043;348.86568671061633;5845.473907348338;5929.288485381755;6000.639961602302;6023.277206735198;6034.607750496215;5764.510016648579;5876.294844618641;5913.970430147843;5931.051031834907;5940.940590594093;4579.061292435051;4584.266517357223;4590.862274131781;4594.494605593382;4597.149527337437;4374.081442896995;4441.866743997685;4472.44094488189;4563.840265590705;4572.268437050073;4525.660575456837;4548.476925153616;4550.954490455086;4562.064776720781;4568.291914753218;4548.863534093983;4551.340055691906;4552.453705555321;4553.817847286105;4556.794944227518;3993;4000.0399904023116;4000.0599859033105;4006.759594424315;4011.097503061817;5606.943930560683;5693.373728889819;5696.088625819849;5700.857478563028;5747.080467125282;5348.893022139536;5389.83830485086;5399.406065332811;5399.514043736082;5402.459754024605;6080.574359794816;6368.140301059344;6392.808215753535;6394.6482943438095;6412.519061070392;4359.716618419824;4419.801108950105;4423.955760442386;4480.215962206601;4508.233600287959;6482.157319548429;6580.111684922522;6583.210014798207;6587;6587.3083326250535;4538.9546104539195;4542.432195975503;4543.227651299287;4545.0909818036525;4547.454305483363;4533.455985281787;4596.333531637961;4603.631709463235;4627.606653434428;4639.9536004640195;5298;5319.813806516753;5323.387810401776;5325.201219817059;5325.4940780625775;6371.55399122057;6408.391202835724;6423.518236132215;6427.100205971168;6428.325025872309;1626.1706529669716;1627.8209396966324;1631.8449747274228;1632.4776071657193;1635.1742370103022;1079.849959792834;1092.2845536173818;1105.7346236903086;1107.1253709569512;1109.9001089901785;5994.910076348859;6010.879782404328;6072.05883088122;6072.271327440735;6079.179310793074;6541.705623246965;6551.868962620721;6563.343665633399;6566.671666416755;6598.835029124214;5949.286085669661;6068.484178844759;6075.027995520695;6076.240469941257;6077.058056001327;3556.110972256936;3579.1410061585034;3579.302036102935;3587.766795158306;3588.2285308658766;6656.234533028667;6666.666666666744;6670.466362690973;6686.699098540577;6687.4984376171005;6623.4038936495945;6752.729890804313;6757.121574195323;6770.458363330922;6771.289014653489;6627.237867645283;6635.402813746689;6635.402813746786;6635.971424429221;6639.203295604559;6403.359664033559;6529.347065293433;6543.214814222324;6559.573627714374;6572.079908812674;6406.647634380154;6478.773242936474;6545.14913061299;6615.636140012153;6628.933710662832;6640.501962352746;6682.131322927989;6723.411486577605;6724.260331363644;6742.089817874524;4536.954630453785;4644.86065418038;4647.744374059459;4649.5815376616265;4652.860414187579;6643.069970204078;6650.068990341259;6650.966745166436;6652.301508341555;6654.600723956578;6459.580127291711;6462.4183823456115;6466.385693359123;6471.870562588628;6475.740970361321;6321.715522801393;6453.612783233021;6463.935360646334;6464.644444555594;6469.5794773339585;6309.621422714652;6327.778527751507;6350.90473642905;6354.364563543793;6355.491560675043;6487.18910136233;6496.155499785186;6500.642464664489;6506.642134682638;6508.251551071688;6095.481884039907;6233.96883015582;6262.2172228471445;6337.8732425352155;6343.9365606343345 02:16:55 INFO - PROCESS | 22200 | |5;yui.html;830.9958450207748;837.5979529825684;838.7119213359764;839.1943734015341;842.2461896602537;12929.741405171892;13373.063885528018;13382.799258011137;13425.261610611426;13433.395497202624;12906.483740650363;13454.932725336384;13513.324333783296;13514.054016218868;13521.59435216945;691.0049528678686;698.552926127279;810.3841080778607;815.8980127484065;818.3698552114868;818.7707441916243;825.005867929144;829.784256093414;831.4387788242942;832.1927730101792;865.9997702653445;866.9566521673922;871.4945331707626;872.040755169315;872.071244125008;717.3722992381666;725.1044959475071;857.6269322844582;866.1035827918106;869.4522450855984;636.0395802338456;636.2428709835281;637.4613451633362;638.6487431912429;639.3191251317332;13540.526081587097;13689;13792.172469651752;13803.2408217549;13805;11634.825477617842;12058.155929084967;12290.692732681666;12467;12738.172018818746;10622.203334749847;10668.359898406121;10675;10778.461076946121;10840.241183117185;3590.0845284452557;3638.599754027055;3657.652523010336;3687.520622319081;3769.5664998525244;44015.55984440147;44059.55940440587;44073.77963110196;44135.117297654186;44229.77885110554;9449.244060475145;9704.223662107015;9911.256655750703;9924.801503970024;10018.949905250427;18465;18532.907335463507;18667.066646667612;18672.25310987545;18682;7508.324250817453;7515.060617422822;7547.207543207884;7584.089909210819;7598.240175982468;4034.778087205173;4047.2714911315657;4142.647874930664;4166.91666166675;4169.812358443877;3083.8612262448246;3103.177657920653;3115.096621979646;3121.625404951375;3123.703248191418;580.4166812353558;587.3744462147799;587.7877400008887;599.658194828952;603.4116736182187;603.2670305578743;618.5082859127004;671.8454755406284;685.8662560800595;706.2619562557037;8609.526476043879;8678.349123815738;8761.849757030146;8880.333974951904;9126.406783559047;666.8766278238444;684.8767221900106;686.0977814174345;698.183125742882;701.2846896165984;3903.5706072332023;4130.256553820341;4189.371594260824;4190.727602705875;4202.138561594866;54093.45906540884;63396;64381.67809160924;64679.35320646827;64719.67640161769;47288.527114728415;47422.28866567004;47551;47855.760721196864;48944.51055489471;44189.77905110454;44877;44916;45778.31332530015;46292.61122166273;8660.48037117775;8691.91308086911;8923;9023.503707296162;9147.359684821999;34031.31937361189;35269.29461410809;35902.10244743902;36078.63921360858;36314.63685363113;42008.1598368037;42222.78888605537;42645.36031959585;43473.34789978089;43537.56462435335;10846.783064338826;10968.835467468154;11043.116550675766;11137.554497819996;11374.31754094757;12316.199447035913;12448.564300249447;12541.122121451412;12576.182548134342;12911.935440322739;11867.228630139014;11940.582079627171;12063.396830158632;12161.270323780247;12538.749225015632;11924.344161070878;12035.578754743541;12322.199057061622;12461.314627695201;12704.936475317565;11080.889191107986;11096.278741881752;11608.477618507357;11762.882371176178;11932.76134477323;9950.751231219278;10091.41529940724;10183.592656293666;10322.12261957712;10434.21743369235;9000.984670135578;9248.815023699353;10003;10043.34718243341;10121.595136194765 02:16:55 INFO - PROCESS | 22200 | __end_tp_report 02:16:55 INFO - PROCESS | 22200 | __start_cc_report 02:16:55 INFO - PROCESS | 22200 | _x_x_mozilla_cycle_collect,1097 02:16:55 INFO - PROCESS | 22200 | __end_cc_report 02:16:55 INFO - PROCESS | 22200 | __startTimestamp1450779415891__endTimestamp 02:16:55 INFO - PROCESS | 22200 | 02:16:55 INFO - PROCESS | 22200 | ------- Summary: start ------- 02:16:55 INFO - PROCESS | 22200 | Number of tests: 6 02:16:55 INFO - PROCESS | 22200 | 02:16:55 INFO - PROCESS | 22200 | [#0] dojo.html Cycles:165 Average:5366.78 Median:5602.22 stddev:607.16 (10.8%) stddev-sans-first:583.40 02:16:55 INFO - PROCESS | 22200 | Values: 3142.3 3188.7 3232.2 3235.9 3249.8 5072.1 5162.9 5375.8 5384.6 5429.5 5263.8 5298.2 5324.5 5390.8 5391.8 4758.6 4760.9 4777.5 4821.4 4958.2 4965.5 4969.2 5021.1 5033.5 5042.3 4752.1 4797.3 4850.8 4861.1 4882.4 4851.3 4939.6 4949.9 4959.9 4980.8 4923.0 4941.4 4957.6 4965.6 4969.2 5008.9 5101.8 5143.8 5243.4 5348.2 5851.6 5872.9 5874.6 5882.7 5887.9 5888.3 5921.3 5929.3 5936.4 5939.1 5352.9 5411.2 5419.1 5426.2 5554.4 5816.2 5842.9 5846.4 5850.7 5896.2 5655.5 5659.3 5659.5 5661.2 5668.5 5514.8 5571.7 5617.4 5772.5 5917.8 5820.3 5838.4 5841.8 5849.5 5879.1 5866.0 5874.1 5880.3 5882.3 5888.1 4353.5 4413.0 4426.4 4489.0 4493.0 3914.8 3914.9 3937.5 3988.0 4062.2 5350.8 5358.3 5360.0 5385.2 5402.2 5753.1 5826.4 5899.3 5943.4 5951.4 5347.8 5422.9 5432.6 5446.0 5475.1 4978.5 4994.4 5008.9 5030.6 5044.1 5751.5 5792.9 5827.1 5871.1 5890.6 5661.3 5683.5 5694.5 5704.5 5768.1 5878.1 5922.3 5938.0 5941.0 5948.7 5592.5 5758.3 5770.2 5775.7 5784.9 5717.1 5848.6 5887.6 5892.0 5905.5 5684.5 5686.4 5712.7 5782.8 5813.7 5769.9 5778.1 5790.0 5790.9 5794.0 5336.9 5449.3 5546.9 5679.8 5702.2 5534.3 5610.2 5611.2 5616.7 5634.8 5602.2 5641.3 5645.5 5646.3 5652.3 02:16:55 INFO - PROCESS | 22200 | 02:16:55 INFO - PROCESS | 22200 | [#1] ext.html Cycles:180 Average:50674.54 Median:36117.55 stddev:88508.37 (245.1%) stddev-sans-first:88676.79 02:16:55 INFO - PROCESS | 22200 | Values: 596.8 610.1 615.2 618.9 628.1 30318.4 38080.6 38558.0 38737.2 38747.8 42976.6 43349.1 43495.1 43594.0 43611.8 7520.2 8623.2 8796.1 8801.2 8852.2 7635.2 7741.1 7741.4 10386.3 10531.4 10157.2 10262.0 10308.0 10364.9 10372.4 10167.6 10266.5 10267.9 10277.3 10286.5 7631.0 7786.8 10025.9 10251.9 10584.6 40182.2 40682.6 40701.2 40726.8 40755.8 3361.7 3431.9 3488.6 3715.7 3826.4 30600.8 30833.7 30989.7 31097.8 31132.7 3944.8 4016.3 4058.4 4061.6 4172.4 270558.0 272866.0 273345.0 273458.0 274675.6 54836.7 56166.7 61871.0 62155.0 62224.0 69958.7 71281.0 71300.0 71990.6 72030.6 15048.0 15269.2 15285.2 15288.7 15300.3 11278.8 11357.0 11372.0 11382.0 11384.9 20048.8 20200.3 20239.8 20364.7 20378.9 7841.1 8086.5 8091.1 8158.7 8178.9 898.9 918.5 1004.1 1005.2 1011.0 28047.9 28424.9 28768.7 29123.1 33276.2 1005.1 1019.9 1039.9 1077.2 1173.8 14472.3 14597.7 14653.6 14814.6 14896.0 410041.0 414739.0 415043.0 416144.0 417375.0 55383.4 55616.7 55822.4 55936.4 55979.4 1328.7 1341.8 1353.8 1357.6 1359.1 27285.0 28298.0 28382.1 33097.8 33406.5 50335.7 50850.7 50861.2 50957.7 51053.2 302695.0 305599.0 306163.0 306484.0 307313.0 36538.5 38137.2 38607.0 42747.6 45050.8 44209.0 44299.3 44893.3 45127.5 45141.0 35175.5 37119.3 37789.4 38502.2 38647.4 30633.8 37073.8 38136.8 38571.8 42678.4 35416.6 35893.6 36341.5 36436.5 36758.6 33332.0 33936.3 34081.8 34457.7 34619.0 23541.0 23721.3 23816.8 23953.9 23969.6 02:16:55 INFO - PROCESS | 22200 | 02:16:55 INFO - PROCESS | 22200 | [#2] jquery.html Cycles:180 Average:30468.70 Median:32558.84 stddev:98063.13 (301.2%) stddev-sans-first:98312.14 02:16:55 INFO - PROCESS | 22200 | Values: 343.7 358.8 360.3 361.1 361.4 13862.4 14320.6 16489.8 17169.4 18015.1 14149.0 14405.0 16103.8 16181.7 16670.5 5216.1 5353.7 5355.0 5358.7 5368.7 3938.3 3999.9 5156.8 5242.7 5375.2 5649.5 5781.4 5801.5 5821.0 5823.1 5351.8 5368.7 5531.6 5770.4 5777.9 5102.3 5110.6 5123.3 5147.9 5190.6 20030.4 20116.7 20125.7 20511.1 20816.1 2214.1 2230.5 2293.6 2647.9 2688.5 13237.7 13316.3 13337.4 13470.7 13490.8 1807.7 1824.8 1867.0 1874.6 1874.9 58485.0 61306.7 61381.7 61569.7 61647.7 9636.8 9720.8 9854.7 9964.4 9992.2 13167.6 13170.7 13203.7 13210.1 13216.6 7318.8 7362.0 7446.7 7477.6 7603.3 7129.8 7143.6 7183.9 7192.5 7210.2 5872.7 5897.8 6001.9 6002.0 6052.2 1544.2 1606.3 1720.6 1728.3 1756.6 834.3 921.8 936.0 1011.8 1092.0 16825.8 17606.5 18541.4 18660.0 18720.4 806.0 943.5 963.6 967.0 1028.6 8312.9 9864.3 10040.1 10167.6 10367.8 575323.0 591836.0 595178.0 599452.0 641001.0 77865.0 78572.0 80885.0 81869.0 82117.2 1109.2 1124.4 1124.8 1134.9 1152.1 15260.3 15431.2 15433.8 15640.1 15965.4 31748.0 32047.8 33069.8 33385.5 33801.7 38077.4 39907.8 40608.6 42291.8 43481.1 9802.0 9922.2 10088.2 10119.1 10228.7 17544.0 17994.4 18068.1 18228.3 18294.0 14759.7 14893.6 15101.7 15289.7 15300.6 13862.2 13932.7 14474.9 14664.6 14666.3 12040.1 15198.5 15286.2 15418.8 15693.3 8232.7 9371.2 9527.7 9613.7 9663.1 10130.1 10246.9 11286.7 13990.9 14499.9 02:16:55 INFO - PROCESS | 22200 | 02:16:55 INFO - PROCESS | 22200 | [#3] mootools.html Cycles:180 Average:5177.81 Median:6269.03 stddev:2599.96 (41.5%) stddev-sans-first:2590.87 02:16:55 INFO - PROCESS | 22200 | Values: 1294.8 1350.2 1366.1 1463.8 1736.7 6493.7 7022.2 7179.8 7185.0 7198.4 7078.9 7201.2 7219.8 7264.2 7280.9 2167.5 2201.1 2201.6 2202.4 2203.7 2233.8 2267.6 2292.1 2292.5 2293.3 2131.9 2165.1 2176.7 2205.4 2207.6 2152.9 2160.5 2185.5 2185.6 2186.4 2244.0 2260.6 2267.8 2272.4 2275.8 7090.3 7148.2 7149.6 7150.1 7168.8 4489.5 4565.4 4588.3 4592.3 4593.7 2968.1 3107.0 3113.5 3133.8 3138.1 974.9 979.4 982.9 1012.8 1022.4 9878.1 9892.7 9921.9 9933.1 9942.6 4049.4 4069.5 4107.4 4111.3 4111.3 8635.1 8642.7 8643.9 8656.2 8657.5 4512.5 4532.1 4546.8 4549.0 4553.6 3650.8 3783.2 4113.3 4144.3 4153.1 3664.2 3675.8 3679.5 3691.8 3724.9 1193.9 1212.2 1213.0 1222.3 1224.2 1282.2 1282.8 1288.3 1290.5 1308.2 6881.2 7060.1 7077.6 7083.6 7106.5 1036.3 1052.2 1117.4 1136.5 1158.9 5628.4 5668.5 5672.5 5674.9 5681.3 8627.8 8632.5 8827.2 8832.3 8969.3 8844.3 8912.5 8916.1 8923.2 8936.9 6851.1 6926.9 6954.7 7017.0 7075.6 6766.2 6771.2 6798.4 6799.8 6804.2 7296.9 7462.1 7488.3 7526.4 7891.6 7709.3 7794.7 7907.8 7951.9 7960.4 5874.5 5910.3 5980.6 6437.7 6515.4 7084.0 7116.4 7143.7 7143.8 7154.0 6587.7 6734.8 6763.8 6780.4 6834.2 6635.9 6662.2 6703.7 6747.9 6762.3 6618.9 6632.1 6673.5 6676.9 6678.7 6126.4 6188.6 6190.1 6202.2 6202.3 6219.4 6318.7 6331.9 6337.4 6340.2 02:16:55 INFO - PROCESS | 22200 | 02:16:55 INFO - PROCESS | 22200 | [#4] prototype.html Cycles:180 Average:5324.85 Median:6017.08 stddev:1595.70 (26.5%) stddev-sans-first:1555.38 02:16:55 INFO - PROCESS | 22200 | Values: 322.4 336.3 339.4 342.1 348.9 5845.5 5929.3 6000.6 6023.3 6034.6 5764.5 5876.3 5914.0 5931.1 5940.9 4579.1 4584.3 4590.9 4594.5 4597.1 4374.1 4441.9 4472.4 4563.8 4572.3 4525.7 4548.5 4551.0 4562.1 4568.3 4548.9 4551.3 4552.5 4553.8 4556.8 3993.0 4000.0 4000.1 4006.8 4011.1 5606.9 5693.4 5696.1 5700.9 5747.1 5348.9 5389.8 5399.4 5399.5 5402.5 6080.6 6368.1 6392.8 6394.6 6412.5 4359.7 4419.8 4424.0 4480.2 4508.2 6482.2 6580.1 6583.2 6587.0 6587.3 4539.0 4542.4 4543.2 4545.1 4547.5 4533.5 4596.3 4603.6 4627.6 4640.0 5298.0 5319.8 5323.4 5325.2 5325.5 6371.6 6408.4 6423.5 6427.1 6428.3 1626.2 1627.8 1631.8 1632.5 1635.2 1079.8 1092.3 1105.7 1107.1 1109.9 5994.9 6010.9 6072.1 6072.3 6079.2 6541.7 6551.9 6563.3 6566.7 6598.8 5949.3 6068.5 6075.0 6076.2 6077.1 3556.1 3579.1 3579.3 3587.8 3588.2 6656.2 6666.7 6670.5 6686.7 6687.5 6623.4 6752.7 6757.1 6770.5 6771.3 6627.2 6635.4 6635.4 6636.0 6639.2 6403.4 6529.3 6543.2 6559.6 6572.1 6406.6 6478.8 6545.1 6615.6 6628.9 6640.5 6682.1 6723.4 6724.3 6742.1 4537.0 4644.9 4647.7 4649.6 4652.9 6643.1 6650.1 6651.0 6652.3 6654.6 6459.6 6462.4 6466.4 6471.9 6475.7 6321.7 6453.6 6463.9 6464.6 6469.6 6309.6 6327.8 6350.9 6354.4 6355.5 6487.2 6496.2 6500.6 6506.6 6508.3 6095.5 6234.0 6262.2 6337.9 6343.9 02:16:55 INFO - PROCESS | 22200 | 02:16:55 INFO - PROCESS | 22200 | [#5] yui.html Cycles:180 Average:13772.62 Median:43059.35 stddev:15739.28 (36.6%) stddev-sans-first:15753.42 02:16:55 INFO - PROCESS | 22200 | Values: 831.0 837.6 838.7 839.2 842.2 12929.7 13373.1 13382.8 13425.3 13433.4 12906.5 13454.9 13513.3 13514.1 13521.6 691.0 698.6 810.4 815.9 818.4 818.8 825.0 829.8 831.4 832.2 866.0 867.0 871.5 872.0 872.1 717.4 725.1 857.6 866.1 869.5 636.0 636.2 637.5 638.6 639.3 13540.5 13689.0 13792.2 13803.2 13805.0 11634.8 12058.2 12290.7 12467.0 12738.2 10622.2 10668.4 10675.0 10778.5 10840.2 3590.1 3638.6 3657.7 3687.5 3769.6 44015.6 44059.6 44073.8 44135.1 44229.8 9449.2 9704.2 9911.3 9924.8 10018.9 18465.0 18532.9 18667.1 18672.3 18682.0 7508.3 7515.1 7547.2 7584.1 7598.2 4034.8 4047.3 4142.6 4166.9 4169.8 3083.9 3103.2 3115.1 3121.6 3123.7 580.4 587.4 587.8 599.7 603.4 603.3 618.5 671.8 685.9 706.3 8609.5 8678.3 8761.8 8880.3 9126.4 666.9 684.9 686.1 698.2 701.3 3903.6 4130.3 4189.4 4190.7 4202.1 54093.5 63396.0 64381.7 64679.4 64719.7 47288.5 47422.3 47551.0 47855.8 48944.5 44189.8 44877.0 44916.0 45778.3 46292.6 8660.5 8691.9 8923.0 9023.5 9147.4 34031.3 35269.3 35902.1 36078.6 36314.6 42008.2 42222.8 42645.4 43473.3 43537.6 10846.8 10968.8 11043.1 11137.6 11374.3 12316.2 12448.6 12541.1 12576.2 12911.9 11867.2 11940.6 12063.4 12161.3 12538.7 11924.3 12035.6 12322.2 12461.3 12704.9 11080.9 11096.3 11608.5 11762.9 11932.8 9950.8 10091.4 10183.6 10322.1 10434.2 9001.0 9248.8 10003.0 10043.3 10121.6 02:16:55 INFO - PROCESS | 22200 | -------- Summary: end -------- 02:16:55 INFO - PROCESS | 22200 | 02:16:56 INFO - TEST-INFO | 22200: exit 0 02:16:56 INFO - TEST-OK | dromaeo_css | took 1112713ms 02:16:56 INFO - TEST-START | kraken 02:16:56 INFO - operating with platform_type : linux_ 02:16:56 INFO - Initialising browser for kraken test... 02:16:56 INFO - TEST-INFO | started process 22401 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgN8jmc/profile http://localhost:49827/getInfo.html) 02:17:00 INFO - PROCESS | 22401 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 02:17:00 INFO - PROCESS | 22401 | __metrics Screen width/height:1600/1200 02:17:00 INFO - PROCESS | 22401 | colorDepth:24 02:17:00 INFO - PROCESS | 22401 | Browser inner width/height: 1024/697 02:17:00 INFO - PROCESS | 22401 | __metrics 02:17:00 INFO - PROCESS | 22401 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:17:00 INFO - PROCESS | 22401 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:17:01 INFO - TEST-INFO | 22401: exit 0 02:17:01 INFO - Browser initialized. 02:17:01 INFO - Running cycle 1/1 for kraken test... 02:17:01 INFO - TEST-INFO | started process 22486 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgN8jmc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:17:13 INFO - PROCESS | 22486 | RSS: Main: 149921792 02:17:13 INFO - PROCESS | 22486 | 02:17:15 INFO - PROCESS | 22486 | Cycle 1(1): loaded http://localhost:49827/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49827/tests/kraken/driver.html?testName=audio-beat-detection) 02:17:16 INFO - PROCESS | 22486 | RSS: Main: 186290176 02:17:16 INFO - PROCESS | 22486 | 02:17:19 INFO - PROCESS | 22486 | Cycle 1(1): loaded http://localhost:49827/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49827/tests/kraken/driver.html?testName=audio-dft) 02:17:19 INFO - PROCESS | 22486 | RSS: Main: 176283648 02:17:19 INFO - PROCESS | 22486 | 02:17:22 INFO - PROCESS | 22486 | Cycle 1(1): loaded http://localhost:49827/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49827/tests/kraken/driver.html?testName=audio-fft) 02:17:23 INFO - PROCESS | 22486 | RSS: Main: 161054720 02:17:23 INFO - PROCESS | 22486 | 02:17:25 INFO - PROCESS | 22486 | Cycle 1(1): loaded http://localhost:49827/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49827/tests/kraken/driver.html?testName=audio-oscillator) 02:17:25 INFO - PROCESS | 22486 | RSS: Main: 162291712 02:17:25 INFO - PROCESS | 22486 | 02:17:27 INFO - PROCESS | 22486 | Cycle 1(1): loaded http://localhost:49827/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49827/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:17:28 INFO - PROCESS | 22486 | RSS: Main: 163725312 02:17:28 INFO - PROCESS | 22486 | 02:17:31 INFO - PROCESS | 22486 | Cycle 1(1): loaded http://localhost:49827/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49827/tests/kraken/driver.html?testName=imaging-darkroom) 02:17:31 INFO - PROCESS | 22486 | RSS: Main: 164065280 02:17:31 INFO - PROCESS | 22486 | 02:17:35 INFO - PROCESS | 22486 | Cycle 1(1): loaded http://localhost:49827/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49827/tests/kraken/driver.html?testName=imaging-desaturate) 02:17:35 INFO - PROCESS | 22486 | RSS: Main: 167018496 02:17:35 INFO - PROCESS | 22486 | 02:17:38 INFO - PROCESS | 22486 | Cycle 1(1): loaded http://localhost:49827/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49827/tests/kraken/driver.html?testName=json-parse-financial) 02:17:39 INFO - PROCESS | 22486 | RSS: Main: 165040128 02:17:39 INFO - PROCESS | 22486 | 02:17:40 INFO - PROCESS | 22486 | Cycle 1(1): loaded http://localhost:49827/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49827/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:17:41 INFO - PROCESS | 22486 | RSS: Main: 177991680 02:17:41 INFO - PROCESS | 22486 | 02:17:43 INFO - PROCESS | 22486 | Cycle 1(1): loaded http://localhost:49827/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49827/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:17:43 INFO - PROCESS | 22486 | RSS: Main: 175968256 02:17:43 INFO - PROCESS | 22486 | 02:17:45 INFO - PROCESS | 22486 | Cycle 1(1): loaded http://localhost:49827/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49827/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:17:46 INFO - PROCESS | 22486 | RSS: Main: 188436480 02:17:46 INFO - PROCESS | 22486 | 02:17:48 INFO - PROCESS | 22486 | Cycle 1(1): loaded http://localhost:49827/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49827/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:17:49 INFO - PROCESS | 22486 | RSS: Main: 194371584 02:17:49 INFO - PROCESS | 22486 | 02:17:51 INFO - PROCESS | 22486 | Cycle 1(1): loaded http://localhost:49827/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49827/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:17:52 INFO - PROCESS | 22486 | RSS: Main: 191909888 02:17:52 INFO - PROCESS | 22486 | 02:17:54 INFO - PROCESS | 22486 | Cycle 1(1): loaded http://localhost:49827/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49827/tests/kraken/driver.html?testName=ai-astar) 02:17:54 INFO - PROCESS | 22486 | RSS: Main: 249552896 02:17:54 INFO - PROCESS | 22486 | 02:17:54 INFO - PROCESS | 22486 | __start_tp_report 02:17:54 INFO - PROCESS | 22486 | _x_x_mozilla_page_load 02:17:54 INFO - PROCESS | 22486 | _x_x_mozilla_page_load_details 02:17:54 INFO - PROCESS | 22486 | |i|pagename|runs| 02:17:54 INFO - PROCESS | 22486 | |0;ai-astar;108;110;106;110;112;109;100;110;111;115 02:17:54 INFO - PROCESS | 22486 | |1;audio-beat-detection;153;131;147;157;125;146;150;123;173;126 02:17:54 INFO - PROCESS | 22486 | |2;audio-dft;162;160;162;163;161;161;161;164;162;161 02:17:54 INFO - PROCESS | 22486 | |3;audio-fft;71;71;82;89;70;70;71;94;89;70 02:17:54 INFO - PROCESS | 22486 | |4;audio-oscillator;93;95;137;93;93;94;138;93;93;136 02:17:54 INFO - PROCESS | 22486 | |5;imaging-gaussian-blur;109;110;109;110;110;109;110;110;110;109 02:17:54 INFO - PROCESS | 22486 | |6;imaging-darkroom;145;146;146;146;147;147;145;146;145;145 02:17:54 INFO - PROCESS | 22486 | |7;imaging-desaturate;95;95;95;95;96;97;96;95;95;96 02:17:54 INFO - PROCESS | 22486 | |8;json-parse-financial;60;59;58;58;61;58;59;66;56;56 02:17:54 INFO - PROCESS | 22486 | |9;json-stringify-tinderbox;68;67;67;67;68;68;67;69;72;69 02:17:54 INFO - PROCESS | 22486 | |10;stanford-crypto-aes;83;84;85;84;94;84;84;85;85;86 02:17:54 INFO - PROCESS | 22486 | |11;stanford-crypto-ccm;126;121;119;116;121;115;123;125;119;118 02:17:54 INFO - PROCESS | 22486 | |12;stanford-crypto-pbkdf2;147;147;155;153;153;147;154;146;143;164 02:17:54 INFO - PROCESS | 22486 | |13;stanford-crypto-sha256-iterative;68;67;69;68;69;66;68;66;66;68 02:17:54 INFO - PROCESS | 22486 | __end_tp_report 02:17:54 INFO - PROCESS | 22486 | __start_cc_report 02:17:54 INFO - PROCESS | 22486 | _x_x_mozilla_cycle_collect,924 02:17:54 INFO - PROCESS | 22486 | __end_cc_report 02:17:54 INFO - PROCESS | 22486 | __startTimestamp1450779474339__endTimestamp 02:17:54 INFO - PROCESS | 22486 | 02:17:54 INFO - PROCESS | 22486 | ------- Summary: start ------- 02:17:54 INFO - PROCESS | 22486 | Number of tests: 14 02:17:54 INFO - PROCESS | 22486 | 02:17:54 INFO - PROCESS | 22486 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:3.98 (3.6%) stddev-sans-first:4.21 02:17:54 INFO - PROCESS | 22486 | Values: 108.0 110.0 106.0 110.0 112.0 109.0 100.0 110.0 111.0 115.0 02:17:54 INFO - PROCESS | 22486 | 02:17:54 INFO - PROCESS | 22486 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:148.50 stddev:16.42 (11.1%) stddev-sans-first:17.02 02:17:54 INFO - PROCESS | 22486 | Values: 153.0 131.0 147.0 157.0 125.0 146.0 150.0 123.0 173.0 126.0 02:17:54 INFO - PROCESS | 22486 | 02:17:54 INFO - PROCESS | 22486 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 02:17:54 INFO - PROCESS | 22486 | Values: 162.0 160.0 162.0 163.0 161.0 161.0 161.0 164.0 162.0 161.0 02:17:54 INFO - PROCESS | 22486 | 02:17:54 INFO - PROCESS | 22486 | [#3] audio-fft Cycles:10 Average:77.70 Median:76.50 stddev:9.73 (12.7%) stddev-sans-first:10.01 02:17:54 INFO - PROCESS | 22486 | Values: 71.0 71.0 82.0 89.0 70.0 70.0 71.0 94.0 89.0 70.0 02:17:54 INFO - PROCESS | 22486 | 02:17:54 INFO - PROCESS | 22486 | [#4] audio-oscillator Cycles:10 Average:106.50 Median:93.00 stddev:21.06 (22.6%) stddev-sans-first:21.77 02:17:54 INFO - PROCESS | 22486 | Values: 93.0 95.0 137.0 93.0 93.0 94.0 138.0 93.0 93.0 136.0 02:17:54 INFO - PROCESS | 22486 | 02:17:54 INFO - PROCESS | 22486 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 02:17:54 INFO - PROCESS | 22486 | Values: 109.0 110.0 109.0 110.0 110.0 109.0 110.0 110.0 110.0 109.0 02:17:54 INFO - PROCESS | 22486 | 02:17:54 INFO - PROCESS | 22486 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 02:17:54 INFO - PROCESS | 22486 | Values: 145.0 146.0 146.0 146.0 147.0 147.0 145.0 146.0 145.0 145.0 02:17:54 INFO - PROCESS | 22486 | 02:17:54 INFO - PROCESS | 22486 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 02:17:54 INFO - PROCESS | 22486 | Values: 95.0 95.0 95.0 95.0 96.0 97.0 96.0 95.0 95.0 96.0 02:17:54 INFO - PROCESS | 22486 | 02:17:54 INFO - PROCESS | 22486 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:59.00 stddev:2.88 (4.9%) stddev-sans-first:3.04 02:17:54 INFO - PROCESS | 22486 | Values: 60.0 59.0 58.0 58.0 61.0 58.0 59.0 66.0 56.0 56.0 02:17:54 INFO - PROCESS | 22486 | 02:17:54 INFO - PROCESS | 22486 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:1.55 (2.3%) stddev-sans-first:1.64 02:17:54 INFO - PROCESS | 22486 | Values: 68.0 67.0 67.0 67.0 68.0 68.0 67.0 69.0 72.0 69.0 02:17:54 INFO - PROCESS | 22486 | 02:17:54 INFO - PROCESS | 22486 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.00 stddev:3.13 (3.7%) stddev-sans-first:3.20 02:17:54 INFO - PROCESS | 22486 | Values: 83.0 84.0 85.0 84.0 94.0 84.0 84.0 85.0 85.0 86.0 02:17:54 INFO - PROCESS | 22486 | 02:17:54 INFO - PROCESS | 22486 | [#11] stanford-crypto-ccm Cycles:10 Average:120.30 Median:121.00 stddev:3.62 (3.0%) stddev-sans-first:3.20 02:17:54 INFO - PROCESS | 22486 | Values: 126.0 121.0 119.0 116.0 121.0 115.0 123.0 125.0 119.0 118.0 02:17:54 INFO - PROCESS | 22486 | 02:17:54 INFO - PROCESS | 22486 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.90 Median:153.00 stddev:6.14 (4.0%) stddev-sans-first:6.34 02:17:54 INFO - PROCESS | 22486 | Values: 147.0 147.0 155.0 153.0 153.0 147.0 154.0 146.0 143.0 164.0 02:17:54 INFO - PROCESS | 22486 | 02:17:54 INFO - PROCESS | 22486 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.18 (1.7%) stddev-sans-first:1.24 02:17:54 INFO - PROCESS | 22486 | Values: 68.0 67.0 69.0 68.0 69.0 66.0 68.0 66.0 66.0 68.0 02:17:54 INFO - PROCESS | 22486 | -------- Summary: end -------- 02:17:54 INFO - PROCESS | 22486 | 02:17:55 INFO - TEST-INFO | 22486: exit 0 02:17:55 INFO - TEST-OK | kraken | took 58541ms 02:17:55 INFO - TEST-START | v8_7 02:17:55 INFO - operating with platform_type : linux_ 02:17:55 INFO - Initialising browser for v8_7 test... 02:17:55 INFO - TEST-INFO | started process 22739 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsDAmwR/profile http://localhost:49827/getInfo.html) 02:17:58 INFO - PROCESS | 22739 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 02:17:59 INFO - PROCESS | 22739 | __metrics Screen width/height:1600/1200 02:17:59 INFO - PROCESS | 22739 | colorDepth:24 02:17:59 INFO - PROCESS | 22739 | Browser inner width/height: 1024/697 02:17:59 INFO - PROCESS | 22739 | __metrics 02:17:59 INFO - PROCESS | 22739 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:17:59 INFO - PROCESS | 22739 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:18:00 INFO - TEST-INFO | 22739: exit 0 02:18:00 INFO - Browser initialized. 02:18:00 INFO - Running cycle 1/1 for v8_7 test... 02:18:00 INFO - TEST-INFO | started process 22823 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsDAmwR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:18:11 INFO - PROCESS | 22823 | RSS: Main: 150016000 02:18:11 INFO - PROCESS | 22823 | 02:18:33 INFO - PROCESS | 22823 | Cycle 1(1): loaded http://localhost:49827/tests/v8_7/run.html (next: http://localhost:49827/tests/v8_7/run.html) 02:18:33 INFO - PROCESS | 22823 | RSS: Main: 611348480 02:18:33 INFO - PROCESS | 22823 | 02:18:33 INFO - PROCESS | 22823 | __start_tp_report 02:18:33 INFO - PROCESS | 22823 | _x_x_mozilla_page_load 02:18:33 INFO - PROCESS | 22823 | _x_x_mozilla_page_load_details 02:18:33 INFO - PROCESS | 22823 | |i|pagename|runs| 02:18:33 INFO - PROCESS | 22823 | |0;Richards;165.89250165892503 02:18:33 INFO - PROCESS | 22823 | |1;DeltaBlue;189.32222642938282 02:18:33 INFO - PROCESS | 22823 | |2;Encrypt;281.29395218002816 02:18:33 INFO - PROCESS | 22823 | |3;Decrypt;5128.205128205128 02:18:33 INFO - PROCESS | 22823 | |4;RayTrace;2002 02:18:33 INFO - PROCESS | 22823 | |5;Earley;786.1635220125786 02:18:33 INFO - PROCESS | 22823 | |6;Boyer;12353.658536585366 02:18:33 INFO - PROCESS | 22823 | |7;RegExp;26179.48717948718 02:18:33 INFO - PROCESS | 22823 | |8;Splay;648.2670089858793 02:18:33 INFO - PROCESS | 22823 | |9;NavierStokes;4822.115384615385 02:18:33 INFO - PROCESS | 22823 | __end_tp_report 02:18:33 INFO - PROCESS | 22823 | __startTimestamp1450779513593__endTimestamp 02:18:33 INFO - PROCESS | 22823 | 02:18:33 INFO - PROCESS | 22823 | ------- Summary: start ------- 02:18:33 INFO - PROCESS | 22823 | Number of tests: 10 02:18:33 INFO - PROCESS | 22823 | 02:18:33 INFO - PROCESS | 22823 | [#0] Richards Cycles:1 Average:165.89 Median:165.89 stddev:0.00 (0.0%) 02:18:33 INFO - PROCESS | 22823 | Values: 165.9 02:18:33 INFO - PROCESS | 22823 | 02:18:33 INFO - PROCESS | 22823 | [#1] DeltaBlue Cycles:1 Average:189.32 Median:189.32 stddev:0.00 (0.0%) 02:18:33 INFO - PROCESS | 22823 | Values: 189.3 02:18:33 INFO - PROCESS | 22823 | 02:18:33 INFO - PROCESS | 22823 | [#2] Encrypt Cycles:1 Average:281.29 Median:281.29 stddev:0.00 (0.0%) 02:18:33 INFO - PROCESS | 22823 | Values: 281.3 02:18:33 INFO - PROCESS | 22823 | 02:18:33 INFO - PROCESS | 22823 | [#3] Decrypt Cycles:1 Average:5128.21 Median:5128.21 stddev:0.00 (0.0%) 02:18:33 INFO - PROCESS | 22823 | Values: 5128.2 02:18:33 INFO - PROCESS | 22823 | 02:18:33 INFO - PROCESS | 22823 | [#4] RayTrace Cycles:1 Average:2002.00 Median:2002.00 stddev:0.00 (0.0%) 02:18:33 INFO - PROCESS | 22823 | Values: 2002.0 02:18:33 INFO - PROCESS | 22823 | 02:18:33 INFO - PROCESS | 22823 | [#5] Earley Cycles:1 Average:786.16 Median:786.16 stddev:0.00 (0.0%) 02:18:33 INFO - PROCESS | 22823 | Values: 786.2 02:18:33 INFO - PROCESS | 22823 | 02:18:33 INFO - PROCESS | 22823 | [#6] Boyer Cycles:1 Average:12353.66 Median:12353.66 stddev:0.00 (0.0%) 02:18:33 INFO - PROCESS | 22823 | Values: 12353.7 02:18:33 INFO - PROCESS | 22823 | 02:18:33 INFO - PROCESS | 22823 | [#7] RegExp Cycles:1 Average:26179.49 Median:26179.49 stddev:0.00 (0.0%) 02:18:33 INFO - PROCESS | 22823 | Values: 26179.5 02:18:33 INFO - PROCESS | 22823 | 02:18:33 INFO - PROCESS | 22823 | [#8] Splay Cycles:1 Average:648.27 Median:648.27 stddev:0.00 (0.0%) 02:18:33 INFO - PROCESS | 22823 | Values: 648.3 02:18:33 INFO - PROCESS | 22823 | 02:18:33 INFO - PROCESS | 22823 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 02:18:33 INFO - PROCESS | 22823 | Values: 4822.1 02:18:33 INFO - PROCESS | 22823 | -------- Summary: end -------- 02:18:33 INFO - PROCESS | 22823 | 02:18:34 INFO - TEST-INFO | 22823: exit 0 02:18:34 INFO - TEST-OK | v8_7 | took 39227ms 02:18:34 INFO - SUITE-END | took 1210s 02:18:34 INFO - Completed test suite (00:20:10) 02:18:34 INFO - Working with test: dromaeo_css 02:18:34 INFO - Generating results file: dromaeo_css 02:18:34 INFO - Working with test: kraken 02:18:34 INFO - Generating results file: kraken 02:18:34 INFO - javascript benchmark 02:18:34 INFO - Working with test: v8_7 02:18:34 INFO - Generating results file: v8_7 02:18:34 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:18:34 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 02:18:34 INFO - process_Request line: dromaeo_css 7046.85 graph.html#tests=[[72,201,35]] 02:18:34 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:18:34 INFO - process_Request line: kraken 1500.40 graph.html#tests=[[232,201,35]] 02:18:34 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:18:34 INFO - process_Request line: v8_7 19661.81 graph.html#tests=[[230,201,35]] 02:18:34 INFO - RETURN: dromaeo_css: 7046.85 02:18:34 INFO - RETURN: kraken: 1500.40 02:18:34 INFO - RETURN: v8_7: 19661.81 02:18:34 INFO - javascript benchmark 02:18:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3142.2772762264676, 3188.665190155035, 3232.1596384939908, 3235.854386552605, 3249.805011699298, 5072.13773658478, 5162.870928226796, 5375.817320189557, 5384.649997750148, 5429.511343979037, 5263.789448422059, 5298.178782288752, 5324.520793128618, 5390.838274851751, 5391.757370918308, 4758.619310455155, 4760.928586071203, 4777.450593181794, 4821.421429428474, 4958.231474121517, 4965.503449655042, 4969.155243608595, 5021.1213037718435, 5033.471485494026, 5042.268871013701, 4752.12085764133, 4797.280407938802, 4850.8059677612855, 4861.052094841507, 4882.41411030675, 4851.345068415754, 4939.629527785394, 4949.851504454872, 4959.925601115986, 4980.800767969277, 4922.975385123052, 4941.431735350445, 4957.5786058185095, 4965.627577931669, 4969.155243608595, 5008.899822003539, 5101.795928162869, 5143.845684629429, 5243.449437809013, 5348.224507446437, 5851.590388672795, 5872.882542349129, 5874.618149820248, 5882.735276912549, 5887.8528036799, 5888.263967004124, 5921.289445266596, 5929.288485381739, 5936.436038576328, 5939.079442686348, 5352.866178345534, 5411.188321751769, 5419.105847535152, 5426.240326354314, 5554.416786237387, 5816.156657284755, 5842.8539286517325, 5846.444587764156, 5850.678212698257, 5896.204012458349, 5655.4910058094965, 5659.3208814941645, 5659.547236221175, 5661.150827375926, 5668.489835914787, 5514.751836167382, 5571.721413929287, 5617.354004289559, 5772.509336706427, 5917.763289468373, 5820.330661973842, 5838.416158384128, 5841.795537156179, 5849.532037436995, 5879.059350503899, 5866.0, 5874.060150375919, 5880.323762767251, 5882.264716910387, 5888.087346461305, 4353.521112677603, 4412.977935110304, 4426.402435671208, 4488.977555112204, 4492.9550704493195, 3914.823832927525, 3914.921701565953, 3937.488126543531, 3987.980060099681, 4062.1875624875142, 5350.839474815762, 5358.33020872391, 5360.014293371492, 5385.219143224211, 5402.243685883979, 5753.05074662676, 5826.446487583673, 5899.321578018497, 5943.435373639497, 5951.404859514014, 5347.812826551052, 5422.864428389322, 5432.59255555827, 5446.046941785251, 5475.06923822951, 4978.5270399312, 4994.40067191932, 5008.899822003539, 5030.622703297267, 5044.066847633199, 5751.539876809845, 5792.855178620568, 5827.125931110368, 5871.089981052944, 5890.558208134321, 5661.2923384576925, 5683.545316374597, 5694.544436444991, 5704.486596206361, 5768.134779783066, 5878.147668588116, 5922.3485416605, 5937.990541607851, 5941.049432090845, 5948.702564871825, 5592.496675299242, 5758.337791153904, 5770.221020162392, 5775.682337471311, 5784.913226301693, 5717.056685646988, 5848.56135789826, 5887.558433117619, 5892.0, 5905.4685078343155, 5684.488396044376, 5686.374498805046, 5712.685802280915, 5782.797602083907, 5813.651180929158, 5769.884602308014, 5778.104393818965, 5790.0, 5790.884182316414, 5794.0439827428, 5336.893262134813, 5449.291592093161, 5546.916796248141, 5679.801206957902, 5702.201691763239, 5534.308211473566, 5610.158476228435, 5611.242333419371, 5616.747246373841, 5634.802781902614, 5602.215689803512, 5641.294838145232, 5645.520130788765, 5646.265985421869, 5652.293463317085], "unit": "score", "name": "dojo.html", "value": 5326.806611257686}, {"lowerIsBetter": false, "replicates": [596.7732261740539, 610.1031483718932, 615.1603061820615, 618.8700372921686, 628.136312570216, 30318.393632127343, 38080.61919380805, 38558.0, 38737.225255494945, 38747.806260968726, 42976.57023429765, 43349.133017339635, 43495.13009739811, 43594.0, 43611.78194109025, 7520.210377910295, 8623.223909848128, 8796.076411976746, 8801.207891289783, 8852.159044890757, 7635.198304178037, 7741.071071471403, 7741.419393545507, 10386.27296089274, 10531.420771857545, 10157.18742500602, 10262.0, 10308.0, 10364.948175259113, 10372.429516376596, 10167.59329626814, 10266.538005789682, 10267.897321026843, 10277.280590358641, 10286.53710583018, 7631.046119235096, 7786.7663970080985, 10025.949870250603, 10251.948740256326, 10584.629537966212, 40182.196356072716, 40682.593174068475, 40701.185976280605, 40726.79636601828, 40755.796221019, 3361.680640339164, 3431.9485207721655, 3488.6162522122545, 3715.692057559521, 3826.4069069294305, 30600.8469957651, 30833.69166308353, 30989.690103099132, 31097.844510777526, 31132.688673113207, 3944.8224829882724, 4016.2770701273757, 4058.350663893763, 4061.591171666464, 4172.415861779354, 270558.0, 272866.0, 273345.0, 273458.0, 274675.6266218676, 54836.725816370665, 56166.719166403906, 61871.0, 62155.0, 62224.0, 69958.65020674966, 71281.0, 71300.0, 71990.64004679942, 72030.63984680043, 15048.0, 15269.160196189316, 15285.159316237492, 15288.694226115414, 15300.311485983157, 11278.774424511465, 11357.0, 11372.0, 11382.032527235278, 11384.918432748877, 20048.799512004985, 20200.29298974529, 20239.797602024086, 20364.741641337314, 20378.89810550938, 7841.098273698598, 8086.5148091114725, 8091.109977902426, 8158.673653053811, 8178.877316840252, 898.9235914947172, 918.5453200665713, 1004.1213937804421, 1005.1857995024054, 1010.9789112995927, 28047.859760701474, 28424.857875710488, 28768.71231287702, 29123.12630621085, 33276.168095797315, 1005.1154983614373, 1019.918406527476, 1039.896010398954, 1077.2459278505078, 1173.7535117625393, 14472.348744306531, 14597.708045839025, 14653.633659158393, 14814.555563333117, 14896.0317579357, 410041.0, 414739.0, 415043.0, 416144.0, 417375.0, 55383.446165537825, 55616.72191639016, 55822.441775582534, 55936.44063559312, 55979.44020559742, 1328.7076843094503, 1341.805438211454, 1353.8104665346661, 1357.5587933921515, 1359.1029920252784, 27285.0, 28298.0, 28382.148535543965, 33097.83451082729, 33406.498902515996, 50335.74832125816, 50850.74574627103, 50861.237081444546, 50957.74521127371, 51053.23420148775, 302695.0, 305599.0, 306163.0, 306484.0, 307313.0, 36538.451923221706, 38137.237255254186, 38607.0, 42747.5725242756, 45050.77474612737, 44209.0, 44299.33550996802, 44893.32660010037, 45127.54872451365, 45141.0, 35175.47236791399, 37119.257614848095, 37789.43315850209, 38502.22995540129, 38647.42028869625, 30633.83438424486, 37073.814630926674, 38136.809315953244, 38571.80714096411, 42678.359824602034, 35416.64583354237, 35893.641063590076, 36341.45487817632, 36436.45345319875, 36758.63241367552, 33332.0, 33936.32127357488, 34081.829590851885, 34457.65542344645, 34619.0, 23541.0, 23721.288361349187, 23816.832054390066, 23953.880230599432, 23969.640455392833], "unit": "score", "name": "ext.html", "value": 19342.793768515086}, {"lowerIsBetter": false, "replicates": [343.71299964529635, 358.8223829204544, 360.31360258707156, 361.0522378755766, 361.3712140874877, 13862.4455021799, 14320.570382888503, 16489.83510164898, 17169.399071032516, 18015.099245037727, 14149.0, 14405.0, 16103.758443623356, 16181.676366472664, 16670.49988500344, 5216.061109000379, 5353.705546194958, 5355.009323275207, 5358.732063396834, 5368.677879327233, 3938.3304838177437, 3999.94001589579, 5156.845294641148, 5242.737863106849, 5375.19372094187, 5649.519790817785, 5781.39295373986, 5801.506871915871, 5821.0, 5823.126531020339, 5351.785928562853, 5368.731563421813, 5531.640443371188, 5770.365259821417, 5777.855553611152, 5102.285680004765, 5110.591152707774, 5123.3339665843205, 5147.871303217412, 5190.610704197163, 20030.39908802738, 20116.698249526267, 20125.698114528295, 20511.077001534966, 20816.063277152563, 2214.125420458926, 2230.4535388829677, 2293.564222797663, 2647.874653272371, 2688.5160671079198, 13237.73524529504, 13316.334183290797, 13337.399817008161, 13470.663233419145, 13490.797638035438, 1807.7469154318405, 1824.7536582561318, 1866.9813301866943, 1874.6157037807218, 1874.8875067495994, 58485.0, 61306.69346653238, 61381.69309153515, 61569.692151538955, 61647.691761541355, 9636.75908102289, 9720.805583888425, 9854.704358869245, 9964.352317099365, 9992.15066719337, 13167.60497185086, 13170.670733231746, 13203.66990825237, 13210.141340812816, 13216.603501894959, 7318.780436586911, 7361.963190184015, 7446.73936412223, 7477.588732619758, 7603.315701586773, 7129.821754456077, 7143.607101609357, 7183.89224161638, 7192.496525243183, 7210.1708303545765, 5872.677002764889, 5897.76408943646, 6001.909971350433, 6002.0, 6052.243469566304, 1544.2047345617016, 1606.2932309783657, 1720.6472673101985, 1728.2568495546784, 1756.5872020075271, 834.3116928533984, 921.7695576105973, 935.9719208423758, 1011.7976404719086, 1092.0, 16825.831741682672, 17606.503805842247, 18541.44375668732, 18660.0, 18720.438386848415, 805.9838803223903, 943.5093751249312, 963.6482683820356, 967.0, 1028.619410818002, 8312.916870831214, 9864.256558601606, 10040.14658754014, 10167.644132455329, 10367.844482332772, 575323.0, 591836.0, 595178.0, 599452.0, 641001.0, 77865.0, 78572.0, 80885.0, 81869.0, 82117.17882821214, 1109.1681239070697, 1124.359115304285, 1124.7862906047824, 1134.9445016135073, 1152.0725815718426, 15260.313285901939, 15431.15128667889, 15433.768493472382, 15640.139792311533, 15965.361385544447, 31748.0, 32047.839760801045, 33069.83465082659, 33385.499217512246, 33801.661983379854, 38077.428838568, 39907.80046099751, 40608.59391406048, 42291.788541057096, 43481.130377391644, 9801.950990245003, 9922.156616687662, 10088.243381746252, 10119.139873110573, 10228.693139205836, 17544.0, 17994.370197043565, 18068.096595170453, 18228.270869165615, 18294.0, 14759.704805903608, 14893.553193404216, 15101.697966040838, 15289.694206115593, 15300.617484562976, 13862.237576933365, 13932.721345572829, 14474.85525144735, 14664.633384165481, 14666.26668666541, 12040.096992725405, 15198.544043678707, 15286.235688215767, 15418.845811542189, 15693.253680606076, 8232.670693172446, 9371.203447707021, 9527.714168574954, 9613.711588652352, 9663.082007209305, 10130.138938190335, 10246.948765256126, 11286.717832054264, 13990.860091398956, 14499.92750036243], "unit": "score", "name": "jquery.html", "value": 8993.096826849709}, {"lowerIsBetter": false, "replicates": [1294.7798874191387, 1350.183139200784, 1366.139332220701, 1463.7584798508246, 1736.7134422820227, 6493.675316234187, 7022.227554968956, 7179.82050448739, 7184.964075179623, 7198.388137008361, 7078.929210707892, 7201.207867134611, 7219.81950451239, 7264.237255088219, 7280.927190728091, 2167.4798048468333, 2201.0755482697227, 2201.625723626987, 2202.4053505553493, 2203.6584329428883, 2233.832462565306, 2267.6031694453486, 2292.128990983424, 2292.4612716011725, 2293.3463962770616, 2131.8507704460694, 2165.1339464214284, 2176.706144670473, 2205.371469131298, 2207.558488302338, 2152.9354119376444, 2160.5246845693923, 2185.4754858833926, 2185.595664802017, 2186.355025267542, 2243.955120897589, 2260.6382978723327, 2267.807236384909, 2272.3750968483632, 2275.7838005389463, 7090.326418990187, 7148.177959534668, 7149.571025738473, 7150.10623672041, 7168.784936451915, 4489.506154323022, 4565.383673204108, 4588.311753237008, 4592.33411155384, 4593.655475839292, 2968.1392396205074, 3106.9689303106907, 3113.501839705636, 3133.8433078345993, 3138.0585824252635, 974.9171320437771, 979.4466126638426, 982.882054153499, 1012.8430093335545, 1022.4018948914894, 9878.110970012733, 9892.703218903445, 9921.851172232422, 9933.106020458194, 9942.602295908227, 4049.372347286175, 4069.491313585802, 4107.424960505532, 4111.321631930698, 4111.321631930758, 8635.093315201939, 8642.654293828302, 8643.91356086431, 8656.177663121993, 8657.523836188944, 4512.548745125527, 4532.138893610204, 4546.818127274938, 4549.044700612908, 4553.590176884097, 3650.762700424464, 3783.243351329745, 4113.259613269581, 4144.316187828975, 4153.086321009373, 3664.2121943782213, 3675.779453232761, 3679.466477360768, 3691.778493290411, 3724.8696295629525, 1193.8806119387991, 1212.1817773003363, 1212.9818052729215, 1222.2544248008708, 1224.161449407159, 1282.1537785061814, 1282.8396450443695, 1288.3429450980068, 1290.470906928155, 1308.188922867809, 6881.243063263037, 7060.082189315459, 7077.610731409822, 7083.610401427868, 7106.502544821917, 1036.3056751976194, 1052.1582733812918, 1117.3519358771894, 1136.4942600542845, 1158.9420528973517, 5628.380878103405, 5668.461496157858, 5672.546196304285, 5674.943250567524, 5681.346645135863, 8627.784305392415, 8632.525211113323, 8827.16141966512, 8832.293416526663, 8969.282457403391, 8844.33667474942, 8912.509811960404, 8916.108389161032, 8923.15230053144, 8936.8659470108, 6851.143607049119, 6926.896096558556, 6954.721811127498, 7016.999999999898, 7075.575465472089, 6766.221884483348, 6771.187457505131, 6798.388145066968, 6799.762008329685, 6804.217514985642, 7296.927030729625, 7462.067241594801, 7488.251174882468, 7526.360259378014, 7891.605419729105, 7709.3447057000785, 7794.6882124714375, 7907.802304942423, 7951.880721789062, 7960.363170946426, 5874.471297583238, 5910.320313164041, 5980.641161530322, 6437.742490300336, 6515.446187074152, 7084.043654106629, 7116.359527642537, 7143.749968751069, 7143.785686429415, 7153.964230178815, 6587.736490540325, 6734.797956061326, 6763.797086087426, 6780.355866192704, 6834.179898412222, 6635.900461493178, 6662.233843108104, 6703.66481675924, 6747.898781518379, 6762.256151823197, 6618.900716489353, 6632.071509988509, 6673.499487538357, 6676.866462670622, 6678.699458524476, 6126.356732543019, 6188.628682279078, 6190.102435146969, 6202.224721909762, 6202.317745048132, 6219.378062193744, 6318.6840657965995, 6331.9050214247745, 6337.397947195009, 6340.207474065742], "unit": "score", "name": "mootools.html", "value": 4312.208272281862}, {"lowerIsBetter": false, "replicates": [322.3520723346075, 336.27532667102395, 339.3772427595362, 342.14634486955043, 348.86568671061633, 5845.473907348338, 5929.288485381755, 6000.639961602302, 6023.277206735198, 6034.607750496215, 5764.510016648579, 5876.294844618641, 5913.970430147843, 5931.051031834907, 5940.940590594093, 4579.061292435051, 4584.266517357223, 4590.862274131781, 4594.494605593382, 4597.149527337437, 4374.081442896995, 4441.866743997685, 4472.44094488189, 4563.840265590705, 4572.268437050073, 4525.660575456837, 4548.476925153616, 4550.954490455086, 4562.064776720781, 4568.291914753218, 4548.863534093983, 4551.340055691906, 4552.453705555321, 4553.817847286105, 4556.794944227518, 3993.0, 4000.0399904023116, 4000.0599859033105, 4006.759594424315, 4011.097503061817, 5606.943930560683, 5693.373728889819, 5696.088625819849, 5700.857478563028, 5747.080467125282, 5348.893022139536, 5389.83830485086, 5399.406065332811, 5399.514043736082, 5402.459754024605, 6080.574359794816, 6368.140301059344, 6392.808215753535, 6394.6482943438095, 6412.519061070392, 4359.716618419824, 4419.801108950105, 4423.955760442386, 4480.215962206601, 4508.233600287959, 6482.157319548429, 6580.111684922522, 6583.210014798207, 6587.0, 6587.3083326250535, 4538.9546104539195, 4542.432195975503, 4543.227651299287, 4545.0909818036525, 4547.454305483363, 4533.455985281787, 4596.333531637961, 4603.631709463235, 4627.606653434428, 4639.9536004640195, 5298.0, 5319.813806516753, 5323.387810401776, 5325.201219817059, 5325.4940780625775, 6371.55399122057, 6408.391202835724, 6423.518236132215, 6427.100205971168, 6428.325025872309, 1626.1706529669716, 1627.8209396966324, 1631.8449747274228, 1632.4776071657193, 1635.1742370103022, 1079.849959792834, 1092.2845536173818, 1105.7346236903086, 1107.1253709569512, 1109.9001089901785, 5994.910076348859, 6010.879782404328, 6072.05883088122, 6072.271327440735, 6079.179310793074, 6541.705623246965, 6551.868962620721, 6563.343665633399, 6566.671666416755, 6598.835029124214, 5949.286085669661, 6068.484178844759, 6075.027995520695, 6076.240469941257, 6077.058056001327, 3556.110972256936, 3579.1410061585034, 3579.302036102935, 3587.766795158306, 3588.2285308658766, 6656.234533028667, 6666.666666666744, 6670.466362690973, 6686.699098540577, 6687.4984376171005, 6623.4038936495945, 6752.729890804313, 6757.121574195323, 6770.458363330922, 6771.289014653489, 6627.237867645283, 6635.402813746689, 6635.402813746786, 6635.971424429221, 6639.203295604559, 6403.359664033559, 6529.347065293433, 6543.214814222324, 6559.573627714374, 6572.079908812674, 6406.647634380154, 6478.773242936474, 6545.14913061299, 6615.636140012153, 6628.933710662832, 6640.501962352746, 6682.131322927989, 6723.411486577605, 6724.260331363644, 6742.089817874524, 4536.954630453785, 4644.86065418038, 4647.744374059459, 4649.5815376616265, 4652.860414187579, 6643.069970204078, 6650.068990341259, 6650.966745166436, 6652.301508341555, 6654.600723956578, 6459.580127291711, 6462.4183823456115, 6466.385693359123, 6471.870562588628, 6475.740970361321, 6321.715522801393, 6453.612783233021, 6463.935360646334, 6464.644444555594, 6469.5794773339585, 6309.621422714652, 6327.778527751507, 6350.90473642905, 6354.364563543793, 6355.491560675043, 6487.18910136233, 6496.155499785186, 6500.642464664489, 6506.642134682638, 6508.251551071688, 6095.481884039907, 6233.96883015582, 6262.2172228471445, 6337.8732425352155, 6343.9365606343345], "unit": "score", "name": "prototype.html", "value": 4807.461879268269}, {"lowerIsBetter": false, "replicates": [830.9958450207748, 837.5979529825684, 838.7119213359764, 839.1943734015341, 842.2461896602537, 12929.741405171892, 13373.063885528018, 13382.799258011137, 13425.261610611426, 13433.395497202624, 12906.483740650363, 13454.932725336384, 13513.324333783296, 13514.054016218868, 13521.59435216945, 691.0049528678686, 698.552926127279, 810.3841080778607, 815.8980127484065, 818.3698552114868, 818.7707441916243, 825.005867929144, 829.784256093414, 831.4387788242942, 832.1927730101792, 865.9997702653445, 866.9566521673922, 871.4945331707626, 872.040755169315, 872.071244125008, 717.3722992381666, 725.1044959475071, 857.6269322844582, 866.1035827918106, 869.4522450855984, 636.0395802338456, 636.2428709835281, 637.4613451633362, 638.6487431912429, 639.3191251317332, 13540.526081587097, 13689.0, 13792.172469651752, 13803.2408217549, 13805.0, 11634.825477617842, 12058.155929084967, 12290.692732681666, 12467.0, 12738.172018818746, 10622.203334749847, 10668.359898406121, 10675.0, 10778.461076946121, 10840.241183117185, 3590.0845284452557, 3638.599754027055, 3657.652523010336, 3687.520622319081, 3769.5664998525244, 44015.55984440147, 44059.55940440587, 44073.77963110196, 44135.117297654186, 44229.77885110554, 9449.244060475145, 9704.223662107015, 9911.256655750703, 9924.801503970024, 10018.949905250427, 18465.0, 18532.907335463507, 18667.066646667612, 18672.25310987545, 18682.0, 7508.324250817453, 7515.060617422822, 7547.207543207884, 7584.089909210819, 7598.240175982468, 4034.778087205173, 4047.2714911315657, 4142.647874930664, 4166.91666166675, 4169.812358443877, 3083.8612262448246, 3103.177657920653, 3115.096621979646, 3121.625404951375, 3123.703248191418, 580.4166812353558, 587.3744462147799, 587.7877400008887, 599.658194828952, 603.4116736182187, 603.2670305578743, 618.5082859127004, 671.8454755406284, 685.8662560800595, 706.2619562557037, 8609.526476043879, 8678.349123815738, 8761.849757030146, 8880.333974951904, 9126.406783559047, 666.8766278238444, 684.8767221900106, 686.0977814174345, 698.183125742882, 701.2846896165984, 3903.5706072332023, 4130.256553820341, 4189.371594260824, 4190.727602705875, 4202.138561594866, 54093.45906540884, 63396.0, 64381.67809160924, 64679.35320646827, 64719.67640161769, 47288.527114728415, 47422.28866567004, 47551.0, 47855.760721196864, 48944.51055489471, 44189.77905110454, 44877.0, 44916.0, 45778.31332530015, 46292.61122166273, 8660.48037117775, 8691.91308086911, 8923.0, 9023.503707296162, 9147.359684821999, 34031.31937361189, 35269.29461410809, 35902.10244743902, 36078.63921360858, 36314.63685363113, 42008.1598368037, 42222.78888605537, 42645.36031959585, 43473.34789978089, 43537.56462435335, 10846.783064338826, 10968.835467468154, 11043.116550675766, 11137.554497819996, 11374.31754094757, 12316.199447035913, 12448.564300249447, 12541.122121451412, 12576.182548134342, 12911.935440322739, 11867.228630139014, 11940.582079627171, 12063.396830158632, 12161.270323780247, 12538.749225015632, 11924.344161070878, 12035.578754743541, 12322.199057061622, 12461.314627695201, 12704.936475317565, 11080.889191107986, 11096.278741881752, 11608.477618507357, 11762.882371176178, 11932.76134477323, 9950.751231219278, 10091.41529940724, 10183.592656293666, 10322.12261957712, 10434.21743369235, 9000.984670135578, 9248.815023699353, 10003.0, 10043.34718243341, 10121.595136194765], "unit": "score", "name": "yui.html", "value": 6374.0782688953195}], "name": "dromaeo_css", "value": 7046.849670550888}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 106.0, 110.0, 112.0, 109.0, 100.0, 110.0, 111.0, 115.0], "unit": "score", "name": "ai-astar", "value": 109.1}, {"lowerIsBetter": true, "replicates": [153.0, 131.0, 147.0, 157.0, 125.0, 146.0, 150.0, 123.0, 173.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 143.1}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 162.0, 163.0, 161.0, 161.0, 161.0, 164.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 82.0, 89.0, 70.0, 70.0, 71.0, 94.0, 89.0, 70.0], "unit": "score", "name": "audio-fft", "value": 77.7}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 137.0, 93.0, 93.0, 94.0, 138.0, 93.0, 93.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 106.5}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 146.0, 147.0, 147.0, 145.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 97.0, 96.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [60.0, 59.0, 58.0, 58.0, 61.0, 58.0, 59.0, 66.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 59.1}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 67.0, 68.0, 68.0, 67.0, 69.0, 72.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 85.0, 84.0, 94.0, 84.0, 84.0, 85.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [126.0, 121.0, 119.0, 116.0, 121.0, 115.0, 123.0, 125.0, 119.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.3}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 155.0, 153.0, 153.0, 147.0, 154.0, 146.0, 143.0, 164.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.9}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 69.0, 68.0, 69.0, 66.0, 68.0, 66.0, 66.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.5}], "name": "kraken", "value": 1500.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.89250165892503], "unit": "score", "name": "Richards", "value": 212.80045599999988}, {"lowerIsBetter": false, "replicates": [189.32222642938282], "unit": "score", "name": "DeltaBlue", "value": 349.235276}, {"lowerIsBetter": false, "replicates": [281.29395218002816], "unit": "score", "name": "Encrypt", "value": 946.2734550000002}, {"lowerIsBetter": false, "replicates": [5128.205128205128], "unit": "score", "name": "Decrypt", "value": 51.90529499999997}, {"lowerIsBetter": false, "replicates": [2002.0], "unit": "score", "name": "RayTrace", "value": 369.62487512487513}, {"lowerIsBetter": false, "replicates": [786.1635220125786], "unit": "score", "name": "Earley", "value": 847.7409359999999}, {"lowerIsBetter": false, "replicates": [12353.658536585366], "unit": "score", "name": "Boyer", "value": 53.948633761105626}, {"lowerIsBetter": false, "replicates": [26179.48717948718], "unit": "score", "name": "RegExp", "value": 34.79766405484819}, {"lowerIsBetter": false, "replicates": [648.2670089858793], "unit": "score", "name": "Splay", "value": 125.70591881188115}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 19661.806555810912}]} 02:18:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19661.81"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1500.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "7046.85"}}} 02:18:34 INFO - Return code: 0 02:18:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:18:34 INFO - # TBPL SUCCESS # 02:18:34 INFO - Running post-action listener: _resource_record_post_action 02:18:34 INFO - Running post-run listener: _resource_record_post_run 02:18:35 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 557043712; Read time: 8; Write time: 468860 02:18:35 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 245383168; Read time: 0; Write time: 276024 02:18:35 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 311660544; Read time: 8; Write time: 192836 02:18:35 INFO - Running post-run listener: _upload_blobber_files 02:18:35 INFO - Blob upload gear active. 02:18:35 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:18:35 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:18:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 02:18:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 02:18:36 INFO - (blobuploader) - INFO - Open directory for files ... 02:18:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:18:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:18:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:18:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:18:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:18:37 INFO - (blobuploader) - INFO - Done attempting. 02:18:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 02:18:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:18:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:18:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:18:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:18:37 INFO - (blobuploader) - INFO - Done attempting. 02:18:37 INFO - (blobuploader) - INFO - Iteration through files over. 02:18:37 INFO - Return code: 0 02:18:37 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:18:37 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:18:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/975e5a9b01d3d8a0b442164858ab63b34fc11cf0297c6c9d93eeb70db5494bf83f2e97e82c6193d1c80c69844bd5e0de19bb297fb0a77ef71a3b10662c0f336b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/3c00e15366a06829588a6295166bd3a734ef06b34596f81a2719453690af436fc3057438df332937b81cee12c4b5edf905a69429359c6f6712cb4b40c9466f6e"} 02:18:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:18:37 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:18:37 INFO - Contents: 02:18:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/975e5a9b01d3d8a0b442164858ab63b34fc11cf0297c6c9d93eeb70db5494bf83f2e97e82c6193d1c80c69844bd5e0de19bb297fb0a77ef71a3b10662c0f336b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/3c00e15366a06829588a6295166bd3a734ef06b34596f81a2719453690af436fc3057438df332937b81cee12c4b5edf905a69429359c6f6712cb4b40c9466f6e"} 02:18:37 INFO - Copying logs to upload dir... 02:18:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.611198 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-22 02:18:36.940222) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 02:18:36.943855) ========= 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=5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069 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/975e5a9b01d3d8a0b442164858ab63b34fc11cf0297c6c9d93eeb70db5494bf83f2e97e82c6193d1c80c69844bd5e0de19bb297fb0a77ef71a3b10662c0f336b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/3c00e15366a06829588a6295166bd3a734ef06b34596f81a2719453690af436fc3057438df332937b81cee12c4b5edf905a69429359c6f6712cb4b40c9466f6e"} build_url:https://queue.taskcluster.net/v1/task/pPWBpeJDRhKNLqzVbD2N8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011534 build_url: 'https://queue.taskcluster.net/v1/task/pPWBpeJDRhKNLqzVbD2N8g/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/975e5a9b01d3d8a0b442164858ab63b34fc11cf0297c6c9d93eeb70db5494bf83f2e97e82c6193d1c80c69844bd5e0de19bb297fb0a77ef71a3b10662c0f336b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/3c00e15366a06829588a6295166bd3a734ef06b34596f81a2719453690af436fc3057438df332937b81cee12c4b5edf905a69429359c6f6712cb4b40c9466f6e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 02:18:36.971293) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 02:18:36.971671) ========= 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=5752742a61d0f534093fa7a9000001cb-1450777951.598612-2119842069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 02:18:37.055548) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 02:18:37.056035) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 02:18:37.056732) ========= ========= Total master_lag: 0.24 =========