builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-044 starttime: 1453910857.14 results: success (0) buildid: 20160127053032 builduid: 8e03a039eb8a469a9b8eead71fc47079 revision: 02c702d7c722ebec0706bd08a58f9fedfff2d0a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-27 08:07:37.138046) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-27 08:07:37.144502) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-27 08:07:37.144838) ========= 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=574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004430 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-27 08:07:37.167225) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-27 08:07:37.167546) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-27 08:07:37.185104) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:07:37.185395) ========= 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=574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:07:37.238119) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-27 08:07:37.238414) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-27 08:07:37.238771) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:07:37.239038) ========= 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=574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-27 08:07:37-- 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% 227M=0s 2016-01-27 08:07:37 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151047 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:07:37.409112) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:07:37.409427) ========= 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=574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016154 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:07:37.465112) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:07:37.465463) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 02c702d7c722ebec0706bd08a58f9fedfff2d0a1 --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 02c702d7c722ebec0706bd08a58f9fedfff2d0a1 --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=574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-27 08:07:37,785 truncating revision to first 12 chars 2016-01-27 08:07:37,785 Setting DEBUG logging. 2016-01-27 08:07:37,785 attempt 1/10 2016-01-27 08:07:37,785 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/02c702d7c722?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-27 08:07:38,162 unpacking tar archive at: b2g-inbound-02c702d7c722/testing/mozharness/ program finished with exit code 0 elapsedTime=0.665097 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:07:38.148936) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-27 08:07:38.149281) ========= echo 02c702d7c722ebec0706bd08a58f9fedfff2d0a1 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'02c702d7c722ebec0706bd08a58f9fedfff2d0a1'] 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=574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02c702d7c722ebec0706bd08a58f9fedfff2d0a1 program finished with exit code 0 elapsedTime=0.004320 script_repo_revision: '02c702d7c722ebec0706bd08a58f9fedfff2d0a1' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-27 08:07:38.203158) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-27 08:07:38.203476) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-27 08:07:38.216944) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-01-27 08:07:38.217262) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:07:38 INFO - MultiFileLogger online at 20160127 08:07:38 in /builds/slave/test-pgo 08:07:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 08:07:38 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:07:38 INFO - {'append_to_log': False, 08:07:38 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:07:38 INFO - 'blob_upload_branch': 'B2G-Inbound', 08:07:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:07:38 INFO - 'branch': 'B2G-Inbound', 08:07:38 INFO - 'buildbot_json_path': 'buildprops.json', 08:07:38 INFO - 'config_files': ('talos/linux_config.py',), 08:07:38 INFO - 'default_actions': ('clobber', 08:07:38 INFO - 'read-buildbot-config', 08:07:38 INFO - 'download-and-extract', 08:07:38 INFO - 'populate-webroot', 08:07:38 INFO - 'create-virtualenv', 08:07:38 INFO - 'install', 08:07:38 INFO - 'run-tests'), 08:07:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:07:38 INFO - 'download_minidump_stackwalk': True, 08:07:38 INFO - 'download_symbols': 'ondemand', 08:07:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:07:38 INFO - 'tooltool.py': '/tools/tooltool.py', 08:07:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:07:38 INFO - '/tools/misc-python/virtualenv.py')}, 08:07:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:07:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:07:38 INFO - 'installer_path': 'installer.exe', 08:07:38 INFO - 'log_level': 'info', 08:07:38 INFO - 'log_name': 'talos', 08:07:38 INFO - 'log_to_console': True, 08:07:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:07:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:07:38 INFO - 'opt_config_files': (), 08:07:38 INFO - 'pip_index': False, 08:07:38 INFO - 'sps_profile': False, 08:07:38 INFO - 'sps_profile_interval': 0, 08:07:38 INFO - 'suite': 'dromaeojs', 08:07:38 INFO - 'system_bits': '32', 08:07:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:07:38 INFO - 'title': 'talos-linux64-ix-044', 08:07:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:07:38 INFO - 'use_talos_json': True, 08:07:38 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:07:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:07:38 INFO - 'work_dir': 'build'} 08:07:38 INFO - ##### 08:07:38 INFO - ##### Running clobber step. 08:07:38 INFO - ##### 08:07:38 INFO - Running pre-action listener: _resource_record_pre_action 08:07:38 INFO - Running main action method: clobber 08:07:38 INFO - rmtree: /builds/slave/test-pgo/build 08:07:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:07:39 INFO - Running post-action listener: _resource_record_post_action 08:07:39 INFO - ##### 08:07:39 INFO - ##### Running read-buildbot-config step. 08:07:39 INFO - ##### 08:07:39 INFO - Running pre-action listener: _resource_record_pre_action 08:07:39 INFO - Running main action method: read_buildbot_config 08:07:39 INFO - Using buildbot properties: 08:07:39 INFO - { 08:07:39 INFO - "project": "", 08:07:39 INFO - "product": "firefox", 08:07:39 INFO - "script_repo_revision": "production", 08:07:39 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 08:07:39 INFO - "repository": "", 08:07:39 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 08:07:39 INFO - "buildid": "20160127053032", 08:07:39 INFO - "pgo_build": "True", 08:07:39 INFO - "basedir": "/builds/slave/test-pgo", 08:07:39 INFO - "buildnumber": 237, 08:07:39 INFO - "slavename": "talos-linux64-ix-044", 08:07:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:07:39 INFO - "platform": "ubuntu64_hw", 08:07:39 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 08:07:39 INFO - "branch": "b2g-inbound", 08:07:39 INFO - "repo_path": "integration/b2g-inbound", 08:07:39 INFO - "revision": "02c702d7c722ebec0706bd08a58f9fedfff2d0a1", 08:07:39 INFO - "stage_platform": "linux64-pgo", 08:07:39 INFO - "builduid": "8e03a039eb8a469a9b8eead71fc47079", 08:07:39 INFO - "slavebuilddir": "test" 08:07:39 INFO - } 08:07:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 08:07:39 INFO - Running post-action listener: _resource_record_post_action 08:07:39 INFO - ##### 08:07:39 INFO - ##### Running download-and-extract step. 08:07:39 INFO - ##### 08:07:39 INFO - Running pre-action listener: _resource_record_pre_action 08:07:39 INFO - Running main action method: download_and_extract 08:07:39 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:07:39 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')]} 08:07:39 INFO - https://queue.taskcluster.net/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:07:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/test_packages.json 08:07:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/test_packages.json 08:07:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:07:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:07:39 INFO - Downloaded 1448 bytes. 08:07:39 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:07:39 INFO - Using the following test package requirements: 08:07:39 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:07:39 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:39 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:07:39 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:39 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:07:39 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:39 INFO - u'jsshell-linux-x86_64.zip'], 08:07:39 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:39 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:07:39 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:07:39 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:39 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:07:39 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:39 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:07:39 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:39 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:07:39 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:07:39 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:39 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:07:39 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:07:39 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')]} 08:07:39 INFO - https://queue.taskcluster.net/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:07:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:07:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:07:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:07:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:07:40 INFO - Downloaded 22499141 bytes. 08:07:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:07:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:07:41 INFO - Return code: 0 08:07:41 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:07:41 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')]} 08:07:41 INFO - https://queue.taskcluster.net/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:07:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:07:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:07:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:07:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:07:43 INFO - Downloaded 22499141 bytes. 08:07:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:07:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:07:44 INFO - Return code: 0 08:07:44 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')]} 08:07:44 INFO - https://queue.taskcluster.net/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:07:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:07:45 INFO - Downloaded 10706572 bytes. 08:07:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:07:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 08:07:45 INFO - Return code: 0 08:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:45 INFO - https://queue.taskcluster.net/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:07:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:07:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:07:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:07:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:07:46 INFO - Downloaded 55983712 bytes. 08:07:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:07:46 INFO - mkdir: /builds/slave/test-pgo/properties 08:07:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:07:46 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:07:46 INFO - Contents: 08:07:46 INFO - build_url:https://queue.taskcluster.net/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:07:46 INFO - Running post-action listener: _resource_record_post_action 08:07:46 INFO - Running post-action listener: set_extra_try_arguments 08:07:46 INFO - ##### 08:07:46 INFO - ##### Running populate-webroot step. 08:07:46 INFO - ##### 08:07:46 INFO - Running pre-action listener: _resource_record_pre_action 08:07:46 INFO - Running main action method: populate_webroot 08:07:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:07:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:07:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:07:46 INFO - '--tppagecycles', 08:07:46 INFO - '7'], 08:07:46 INFO - 'tests': ['tsvgm']}}, 08:07:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:07:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:07:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:07:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:07:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:07:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:07:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:07:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:46 INFO - 'talos_options': ['--e10s'], 08:07:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:07:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:46 INFO - 'tests': ['damp', 'tps']}, 08:07:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:46 INFO - 'talos_options': ['--e10s'], 08:07:46 INFO - 'tests': ['damp', 'tps']}, 08:07:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:07:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:07:46 INFO - 'other': {'tests': ['a11yr', 08:07:46 INFO - 'ts_paint', 08:07:46 INFO - 'tpaint', 08:07:46 INFO - 'sessionrestore', 08:07:46 INFO - 'sessionrestore_no_auto_restore']}, 08:07:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:07:46 INFO - 'tests': ['a11yr', 08:07:46 INFO - 'ts_paint', 08:07:46 INFO - 'tpaint', 08:07:46 INFO - 'sessionrestore', 08:07:46 INFO - 'sessionrestore_no_auto_restore']}, 08:07:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:07:46 INFO - 'tests': ['a11yr', 08:07:46 INFO - 'ts_paint', 08:07:46 INFO - 'tpaint', 08:07:46 INFO - 'sessionrestore', 08:07:46 INFO - 'sessionrestore_no_auto_restore']}, 08:07:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:07:46 INFO - 'tests': ['a11yr', 08:07:46 INFO - 'ts_paint', 08:07:46 INFO - 'tpaint', 08:07:46 INFO - 'sessionrestore', 08:07:46 INFO - 'sessionrestore_no_auto_restore']}, 08:07:46 INFO - 'other_l64': {'tests': ['a11yr', 08:07:46 INFO - 'ts_paint', 08:07:46 INFO - 'tpaint', 08:07:46 INFO - 'sessionrestore', 08:07:46 INFO - 'sessionrestore_no_auto_restore']}, 08:07:46 INFO - 'other_nol64': {'tests': ['a11yr', 08:07:46 INFO - 'ts_paint', 08:07:46 INFO - 'tpaint', 08:07:46 INFO - 'sessionrestore', 08:07:46 INFO - 'sessionrestore_no_auto_restore']}, 08:07:46 INFO - 'svgr': {'tests': ['tsvgx', 08:07:46 INFO - 'tsvgr_opacity', 08:07:46 INFO - 'tart', 08:07:46 INFO - 'tscrollx', 08:07:46 INFO - 'cart']}, 08:07:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:07:46 INFO - 'tests': ['tsvgx', 08:07:46 INFO - 'tsvgr_opacity', 08:07:46 INFO - 'tart', 08:07:46 INFO - 'tscrollx', 08:07:46 INFO - 'cart']}, 08:07:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:46 INFO - 'tests': ['tp5o']}, 08:07:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:46 INFO - 'talos_options': ['--e10s'], 08:07:46 INFO - 'tests': ['tp5o']}, 08:07:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:46 INFO - 'talos_options': ['--xperf_path', 08:07:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:07:46 INFO - 'tests': ['tp5n']}, 08:07:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:46 INFO - 'talos_options': ['--e10s', 08:07:46 INFO - '--xperf_path', 08:07:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:07:46 INFO - 'tests': ['tp5n']}}, 08:07:46 INFO - 'talos.zip': {'path': '', 08:07:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:07:46 INFO - Running post-action listener: _resource_record_post_action 08:07:46 INFO - ##### 08:07:46 INFO - ##### Running create-virtualenv step. 08:07:46 INFO - ##### 08:07:46 INFO - Running pre-action listener: _resource_record_pre_action 08:07:46 INFO - Running main action method: create_virtualenv 08:07:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:07:46 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 08:07:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:07:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:07:47 INFO - Using real prefix '/usr' 08:07:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:07:47 INFO - Installing distribute.............................................................................................................................................................................................done. 08:07:49 INFO - Installing pip.................done. 08:07:49 INFO - Return code: 0 08:07:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:07: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')]} 08:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07: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')]} 08:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f63fb5b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1415630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a6840>, '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 0x14136b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1413b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714', '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 08:07:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:07:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:07:49 INFO - Using env: {'DISPLAY': ':0', 08:07:49 INFO - 'HOME': '/home/cltbld', 08:07:49 INFO - 'LANG': 'en_US.UTF-8', 08:07:49 INFO - 'LANGUAGE': 'en_US:en', 08:07:49 INFO - 'LOGNAME': 'cltbld', 08:07:49 INFO - 'MAIL': '/var/mail/cltbld', 08:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:49 INFO - 'MOZ_NO_REMOTE': '1', 08:07:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:49 INFO - 'NO_EM_RESTART': '1', 08:07:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:07:49 INFO - 'PWD': '/builds/slave/test-pgo', 08:07:49 INFO - 'SHELL': '/bin/bash', 08:07:49 INFO - 'SHLVL': '1', 08:07:49 INFO - 'TERM': 'linux', 08:07:49 INFO - 'TMOUT': '86400', 08:07:49 INFO - 'USER': 'cltbld', 08:07:49 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714', 08:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:49 INFO - '_': '/tools/buildbot/bin/python'} 08:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:49 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 08:07:49 INFO - Cleaning up... 08:07:49 INFO - Return code: 0 08:07:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:07: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')]} 08:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07: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')]} 08:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f63fb5b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1415630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a6840>, '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 0x14136b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1413b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714', '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 08:07:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:07:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:07:49 INFO - Using env: {'DISPLAY': ':0', 08:07:49 INFO - 'HOME': '/home/cltbld', 08:07:49 INFO - 'LANG': 'en_US.UTF-8', 08:07:49 INFO - 'LANGUAGE': 'en_US:en', 08:07:49 INFO - 'LOGNAME': 'cltbld', 08:07:49 INFO - 'MAIL': '/var/mail/cltbld', 08:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:49 INFO - 'MOZ_NO_REMOTE': '1', 08:07:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:49 INFO - 'NO_EM_RESTART': '1', 08:07:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:07:49 INFO - 'PWD': '/builds/slave/test-pgo', 08:07:49 INFO - 'SHELL': '/bin/bash', 08:07:49 INFO - 'SHLVL': '1', 08:07:49 INFO - 'TERM': 'linux', 08:07:49 INFO - 'TMOUT': '86400', 08:07:49 INFO - 'USER': 'cltbld', 08:07:49 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714', 08:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:49 INFO - '_': '/tools/buildbot/bin/python'} 08:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:49 INFO - Downloading/unpacking psutil>=0.7.1 08:07: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 08:07: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 08:07: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 08:07: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 08:07: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 08:07: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 08:07:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:07:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:07:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:07:51 INFO - Installing collected packages: psutil 08:07:51 INFO - Running setup.py install for psutil 08:07:51 INFO - building 'psutil._psutil_linux' extension 08:07:51 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 08:07:52 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 08:07:52 INFO - building 'psutil._psutil_posix' extension 08:07:52 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 08:07:52 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 08:07:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:07:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:07:52 INFO - Successfully installed psutil 08:07:52 INFO - Cleaning up... 08:07:52 INFO - Return code: 0 08:07:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:07:52 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')]} 08:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:52 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')]} 08:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f63fb5b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1415630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a6840>, '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 0x14136b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1413b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714', '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 08:07:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:07:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:07:52 INFO - Using env: {'DISPLAY': ':0', 08:07:52 INFO - 'HOME': '/home/cltbld', 08:07:52 INFO - 'LANG': 'en_US.UTF-8', 08:07:52 INFO - 'LANGUAGE': 'en_US:en', 08:07:52 INFO - 'LOGNAME': 'cltbld', 08:07:52 INFO - 'MAIL': '/var/mail/cltbld', 08:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:52 INFO - 'MOZ_NO_REMOTE': '1', 08:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:52 INFO - 'NO_EM_RESTART': '1', 08:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:07:52 INFO - 'PWD': '/builds/slave/test-pgo', 08:07:52 INFO - 'SHELL': '/bin/bash', 08:07:52 INFO - 'SHLVL': '1', 08:07:52 INFO - 'TERM': 'linux', 08:07:52 INFO - 'TMOUT': '86400', 08:07:52 INFO - 'USER': 'cltbld', 08:07:52 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714', 08:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:52 INFO - '_': '/tools/buildbot/bin/python'} 08:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:07:52 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 08:07:52 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 08:07:52 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 08:07:52 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 08:07:52 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 08:07:52 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 08:07:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:07:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:07:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:07:54 INFO - Installing collected packages: mozsystemmonitor 08:07:54 INFO - Running setup.py install for mozsystemmonitor 08:07:54 INFO - Successfully installed mozsystemmonitor 08:07:54 INFO - Cleaning up... 08:07:54 INFO - Return code: 0 08:07:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:07: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')]} 08:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07: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')]} 08:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f63fb5b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1415630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a6840>, '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 0x14136b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1413b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714', '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 08:07:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:07:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:07:54 INFO - Using env: {'DISPLAY': ':0', 08:07:54 INFO - 'HOME': '/home/cltbld', 08:07:54 INFO - 'LANG': 'en_US.UTF-8', 08:07:54 INFO - 'LANGUAGE': 'en_US:en', 08:07:54 INFO - 'LOGNAME': 'cltbld', 08:07:54 INFO - 'MAIL': '/var/mail/cltbld', 08:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:54 INFO - 'MOZ_NO_REMOTE': '1', 08:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:54 INFO - 'NO_EM_RESTART': '1', 08:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:07:54 INFO - 'PWD': '/builds/slave/test-pgo', 08:07:54 INFO - 'SHELL': '/bin/bash', 08:07:54 INFO - 'SHLVL': '1', 08:07:54 INFO - 'TERM': 'linux', 08:07:54 INFO - 'TMOUT': '86400', 08:07:54 INFO - 'USER': 'cltbld', 08:07:54 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714', 08:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:54 INFO - '_': '/tools/buildbot/bin/python'} 08:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:54 INFO - Downloading/unpacking blobuploader==1.2.4 08:07:54 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 08:07:54 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 08:07:54 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 08:07:54 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 08:07:54 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 08:07:54 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 08:07:56 INFO - Downloading blobuploader-1.2.4.tar.gz 08:07:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:07:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:07:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:57 INFO - Downloading docopt-0.6.1.tar.gz 08:07:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:07:57 INFO - Installing collected packages: blobuploader, requests, docopt 08:07:57 INFO - Running setup.py install for blobuploader 08:07:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:07:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:07:57 INFO - Running setup.py install for requests 08:07:57 INFO - Running setup.py install for docopt 08:07:58 INFO - Successfully installed blobuploader requests docopt 08:07:58 INFO - Cleaning up... 08:07:58 INFO - Return code: 0 08:07:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f63fb5b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1415630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a6840>, '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 0x14136b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1413b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714', '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 08:07:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 08:07:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 08:07:58 INFO - Using env: {'DISPLAY': ':0', 08:07:58 INFO - 'HOME': '/home/cltbld', 08:07:58 INFO - 'LANG': 'en_US.UTF-8', 08:07:58 INFO - 'LANGUAGE': 'en_US:en', 08:07:58 INFO - 'LOGNAME': 'cltbld', 08:07:58 INFO - 'MAIL': '/var/mail/cltbld', 08:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:58 INFO - 'MOZ_NO_REMOTE': '1', 08:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:58 INFO - 'NO_EM_RESTART': '1', 08:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:07:58 INFO - 'PWD': '/builds/slave/test-pgo', 08:07:58 INFO - 'SHELL': '/bin/bash', 08:07:58 INFO - 'SHLVL': '1', 08:07:58 INFO - 'TERM': 'linux', 08:07:58 INFO - 'TMOUT': '86400', 08:07:58 INFO - 'USER': 'cltbld', 08:07:58 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714', 08:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:58 INFO - '_': '/tools/buildbot/bin/python'} 08:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:07:58 INFO - Running setup.py (path:/tmp/pip-MTHxEX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:07:58 INFO - Running setup.py (path:/tmp/pip-nFiDhF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:07:58 INFO - Running setup.py (path:/tmp/pip-I7hSo4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:07:58 INFO - Running setup.py (path:/tmp/pip-rc8kLI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:07:58 INFO - Running setup.py (path:/tmp/pip-AS0D8q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:07:58 INFO - Running setup.py (path:/tmp/pip-5sr0Oq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:07:58 INFO - Running setup.py (path:/tmp/pip-WB4vCS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:07:58 INFO - Running setup.py (path:/tmp/pip-_tNn89-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:07:58 INFO - Running setup.py (path:/tmp/pip-PqQglJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:07:58 INFO - Running setup.py (path:/tmp/pip-rBQblV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:07:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:07:59 INFO - Running setup.py (path:/tmp/pip-UA3Ukm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:07:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:07:59 INFO - Running setup.py (path:/tmp/pip-whB_3J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:07:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:07:59 INFO - Running setup.py (path:/tmp/pip-YmCI_T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:07:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:07:59 INFO - Running setup.py (path:/tmp/pip-XgbmfS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:07:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:07:59 INFO - Running setup.py (path:/tmp/pip-0FMSxd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:07:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:07:59 INFO - Running setup.py (path:/tmp/pip-4i5go8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:07:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:07:59 INFO - Running setup.py (path:/tmp/pip-J_MRRB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:07:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:07:59 INFO - Running setup.py install for manifestparser 08:07:59 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:07:59 INFO - Running setup.py install for mozcrash 08:07:59 INFO - Running setup.py install for mozdebug 08:07:59 INFO - Running setup.py install for mozdevice 08:07:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:07:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:07:59 INFO - Running setup.py install for mozfile 08:08:00 INFO - Running setup.py install for mozhttpd 08:08:00 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:08:00 INFO - Running setup.py install for mozinfo 08:08:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:08:00 INFO - Running setup.py install for mozInstall 08:08:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:08:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:08:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:08:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:08:00 INFO - Running setup.py install for mozleak 08:08:00 INFO - Running setup.py install for mozlog 08:08:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:08:00 INFO - Running setup.py install for moznetwork 08:08:00 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:08:00 INFO - Running setup.py install for mozprocess 08:08:00 INFO - Running setup.py install for mozprofile 08:08:00 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:08:00 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:08:00 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:08:00 INFO - Running setup.py install for mozrunner 08:08:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:08:01 INFO - Running setup.py install for mozscreenshot 08:08:01 INFO - Running setup.py install for moztest 08:08:01 INFO - Running setup.py install for mozversion 08:08:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:08:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:08:01 INFO - Cleaning up... 08:08:01 INFO - Return code: 0 08:08:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:08: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')]} 08:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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')]} 08:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f63fb5b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1415630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a6840>, '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 0x14136b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1413b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714', '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 08:08:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:08:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:08:01 INFO - Using env: {'DISPLAY': ':0', 08:08:01 INFO - 'HOME': '/home/cltbld', 08:08:01 INFO - 'LANG': 'en_US.UTF-8', 08:08:01 INFO - 'LANGUAGE': 'en_US:en', 08:08:01 INFO - 'LOGNAME': 'cltbld', 08:08:01 INFO - 'MAIL': '/var/mail/cltbld', 08:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:01 INFO - 'MOZ_NO_REMOTE': '1', 08:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:01 INFO - 'NO_EM_RESTART': '1', 08:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:01 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:01 INFO - 'SHELL': '/bin/bash', 08:08:01 INFO - 'SHLVL': '1', 08:08:01 INFO - 'TERM': 'linux', 08:08:01 INFO - 'TMOUT': '86400', 08:08:01 INFO - 'USER': 'cltbld', 08:08:01 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714', 08:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:01 INFO - '_': '/tools/buildbot/bin/python'} 08:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:08:01 INFO - Running setup.py (path:/tmp/pip-_yU7m0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:08:01 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)) 08:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:08:01 INFO - Running setup.py (path:/tmp/pip-Oveqnz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:08:01 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)) 08:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:08:01 INFO - Running setup.py (path:/tmp/pip-0p6pgZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:08:01 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)) 08:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:08:01 INFO - Running setup.py (path:/tmp/pip-Dknmi9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 08:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:08:01 INFO - Running setup.py (path:/tmp/pip-v1iWCV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:08:01 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)) 08:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:08:01 INFO - Running setup.py (path:/tmp/pip-T8dkSa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:08:01 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)) 08:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:08:01 INFO - Running setup.py (path:/tmp/pip-NiyTsW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:08:02 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)) 08:08:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:08:02 INFO - Running setup.py (path:/tmp/pip-PYBw9m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:08:02 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)) 08:08:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:08:02 INFO - Running setup.py (path:/tmp/pip-rM3hfT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:08:02 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)) 08:08:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:08:02 INFO - Running setup.py (path:/tmp/pip-_U2psr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:08:02 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)) 08:08:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:08:02 INFO - Running setup.py (path:/tmp/pip-aChSc2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:08:02 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)) 08:08:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:08:02 INFO - Running setup.py (path:/tmp/pip-X96ZnY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:08:02 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)) 08:08:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:08:02 INFO - Running setup.py (path:/tmp/pip-fdmUYO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:08:02 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)) 08:08:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:08:02 INFO - Running setup.py (path:/tmp/pip-pdEC40-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:08:02 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)) 08:08:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:08:02 INFO - Running setup.py (path:/tmp/pip-Qe4tM5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:08:02 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)) 08:08:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:08:02 INFO - Running setup.py (path:/tmp/pip-4xlFX7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:08:02 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)) 08:08:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:08:02 INFO - Running setup.py (path:/tmp/pip-CdoS8D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:08:02 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)) 08:08:02 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)) 08:08:02 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)) 08:08:02 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)) 08:08:02 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:08:02 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:08:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:04 INFO - Downloading blessings-1.6.tar.gz 08:08:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:08:04 INFO - Installing collected packages: blessings 08:08:04 INFO - Running setup.py install for blessings 08:08:04 INFO - Successfully installed blessings 08:08:04 INFO - Cleaning up... 08:08:04 INFO - Return code: 0 08:08:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:08:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:08:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:08:04 INFO - Reading from file tmpfile_stdout 08:08:04 INFO - Current package versions: 08:08:04 INFO - argparse == 1.2.1 08:08:04 INFO - blessings == 1.6 08:08:04 INFO - blobuploader == 1.2.4 08:08:04 INFO - docopt == 0.6.1 08:08:04 INFO - manifestparser == 1.1 08:08:04 INFO - mozInstall == 1.12 08:08:04 INFO - mozcrash == 0.16 08:08:04 INFO - mozdebug == 0.1 08:08:04 INFO - mozdevice == 0.48 08:08:04 INFO - mozfile == 1.2 08:08:04 INFO - mozhttpd == 0.7 08:08:04 INFO - mozinfo == 0.9 08:08:04 INFO - mozleak == 0.1 08:08:04 INFO - mozlog == 3.1 08:08:04 INFO - moznetwork == 0.27 08:08:04 INFO - mozprocess == 0.22 08:08:04 INFO - mozprofile == 0.28 08:08:04 INFO - mozrunner == 6.11 08:08:04 INFO - mozscreenshot == 0.1 08:08:04 INFO - mozsystemmonitor == 0.0 08:08:04 INFO - moztest == 0.7 08:08:04 INFO - mozversion == 1.4 08:08:04 INFO - psutil == 3.1.1 08:08:04 INFO - requests == 1.2.3 08:08:04 INFO - wsgiref == 0.1.2 08:08:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:08:04 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')]} 08:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:04 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')]} 08:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f63fb5b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1415630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a6840>, '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 0x14136b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1413b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714', '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 08:08:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:08:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:08:04 INFO - Using env: {'DISPLAY': ':0', 08:08:04 INFO - 'HOME': '/home/cltbld', 08:08:04 INFO - 'LANG': 'en_US.UTF-8', 08:08:04 INFO - 'LANGUAGE': 'en_US:en', 08:08:04 INFO - 'LOGNAME': 'cltbld', 08:08:04 INFO - 'MAIL': '/var/mail/cltbld', 08:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:04 INFO - 'MOZ_NO_REMOTE': '1', 08:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:04 INFO - 'NO_EM_RESTART': '1', 08:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:04 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:04 INFO - 'SHELL': '/bin/bash', 08:08:04 INFO - 'SHLVL': '1', 08:08:04 INFO - 'TERM': 'linux', 08:08:04 INFO - 'TMOUT': '86400', 08:08:04 INFO - 'USER': 'cltbld', 08:08:04 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714', 08:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:04 INFO - '_': '/tools/buildbot/bin/python'} 08:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:05 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)) 08:08:05 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)) 08:08:05 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)) 08:08:05 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)) 08:08:05 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)) 08:08:05 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)) 08:08:05 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)) 08:08:05 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)) 08:08:05 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)) 08:08:05 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)) 08:08:05 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)) 08:08:05 INFO - Cleaning up... 08:08:05 INFO - Return code: 0 08:08:05 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:08:05 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')]} 08:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:05 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')]} 08:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f63fb5b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1415630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a6840>, '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 0x14136b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1413b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714', '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 08:08:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:08:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:08:05 INFO - Using env: {'DISPLAY': ':0', 08:08:05 INFO - 'HOME': '/home/cltbld', 08:08:05 INFO - 'LANG': 'en_US.UTF-8', 08:08:05 INFO - 'LANGUAGE': 'en_US:en', 08:08:05 INFO - 'LOGNAME': 'cltbld', 08:08:05 INFO - 'MAIL': '/var/mail/cltbld', 08:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:05 INFO - 'MOZ_NO_REMOTE': '1', 08:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:05 INFO - 'NO_EM_RESTART': '1', 08:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:05 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:05 INFO - 'SHELL': '/bin/bash', 08:08:05 INFO - 'SHLVL': '1', 08:08:05 INFO - 'TERM': 'linux', 08:08:05 INFO - 'TMOUT': '86400', 08:08:05 INFO - 'USER': 'cltbld', 08:08:05 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714', 08:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:05 INFO - '_': '/tools/buildbot/bin/python'} 08:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:05 INFO - Downloading/unpacking jsonschema 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:08:07 INFO - Downloading/unpacking functools32 (from jsonschema) 08:08:07 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 08:08:07 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 08:08:07 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 08:08:07 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 08:08:07 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 08:08:07 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 08:08:07 INFO - Downloading functools32-3.2.3-2.tar.gz 08:08:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:08:07 INFO - warning: no files found matching '*.txt' 08:08:07 INFO - no previously-included directories found matching 'build' 08:08:07 INFO - no previously-included directories found matching 'dist' 08:08:07 INFO - no previously-included directories found matching '.git*' 08:08:07 INFO - Installing collected packages: jsonschema, functools32 08:08:07 INFO - Running setup.py install for functools32 08:08:07 INFO - warning: no files found matching '*.txt' 08:08:07 INFO - no previously-included directories found matching 'build' 08:08:07 INFO - no previously-included directories found matching 'dist' 08:08:07 INFO - no previously-included directories found matching '.git*' 08:08:07 INFO - Successfully installed jsonschema functools32 08:08:07 INFO - Cleaning up... 08:08:07 INFO - Return code: 0 08:08:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:08:07 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')]} 08:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:07 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')]} 08:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f63fb5b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1415630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a6840>, '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 0x14136b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1413b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714', '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 08:08:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:08:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:08:07 INFO - Using env: {'DISPLAY': ':0', 08:08:07 INFO - 'HOME': '/home/cltbld', 08:08:07 INFO - 'LANG': 'en_US.UTF-8', 08:08:07 INFO - 'LANGUAGE': 'en_US:en', 08:08:07 INFO - 'LOGNAME': 'cltbld', 08:08:07 INFO - 'MAIL': '/var/mail/cltbld', 08:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:07 INFO - 'MOZ_NO_REMOTE': '1', 08:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:07 INFO - 'NO_EM_RESTART': '1', 08:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:07 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:07 INFO - 'SHELL': '/bin/bash', 08:08:07 INFO - 'SHLVL': '1', 08:08:07 INFO - 'TERM': 'linux', 08:08:07 INFO - 'TMOUT': '86400', 08:08:07 INFO - 'USER': 'cltbld', 08:08:07 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714', 08:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:07 INFO - '_': '/tools/buildbot/bin/python'} 08:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:07 INFO - Downloading/unpacking flake8 08:08:07 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 08:08:07 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 08:08:07 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 08:08:07 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 08:08:07 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 08:08:07 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 08:08:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:08:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:08:09 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 08:08:09 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 08:08:09 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 08:08:09 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 08:08:09 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 08:08:09 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 08:08:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:08:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:08:09 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 08:08:09 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 08:08:09 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 08:08:09 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 08:08:09 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 08:08:09 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 08:08:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:08:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:08:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:08:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:08:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:08:10 INFO - no previously-included directories found matching 'docs/_build' 08:08:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:08:10 INFO - Running setup.py install for pep8 08:08:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:08:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:08:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:08:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:08:10 INFO - no previously-included directories found matching 'docs/_build' 08:08:10 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:08:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:08:10 INFO - Cleaning up... 08:08:10 INFO - Return code: 0 08:08:10 INFO - Running post-action listener: _resource_record_post_action 08:08:10 INFO - Running post-action listener: _start_resource_monitoring 08:08:10 INFO - Starting resource monitoring. 08:08:10 INFO - ##### 08:08:10 INFO - ##### Running install step. 08:08:10 INFO - ##### 08:08:10 INFO - Running pre-action listener: _resource_record_pre_action 08:08:10 INFO - Running main action method: install 08:08:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:08:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:08:10 INFO - Reading from file tmpfile_stdout 08:08:10 INFO - Detecting whether we're running mozinstall >=1.0... 08:08:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:08:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:08:10 INFO - Reading from file tmpfile_stdout 08:08:10 INFO - Output received: 08:08:10 INFO - Usage: mozinstall [options] installer 08:08:10 INFO - Options: 08:08:10 INFO - -h, --help show this help message and exit 08:08:10 INFO - -d DEST, --destination=DEST 08:08:10 INFO - Directory to install application into. [default: 08:08:10 INFO - "/builds/slave/test-pgo"] 08:08:10 INFO - --app=APP Application being installed. [default: firefox] 08:08:10 INFO - mkdir: /builds/slave/test-pgo/build/application 08:08:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 08:08:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 08:08:26 INFO - Reading from file tmpfile_stdout 08:08:26 INFO - Output received: 08:08:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:08:26 INFO - Running post-action listener: _resource_record_post_action 08:08:26 INFO - ##### 08:08:26 INFO - ##### Running run-tests step. 08:08:26 INFO - ##### 08:08:26 INFO - Running pre-action listener: _resource_record_pre_action 08:08:26 INFO - Running main action method: run_tests 08:08:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:08:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:08:26 INFO - Python 2.7.3 08:08:26 INFO - Return code: 0 08:08:26 INFO - grabbing minidump binary from tooltool 08:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:26 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 0x14a6840>, '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 0x14136b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1413b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:08:26 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 08:08:26 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 08:08:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:08:27 INFO - Return code: 0 08:08:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:08:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:08:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:08:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:08:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:08:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:08:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:08:28 INFO - Return code: 0 08:08:28 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/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 08:08:28 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/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 08:08:28 INFO - Using env: {'DISPLAY': ':0', 08:08:28 INFO - 'HOME': '/home/cltbld', 08:08:28 INFO - 'LANG': 'en_US.UTF-8', 08:08:28 INFO - 'LANGUAGE': 'en_US:en', 08:08:28 INFO - 'LOGNAME': 'cltbld', 08:08:28 INFO - 'MAIL': '/var/mail/cltbld', 08:08:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:08:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:28 INFO - 'MOZ_NO_REMOTE': '1', 08:08:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:08:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:28 INFO - 'NO_EM_RESTART': '1', 08:08:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:28 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:08:28 INFO - 'SHELL': '/bin/bash', 08:08:28 INFO - 'SHLVL': '1', 08:08:28 INFO - 'TERM': 'linux', 08:08:28 INFO - 'TMOUT': '86400', 08:08:28 INFO - 'USER': 'cltbld', 08:08:28 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714', 08:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:28 INFO - '_': '/tools/buildbot/bin/python'} 08:08:28 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/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 08:08:28 INFO - mozversion application_buildid: 20160127053032 08:08:28 INFO - mozversion application_changeset: 02c702d7c722ebec0706bd08a58f9fedfff2d0a1 08:08:28 INFO - mozversion application_display_name: Nightly 08:08:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:08:28 INFO - mozversion application_name: Firefox 08:08:28 INFO - mozversion application_remotingname: firefox 08:08:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 08:08:28 INFO - mozversion application_vendor: Mozilla 08:08:28 INFO - mozversion application_version: 47.0a1 08:08:28 INFO - mozversion platform_buildid: 20160127053032 08:08:28 INFO - mozversion platform_changeset: 02c702d7c722ebec0706bd08a58f9fedfff2d0a1 08:08:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 08:08:28 INFO - mozversion platform_version: 47.0a1 08:08:28 INFO - using testdate: 1453910908 08:08:28 INFO - actual date: 1453910908 08:08:28 INFO - starting webserver on 'localhost:41679' 08:08:28 INFO - SUITE-START | Running 3 tests 08:08:28 INFO - TEST-START | dromaeo_css 08:08:28 INFO - operating with platform_type : linux_ 08:08:28 INFO - Initialising browser for dromaeo_css test... 08:08:28 INFO - TEST-INFO | started process 7314 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLiNH8E/profile http://localhost:41679/getInfo.html) 08:08:32 INFO - PROCESS | 7314 | __metrics Screen width/height:1600/1200 08:08:32 INFO - PROCESS | 7314 | colorDepth:24 08:08:32 INFO - PROCESS | 7314 | Browser inner width/height: 1024/697 08:08:32 INFO - PROCESS | 7314 | __metrics 08:08:32 INFO - PROCESS | 7314 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:08:32 INFO - PROCESS | 7314 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:08:33 INFO - TEST-INFO | 7314: exit 0 08:08:33 INFO - Browser initialized. 08:08:33 INFO - Running cycle 1/1 for dromaeo_css test... 08:08:33 INFO - TEST-INFO | started process 7406 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLiNH8E/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:08:45 INFO - PROCESS | 7406 | RSS: Main: 148316160 08:08:45 INFO - PROCESS | 7406 | 08:09:36 INFO - PROCESS | 7406 | 1453910976931 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] 08:11:45 INFO - PROCESS | 7406 | Cycle 1(1): loaded http://localhost:41679/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41679/tests/dromaeo/cssquery-ext.html) 08:11:46 INFO - PROCESS | 7406 | RSS: Main: 271167488 08:11:46 INFO - PROCESS | 7406 | 08:14:48 INFO - PROCESS | 7406 | Cycle 1(1): loaded http://localhost:41679/tests/dromaeo/cssquery-ext.html (next: http://localhost:41679/tests/dromaeo/cssquery-jquery.html) 08:14:49 INFO - PROCESS | 7406 | RSS: Main: 235118592 08:14:49 INFO - PROCESS | 7406 | 08:17:51 INFO - PROCESS | 7406 | Cycle 1(1): loaded http://localhost:41679/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41679/tests/dromaeo/cssquery-mootools.html) 08:17:51 INFO - PROCESS | 7406 | RSS: Main: 239136768 08:17:51 INFO - PROCESS | 7406 | 08:20:53 INFO - PROCESS | 7406 | Cycle 1(1): loaded http://localhost:41679/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41679/tests/dromaeo/cssquery-prototype.html) 08:20:54 INFO - PROCESS | 7406 | RSS: Main: 213921792 08:20:54 INFO - PROCESS | 7406 | 08:23:56 INFO - PROCESS | 7406 | Cycle 1(1): loaded http://localhost:41679/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41679/tests/dromaeo/cssquery-yui.html) 08:23:57 INFO - PROCESS | 7406 | RSS: Main: 215498752 08:23:57 INFO - PROCESS | 7406 | 08:27:00 INFO - PROCESS | 7406 | Cycle 1(1): loaded http://localhost:41679/tests/dromaeo/cssquery-yui.html (next: http://localhost:41679/tests/dromaeo/cssquery-dojo.html) 08:27:00 INFO - PROCESS | 7406 | RSS: Main: 267128832 08:27:00 INFO - PROCESS | 7406 | 08:27:00 INFO - PROCESS | 7406 | __start_tp_report 08:27:00 INFO - PROCESS | 7406 | _x_x_mozilla_page_load 08:27:00 INFO - PROCESS | 7406 | _x_x_mozilla_page_load_details 08:27:00 INFO - PROCESS | 7406 | |i|pagename|runs| 08:27:00 INFO - PROCESS | 7406 | |0;dojo.html;3130.9530357044646;3173.1749745066277;3218.452863013289;3222.9355412891728;3248.658890816464;5052.343195384604;5184.300119483869;5214.009338225739;5221.500883018676;5264.86837829054;5155.226715992603;5193.480651934805;5206.609504287184;5207.297014902987;5306.761195746191;4693.507181745918;4695.1079294934025;4718.598919091882;4766.618670506368;4882.462929077798;4797.208460603996;4805.111054454937;4824.662273640846;4858.708477491344;4865.464798872121;4693.601043911254;4695.577398034194;4783.689060211075;4800.687955282913;4806.663533552618;4716.858494245143;4719.716816990992;4755.833545825914;4776.952230477686;4784.880377990578;4738.739369334685;4739.123262196505;4739.9526004739855;4744.098621261984;4751.287306903958;4978.950210497885;4996.550310472075;5055.545000949932;5064.5441910228255;5114.43741188469;5628.296462942132;5642.463965923231;5644.350899646511;5650.039493286151;5651.039323315005;5658.858528536778;5674.205611214434;5695.743691533891;5695.943040569583;5703.173039909231;5252.159654455345;5257.526822585947;5277.340332458442;5280.551153151987;5285.920711189336;5636.577256705764;5679.659220446703;5686.943130568641;5724;5743.597948143673;5437.537809286176;5447.700376479253;5486.204500347428;5491.039068163055;5494.945050549523;5525.033119204204;5562.415946325658;5611.971940140274;5617.859553511195;5664.51851592611;5453.890922181534;5464.3442786865835;5464.699441530674;5466.644668096561;5474.479924407175;5456.399796022434;5484.341878974469;5488.670679759227;5516.282883225155;5539.778408863681;4347.978260108679;4357.520672725997;4400.383946247528;4431.800568974404;4440.600345968878;3894.4353068804867;3915.7063220258597;3925.1364699766004;3958.1687845552183;3962.7226094173707;4994.850154495371;5193.246979188072;5210.76551555181;5238.1618940969265;5240.580753539708;5538.584606154554;5549.250851135126;5556.611037227355;5579.246801681721;5620.466055724782;5167.328247327899;5170.250313704491;5173.896522069537;5179.404368497596;5182.922256166161;4738.95261047392;4751.50109238525;4773.331733557305;4777.570018698334;4815.3017812417;5751.367349591542;5784.248047753765;5834.095715164156;5836.67898265591;5876.7649294028615;5575.637583557056;5577.107662773937;5578.9163162553405;5580.441955804387;5586.190002449704;5661.773529058792;5737.168110624019;5786.855328616818;5787.102999035156;5789.652620842763;5487.945120548743;5488.533474654699;5490.368607610176;5499.890002199853;5539.390667026704;5515.393306736176;5529.944700552943;5613.915791263216;5620.550355971594;5630.183623374506;5428.185772134054;5448.182772584144;5495.725213739377;5541.750621222135;5547.4175211603815;5428.240046393587;5436.700981446058;5439.700816454974;5440.319960004999;5468.207109969112;5345.38528069277;5350.759215835219;5352.063388906848;5362.839114826562;5410.053240682943;5341.332333458317;5398.811041613525;5452.91820622683;5483.725813709379;5487.972560137174;5370.301860758076;5370.785168593213;5374;5377.112776392008;5383.973080134731 08:27:00 INFO - PROCESS | 7406 | |1;ext.html;538.0771976061054;548.5529293625697;564.7656222667594;568.5593664909694;578.158778976589;28204.576931346022;28432.715672843293;35475.46786798197;36112.2777544449;36264.27471450569;38371.23257534848;38751;38814;38844;38867.22265554687;8445.95777021114;8663.263622592056;8665.740027799176;8671.262942649852;8673.653053877837;8352.665893364257;8405.369597280229;8466.66133354668;8466.957665211665;8470;8681.82636347276;8727.04002559721;8758.167974042488;8761.868571971425;8766.123387661246;8607.870881936713;8610.483370997697;8611.526366049864;8645.52449615271;8693.391462597652;8515.57422128891;8633.913660863436;8657.437266577652;8666.783330416727;8671.523066231355;38962.41556376657;39397.212055758726;39516;39536.04639536023;39589.60410395888;3243.513472979072;3332.3335332933266;3358.798472091658;3400.404929137416;3941.428492868518;26088.60867086995;26529.336766580796;26617.733822661718;26724.19827405181;26726.06458773953;3553.573571171476;3600.5499312585926;3702.582978237901;3759.172981943968;3967.206558688274;213076;213251;215013;215077;215435;55755.16367254494;56184.438155618736;60155;60173.39826601678;60258.698706507064;61435.69282153561;61895.690521547105;61903.690481548205;61904;61985.38014619796;12355.62933112008;12531.937340313423;12543.560975366001;12568.937155314165;12608.747825043447;10403;10408.063274305348;10428.634997775041;10428.843567346496;10432.530536125892;19612.70580941287;20427.897860510602;20528.17887284522;20654.896725516577;20781;6717.261101278856;7804.726834560876;7934.761957141295;7995.880061799077;8140.308073813792;872.8647059705755;957.3537861943161;973.6592192732487;1010.6715317521688;1037.3723897042332;28113.57829632557;28337.71662283392;28695.56956645652;28830.855845720638;30122.24694382614;1026.707388394319;1046.2728403759313;1071.689210129054;1114.8327750837439;1144.891235332642;13522.18866867991;13970.650733731534;15441.15073670959;16399.42602008948;16453.259603317878;369111;372278;373922;374947;376926;51541.742291288305;52019.47980520222;52038.73980630073;52061.73969130206;52093;1349.1163288046346;1368.9383977721027;1369.472752990086;1372.6911444925013;1372.945082196721;28254.174582542404;29612.703872961858;29708.55437168401;30135.547966780956;30241.546376804807;45625.31562026506;45809.77095114503;46181.538184617726;46343.76828115838;46413.53586464092;284822;285812;286720;287344;289975;31340.52989205118;31623.525647114853;31961.200969975936;31992.28065614449;32150.83924580362;40698.389524157756;42304.15391692211;42826.78586607047;43081.784591076845;43117;35191.47212791861;35390.64609353874;36025.45961810627;36656.81671591732;36768;36650.8167459161;38412;41312.38031429591;42567;42971.57028429676;34361.966654447795;34894.825525872206;35382.646173537934;35398.469022964164;35426.11434714153;29775.851120744257;29831.552526711683;32398;32904;36233;24704.629430558198;25063.248102556954;25352.239432817045;25455.436238926195;25481.49037019212 08:27:00 INFO - PROCESS | 7406 | |2;jquery.html;365.8335457366898;366.3387585408338;367.69665026353266;368.29103974848425;369.2117329501514;13451.327433628328;13626.931865340659;15459.30433130509;16249.431269905555;17067.91466042671;14993.25033748311;15590.376384944588;15834;15844.366225350972;16480.42318518852;5306.044911915854;5483.369412517552;5483.725813709319;5486.643368181076;5488.862778430531;4032.8588499402526;4166.437530933315;5335.626506144571;5407.972960135214;5877.441643043904;5824.475797178253;6017.368176341487;6071.969640151793;6074.908876366858;6078.604890682113;5920.585559010871;5950.732217050243;5951.047832346804;5955.166276721263;5989.460948514633;5084.771185296633;5266.262723218752;5295.682259064469;5315.813946511854;5316.867078323035;17975.550611234692;19655.705164422547;19767.901160494104;19898.50253743668;19901.303454379027;2128.6381315176304;2209.4476380904775;2388.474535602165;2462.347477918353;2705.3101459127797;8882.978457477344;9482.478463684494;11712.238704484267;12042.458089385911;12748.553800617026;1812.4562631210715;1836.5316844204776;1851.1947302923272;1873.7564116664746;1882.8587855910862;52085.73957130228;55392.446075539134;55498.16752748712;55679.72160139214;55702.44297557013;9979.650712225182;9985.30102892805;10084.142847857867;10133.949330253301;10188.796224075626;13176.275304858133;13201.20792752438;13341.66645833862;13346.332683365792;13355.53255636048;7221.169565500035;7309.086364204474;7349.448791340671;7351.889721654179;7399.371053460409;6991.825204369829;7019.789406317818;7078.079849619517;7085.751998680124;7088.681009354591;4395.384646149541;4445.59989600931;4468.977655111704;4490.663200259994;4522.977385113053;1707.8292170782822;1720.5010546941246;1755.4031629245862;1814.655215509049;1829.4968883556862;827.5241736001823;848.2662496940102;887.3788348156316;911.1935936696071;993.0317940008434;14632.19522926228;14903.254837258311;16134.838651613569;16279.51161465158;16545.83454165467;923.2613908872875;928.9953550232206;933.3606479561522;971.3006635222629;1012.119456073221;9400.200982916393;9406.623735050522;9509.714708558755;9528.094830991045;9671.323007389556;454394;470581;497370;501393;508709;69363;69751.65124174347;69993;70282.64858675674;71421;1167.9708007299885;1169.4328250798355;1171.7949358862165;1197.8845656798762;1207.1007099710596;13829.861701382857;14761.483348082766;14763.704725905207;14990;15269.312880920163;29799.55300670535;30162.09513714592;30370.696293037672;31315.53026704647;31508.212294692818;36931.81534092312;39918.80040599778;40491.79754101211;40817;42433;7220.277972202738;7263.636818159177;7637.770866874002;7695.961520192363;7825.3739700824935;8584.570771461276;10944.39805810688;11134;11292;11596.420178990847;9484.430934143973;9577.23382129414;9739.561719722771;9991.100800927952;10186.643467478603;2918.605988191567;2950.690177531414;9076.930707802036;9224.262059035394;9588.753462049888;7421.591812450367;9315.301352398732;9574.856377154487;10056.849147262943;10137.138343240907;7613.505122167041;7706.383489320729;7712.768616941501;7716.807079822825;7738.883916741366;9377.812443751223;10220.795584088426;10426.218033647356;10433.478326083818;10440.060394564525 08:27:00 INFO - PROCESS | 7406 | |3;mootools.html;1335.714143207709;1464.8535146485349;1496.9101853888765;1648.6867495175923;1802.8197180281973;7094.11323584552;7715.074191097069;7844.058712954439;7853.253940875615;7854.900313956051;7643.732469363574;7783.883241751379;7838.216178382159;7848.058233012032;7848.136704962464;2003.9799602004011;2058.9794102058936;2313.687652166953;2381.487980084286;2389.7849193572574;2376.7742064503846;2395.4729959408987;2399.8440101393353;2400.2079313826484;2400.627902675088;2274.306336567346;2328.557574060923;2330.4057465346395;2331.079223706635;2332.720073591163;2351.6942797436395;2372.632242002484;2376;2402.903883844644;2409.289259668402;2307.9538409231723;2333.719953605578;2358.693369861907;2360.0441821062495;2361.315218586608;7906.7627971160955;7968.8406231875615;7991.320737737299;8013.919860801434;8015.358771298283;4898.657094003421;5019.47295533971;5019.623528235397;5022.59819214462;5024.698518088926;3240.4815229563155;3292.423825830494;3333.8833140839956;3376.4260075787174;3391.3556424279554;1046.1526163807341;1058.1111866032493;1065.8028264771042;1088.2654208409292;1099.4612639806517;11283.323000619988;11292.830607540893;11292.943535282271;11302.717432064183;11304.886951130466;4550.613197878218;4571.200039993055;4620.653450991189;4676.462206846256;4689.929651055237;9584.520773961274;9591.328606997444;9600.183984361407;9606.903930960601;9609.039096090335;4898.53463920927;4940.357753492095;4942.28336891156;4942.5304596063315;4946.851594452172;4450.310201918708;4513.142502924499;4517.073999830027;4517.277235642281;4519.954800451954;3429.639887811744;3477.4609935460044;3478.4086705260165;3770.453284273765;3837.366834472281;1230.2126638951079;1257.3587470390166;1261.2621616354536;1274.3055035005943;1293.9029572782079;1078.7788503356794;1110.3726394587034;1111.5942680921567;1303.9674008149873;1408.7041721238654;7368;7508.849823003509;7519.661615227328;7534.510256833289;7576.01511803473;1010.368519675203;1039.6309310194922;1105.0717397386234;1109.7170221593442;1147.0766033343239;5944.048952167633;6021.157038014681;6023.3374328824675;6024.427679370453;6024.849378765478;9435.575399107056;9644.855327170098;9756.975517570694;9876.259280553988;9902.504874756234;9631.08504692053;9674.08096230857;9867.703968880945;9869.950650246703;9875.555599998017;7105.822354441077;7293.307135822089;7299.635018249066;7313.780586582411;7583.848323033509;7338.119425668954;7437.590932498764;7438.70245190208;7447.88828167567;7462.216467270859;8221.383396245186;8287.751367458986;8547.444416112932;8564.828703426021;8572.528510931708;8419.410641255054;8500.404971652173;8698.695545655872;8704.78238044054;8706.521141337287;6971.3028697129885;7097.25478824716;7098.716051357887;7101;7108.644567771694;6709.329067093252;6824.761133360507;7203.71185152588;7372.741954031583;7391.2239214881665;6979.790606281819;6990.09128813251;7093.255208203271;7106.324899134574;7199.820004499929;6934.445244380337;6968.477364197604;7017.964910175417;7092.184398793998;7129.536580122275;6979.336962988508;7017.122859642544;7091.716331346688;7111.431085513043;7112.466565007749;6559.704813283318;6610.173728283965;6610.173728283965;6612.933870661232;6614.338566143347;6596.637184954873;6635.469162467088;6637.933620663732;6745.730170793114;6800.047993280846 08:27:00 INFO - PROCESS | 7406 | |4;prototype.html;343.23972401131493;352.1423647103754;353.1242518553986;353.93806083935306;357.08942197396647;5740.540756739461;5841.970790146049;5869.14897339886;5902.498287645544;5904.173415721792;5655.179998900157;5763.308402991636;5772.769089236425;5777.797777077803;5779.104238842976;4563.771811409433;4564.97717511412;4568.086382723461;4579.702319349249;4582.427196600425;4355.063661312817;4421.889452763675;4422.823087076513;4467.15124126415;4571.565701258375;4429;4441.5336389679105;4452.332150177467;4535.909281814362;4551.021530370969;4499.797509112098;4523.841665541707;4534.501204867462;4540.614047805908;4557.475890272594;4021.959780402217;4029.7582145071387;4054.898627534306;4056.4320995060716;4064.939025914584;5466.426025267329;5501.614886957915;5521.4478552144865;5539.058360078756;5556.222128901957;5285.524302812727;5292.735363231862;5297.046531624306;5298.231756395339;5302.602304827154;5868.677222752747;6170.136180934673;6170.321264660884;6173.722182501798;6179.752809887599;4379.802908869108;4389.275769498029;4456.955430445719;4482.148391805546;4495.820167193308;6463.903041454382;6483.805485835385;6500.187476565477;6505.4795616350575;6505.772297969548;4564.931526027112;4572.7713614319155;4574.153781550423;4584;4588.518205588432;4558.2251017327135;4638.83764068256;4647.34937108805;4649.04694537619;4661.720296782204;5217.6086793489885;5264;5265.262863199156;5268.157094864803;5272.472752724697;6218.160548325918;6220.160278362363;6229.7508099676415;6233.563650544418;6240.095186198067;1629.0958518022373;1650.570851578574;1650.9587260318588;1653.0577570784778;1653.5039488153507;1120.277421063426;1125.7692173104494;1138.5957984915235;1149.0807354116673;1152.8904754048351;5896.6756828374855;5904.704764761831;5908.911366329508;5910.674912879833;5913.2608423947;6406.135171751847;6408.134901788292;6416.390442907917;6450.0647406125845;6490.610563366213;5773.624714393635;5837.620554663933;5874.1776151338845;5889.617174883619;5914.378990205966;3409.147713071732;3430.27964127536;3448.6034106078123;3451.5685539307588;3457.6023757268235;6696.966515167393;6702.899456508157;6702.899456508157;6707.5975441473665;6712.765053223114;6547.083408322838;6561.0814485972005;6563.1796025496815;6566.3105373936005;6568.277489476154;6466.741330346827;6608.933910660928;6624.470042396597;6627.801165965126;6674.199096108498;6195.473384762346;6365.936340636535;6391.2330520337855;6391.58454700443;6402.967985160044;6231.501479881689;6288;6297.748090076529;6436.742530298736;6460.773872914426;6707.295733947865;6739.966300168468;6744.0895479109695;6761.526693131434;6764.966175169289;4330.52364239927;4568.132054909556;4599.356090147315;4601.217792975269;4603.102395032936;6383.904241436289;6401.455876250571;6408.903866441914;6413.615183088843;6420.6147631142285;6222.81331560054;6245.812625621239;6251.624902505864;6253.405926436982;6261;6089.269287685506;6231.470325022424;6244.968775156095;6245.96877015612;6254.6247225166635;6195.101710252078;6195.2255968004;6195.4424101831055;6198.132261483306;6198.543342314642;6325.240971083499;6326.715297811517;6327.114204011534;6333.493320534439;6340.30256671775;6075.908861367171;6181.474574661204;6183.81448556544;6193.256809182927;6197.318294987457 08:27:00 INFO - PROCESS | 7406 | |5;yui.html;727.9854402911942;764.7017663111384;823.000054933256;856.948583085015;867.2151702709047;12768.233905965637;12905.999999999989;12957;12985.805212921801;13000.34998250086;12444.066694997866;12452.43964021619;12465.439055242514;12499.500019999188;12525.874741252584;659.9043138744879;673.6261374936909;777.949433286836;784.5488843914743;787.858185526605;796.9402294827883;799.3645052183529;800.6997375984006;802.7952872017627;803.6222975201646;825.558326295432;836.506461187899;836.7615229659548;836.8661014237692;837.6063250272363;686.6223577032637;697.0937780884855;818.9590520473982;836.3768992100923;838.5471845203583;611.7522403426619;611.7552978808468;615.3354377272535;616.2820314333795;619.1084837833505;12520.186187897758;12536.247825130522;12591.559295424708;12605.558805441857;12615.053870959715;12034.51861925522;12486.250824950532;12497.125201235825;12581.24512529242;12604.68488287791;10598.62904798336;10642.787144257072;10696.625618103408;10986;11071.16966227536;3618.095476130967;3660.432632941898;3683.526589364276;3758.7180961428003;3763.6612704856693;41900.79049604763;42010.1597968042;42037.57962420398;42062.57937420617;42326.36510452346;9543.0456954304;9962.55168517404;10163.136691795336;10271.897281027244;10552.26134170616;16581.25384357707;16787.328506859834;16892.155392230587;16939.153042347833;16996.660066798842;7439.85120297591;7599.050118735158;7643.464957452925;7712.730054448068;7751.069871615442;4264.424302719093;4294.347742021829;4362.062156636339;4371.213181627338;4383.123375324948;3078.98460507696;3112.37752449511;3119.5632611434417;3121.2352973521633;3124.718775310233;586.2086183652036;623.7754408412968;639.1180171363488;650.5868773328971;655.3708439897752;667.4760313154151;693.784926672733;711.3242419701304;720.5784615999698;730.441212472459;8001.599920003977;8074.636641351153;8358.623861926228;8678.696245631372;8898;562.103445005216;583.3233449198909;636.2905360522983;645.3062957320899;671.6171782084165;3853.6917046636204;3886.8344665791633;3932.4494570760116;4018.578049304839;4146.3158578834755;49397;49569.752151239016;49596.75201623969;50126.498735012916;52054;42497.78751106225;42502.78748606237;43168.352474712905;43332;43565.56434435615;38225.426618600744;39521.40717889234;39564;39646.40530392047;44635.33047004297;8418.242358187792;8583.957080214559;8922.41250037482;9050.479207683176;9069.365144439826;32000.67999319977;32672.34655306833;32896.67103329032;33473;33674.83162584171;37731.811340944216;42663;42784.786076069424;42994;43487;10568.471576420994;10628.202884783826;11121.499532521218;11268.887311126784;11669;12359;12383.690407739517;12691.111622186727;12929.288889111189;13137.277449740355;11335.149863760085;11489.885101149215;11658.825117623073;11692.123090768056;12144.39278036077;10874.001486855403;10953.302457006213;11147.777044459228;11184.273022253528;11273.830892536454;10649.094826939798;10724.463776811284;10793.838092428778;10924.890751092387;10934.945325273322;8357.916420835714;8432.578371081545;8572.228499435081;9089.363744538083;9330.906690933003;8961.910380896108;9470.289728270545;9517.476538790434;9592;9727.221822254061 08:27:00 INFO - PROCESS | 7406 | __end_tp_report 08:27:00 INFO - PROCESS | 7406 | __start_cc_report 08:27:00 INFO - PROCESS | 7406 | _x_x_mozilla_cycle_collect,1012 08:27:00 INFO - PROCESS | 7406 | __end_cc_report 08:27:00 INFO - PROCESS | 7406 | __startTimestamp1453912020466__endTimestamp 08:27:00 INFO - PROCESS | 7406 | 08:27:00 INFO - PROCESS | 7406 | ------- Summary: start ------- 08:27:00 INFO - PROCESS | 7406 | Number of tests: 6 08:27:00 INFO - PROCESS | 7406 | 08:27:00 INFO - PROCESS | 7406 | [#0] dojo.html Cycles:165 Average:5186.46 Median:5374.00 stddev:551.97 (10.3%) stddev-sans-first:529.58 08:27:00 INFO - PROCESS | 7406 | Values: 3131.0 3173.2 3218.5 3222.9 3248.7 5052.3 5184.3 5214.0 5221.5 5264.9 5155.2 5193.5 5206.6 5207.3 5306.8 4693.5 4695.1 4718.6 4766.6 4882.5 4797.2 4805.1 4824.7 4858.7 4865.5 4693.6 4695.6 4783.7 4800.7 4806.7 4716.9 4719.7 4755.8 4777.0 4784.9 4738.7 4739.1 4740.0 4744.1 4751.3 4979.0 4996.6 5055.5 5064.5 5114.4 5628.3 5642.5 5644.4 5650.0 5651.0 5658.9 5674.2 5695.7 5695.9 5703.2 5252.2 5257.5 5277.3 5280.6 5285.9 5636.6 5679.7 5686.9 5724.0 5743.6 5437.5 5447.7 5486.2 5491.0 5494.9 5525.0 5562.4 5612.0 5617.9 5664.5 5453.9 5464.3 5464.7 5466.6 5474.5 5456.4 5484.3 5488.7 5516.3 5539.8 4348.0 4357.5 4400.4 4431.8 4440.6 3894.4 3915.7 3925.1 3958.2 3962.7 4994.9 5193.2 5210.8 5238.2 5240.6 5538.6 5549.3 5556.6 5579.2 5620.5 5167.3 5170.3 5173.9 5179.4 5182.9 4739.0 4751.5 4773.3 4777.6 4815.3 5751.4 5784.2 5834.1 5836.7 5876.8 5575.6 5577.1 5578.9 5580.4 5586.2 5661.8 5737.2 5786.9 5787.1 5789.7 5487.9 5488.5 5490.4 5499.9 5539.4 5515.4 5529.9 5613.9 5620.6 5630.2 5428.2 5448.2 5495.7 5541.8 5547.4 5428.2 5436.7 5439.7 5440.3 5468.2 5345.4 5350.8 5352.1 5362.8 5410.1 5341.3 5398.8 5452.9 5483.7 5488.0 5370.3 5370.8 5374.0 5377.1 5384.0 08:27:00 INFO - PROCESS | 7406 | 08:27:00 INFO - PROCESS | 7406 | [#1] ext.html Cycles:180 Average:45906.69 Median:36457.55 stddev:78489.05 (215.3%) stddev-sans-first:78635.32 08:27:00 INFO - PROCESS | 7406 | Values: 538.1 548.6 564.8 568.6 578.2 28204.6 28432.7 35475.5 36112.3 36264.3 38371.2 38751.0 38814.0 38844.0 38867.2 8446.0 8663.3 8665.7 8671.3 8673.7 8352.7 8405.4 8466.7 8467.0 8470.0 8681.8 8727.0 8758.2 8761.9 8766.1 8607.9 8610.5 8611.5 8645.5 8693.4 8515.6 8633.9 8657.4 8666.8 8671.5 38962.4 39397.2 39516.0 39536.0 39589.6 3243.5 3332.3 3358.8 3400.4 3941.4 26088.6 26529.3 26617.7 26724.2 26726.1 3553.6 3600.5 3702.6 3759.2 3967.2 213076.0 213251.0 215013.0 215077.0 215435.0 55755.2 56184.4 60155.0 60173.4 60258.7 61435.7 61895.7 61903.7 61904.0 61985.4 12355.6 12531.9 12543.6 12568.9 12608.7 10403.0 10408.1 10428.6 10428.8 10432.5 19612.7 20427.9 20528.2 20654.9 20781.0 6717.3 7804.7 7934.8 7995.9 8140.3 872.9 957.4 973.7 1010.7 1037.4 28113.6 28337.7 28695.6 28830.9 30122.2 1026.7 1046.3 1071.7 1114.8 1144.9 13522.2 13970.7 15441.2 16399.4 16453.3 369111.0 372278.0 373922.0 374947.0 376926.0 51541.7 52019.5 52038.7 52061.7 52093.0 1349.1 1368.9 1369.5 1372.7 1372.9 28254.2 29612.7 29708.6 30135.5 30241.5 45625.3 45809.8 46181.5 46343.8 46413.5 284822.0 285812.0 286720.0 287344.0 289975.0 31340.5 31623.5 31961.2 31992.3 32150.8 40698.4 42304.2 42826.8 43081.8 43117.0 35191.5 35390.6 36025.5 36656.8 36768.0 36650.8 38412.0 41312.4 42567.0 42971.6 34362.0 34894.8 35382.6 35398.5 35426.1 29775.9 29831.6 32398.0 32904.0 36233.0 24704.6 25063.2 25352.2 25455.4 25481.5 08:27:00 INFO - PROCESS | 7406 | 08:27:00 INFO - PROCESS | 7406 | [#2] jquery.html Cycles:180 Average:25686.90 Median:4506.82 stddev:79543.21 (1765.0%) stddev-sans-first:79743.63 08:27:00 INFO - PROCESS | 7406 | Values: 365.8 366.3 367.7 368.3 369.2 13451.3 13626.9 15459.3 16249.4 17067.9 14993.3 15590.4 15834.0 15844.4 16480.4 5306.0 5483.4 5483.7 5486.6 5488.9 4032.9 4166.4 5335.6 5408.0 5877.4 5824.5 6017.4 6072.0 6074.9 6078.6 5920.6 5950.7 5951.0 5955.2 5989.5 5084.8 5266.3 5295.7 5315.8 5316.9 17975.6 19655.7 19767.9 19898.5 19901.3 2128.6 2209.4 2388.5 2462.3 2705.3 8883.0 9482.5 11712.2 12042.5 12748.6 1812.5 1836.5 1851.2 1873.8 1882.9 52085.7 55392.4 55498.2 55679.7 55702.4 9979.7 9985.3 10084.1 10133.9 10188.8 13176.3 13201.2 13341.7 13346.3 13355.5 7221.2 7309.1 7349.4 7351.9 7399.4 6991.8 7019.8 7078.1 7085.8 7088.7 4395.4 4445.6 4469.0 4490.7 4523.0 1707.8 1720.5 1755.4 1814.7 1829.5 827.5 848.3 887.4 911.2 993.0 14632.2 14903.3 16134.8 16279.5 16545.8 923.3 929.0 933.4 971.3 1012.1 9400.2 9406.6 9509.7 9528.1 9671.3 454394.0 470581.0 497370.0 501393.0 508709.0 69363.0 69751.7 69993.0 70282.6 71421.0 1168.0 1169.4 1171.8 1197.9 1207.1 13829.9 14761.5 14763.7 14990.0 15269.3 29799.6 30162.1 30370.7 31315.5 31508.2 36931.8 39918.8 40491.8 40817.0 42433.0 7220.3 7263.6 7637.8 7696.0 7825.4 8584.6 10944.4 11134.0 11292.0 11596.4 9484.4 9577.2 9739.6 9991.1 10186.6 2918.6 2950.7 9076.9 9224.3 9588.8 7421.6 9315.3 9574.9 10056.8 10137.1 7613.5 7706.4 7712.8 7716.8 7738.9 9377.8 10220.8 10426.2 10433.5 10440.1 08:27:00 INFO - PROCESS | 7406 | 08:27:00 INFO - PROCESS | 7406 | [#3] mootools.html Cycles:180 Average:5599.72 Median:6578.17 stddev:2890.83 (43.9%) stddev-sans-first:2881.17 08:27:00 INFO - PROCESS | 7406 | Values: 1335.7 1464.9 1496.9 1648.7 1802.8 7094.1 7715.1 7844.1 7853.3 7854.9 7643.7 7783.9 7838.2 7848.1 7848.1 2004.0 2059.0 2313.7 2381.5 2389.8 2376.8 2395.5 2399.8 2400.2 2400.6 2274.3 2328.6 2330.4 2331.1 2332.7 2351.7 2372.6 2376.0 2402.9 2409.3 2308.0 2333.7 2358.7 2360.0 2361.3 7906.8 7968.8 7991.3 8013.9 8015.4 4898.7 5019.5 5019.6 5022.6 5024.7 3240.5 3292.4 3333.9 3376.4 3391.4 1046.2 1058.1 1065.8 1088.3 1099.5 11283.3 11292.8 11292.9 11302.7 11304.9 4550.6 4571.2 4620.7 4676.5 4689.9 9584.5 9591.3 9600.2 9606.9 9609.0 4898.5 4940.4 4942.3 4942.5 4946.9 4450.3 4513.1 4517.1 4517.3 4520.0 3429.6 3477.5 3478.4 3770.5 3837.4 1230.2 1257.4 1261.3 1274.3 1293.9 1078.8 1110.4 1111.6 1304.0 1408.7 7368.0 7508.8 7519.7 7534.5 7576.0 1010.4 1039.6 1105.1 1109.7 1147.1 5944.0 6021.2 6023.3 6024.4 6024.8 9435.6 9644.9 9757.0 9876.3 9902.5 9631.1 9674.1 9867.7 9870.0 9875.6 7105.8 7293.3 7299.6 7313.8 7583.8 7338.1 7437.6 7438.7 7447.9 7462.2 8221.4 8287.8 8547.4 8564.8 8572.5 8419.4 8500.4 8698.7 8704.8 8706.5 6971.3 7097.3 7098.7 7101.0 7108.6 6709.3 6824.8 7203.7 7372.7 7391.2 6979.8 6990.1 7093.3 7106.3 7199.8 6934.4 6968.5 7018.0 7092.2 7129.5 6979.3 7017.1 7091.7 7111.4 7112.5 6559.7 6610.2 6610.2 6612.9 6614.3 6596.6 6635.5 6637.9 6745.7 6800.0 08:27:00 INFO - PROCESS | 7406 | 08:27:00 INFO - PROCESS | 7406 | [#4] prototype.html Cycles:180 Average:5233.55 Median:5871.66 stddev:1545.12 (26.3%) stddev-sans-first:1505.22 08:27:00 INFO - PROCESS | 7406 | Values: 343.2 352.1 353.1 353.9 357.1 5740.5 5842.0 5869.1 5902.5 5904.2 5655.2 5763.3 5772.8 5777.8 5779.1 4563.8 4565.0 4568.1 4579.7 4582.4 4355.1 4421.9 4422.8 4467.2 4571.6 4429.0 4441.5 4452.3 4535.9 4551.0 4499.8 4523.8 4534.5 4540.6 4557.5 4022.0 4029.8 4054.9 4056.4 4064.9 5466.4 5501.6 5521.4 5539.1 5556.2 5285.5 5292.7 5297.0 5298.2 5302.6 5868.7 6170.1 6170.3 6173.7 6179.8 4379.8 4389.3 4457.0 4482.1 4495.8 6463.9 6483.8 6500.2 6505.5 6505.8 4564.9 4572.8 4574.2 4584.0 4588.5 4558.2 4638.8 4647.3 4649.0 4661.7 5217.6 5264.0 5265.3 5268.2 5272.5 6218.2 6220.2 6229.8 6233.6 6240.1 1629.1 1650.6 1651.0 1653.1 1653.5 1120.3 1125.8 1138.6 1149.1 1152.9 5896.7 5904.7 5908.9 5910.7 5913.3 6406.1 6408.1 6416.4 6450.1 6490.6 5773.6 5837.6 5874.2 5889.6 5914.4 3409.1 3430.3 3448.6 3451.6 3457.6 6697.0 6702.9 6702.9 6707.6 6712.8 6547.1 6561.1 6563.2 6566.3 6568.3 6466.7 6608.9 6624.5 6627.8 6674.2 6195.5 6365.9 6391.2 6391.6 6403.0 6231.5 6288.0 6297.7 6436.7 6460.8 6707.3 6740.0 6744.1 6761.5 6765.0 4330.5 4568.1 4599.4 4601.2 4603.1 6383.9 6401.5 6408.9 6413.6 6420.6 6222.8 6245.8 6251.6 6253.4 6261.0 6089.3 6231.5 6245.0 6246.0 6254.6 6195.1 6195.2 6195.4 6198.1 6198.5 6325.2 6326.7 6327.1 6333.5 6340.3 6075.9 6181.5 6183.8 6193.3 6197.3 08:27:00 INFO - PROCESS | 7406 | 08:27:00 INFO - PROCESS | 7406 | [#5] yui.html Cycles:180 Average:12793.64 Median:23463.71 stddev:13938.71 (59.4%) stddev-sans-first:13948.36 08:27:00 INFO - PROCESS | 7406 | Values: 728.0 764.7 823.0 856.9 867.2 12768.2 12906.0 12957.0 12985.8 13000.3 12444.1 12452.4 12465.4 12499.5 12525.9 659.9 673.6 777.9 784.5 787.9 796.9 799.4 800.7 802.8 803.6 825.6 836.5 836.8 836.9 837.6 686.6 697.1 819.0 836.4 838.5 611.8 611.8 615.3 616.3 619.1 12520.2 12536.2 12591.6 12605.6 12615.1 12034.5 12486.3 12497.1 12581.2 12604.7 10598.6 10642.8 10696.6 10986.0 11071.2 3618.1 3660.4 3683.5 3758.7 3763.7 41900.8 42010.2 42037.6 42062.6 42326.4 9543.0 9962.6 10163.1 10271.9 10552.3 16581.3 16787.3 16892.2 16939.2 16996.7 7439.9 7599.1 7643.5 7712.7 7751.1 4264.4 4294.3 4362.1 4371.2 4383.1 3079.0 3112.4 3119.6 3121.2 3124.7 586.2 623.8 639.1 650.6 655.4 667.5 693.8 711.3 720.6 730.4 8001.6 8074.6 8358.6 8678.7 8898.0 562.1 583.3 636.3 645.3 671.6 3853.7 3886.8 3932.4 4018.6 4146.3 49397.0 49569.8 49596.8 50126.5 52054.0 42497.8 42502.8 43168.4 43332.0 43565.6 38225.4 39521.4 39564.0 39646.4 44635.3 8418.2 8584.0 8922.4 9050.5 9069.4 32000.7 32672.3 32896.7 33473.0 33674.8 37731.8 42663.0 42784.8 42994.0 43487.0 10568.5 10628.2 11121.5 11268.9 11669.0 12359.0 12383.7 12691.1 12929.3 13137.3 11335.1 11489.9 11658.8 11692.1 12144.4 10874.0 10953.3 11147.8 11184.3 11273.8 10649.1 10724.5 10793.8 10924.9 10934.9 8357.9 8432.6 8572.2 9089.4 9330.9 8961.9 9470.3 9517.5 9592.0 9727.2 08:27:00 INFO - PROCESS | 7406 | -------- Summary: end -------- 08:27:00 INFO - PROCESS | 7406 | 08:27:01 INFO - TEST-INFO | 7406: exit 0 08:27:01 INFO - TEST-OK | dromaeo_css | took 1112867ms 08:27:01 INFO - TEST-START | kraken 08:27:01 INFO - operating with platform_type : linux_ 08:27:01 INFO - Initialising browser for kraken test... 08:27:01 INFO - TEST-INFO | started process 7608 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsQnNBW/profile http://localhost:41679/getInfo.html) 08:27:05 INFO - PROCESS | 7608 | __metrics Screen width/height:1600/1200 08:27:05 INFO - PROCESS | 7608 | colorDepth:24 08:27:05 INFO - PROCESS | 7608 | Browser inner width/height: 1024/697 08:27:05 INFO - PROCESS | 7608 | __metrics 08:27:05 INFO - PROCESS | 7608 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:27:05 INFO - PROCESS | 7608 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:27:06 INFO - TEST-INFO | 7608: exit 0 08:27:06 INFO - Browser initialized. 08:27:06 INFO - Running cycle 1/1 for kraken test... 08:27:06 INFO - TEST-INFO | started process 7692 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsQnNBW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:27:18 INFO - PROCESS | 7692 | RSS: Main: 148639744 08:27:18 INFO - PROCESS | 7692 | 08:27:20 INFO - PROCESS | 7692 | Cycle 1(1): loaded http://localhost:41679/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41679/tests/kraken/driver.html?testName=audio-beat-detection) 08:27:21 INFO - PROCESS | 7692 | RSS: Main: 188682240 08:27:21 INFO - PROCESS | 7692 | 08:27:23 INFO - PROCESS | 7692 | Cycle 1(1): loaded http://localhost:41679/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41679/tests/kraken/driver.html?testName=audio-dft) 08:27:24 INFO - PROCESS | 7692 | RSS: Main: 179662848 08:27:24 INFO - PROCESS | 7692 | 08:27:27 INFO - PROCESS | 7692 | Cycle 1(1): loaded http://localhost:41679/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41679/tests/kraken/driver.html?testName=audio-fft) 08:27:27 INFO - PROCESS | 7692 | RSS: Main: 164487168 08:27:27 INFO - PROCESS | 7692 | 08:27:29 INFO - PROCESS | 7692 | Cycle 1(1): loaded http://localhost:41679/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41679/tests/kraken/driver.html?testName=audio-oscillator) 08:27:30 INFO - PROCESS | 7692 | RSS: Main: 166662144 08:27:30 INFO - PROCESS | 7692 | 08:27:32 INFO - PROCESS | 7692 | Cycle 1(1): loaded http://localhost:41679/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41679/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:27:33 INFO - PROCESS | 7692 | RSS: Main: 167153664 08:27:33 INFO - PROCESS | 7692 | 08:27:36 INFO - PROCESS | 7692 | Cycle 1(1): loaded http://localhost:41679/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41679/tests/kraken/driver.html?testName=imaging-darkroom) 08:27:36 INFO - PROCESS | 7692 | RSS: Main: 167116800 08:27:36 INFO - PROCESS | 7692 | 08:27:40 INFO - PROCESS | 7692 | Cycle 1(1): loaded http://localhost:41679/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41679/tests/kraken/driver.html?testName=imaging-desaturate) 08:27:40 INFO - PROCESS | 7692 | RSS: Main: 170123264 08:27:40 INFO - PROCESS | 7692 | 08:27:43 INFO - PROCESS | 7692 | Cycle 1(1): loaded http://localhost:41679/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41679/tests/kraken/driver.html?testName=json-parse-financial) 08:27:44 INFO - PROCESS | 7692 | RSS: Main: 169439232 08:27:44 INFO - PROCESS | 7692 | 08:27:45 INFO - PROCESS | 7692 | Cycle 1(1): loaded http://localhost:41679/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41679/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:27:46 INFO - PROCESS | 7692 | RSS: Main: 180080640 08:27:46 INFO - PROCESS | 7692 | 08:27:48 INFO - PROCESS | 7692 | Cycle 1(1): loaded http://localhost:41679/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41679/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:27:48 INFO - PROCESS | 7692 | RSS: Main: 178237440 08:27:48 INFO - PROCESS | 7692 | 08:27:50 INFO - PROCESS | 7692 | Cycle 1(1): loaded http://localhost:41679/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41679/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:27:51 INFO - PROCESS | 7692 | RSS: Main: 183500800 08:27:51 INFO - PROCESS | 7692 | 08:27:53 INFO - PROCESS | 7692 | Cycle 1(1): loaded http://localhost:41679/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41679/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:27:54 INFO - PROCESS | 7692 | RSS: Main: 194248704 08:27:54 INFO - PROCESS | 7692 | 08:27:56 INFO - PROCESS | 7692 | Cycle 1(1): loaded http://localhost:41679/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41679/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:27:57 INFO - PROCESS | 7692 | RSS: Main: 192770048 08:27:57 INFO - PROCESS | 7692 | 08:27:59 INFO - PROCESS | 7692 | Cycle 1(1): loaded http://localhost:41679/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41679/tests/kraken/driver.html?testName=ai-astar) 08:27:59 INFO - PROCESS | 7692 | RSS: Main: 252145664 08:27:59 INFO - PROCESS | 7692 | 08:27:59 INFO - PROCESS | 7692 | __start_tp_report 08:27:59 INFO - PROCESS | 7692 | _x_x_mozilla_page_load 08:27:59 INFO - PROCESS | 7692 | _x_x_mozilla_page_load_details 08:27:59 INFO - PROCESS | 7692 | |i|pagename|runs| 08:27:59 INFO - PROCESS | 7692 | |0;ai-astar;111;110;105;110;111;111;110;110;102;108 08:27:59 INFO - PROCESS | 7692 | |1;audio-beat-detection;158;125;153;167;129;151;149;127;168;125 08:27:59 INFO - PROCESS | 7692 | |2;audio-dft;161;160;160;161;160;161;160;160;162;161 08:27:59 INFO - PROCESS | 7692 | |3;audio-fft;74;73;102;94;73;73;73;116;98;72 08:27:59 INFO - PROCESS | 7692 | |4;audio-oscillator;97;97;141;95;96;95;154;95;96;143 08:27:59 INFO - PROCESS | 7692 | |5;imaging-gaussian-blur;118;115;115;114;114;116;115;114;115;115 08:27:59 INFO - PROCESS | 7692 | |6;imaging-darkroom;145;146;146;145;146;145;146;147;145;145 08:27:59 INFO - PROCESS | 7692 | |7;imaging-desaturate;96;96;96;95;96;97;97;96;96;95 08:27:59 INFO - PROCESS | 7692 | |8;json-parse-financial;58;55;57;57;56;56;57;57;58;56 08:27:59 INFO - PROCESS | 7692 | |9;json-stringify-tinderbox;67;68;67;67;67;68;69;67;68;68 08:27:59 INFO - PROCESS | 7692 | |10;stanford-crypto-aes;82;82;85;83;84;89;84;83;90;84 08:27:59 INFO - PROCESS | 7692 | |11;stanford-crypto-ccm;130;114;115;115;119;116;113;117;115;117 08:27:59 INFO - PROCESS | 7692 | |12;stanford-crypto-pbkdf2;144;136;142;142;143;131;135;142;151;131 08:27:59 INFO - PROCESS | 7692 | |13;stanford-crypto-sha256-iterative;67;71;68;68;68;66;68;70;68;66 08:27:59 INFO - PROCESS | 7692 | __end_tp_report 08:27:59 INFO - PROCESS | 7692 | __start_cc_report 08:27:59 INFO - PROCESS | 7692 | _x_x_mozilla_cycle_collect,918 08:27:59 INFO - PROCESS | 7692 | __end_cc_report 08:27:59 INFO - PROCESS | 7692 | __startTimestamp1453912079338__endTimestamp 08:27:59 INFO - PROCESS | 7692 | 08:27:59 INFO - PROCESS | 7692 | ------- Summary: start ------- 08:27:59 INFO - PROCESS | 7692 | Number of tests: 14 08:27:59 INFO - PROCESS | 7692 | 08:27:59 INFO - PROCESS | 7692 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:3.01 (2.7%) stddev-sans-first:3.09 08:27:59 INFO - PROCESS | 7692 | Values: 111.0 110.0 105.0 110.0 111.0 111.0 110.0 110.0 102.0 108.0 08:27:59 INFO - PROCESS | 7692 | 08:27:59 INFO - PROCESS | 7692 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:152.00 stddev:17.25 (11.3%) stddev-sans-first:17.66 08:27:59 INFO - PROCESS | 7692 | Values: 158.0 125.0 153.0 167.0 129.0 151.0 149.0 127.0 168.0 125.0 08:27:59 INFO - PROCESS | 7692 | 08:27:59 INFO - PROCESS | 7692 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 08:27:59 INFO - PROCESS | 7692 | Values: 161.0 160.0 160.0 161.0 160.0 161.0 160.0 160.0 162.0 161.0 08:27:59 INFO - PROCESS | 7692 | 08:27:59 INFO - PROCESS | 7692 | [#3] audio-fft Cycles:10 Average:84.80 Median:73.00 stddev:16.21 (22.2%) stddev-sans-first:16.72 08:27:59 INFO - PROCESS | 7692 | Values: 74.0 73.0 102.0 94.0 73.0 73.0 73.0 116.0 98.0 72.0 08:27:59 INFO - PROCESS | 7692 | 08:27:59 INFO - PROCESS | 7692 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:95.50 stddev:24.46 (25.6%) stddev-sans-first:25.42 08:27:59 INFO - PROCESS | 7692 | Values: 97.0 97.0 141.0 95.0 96.0 95.0 154.0 95.0 96.0 143.0 08:27:59 INFO - PROCESS | 7692 | 08:27:59 INFO - PROCESS | 7692 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:115.00 stddev:1.20 (1.0%) stddev-sans-first:0.67 08:27:59 INFO - PROCESS | 7692 | Values: 118.0 115.0 115.0 114.0 114.0 116.0 115.0 114.0 115.0 115.0 08:27:59 INFO - PROCESS | 7692 | 08:27:59 INFO - PROCESS | 7692 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 08:27:59 INFO - PROCESS | 7692 | Values: 145.0 146.0 146.0 145.0 146.0 145.0 146.0 147.0 145.0 145.0 08:27:59 INFO - PROCESS | 7692 | 08:27:59 INFO - PROCESS | 7692 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 08:27:59 INFO - PROCESS | 7692 | Values: 96.0 96.0 96.0 95.0 96.0 97.0 97.0 96.0 96.0 95.0 08:27:59 INFO - PROCESS | 7692 | 08:27:59 INFO - PROCESS | 7692 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:0.95 (1.7%) stddev-sans-first:0.88 08:27:59 INFO - PROCESS | 7692 | Values: 58.0 55.0 57.0 57.0 56.0 56.0 57.0 57.0 58.0 56.0 08:27:59 INFO - PROCESS | 7692 | 08:27:59 INFO - PROCESS | 7692 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 08:27:59 INFO - PROCESS | 7692 | Values: 67.0 68.0 67.0 67.0 67.0 68.0 69.0 67.0 68.0 68.0 08:27:59 INFO - PROCESS | 7692 | 08:27:59 INFO - PROCESS | 7692 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.00 stddev:2.76 (3.3%) stddev-sans-first:2.76 08:27:59 INFO - PROCESS | 7692 | Values: 82.0 82.0 85.0 83.0 84.0 89.0 84.0 83.0 90.0 84.0 08:27:59 INFO - PROCESS | 7692 | 08:27:59 INFO - PROCESS | 7692 | [#11] stanford-crypto-ccm Cycles:10 Average:117.10 Median:116.50 stddev:4.84 (4.2%) stddev-sans-first:1.80 08:27:59 INFO - PROCESS | 7692 | Values: 130.0 114.0 115.0 115.0 119.0 116.0 113.0 117.0 115.0 117.0 08:27:59 INFO - PROCESS | 7692 | 08:27:59 INFO - PROCESS | 7692 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.70 Median:142.00 stddev:6.33 (4.5%) stddev-sans-first:6.51 08:27:59 INFO - PROCESS | 7692 | Values: 144.0 136.0 142.0 142.0 143.0 131.0 135.0 142.0 151.0 131.0 08:27:59 INFO - PROCESS | 7692 | 08:27:59 INFO - PROCESS | 7692 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.56 (2.3%) stddev-sans-first:1.62 08:27:59 INFO - PROCESS | 7692 | Values: 67.0 71.0 68.0 68.0 68.0 66.0 68.0 70.0 68.0 66.0 08:27:59 INFO - PROCESS | 7692 | -------- Summary: end -------- 08:27:59 INFO - PROCESS | 7692 | 08:28:00 INFO - TEST-INFO | 7692: exit 0 08:28:00 INFO - TEST-OK | kraken | took 59061ms 08:28:00 INFO - TEST-START | v8_7 08:28:00 INFO - operating with platform_type : linux_ 08:28:00 INFO - Initialising browser for v8_7 test... 08:28:00 INFO - TEST-INFO | started process 7942 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpu3hr_j/profile http://localhost:41679/getInfo.html) 08:28:04 INFO - PROCESS | 7942 | __metrics Screen width/height:1600/1200 08:28:04 INFO - PROCESS | 7942 | colorDepth:24 08:28:04 INFO - PROCESS | 7942 | Browser inner width/height: 1024/697 08:28:04 INFO - PROCESS | 7942 | __metrics 08:28:04 INFO - PROCESS | 7942 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:28:04 INFO - PROCESS | 7942 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:28:05 INFO - TEST-INFO | 7942: exit 0 08:28:05 INFO - Browser initialized. 08:28:05 INFO - Running cycle 1/1 for v8_7 test... 08:28:05 INFO - TEST-INFO | started process 8023 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpu3hr_j/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:28:17 INFO - PROCESS | 8023 | RSS: Main: 148905984 08:28:17 INFO - PROCESS | 8023 | 08:28:39 INFO - PROCESS | 8023 | Cycle 1(1): loaded http://localhost:41679/tests/v8_7/run.html (next: http://localhost:41679/tests/v8_7/run.html) 08:28:39 INFO - PROCESS | 8023 | RSS: Main: 553140224 08:28:39 INFO - PROCESS | 8023 | 08:28:39 INFO - PROCESS | 8023 | __start_tp_report 08:28:39 INFO - PROCESS | 8023 | _x_x_mozilla_page_load 08:28:39 INFO - PROCESS | 8023 | _x_x_mozilla_page_load_details 08:28:39 INFO - PROCESS | 8023 | |i|pagename|runs| 08:28:39 INFO - PROCESS | 8023 | |0;Richards;166.05778811026238 08:28:39 INFO - PROCESS | 8023 | |1;DeltaBlue;189.32222642938282 08:28:39 INFO - PROCESS | 8023 | |2;Encrypt;273.8975623116954 08:28:39 INFO - PROCESS | 8023 | |3;Decrypt;5263.1578947368425 08:28:39 INFO - PROCESS | 8023 | |4;RayTrace;1122.334455667789 08:28:39 INFO - PROCESS | 8023 | |5;Earley;783.6990595611285 08:28:39 INFO - PROCESS | 8023 | |6;Boyer;12341.463414634147 08:28:39 INFO - PROCESS | 8023 | |7;RegExp;41660 08:28:39 INFO - PROCESS | 8023 | |8;Splay;564.0022358859699 08:28:39 INFO - PROCESS | 8023 | |9;NavierStokes;4840.579710144928 08:28:39 INFO - PROCESS | 8023 | __end_tp_report 08:28:39 INFO - PROCESS | 8023 | __startTimestamp1453912119800__endTimestamp 08:28:39 INFO - PROCESS | 8023 | 08:28:39 INFO - PROCESS | 8023 | ------- Summary: start ------- 08:28:39 INFO - PROCESS | 8023 | Number of tests: 10 08:28:39 INFO - PROCESS | 8023 | 08:28:39 INFO - PROCESS | 8023 | [#0] Richards Cycles:1 Average:166.06 Median:166.06 stddev:0.00 (0.0%) 08:28:39 INFO - PROCESS | 8023 | Values: 166.1 08:28:39 INFO - PROCESS | 8023 | 08:28:39 INFO - PROCESS | 8023 | [#1] DeltaBlue Cycles:1 Average:189.32 Median:189.32 stddev:0.00 (0.0%) 08:28:39 INFO - PROCESS | 8023 | Values: 189.3 08:28:39 INFO - PROCESS | 8023 | 08:28:39 INFO - PROCESS | 8023 | [#2] Encrypt Cycles:1 Average:273.90 Median:273.90 stddev:0.00 (0.0%) 08:28:39 INFO - PROCESS | 8023 | Values: 273.9 08:28:39 INFO - PROCESS | 8023 | 08:28:39 INFO - PROCESS | 8023 | [#3] Decrypt Cycles:1 Average:5263.16 Median:5263.16 stddev:0.00 (0.0%) 08:28:39 INFO - PROCESS | 8023 | Values: 5263.2 08:28:39 INFO - PROCESS | 8023 | 08:28:39 INFO - PROCESS | 8023 | [#4] RayTrace Cycles:1 Average:1122.33 Median:1122.33 stddev:0.00 (0.0%) 08:28:39 INFO - PROCESS | 8023 | Values: 1122.3 08:28:39 INFO - PROCESS | 8023 | 08:28:39 INFO - PROCESS | 8023 | [#5] Earley Cycles:1 Average:783.70 Median:783.70 stddev:0.00 (0.0%) 08:28:39 INFO - PROCESS | 8023 | Values: 783.7 08:28:39 INFO - PROCESS | 8023 | 08:28:39 INFO - PROCESS | 8023 | [#6] Boyer Cycles:1 Average:12341.46 Median:12341.46 stddev:0.00 (0.0%) 08:28:39 INFO - PROCESS | 8023 | Values: 12341.5 08:28:39 INFO - PROCESS | 8023 | 08:28:39 INFO - PROCESS | 8023 | [#7] RegExp Cycles:1 Average:41660.00 Median:41660.00 stddev:0.00 (0.0%) 08:28:39 INFO - PROCESS | 8023 | Values: 41660.0 08:28:39 INFO - PROCESS | 8023 | 08:28:39 INFO - PROCESS | 8023 | [#8] Splay Cycles:1 Average:564.00 Median:564.00 stddev:0.00 (0.0%) 08:28:39 INFO - PROCESS | 8023 | Values: 564.0 08:28:39 INFO - PROCESS | 8023 | 08:28:39 INFO - PROCESS | 8023 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 08:28:39 INFO - PROCESS | 8023 | Values: 4840.6 08:28:39 INFO - PROCESS | 8023 | -------- Summary: end -------- 08:28:39 INFO - PROCESS | 8023 | 08:28:40 INFO - TEST-INFO | 8023: exit 0 08:28:40 INFO - TEST-OK | v8_7 | took 40520ms 08:28:40 INFO - SUITE-END | took 1212s 08:28:41 INFO - Completed test suite (00:20:12) 08:28:41 INFO - Working with test: dromaeo_css 08:28:41 INFO - Generating results file: dromaeo_css 08:28:41 INFO - Working with test: kraken 08:28:41 INFO - Generating results file: kraken 08:28:41 INFO - javascript benchmark 08:28:41 INFO - Working with test: v8_7 08:28:41 INFO - Generating results file: v8_7 08:28:41 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:28:41 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 08:28:41 INFO - process_Request line: dromaeo_css 6825.12 graph.html#tests=[[72,201,35]] 08:28:41 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:28:41 INFO - process_Request line: kraken 1500.70 graph.html#tests=[[232,201,35]] 08:28:41 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:28:41 INFO - process_Request line: v8_7 20198.65 graph.html#tests=[[230,201,35]] 08:28:41 INFO - RETURN: dromaeo_css: 6825.12 08:28:41 INFO - RETURN: kraken: 1500.70 08:28:41 INFO - RETURN: v8_7: 20198.65 08:28:41 INFO - javascript benchmark 08:28:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3130.9530357044646, 3173.1749745066277, 3218.452863013289, 3222.9355412891728, 3248.658890816464, 5052.343195384604, 5184.300119483869, 5214.009338225739, 5221.500883018676, 5264.86837829054, 5155.226715992603, 5193.480651934805, 5206.609504287184, 5207.297014902987, 5306.761195746191, 4693.507181745918, 4695.1079294934025, 4718.598919091882, 4766.618670506368, 4882.462929077798, 4797.208460603996, 4805.111054454937, 4824.662273640846, 4858.708477491344, 4865.464798872121, 4693.601043911254, 4695.577398034194, 4783.689060211075, 4800.687955282913, 4806.663533552618, 4716.858494245143, 4719.716816990992, 4755.833545825914, 4776.952230477686, 4784.880377990578, 4738.739369334685, 4739.123262196505, 4739.9526004739855, 4744.098621261984, 4751.287306903958, 4978.950210497885, 4996.550310472075, 5055.545000949932, 5064.5441910228255, 5114.43741188469, 5628.296462942132, 5642.463965923231, 5644.350899646511, 5650.039493286151, 5651.039323315005, 5658.858528536778, 5674.205611214434, 5695.743691533891, 5695.943040569583, 5703.173039909231, 5252.159654455345, 5257.526822585947, 5277.340332458442, 5280.551153151987, 5285.920711189336, 5636.577256705764, 5679.659220446703, 5686.943130568641, 5724.0, 5743.597948143673, 5437.537809286176, 5447.700376479253, 5486.204500347428, 5491.039068163055, 5494.945050549523, 5525.033119204204, 5562.415946325658, 5611.971940140274, 5617.859553511195, 5664.51851592611, 5453.890922181534, 5464.3442786865835, 5464.699441530674, 5466.644668096561, 5474.479924407175, 5456.399796022434, 5484.341878974469, 5488.670679759227, 5516.282883225155, 5539.778408863681, 4347.978260108679, 4357.520672725997, 4400.383946247528, 4431.800568974404, 4440.600345968878, 3894.4353068804867, 3915.7063220258597, 3925.1364699766004, 3958.1687845552183, 3962.7226094173707, 4994.850154495371, 5193.246979188072, 5210.76551555181, 5238.1618940969265, 5240.580753539708, 5538.584606154554, 5549.250851135126, 5556.611037227355, 5579.246801681721, 5620.466055724782, 5167.328247327899, 5170.250313704491, 5173.896522069537, 5179.404368497596, 5182.922256166161, 4738.95261047392, 4751.50109238525, 4773.331733557305, 4777.570018698334, 4815.3017812417, 5751.367349591542, 5784.248047753765, 5834.095715164156, 5836.67898265591, 5876.7649294028615, 5575.637583557056, 5577.107662773937, 5578.9163162553405, 5580.441955804387, 5586.190002449704, 5661.773529058792, 5737.168110624019, 5786.855328616818, 5787.102999035156, 5789.652620842763, 5487.945120548743, 5488.533474654699, 5490.368607610176, 5499.890002199853, 5539.390667026704, 5515.393306736176, 5529.944700552943, 5613.915791263216, 5620.550355971594, 5630.183623374506, 5428.185772134054, 5448.182772584144, 5495.725213739377, 5541.750621222135, 5547.4175211603815, 5428.240046393587, 5436.700981446058, 5439.700816454974, 5440.319960004999, 5468.207109969112, 5345.38528069277, 5350.759215835219, 5352.063388906848, 5362.839114826562, 5410.053240682943, 5341.332333458317, 5398.811041613525, 5452.91820622683, 5483.725813709379, 5487.972560137174, 5370.301860758076, 5370.785168593213, 5374.0, 5377.112776392008, 5383.973080134731], "unit": "score", "name": "dojo.html", "value": 5152.483388893844}, {"lowerIsBetter": false, "replicates": [538.0771976061054, 548.5529293625697, 564.7656222667594, 568.5593664909694, 578.158778976589, 28204.576931346022, 28432.715672843293, 35475.46786798197, 36112.2777544449, 36264.27471450569, 38371.23257534848, 38751.0, 38814.0, 38844.0, 38867.22265554687, 8445.95777021114, 8663.263622592056, 8665.740027799176, 8671.262942649852, 8673.653053877837, 8352.665893364257, 8405.369597280229, 8466.66133354668, 8466.957665211665, 8470.0, 8681.82636347276, 8727.04002559721, 8758.167974042488, 8761.868571971425, 8766.123387661246, 8607.870881936713, 8610.483370997697, 8611.526366049864, 8645.52449615271, 8693.391462597652, 8515.57422128891, 8633.913660863436, 8657.437266577652, 8666.783330416727, 8671.523066231355, 38962.41556376657, 39397.212055758726, 39516.0, 39536.04639536023, 39589.60410395888, 3243.513472979072, 3332.3335332933266, 3358.798472091658, 3400.404929137416, 3941.428492868518, 26088.60867086995, 26529.336766580796, 26617.733822661718, 26724.19827405181, 26726.06458773953, 3553.573571171476, 3600.5499312585926, 3702.582978237901, 3759.172981943968, 3967.206558688274, 213076.0, 213251.0, 215013.0, 215077.0, 215435.0, 55755.16367254494, 56184.438155618736, 60155.0, 60173.39826601678, 60258.698706507064, 61435.69282153561, 61895.690521547105, 61903.690481548205, 61904.0, 61985.38014619796, 12355.62933112008, 12531.937340313423, 12543.560975366001, 12568.937155314165, 12608.747825043447, 10403.0, 10408.063274305348, 10428.634997775041, 10428.843567346496, 10432.530536125892, 19612.70580941287, 20427.897860510602, 20528.17887284522, 20654.896725516577, 20781.0, 6717.261101278856, 7804.726834560876, 7934.761957141295, 7995.880061799077, 8140.308073813792, 872.8647059705755, 957.3537861943161, 973.6592192732487, 1010.6715317521688, 1037.3723897042332, 28113.57829632557, 28337.71662283392, 28695.56956645652, 28830.855845720638, 30122.24694382614, 1026.707388394319, 1046.2728403759313, 1071.689210129054, 1114.8327750837439, 1144.891235332642, 13522.18866867991, 13970.650733731534, 15441.15073670959, 16399.42602008948, 16453.259603317878, 369111.0, 372278.0, 373922.0, 374947.0, 376926.0, 51541.742291288305, 52019.47980520222, 52038.73980630073, 52061.73969130206, 52093.0, 1349.1163288046346, 1368.9383977721027, 1369.472752990086, 1372.6911444925013, 1372.945082196721, 28254.174582542404, 29612.703872961858, 29708.55437168401, 30135.547966780956, 30241.546376804807, 45625.31562026506, 45809.77095114503, 46181.538184617726, 46343.76828115838, 46413.53586464092, 284822.0, 285812.0, 286720.0, 287344.0, 289975.0, 31340.52989205118, 31623.525647114853, 31961.200969975936, 31992.28065614449, 32150.83924580362, 40698.389524157756, 42304.15391692211, 42826.78586607047, 43081.784591076845, 43117.0, 35191.47212791861, 35390.64609353874, 36025.45961810627, 36656.81671591732, 36768.0, 36650.8167459161, 38412.0, 41312.38031429591, 42567.0, 42971.57028429676, 34361.966654447795, 34894.825525872206, 35382.646173537934, 35398.469022964164, 35426.11434714153, 29775.851120744257, 29831.552526711683, 32398.0, 32904.0, 36233.0, 24704.629430558198, 25063.248102556954, 25352.239432817045, 25455.436238926195, 25481.49037019212], "unit": "score", "name": "ext.html", "value": 18110.107476241512}, {"lowerIsBetter": false, "replicates": [365.8335457366898, 366.3387585408338, 367.69665026353266, 368.29103974848425, 369.2117329501514, 13451.327433628328, 13626.931865340659, 15459.30433130509, 16249.431269905555, 17067.91466042671, 14993.25033748311, 15590.376384944588, 15834.0, 15844.366225350972, 16480.42318518852, 5306.044911915854, 5483.369412517552, 5483.725813709319, 5486.643368181076, 5488.862778430531, 4032.8588499402526, 4166.437530933315, 5335.626506144571, 5407.972960135214, 5877.441643043904, 5824.475797178253, 6017.368176341487, 6071.969640151793, 6074.908876366858, 6078.604890682113, 5920.585559010871, 5950.732217050243, 5951.047832346804, 5955.166276721263, 5989.460948514633, 5084.771185296633, 5266.262723218752, 5295.682259064469, 5315.813946511854, 5316.867078323035, 17975.550611234692, 19655.705164422547, 19767.901160494104, 19898.50253743668, 19901.303454379027, 2128.6381315176304, 2209.4476380904775, 2388.474535602165, 2462.347477918353, 2705.3101459127797, 8882.978457477344, 9482.478463684494, 11712.238704484267, 12042.458089385911, 12748.553800617026, 1812.4562631210715, 1836.5316844204776, 1851.1947302923272, 1873.7564116664746, 1882.8587855910862, 52085.73957130228, 55392.446075539134, 55498.16752748712, 55679.72160139214, 55702.44297557013, 9979.650712225182, 9985.30102892805, 10084.142847857867, 10133.949330253301, 10188.796224075626, 13176.275304858133, 13201.20792752438, 13341.66645833862, 13346.332683365792, 13355.53255636048, 7221.169565500035, 7309.086364204474, 7349.448791340671, 7351.889721654179, 7399.371053460409, 6991.825204369829, 7019.789406317818, 7078.079849619517, 7085.751998680124, 7088.681009354591, 4395.384646149541, 4445.59989600931, 4468.977655111704, 4490.663200259994, 4522.977385113053, 1707.8292170782822, 1720.5010546941246, 1755.4031629245862, 1814.655215509049, 1829.4968883556862, 827.5241736001823, 848.2662496940102, 887.3788348156316, 911.1935936696071, 993.0317940008434, 14632.19522926228, 14903.254837258311, 16134.838651613569, 16279.51161465158, 16545.83454165467, 923.2613908872875, 928.9953550232206, 933.3606479561522, 971.3006635222629, 1012.119456073221, 9400.200982916393, 9406.623735050522, 9509.714708558755, 9528.094830991045, 9671.323007389556, 454394.0, 470581.0, 497370.0, 501393.0, 508709.0, 69363.0, 69751.65124174347, 69993.0, 70282.64858675674, 71421.0, 1167.9708007299885, 1169.4328250798355, 1171.7949358862165, 1197.8845656798762, 1207.1007099710596, 13829.861701382857, 14761.483348082766, 14763.704725905207, 14990.0, 15269.312880920163, 29799.55300670535, 30162.09513714592, 30370.696293037672, 31315.53026704647, 31508.212294692818, 36931.81534092312, 39918.80040599778, 40491.79754101211, 40817.0, 42433.0, 7220.277972202738, 7263.636818159177, 7637.770866874002, 7695.961520192363, 7825.3739700824935, 8584.570771461276, 10944.39805810688, 11134.0, 11292.0, 11596.420178990847, 9484.430934143973, 9577.23382129414, 9739.561719722771, 9991.100800927952, 10186.643467478603, 2918.605988191567, 2950.690177531414, 9076.930707802036, 9224.262059035394, 9588.753462049888, 7421.591812450367, 9315.301352398732, 9574.856377154487, 10056.849147262943, 10137.138343240907, 7613.505122167041, 7706.383489320729, 7712.768616941501, 7716.807079822825, 7738.883916741366, 9377.812443751223, 10220.795584088426, 10426.218033647356, 10433.478326083818, 10440.060394564525], "unit": "score", "name": "jquery.html", "value": 8075.951082069565}, {"lowerIsBetter": false, "replicates": [1335.714143207709, 1464.8535146485349, 1496.9101853888765, 1648.6867495175923, 1802.8197180281973, 7094.11323584552, 7715.074191097069, 7844.058712954439, 7853.253940875615, 7854.900313956051, 7643.732469363574, 7783.883241751379, 7838.216178382159, 7848.058233012032, 7848.136704962464, 2003.9799602004011, 2058.9794102058936, 2313.687652166953, 2381.487980084286, 2389.7849193572574, 2376.7742064503846, 2395.4729959408987, 2399.8440101393353, 2400.2079313826484, 2400.627902675088, 2274.306336567346, 2328.557574060923, 2330.4057465346395, 2331.079223706635, 2332.720073591163, 2351.6942797436395, 2372.632242002484, 2376.0, 2402.903883844644, 2409.289259668402, 2307.9538409231723, 2333.719953605578, 2358.693369861907, 2360.0441821062495, 2361.315218586608, 7906.7627971160955, 7968.8406231875615, 7991.320737737299, 8013.919860801434, 8015.358771298283, 4898.657094003421, 5019.47295533971, 5019.623528235397, 5022.59819214462, 5024.698518088926, 3240.4815229563155, 3292.423825830494, 3333.8833140839956, 3376.4260075787174, 3391.3556424279554, 1046.1526163807341, 1058.1111866032493, 1065.8028264771042, 1088.2654208409292, 1099.4612639806517, 11283.323000619988, 11292.830607540893, 11292.943535282271, 11302.717432064183, 11304.886951130466, 4550.613197878218, 4571.200039993055, 4620.653450991189, 4676.462206846256, 4689.929651055237, 9584.520773961274, 9591.328606997444, 9600.183984361407, 9606.903930960601, 9609.039096090335, 4898.53463920927, 4940.357753492095, 4942.28336891156, 4942.5304596063315, 4946.851594452172, 4450.310201918708, 4513.142502924499, 4517.073999830027, 4517.277235642281, 4519.954800451954, 3429.639887811744, 3477.4609935460044, 3478.4086705260165, 3770.453284273765, 3837.366834472281, 1230.2126638951079, 1257.3587470390166, 1261.2621616354536, 1274.3055035005943, 1293.9029572782079, 1078.7788503356794, 1110.3726394587034, 1111.5942680921567, 1303.9674008149873, 1408.7041721238654, 7368.0, 7508.849823003509, 7519.661615227328, 7534.510256833289, 7576.01511803473, 1010.368519675203, 1039.6309310194922, 1105.0717397386234, 1109.7170221593442, 1147.0766033343239, 5944.048952167633, 6021.157038014681, 6023.3374328824675, 6024.427679370453, 6024.849378765478, 9435.575399107056, 9644.855327170098, 9756.975517570694, 9876.259280553988, 9902.504874756234, 9631.08504692053, 9674.08096230857, 9867.703968880945, 9869.950650246703, 9875.555599998017, 7105.822354441077, 7293.307135822089, 7299.635018249066, 7313.780586582411, 7583.848323033509, 7338.119425668954, 7437.590932498764, 7438.70245190208, 7447.88828167567, 7462.216467270859, 8221.383396245186, 8287.751367458986, 8547.444416112932, 8564.828703426021, 8572.528510931708, 8419.410641255054, 8500.404971652173, 8698.695545655872, 8704.78238044054, 8706.521141337287, 6971.3028697129885, 7097.25478824716, 7098.716051357887, 7101.0, 7108.644567771694, 6709.329067093252, 6824.761133360507, 7203.71185152588, 7372.741954031583, 7391.2239214881665, 6979.790606281819, 6990.09128813251, 7093.255208203271, 7106.324899134574, 7199.820004499929, 6934.445244380337, 6968.477364197604, 7017.964910175417, 7092.184398793998, 7129.536580122275, 6979.336962988508, 7017.122859642544, 7091.716331346688, 7111.431085513043, 7112.466565007749, 6559.704813283318, 6610.173728283965, 6610.173728283965, 6612.933870661232, 6614.338566143347, 6596.637184954873, 6635.469162467088, 6637.933620663732, 6745.730170793114, 6800.047993280846], "unit": "score", "name": "mootools.html", "value": 4611.690587612421}, {"lowerIsBetter": false, "replicates": [343.23972401131493, 352.1423647103754, 353.1242518553986, 353.93806083935306, 357.08942197396647, 5740.540756739461, 5841.970790146049, 5869.14897339886, 5902.498287645544, 5904.173415721792, 5655.179998900157, 5763.308402991636, 5772.769089236425, 5777.797777077803, 5779.104238842976, 4563.771811409433, 4564.97717511412, 4568.086382723461, 4579.702319349249, 4582.427196600425, 4355.063661312817, 4421.889452763675, 4422.823087076513, 4467.15124126415, 4571.565701258375, 4429.0, 4441.5336389679105, 4452.332150177467, 4535.909281814362, 4551.021530370969, 4499.797509112098, 4523.841665541707, 4534.501204867462, 4540.614047805908, 4557.475890272594, 4021.959780402217, 4029.7582145071387, 4054.898627534306, 4056.4320995060716, 4064.939025914584, 5466.426025267329, 5501.614886957915, 5521.4478552144865, 5539.058360078756, 5556.222128901957, 5285.524302812727, 5292.735363231862, 5297.046531624306, 5298.231756395339, 5302.602304827154, 5868.677222752747, 6170.136180934673, 6170.321264660884, 6173.722182501798, 6179.752809887599, 4379.802908869108, 4389.275769498029, 4456.955430445719, 4482.148391805546, 4495.820167193308, 6463.903041454382, 6483.805485835385, 6500.187476565477, 6505.4795616350575, 6505.772297969548, 4564.931526027112, 4572.7713614319155, 4574.153781550423, 4584.0, 4588.518205588432, 4558.2251017327135, 4638.83764068256, 4647.34937108805, 4649.04694537619, 4661.720296782204, 5217.6086793489885, 5264.0, 5265.262863199156, 5268.157094864803, 5272.472752724697, 6218.160548325918, 6220.160278362363, 6229.7508099676415, 6233.563650544418, 6240.095186198067, 1629.0958518022373, 1650.570851578574, 1650.9587260318588, 1653.0577570784778, 1653.5039488153507, 1120.277421063426, 1125.7692173104494, 1138.5957984915235, 1149.0807354116673, 1152.8904754048351, 5896.6756828374855, 5904.704764761831, 5908.911366329508, 5910.674912879833, 5913.2608423947, 6406.135171751847, 6408.134901788292, 6416.390442907917, 6450.0647406125845, 6490.610563366213, 5773.624714393635, 5837.620554663933, 5874.1776151338845, 5889.617174883619, 5914.378990205966, 3409.147713071732, 3430.27964127536, 3448.6034106078123, 3451.5685539307588, 3457.6023757268235, 6696.966515167393, 6702.899456508157, 6702.899456508157, 6707.5975441473665, 6712.765053223114, 6547.083408322838, 6561.0814485972005, 6563.1796025496815, 6566.3105373936005, 6568.277489476154, 6466.741330346827, 6608.933910660928, 6624.470042396597, 6627.801165965126, 6674.199096108498, 6195.473384762346, 6365.936340636535, 6391.2330520337855, 6391.58454700443, 6402.967985160044, 6231.501479881689, 6288.0, 6297.748090076529, 6436.742530298736, 6460.773872914426, 6707.295733947865, 6739.966300168468, 6744.0895479109695, 6761.526693131434, 6764.966175169289, 4330.52364239927, 4568.132054909556, 4599.356090147315, 4601.217792975269, 4603.102395032936, 6383.904241436289, 6401.455876250571, 6408.903866441914, 6413.615183088843, 6420.6147631142285, 6222.81331560054, 6245.812625621239, 6251.624902505864, 6253.405926436982, 6261.0, 6089.269287685506, 6231.470325022424, 6244.968775156095, 6245.96877015612, 6254.6247225166635, 6195.101710252078, 6195.2255968004, 6195.4424101831055, 6198.132261483306, 6198.543342314642, 6325.240971083499, 6326.715297811517, 6327.114204011534, 6333.493320534439, 6340.30256671775, 6075.908861367171, 6181.474574661204, 6183.81448556544, 6193.256809182927, 6197.318294987457], "unit": "score", "name": "prototype.html", "value": 4743.74704584547}, {"lowerIsBetter": false, "replicates": [727.9854402911942, 764.7017663111384, 823.000054933256, 856.948583085015, 867.2151702709047, 12768.233905965637, 12905.999999999989, 12957.0, 12985.805212921801, 13000.34998250086, 12444.066694997866, 12452.43964021619, 12465.439055242514, 12499.500019999188, 12525.874741252584, 659.9043138744879, 673.6261374936909, 777.949433286836, 784.5488843914743, 787.858185526605, 796.9402294827883, 799.3645052183529, 800.6997375984006, 802.7952872017627, 803.6222975201646, 825.558326295432, 836.506461187899, 836.7615229659548, 836.8661014237692, 837.6063250272363, 686.6223577032637, 697.0937780884855, 818.9590520473982, 836.3768992100923, 838.5471845203583, 611.7522403426619, 611.7552978808468, 615.3354377272535, 616.2820314333795, 619.1084837833505, 12520.186187897758, 12536.247825130522, 12591.559295424708, 12605.558805441857, 12615.053870959715, 12034.51861925522, 12486.250824950532, 12497.125201235825, 12581.24512529242, 12604.68488287791, 10598.62904798336, 10642.787144257072, 10696.625618103408, 10986.0, 11071.16966227536, 3618.095476130967, 3660.432632941898, 3683.526589364276, 3758.7180961428003, 3763.6612704856693, 41900.79049604763, 42010.1597968042, 42037.57962420398, 42062.57937420617, 42326.36510452346, 9543.0456954304, 9962.55168517404, 10163.136691795336, 10271.897281027244, 10552.26134170616, 16581.25384357707, 16787.328506859834, 16892.155392230587, 16939.153042347833, 16996.660066798842, 7439.85120297591, 7599.050118735158, 7643.464957452925, 7712.730054448068, 7751.069871615442, 4264.424302719093, 4294.347742021829, 4362.062156636339, 4371.213181627338, 4383.123375324948, 3078.98460507696, 3112.37752449511, 3119.5632611434417, 3121.2352973521633, 3124.718775310233, 586.2086183652036, 623.7754408412968, 639.1180171363488, 650.5868773328971, 655.3708439897752, 667.4760313154151, 693.784926672733, 711.3242419701304, 720.5784615999698, 730.441212472459, 8001.599920003977, 8074.636641351153, 8358.623861926228, 8678.696245631372, 8898.0, 562.103445005216, 583.3233449198909, 636.2905360522983, 645.3062957320899, 671.6171782084165, 3853.6917046636204, 3886.8344665791633, 3932.4494570760116, 4018.578049304839, 4146.3158578834755, 49397.0, 49569.752151239016, 49596.75201623969, 50126.498735012916, 52054.0, 42497.78751106225, 42502.78748606237, 43168.352474712905, 43332.0, 43565.56434435615, 38225.426618600744, 39521.40717889234, 39564.0, 39646.40530392047, 44635.33047004297, 8418.242358187792, 8583.957080214559, 8922.41250037482, 9050.479207683176, 9069.365144439826, 32000.67999319977, 32672.34655306833, 32896.67103329032, 33473.0, 33674.83162584171, 37731.811340944216, 42663.0, 42784.786076069424, 42994.0, 43487.0, 10568.471576420994, 10628.202884783826, 11121.499532521218, 11268.887311126784, 11669.0, 12359.0, 12383.690407739517, 12691.111622186727, 12929.288889111189, 13137.277449740355, 11335.149863760085, 11489.885101149215, 11658.825117623073, 11692.123090768056, 12144.39278036077, 10874.001486855403, 10953.302457006213, 11147.777044459228, 11184.273022253528, 11273.830892536454, 10649.094826939798, 10724.463776811284, 10793.838092428778, 10924.890751092387, 10934.945325273322, 8357.916420835714, 8432.578371081545, 8572.228499435081, 9089.363744538083, 9330.906690933003, 8961.910380896108, 9470.289728270545, 9517.476538790434, 9592.0, 9727.221822254061], "unit": "score", "name": "yui.html", "value": 6130.722892042871}], "name": "dromaeo_css", "value": 6825.119309216116}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 105.0, 110.0, 111.0, 111.0, 110.0, 110.0, 102.0, 108.0], "unit": "score", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [158.0, 125.0, 153.0, 167.0, 129.0, 151.0, 149.0, 127.0, 168.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 145.2}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 161.0, 160.0, 161.0, 160.0, 160.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 102.0, 94.0, 73.0, 73.0, 73.0, 116.0, 98.0, 72.0], "unit": "score", "name": "audio-fft", "value": 84.8}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 141.0, 95.0, 96.0, 95.0, 154.0, 95.0, 96.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 110.9}, {"lowerIsBetter": true, "replicates": [118.0, 115.0, 115.0, 114.0, 114.0, 116.0, 115.0, 114.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.1}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 147.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 97.0, 97.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [58.0, 55.0, 57.0, 57.0, 56.0, 56.0, 57.0, 57.0, 58.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 68.0, 69.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 85.0, 83.0, 84.0, 89.0, 84.0, 83.0, 90.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [130.0, 114.0, 115.0, 115.0, 119.0, 116.0, 113.0, 117.0, 115.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.1}, {"lowerIsBetter": true, "replicates": [144.0, 136.0, 142.0, 142.0, 143.0, 131.0, 135.0, 142.0, 151.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.7}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 68.0, 68.0, 68.0, 66.0, 68.0, 70.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1500.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.05778811026238], "unit": "score", "name": "Richards", "value": 212.58864400000002}, {"lowerIsBetter": false, "replicates": [189.32222642938282], "unit": "score", "name": "DeltaBlue", "value": 349.235276}, {"lowerIsBetter": false, "replicates": [273.8975623116954], "unit": "score", "name": "Encrypt", "value": 971.8268310000004}, {"lowerIsBetter": false, "replicates": [5263.1578947368425], "unit": "score", "name": "Decrypt", "value": 50.57439}, {"lowerIsBetter": false, "replicates": [1122.334455667789], "unit": "score", "name": "RayTrace", "value": 659.3301990000002}, {"lowerIsBetter": false, "replicates": [783.6990595611285], "unit": "score", "name": "Earley", "value": 850.4067880000003}, {"lowerIsBetter": false, "replicates": [12341.463414634147], "unit": "score", "name": "Boyer", "value": 54.00194268774702}, {"lowerIsBetter": false, "replicates": [41660.0], "unit": "score", "name": "RegExp", "value": 21.867138742198733}, {"lowerIsBetter": false, "replicates": [564.0022358859699], "unit": "score", "name": "Splay", "value": 144.4870158572845}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20198.646789875682}]} 08:28:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20198.65"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1500.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6825.12"}}} 08:28:41 INFO - Return code: 0 08:28:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:28:41 INFO - # TBPL SUCCESS # 08:28:41 INFO - Running post-action listener: _resource_record_post_action 08:28:41 INFO - Running post-run listener: _resource_record_post_run 08:28:42 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 4096; Write bytes: 537690112; Read time: 12; Write time: 399424 08:28:42 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236556288; Read time: 0; Write time: 219164 08:28:42 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 4096; Write bytes: 301133824; Read time: 12; Write time: 180260 08:28:42 INFO - Running post-run listener: _upload_blobber_files 08:28:42 INFO - Blob upload gear active. 08:28:42 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:28:42 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 08:28:42 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'] 08:28:42 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 08:28:42 INFO - (blobuploader) - INFO - Open directory for files ... 08:28:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:28:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:28:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:43 INFO - (blobuploader) - INFO - Done attempting. 08:28:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:28:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:28:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:44 INFO - (blobuploader) - INFO - Done attempting. 08:28:44 INFO - (blobuploader) - INFO - Iteration through files over. 08:28:44 INFO - Return code: 0 08:28:44 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:28:44 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:28:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/c24527e0c8bd32634c1fbcf13e28ef194add245d7269561eff4c01691c495b938da1e9ac60c8355eb5c362bc6195cd8ab0fc809c5741046dc238fab910870b61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d19c7054e9441882b9714441f30be058b073c0f6fd106c3e72d5cade0a4d1757b96fddf8cfb7286bb78a13ad55116c203cfd4043f95aef4080c60550f9c7f1b9"} 08:28:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:28:44 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:28:44 INFO - Contents: 08:28:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/c24527e0c8bd32634c1fbcf13e28ef194add245d7269561eff4c01691c495b938da1e9ac60c8355eb5c362bc6195cd8ab0fc809c5741046dc238fab910870b61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d19c7054e9441882b9714441f30be058b073c0f6fd106c3e72d5cade0a4d1757b96fddf8cfb7286bb78a13ad55116c203cfd4043f95aef4080c60550f9c7f1b9"} 08:28:44 INFO - Running post-run listener: copy_logs_to_upload_dir 08:28:44 INFO - Copying logs to upload dir... 08:28:44 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 08:28:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.267312 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-01-27 08:28:44.487635) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-27 08:28:44.490856) ========= 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=574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714 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/c24527e0c8bd32634c1fbcf13e28ef194add245d7269561eff4c01691c495b938da1e9ac60c8355eb5c362bc6195cd8ab0fc809c5741046dc238fab910870b61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d19c7054e9441882b9714441f30be058b073c0f6fd106c3e72d5cade0a4d1757b96fddf8cfb7286bb78a13ad55116c203cfd4043f95aef4080c60550f9c7f1b9"} build_url:https://queue.taskcluster.net/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011259 build_url: 'https://queue.taskcluster.net/v1/task/GlFFSkikSpyidjeoZVtn3Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/c24527e0c8bd32634c1fbcf13e28ef194add245d7269561eff4c01691c495b938da1e9ac60c8355eb5c362bc6195cd8ab0fc809c5741046dc238fab910870b61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d19c7054e9441882b9714441f30be058b073c0f6fd106c3e72d5cade0a4d1757b96fddf8cfb7286bb78a13ad55116c203cfd4043f95aef4080c60550f9c7f1b9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-27 08:28:44.515158) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:28:44.515488) ========= 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=574dc5aafe09851ec43d388c000001b6-1453910780.372279-1892336714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:28:44.599338) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-27 08:28:44.599657) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-27 08:28:44.599946) ========= ========= Total master_lag: 0.29 =========